builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1475059019.74 results: success (0) buildid: 20160928004008 builduid: b1f27a1ee8df43e69c8c6703493ce526 revision: 3db11822d83f7a97cb882ec8338578f50b51a994 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 03:36:59.740810) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 03:36:59.741279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 03:36:59.741558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 03:36:59.756610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 03:36:59.756962) ========= 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=32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 03:37:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-09-28 03:37:00 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167710 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 03:36:59.939360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 03:36:59.939680) ========= 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=32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017449 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 03:36:59.990094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 03:36:59.990461) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3db11822d83f7a97cb882ec8338578f50b51a994 --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 3db11822d83f7a97cb882ec8338578f50b51a994 --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=32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 03:37:00,954 truncating revision to first 12 chars 2016-09-28 03:37:00,954 Setting DEBUG logging. 2016-09-28 03:37:00,954 attempt 1/10 2016-09-28 03:37:00,955 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3db11822d83f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 03:37:02,443 unpacking tar archive at: mozilla-aurora-3db11822d83f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.869051 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 03:37:01.872881) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 03:37:01.873212) ========= script_repo_revision: 3db11822d83f7a97cb882ec8338578f50b51a994 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 03:37:01.873614) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 03:37:01.873885) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 03:37:01.884465) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-09-28 03:37:01.884735) ========= /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=32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:37:02 INFO - MultiFileLogger online at 20160928 03:37:02 in /builds/slave/test 03:37:02 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:37:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:37:02 INFO - {'append_to_log': False, 03:37:02 INFO - 'base_work_dir': '/builds/slave/test', 03:37:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:37:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:37:02 INFO - 'branch': 'Mozilla-Aurora', 03:37:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:37:02 INFO - 'config_files': ('talos/linux_config.py',), 03:37:02 INFO - 'default_actions': ('clobber', 03:37:02 INFO - 'read-buildbot-config', 03:37:02 INFO - 'download-and-extract', 03:37:02 INFO - 'populate-webroot', 03:37:02 INFO - 'create-virtualenv', 03:37:02 INFO - 'install', 03:37:02 INFO - 'run-tests'), 03:37:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:37:02 INFO - 'download_minidump_stackwalk': True, 03:37:02 INFO - 'download_symbols': 'ondemand', 03:37:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:37:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:37:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:37:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:37:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:37:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:37:02 INFO - 'installer_path': 'installer.exe', 03:37:02 INFO - 'log_level': 'info', 03:37:02 INFO - 'log_name': 'talos', 03:37:02 INFO - 'log_to_console': True, 03:37:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:37:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:37:02 INFO - 'opt_config_files': (), 03:37:02 INFO - 'pip_index': False, 03:37:02 INFO - 'sps_profile': False, 03:37:02 INFO - 'sps_profile_interval': 0, 03:37:02 INFO - 'suite': 'dromaeojs', 03:37:02 INFO - 'system_bits': '32', 03:37:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:37:02 INFO - 'title': 'talos-linux64-ix-008', 03:37:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:37:02 INFO - 'use_talos_json': True, 03:37:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:37:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:37:02 INFO - 'work_dir': 'build'} 03:37:02 INFO - [mozharness: 2016-09-28 10:37:02.947359Z] Running clobber step. 03:37:02 INFO - Running pre-action listener: _resource_record_pre_action 03:37:02 INFO - Running main action method: clobber 03:37:02 INFO - rmtree: /builds/slave/test/build 03:37:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:37:03 INFO - Running post-action listener: _resource_record_post_action 03:37:03 INFO - [mozharness: 2016-09-28 10:37:03.405182Z] Finished clobber step (success) 03:37:03 INFO - [mozharness: 2016-09-28 10:37:03.405282Z] Running read-buildbot-config step. 03:37:03 INFO - Running pre-action listener: _resource_record_pre_action 03:37:03 INFO - Running main action method: read_buildbot_config 03:37:03 INFO - Using buildbot properties: 03:37:03 INFO - { 03:37:03 INFO - "project": "", 03:37:03 INFO - "product": "firefox", 03:37:03 INFO - "script_repo_revision": "production", 03:37:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:37:03 INFO - "repository": "", 03:37:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:37:03 INFO - "buildid": "20160928004008", 03:37:03 INFO - "stage_platform": "linux64-pgo", 03:37:03 INFO - "basedir": "/builds/slave/test", 03:37:03 INFO - "nightly_build": "True", 03:37:03 INFO - "buildnumber": 490, 03:37:03 INFO - "slavename": "talos-linux64-ix-008", 03:37:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:37:03 INFO - "platform": "ubuntu64_hw", 03:37:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:37:03 INFO - "branch": "mozilla-aurora", 03:37:03 INFO - "repo_path": "releases/mozilla-aurora", 03:37:03 INFO - "revision": "3db11822d83f7a97cb882ec8338578f50b51a994", 03:37:03 INFO - "pgo_build": "True", 03:37:03 INFO - "builduid": "b1f27a1ee8df43e69c8c6703493ce526", 03:37:03 INFO - "slavebuilddir": "test" 03:37:03 INFO - } 03:37:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:37:03 INFO - Running post-action listener: _resource_record_post_action 03:37:03 INFO - [mozharness: 2016-09-28 10:37:03.407786Z] Finished read-buildbot-config step (success) 03:37:03 INFO - [mozharness: 2016-09-28 10:37:03.407875Z] Running download-and-extract step. 03:37:03 INFO - Running pre-action listener: _resource_record_pre_action 03:37:03 INFO - Running main action method: download_and_extract 03:37:03 INFO - mkdir: /builds/slave/test/build/tests 03:37: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:37:03 INFO - trying https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:37:03 INFO - Downloading https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/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:37:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/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:37:03 INFO - Downloaded 1361 bytes. 03:37:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:37:03 INFO - Using the following test package requirements: 03:37:03 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:03 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:37:03 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:37:03 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:03 INFO - u'jsshell-linux-x86_64.zip'], 03:37:03 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:37:03 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:37:03 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:37:03 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:37:03 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:37:03 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:37:03 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:37:03 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:37:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:37:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:37:03 INFO - Fetch https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:37:04 INFO - Expected file size: 21900064 03:37:08 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:37:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:37:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:37:08 INFO - Fetch https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:37:09 INFO - Expected file size: 21900064 03:37:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:37:14 INFO - Fetch https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:37:14 INFO - Expected file size: 14414059 03:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:15 INFO - trying https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:37:15 INFO - Downloading https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/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:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/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:37:16 INFO - Downloaded 63942720 bytes. 03:37:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:37:16 INFO - mkdir: /builds/slave/test/properties 03:37:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:37:16 INFO - Writing to file /builds/slave/test/properties/build_url 03:37:16 INFO - Contents: 03:37:16 INFO - build_url:https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:37:17 INFO - Running post-action listener: _resource_record_post_action 03:37:17 INFO - Running post-action listener: set_extra_try_arguments 03:37:17 INFO - [mozharness: 2016-09-28 10:37:17.467597Z] Finished download-and-extract step (success) 03:37:17 INFO - [mozharness: 2016-09-28 10:37:17.467896Z] Running populate-webroot step. 03:37:17 INFO - Running pre-action listener: _resource_record_pre_action 03:37:17 INFO - Running main action method: populate_webroot 03:37:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:37:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:37:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:37:17 INFO - '--tppagecycles', 03:37:17 INFO - '7'], 03:37:17 INFO - 'tests': ['tsvgm']}}, 03:37:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:37:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:37:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:37:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:37:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:17 INFO - 'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:17 INFO - 'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['damp', 'tps']}, 03:37:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:17 INFO - 'tests': ['damp', 'tps']}, 03:37:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['dromaeo_dom']}, 03:37:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:37:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['basic_compositor_video']}, 03:37:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:37:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['a11yr', 03:37:17 INFO - 'ts_paint', 03:37:17 INFO - 'tpaint', 03:37:17 INFO - 'sessionrestore', 03:37:17 INFO - 'sessionrestore_no_auto_restore', 03:37:17 INFO - 'tabpaint']}, 03:37:17 INFO - 'other-e10s': {'tests': ['a11yr', 03:37:17 INFO - 'ts_paint', 03:37:17 INFO - 'tpaint', 03:37:17 INFO - 'sessionrestore', 03:37:17 INFO - 'sessionrestore_no_auto_restore', 03:37:17 INFO - 'tabpaint']}, 03:37:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:37:17 INFO - 'ts_paint', 03:37:17 INFO - 'tpaint', 03:37:17 INFO - 'sessionrestore', 03:37:17 INFO - 'sessionrestore_no_auto_restore', 03:37:17 INFO - 'tabpaint']}, 03:37:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:37:17 INFO - 'ts_paint', 03:37:17 INFO - 'tpaint', 03:37:17 INFO - 'sessionrestore', 03:37:17 INFO - 'sessionrestore_no_auto_restore', 03:37:17 INFO - 'tabpaint']}, 03:37:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['a11yr', 03:37:17 INFO - 'ts_paint', 03:37:17 INFO - 'tpaint', 03:37:17 INFO - 'sessionrestore', 03:37:17 INFO - 'sessionrestore_no_auto_restore', 03:37:17 INFO - 'tabpaint']}, 03:37:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['a11yr', 03:37:17 INFO - 'ts_paint', 03:37:17 INFO - 'tpaint', 03:37:17 INFO - 'sessionrestore', 03:37:17 INFO - 'sessionrestore_no_auto_restore', 03:37:17 INFO - 'tabpaint']}, 03:37:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['tsvgx', 03:37:17 INFO - 'tsvgr_opacity', 03:37:17 INFO - 'tart', 03:37:17 INFO - 'tscrollx', 03:37:17 INFO - 'cart']}, 03:37:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:37:17 INFO - 'tsvgr_opacity', 03:37:17 INFO - 'tart', 03:37:17 INFO - 'tscrollx', 03:37:17 INFO - 'cart']}, 03:37:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:17 INFO - 'talos_options': ['--disable-e10s'], 03:37:17 INFO - 'tests': ['tp5o']}, 03:37:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:17 INFO - 'tests': ['tp5o']}, 03:37:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:17 INFO - 'talos_options': ['--disable-e10s', 03:37:17 INFO - '--xperf_path', 03:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:17 INFO - 'tests': ['tp5n']}, 03:37:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:37:17 INFO - 'talos_options': ['--xperf_path', 03:37:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:17 INFO - 'tests': ['tp5n']}}, 03:37:17 INFO - 'talos.zip': {'path': '', 03:37:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:37:17 INFO - Running post-action listener: _resource_record_post_action 03:37:17 INFO - [mozharness: 2016-09-28 10:37:17.488465Z] Finished populate-webroot step (success) 03:37:17 INFO - [mozharness: 2016-09-28 10:37:17.488558Z] Running create-virtualenv step. 03:37:17 INFO - Running pre-action listener: _resource_record_pre_action 03:37:17 INFO - Running main action method: create_virtualenv 03:37:17 INFO - Creating virtualenv /builds/slave/test/build/venv 03:37:17 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:37:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:37:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:37:17 INFO - Using real prefix '/usr' 03:37:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:37:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:37:20 INFO - Installing pip.................done. 03:37:20 INFO - Return code: 0 03:37:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:20 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 0x7fa9d72bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, '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': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', '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:37:20 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:37:20 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:37:20 INFO - Using env: {'DISPLAY': ':0', 03:37:20 INFO - 'HOME': '/home/cltbld', 03:37:20 INFO - 'LANG': 'en_US.UTF-8', 03:37:20 INFO - 'LANGUAGE': 'en_US:en', 03:37:20 INFO - 'LOGNAME': 'cltbld', 03:37:20 INFO - 'MAIL': '/var/mail/cltbld', 03:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:20 INFO - 'MOZ_NO_REMOTE': '1', 03:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:20 INFO - 'NO_EM_RESTART': '1', 03:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:20 INFO - 'PWD': '/builds/slave/test', 03:37:20 INFO - 'SHELL': '/bin/bash', 03:37:20 INFO - 'SHLVL': '1', 03:37:20 INFO - 'TERM': 'linux', 03:37:20 INFO - 'TMOUT': '86400', 03:37:20 INFO - 'USER': 'cltbld', 03:37:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:20 INFO - '_': '/tools/buildbot/bin/python'} 03:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:20 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:37:20 INFO - Cleaning up... 03:37:20 INFO - Return code: 0 03:37:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:20 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 0x7fa9d72bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, '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': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', '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:37:20 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:37:20 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:37:20 INFO - Using env: {'DISPLAY': ':0', 03:37:20 INFO - 'HOME': '/home/cltbld', 03:37:20 INFO - 'LANG': 'en_US.UTF-8', 03:37:20 INFO - 'LANGUAGE': 'en_US:en', 03:37:20 INFO - 'LOGNAME': 'cltbld', 03:37:20 INFO - 'MAIL': '/var/mail/cltbld', 03:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:20 INFO - 'MOZ_NO_REMOTE': '1', 03:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:20 INFO - 'NO_EM_RESTART': '1', 03:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:20 INFO - 'PWD': '/builds/slave/test', 03:37:20 INFO - 'SHELL': '/bin/bash', 03:37:20 INFO - 'SHLVL': '1', 03:37:20 INFO - 'TERM': 'linux', 03:37:20 INFO - 'TMOUT': '86400', 03:37:20 INFO - 'USER': 'cltbld', 03:37:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:20 INFO - '_': '/tools/buildbot/bin/python'} 03:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:20 INFO - Downloading/unpacking psutil>=3.1.1 03:37:20 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:37:20 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:37:20 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:37:20 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:37:20 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:37:20 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:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:22 INFO - Installing collected packages: psutil 03:37:22 INFO - Running setup.py install for psutil 03:37:22 INFO - building 'psutil._psutil_linux' extension 03:37:22 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:37:22 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:37:22 INFO - building 'psutil._psutil_posix' extension 03:37:22 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:37:22 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:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:23 INFO - Successfully installed psutil 03:37:23 INFO - Cleaning up... 03:37:23 INFO - Return code: 0 03:37:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:23 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 0x7fa9d72bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, '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': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', '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:37:23 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:37:23 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:37:23 INFO - Using env: {'DISPLAY': ':0', 03:37:23 INFO - 'HOME': '/home/cltbld', 03:37:23 INFO - 'LANG': 'en_US.UTF-8', 03:37:23 INFO - 'LANGUAGE': 'en_US:en', 03:37:23 INFO - 'LOGNAME': 'cltbld', 03:37:23 INFO - 'MAIL': '/var/mail/cltbld', 03:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:23 INFO - 'MOZ_NO_REMOTE': '1', 03:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:23 INFO - 'NO_EM_RESTART': '1', 03:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:23 INFO - 'PWD': '/builds/slave/test', 03:37:23 INFO - 'SHELL': '/bin/bash', 03:37:23 INFO - 'SHLVL': '1', 03:37:23 INFO - 'TERM': 'linux', 03:37:23 INFO - 'TMOUT': '86400', 03:37:23 INFO - 'USER': 'cltbld', 03:37:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:23 INFO - '_': '/tools/buildbot/bin/python'} 03:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:23 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:37:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:37:25 INFO - Installing collected packages: mozsystemmonitor 03:37:25 INFO - Running setup.py install for mozsystemmonitor 03:37:25 INFO - Successfully installed mozsystemmonitor 03:37:25 INFO - Cleaning up... 03:37:25 INFO - Return code: 0 03:37:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:37:25 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:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:25 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:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:25 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 0x7fa9d72bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, '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': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', '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:37:25 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:37:25 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:37:25 INFO - Using env: {'DISPLAY': ':0', 03:37:25 INFO - 'HOME': '/home/cltbld', 03:37:25 INFO - 'LANG': 'en_US.UTF-8', 03:37:25 INFO - 'LANGUAGE': 'en_US:en', 03:37:25 INFO - 'LOGNAME': 'cltbld', 03:37:25 INFO - 'MAIL': '/var/mail/cltbld', 03:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:25 INFO - 'MOZ_NO_REMOTE': '1', 03:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:25 INFO - 'NO_EM_RESTART': '1', 03:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:25 INFO - 'PWD': '/builds/slave/test', 03:37:25 INFO - 'SHELL': '/bin/bash', 03:37:25 INFO - 'SHLVL': '1', 03:37:25 INFO - 'TERM': 'linux', 03:37:25 INFO - 'TMOUT': '86400', 03:37:25 INFO - 'USER': 'cltbld', 03:37:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:25 INFO - '_': '/tools/buildbot/bin/python'} 03:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:25 INFO - Downloading/unpacking jsonschema==2.5.1 03:37:25 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:37:25 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:37:25 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:37:25 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:37:25 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:37:25 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:37:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:27 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:27 INFO - warning: no files found matching '*.txt' 03:37:27 INFO - no previously-included directories found matching 'build' 03:37:27 INFO - no previously-included directories found matching 'dist' 03:37:27 INFO - no previously-included directories found matching '.git*' 03:37:27 INFO - Installing collected packages: jsonschema, functools32 03:37:27 INFO - Running setup.py install for functools32 03:37:27 INFO - warning: no files found matching '*.txt' 03:37:27 INFO - no previously-included directories found matching 'build' 03:37:27 INFO - no previously-included directories found matching 'dist' 03:37:27 INFO - no previously-included directories found matching '.git*' 03:37:27 INFO - Successfully installed jsonschema functools32 03:37:27 INFO - Cleaning up... 03:37:27 INFO - Return code: 0 03:37:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:37:27 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:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:27 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:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:27 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 0x7fa9d72bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, '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': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', '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:37:27 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:37:27 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:37:27 INFO - Using env: {'DISPLAY': ':0', 03:37:27 INFO - 'HOME': '/home/cltbld', 03:37:27 INFO - 'LANG': 'en_US.UTF-8', 03:37:27 INFO - 'LANGUAGE': 'en_US:en', 03:37:27 INFO - 'LOGNAME': 'cltbld', 03:37:27 INFO - 'MAIL': '/var/mail/cltbld', 03:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:27 INFO - 'MOZ_NO_REMOTE': '1', 03:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:27 INFO - 'NO_EM_RESTART': '1', 03:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:27 INFO - 'PWD': '/builds/slave/test', 03:37:27 INFO - 'SHELL': '/bin/bash', 03:37:27 INFO - 'SHLVL': '1', 03:37:27 INFO - 'TERM': 'linux', 03:37:27 INFO - 'TMOUT': '86400', 03:37:27 INFO - 'USER': 'cltbld', 03:37:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:27 INFO - '_': '/tools/buildbot/bin/python'} 03:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:37:28 INFO - Cleaning up... 03:37:28 INFO - Return code: 0 03:37:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:28 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:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:28 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:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:28 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 0x7fa9d72bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, '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': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', '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:37:28 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:37:28 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:37:28 INFO - Using env: {'DISPLAY': ':0', 03:37:28 INFO - 'HOME': '/home/cltbld', 03:37:28 INFO - 'LANG': 'en_US.UTF-8', 03:37:28 INFO - 'LANGUAGE': 'en_US:en', 03:37:28 INFO - 'LOGNAME': 'cltbld', 03:37:28 INFO - 'MAIL': '/var/mail/cltbld', 03:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:28 INFO - 'MOZ_NO_REMOTE': '1', 03:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:28 INFO - 'NO_EM_RESTART': '1', 03:37:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:28 INFO - 'PWD': '/builds/slave/test', 03:37:28 INFO - 'SHELL': '/bin/bash', 03:37:28 INFO - 'SHLVL': '1', 03:37:28 INFO - 'TERM': 'linux', 03:37:28 INFO - 'TMOUT': '86400', 03:37:28 INFO - 'USER': 'cltbld', 03:37:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:28 INFO - '_': '/tools/buildbot/bin/python'} 03:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:28 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:28 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:37:28 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:37:28 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:37:28 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:37:28 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:37:28 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:37:30 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:31 INFO - Downloading docopt-0.6.1.tar.gz 03:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:31 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:31 INFO - Running setup.py install for blobuploader 03:37:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:31 INFO - Running setup.py install for requests 03:37:31 INFO - Running setup.py install for docopt 03:37:31 INFO - Successfully installed blobuploader requests docopt 03:37:31 INFO - Cleaning up... 03:37:31 INFO - Return code: 0 03:37:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:31 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:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:31 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:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:31 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 0x7fa9d72bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, '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': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', '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:37:31 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:37:31 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:37:31 INFO - Using env: {'DISPLAY': ':0', 03:37:31 INFO - 'HOME': '/home/cltbld', 03:37:31 INFO - 'LANG': 'en_US.UTF-8', 03:37:31 INFO - 'LANGUAGE': 'en_US:en', 03:37:31 INFO - 'LOGNAME': 'cltbld', 03:37:31 INFO - 'MAIL': '/var/mail/cltbld', 03:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:31 INFO - 'MOZ_NO_REMOTE': '1', 03:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:31 INFO - 'NO_EM_RESTART': '1', 03:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:31 INFO - 'PWD': '/builds/slave/test', 03:37:31 INFO - 'SHELL': '/bin/bash', 03:37:31 INFO - 'SHLVL': '1', 03:37:31 INFO - 'TERM': 'linux', 03:37:31 INFO - 'TMOUT': '86400', 03:37:31 INFO - 'USER': 'cltbld', 03:37:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:31 INFO - '_': '/tools/buildbot/bin/python'} 03:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:31 INFO - Running setup.py (path:/tmp/pip-MwL9uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:31 INFO - Running setup.py (path:/tmp/pip-aMuBYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:32 INFO - Running setup.py (path:/tmp/pip-4JyK3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:32 INFO - Running setup.py (path:/tmp/pip-C6OPD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:32 INFO - Running setup.py (path:/tmp/pip-juPu_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:32 INFO - Running setup.py (path:/tmp/pip-EExrhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:32 INFO - Running setup.py (path:/tmp/pip-ZQjy6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:32 INFO - Running setup.py (path:/tmp/pip-2wTQMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:32 INFO - Running setup.py (path:/tmp/pip-3d4yj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:32 INFO - Running setup.py (path:/tmp/pip-CofeXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:32 INFO - Running setup.py (path:/tmp/pip-M874rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:32 INFO - Running setup.py (path:/tmp/pip-2DfV0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:32 INFO - Running setup.py (path:/tmp/pip-P3QpIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:32 INFO - Running setup.py (path:/tmp/pip-8E3dI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:32 INFO - Running setup.py (path:/tmp/pip-yCDHeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:33 INFO - Running setup.py (path:/tmp/pip-9W3siD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:33 INFO - Running setup.py (path:/tmp/pip-P563m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:33 INFO - Running setup.py install for manifestparser 03:37:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:33 INFO - Running setup.py install for mozcrash 03:37:33 INFO - Running setup.py install for mozdebug 03:37:33 INFO - Running setup.py install for mozdevice 03:37:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:37:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:33 INFO - Running setup.py install for mozfile 03:37:33 INFO - Running setup.py install for mozhttpd 03:37:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:33 INFO - Running setup.py install for mozinfo 03:37:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:33 INFO - Running setup.py install for mozInstall 03:37:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:33 INFO - Running setup.py install for mozleak 03:37:34 INFO - Running setup.py install for mozlog 03:37:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Running setup.py install for moznetwork 03:37:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Running setup.py install for mozprocess 03:37:34 INFO - Running setup.py install for mozprofile 03:37:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Running setup.py install for mozrunner 03:37:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Running setup.py install for mozscreenshot 03:37:34 INFO - Running setup.py install for moztest 03:37:34 INFO - Running setup.py install for mozversion 03:37:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:34 INFO - Cleaning up... 03:37:34 INFO - Return code: 0 03:37:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:34 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:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:34 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:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:34 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 0x7fa9d72bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, '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': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', '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:37:34 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:37:34 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:37:34 INFO - Using env: {'DISPLAY': ':0', 03:37:34 INFO - 'HOME': '/home/cltbld', 03:37:34 INFO - 'LANG': 'en_US.UTF-8', 03:37:34 INFO - 'LANGUAGE': 'en_US:en', 03:37:34 INFO - 'LOGNAME': 'cltbld', 03:37:34 INFO - 'MAIL': '/var/mail/cltbld', 03:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:34 INFO - 'MOZ_NO_REMOTE': '1', 03:37:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:34 INFO - 'NO_EM_RESTART': '1', 03:37:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:34 INFO - 'PWD': '/builds/slave/test', 03:37:34 INFO - 'SHELL': '/bin/bash', 03:37:34 INFO - 'SHLVL': '1', 03:37:34 INFO - 'TERM': 'linux', 03:37:34 INFO - 'TMOUT': '86400', 03:37:34 INFO - 'USER': 'cltbld', 03:37:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:34 INFO - '_': '/tools/buildbot/bin/python'} 03:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:35 INFO - Running setup.py (path:/tmp/pip-Xc4XUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:35 INFO - Running setup.py (path:/tmp/pip-csGYkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:35 INFO - Running setup.py (path:/tmp/pip-ZzRofe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:35 INFO - Running setup.py (path:/tmp/pip-Mmry5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:35 INFO - Running setup.py (path:/tmp/pip-9GLbAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:35 INFO - Running setup.py (path:/tmp/pip-rSuQF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:35 INFO - Running setup.py (path:/tmp/pip-QjBTOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:35 INFO - Running setup.py (path:/tmp/pip-eeINk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:35 INFO - Running setup.py (path:/tmp/pip-BYD1J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:35 INFO - Running setup.py (path:/tmp/pip-ryEtuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:35 INFO - Running setup.py (path:/tmp/pip-CbM8h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:35 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:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:35 INFO - Running setup.py (path:/tmp/pip-6N0PWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:36 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:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:36 INFO - Running setup.py (path:/tmp/pip-yFTs5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:36 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:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:36 INFO - Running setup.py (path:/tmp/pip-FtA8pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:36 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:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:36 INFO - Running setup.py (path:/tmp/pip-zAU7Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:36 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:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:36 INFO - Running setup.py (path:/tmp/pip-NLjEDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:36 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:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:36 INFO - Running setup.py (path:/tmp/pip-0f30zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:36 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:37:36 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:37:36 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:37:36 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:37:36 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:37:36 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:37:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:36 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:37:36 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:37:36 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:37:36 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:37:36 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:37:36 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:37:38 INFO - Downloading blessings-1.6.tar.gz 03:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:38 INFO - Installing collected packages: blessings 03:37:38 INFO - Running setup.py install for blessings 03:37:38 INFO - Successfully installed blessings 03:37:38 INFO - Cleaning up... 03:37:38 INFO - Return code: 0 03:37:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:38 INFO - Reading from file tmpfile_stdout 03:37:38 INFO - Current package versions: 03:37:38 INFO - argparse == 1.2.1 03:37:38 INFO - blessings == 1.6 03:37:38 INFO - blobuploader == 1.2.4 03:37:38 INFO - docopt == 0.6.1 03:37:38 INFO - functools32 == 3.2.3-2 03:37:38 INFO - jsonschema == 2.5.1 03:37:38 INFO - manifestparser == 1.1 03:37:38 INFO - mozInstall == 1.12 03:37:38 INFO - mozcrash == 0.17 03:37:38 INFO - mozdebug == 0.1 03:37:38 INFO - mozdevice == 0.48 03:37:38 INFO - mozfile == 1.2 03:37:38 INFO - mozhttpd == 0.7 03:37:38 INFO - mozinfo == 0.9 03:37:38 INFO - mozleak == 0.1 03:37:38 INFO - mozlog == 3.4 03:37:38 INFO - moznetwork == 0.27 03:37:38 INFO - mozprocess == 0.23 03:37:38 INFO - mozprofile == 0.28 03:37:38 INFO - mozrunner == 6.12 03:37:38 INFO - mozscreenshot == 0.1 03:37:38 INFO - mozsystemmonitor == 0.3 03:37:38 INFO - moztest == 0.7 03:37:38 INFO - mozversion == 1.4 03:37:38 INFO - psutil == 3.1.1 03:37:38 INFO - requests == 1.2.3 03:37:38 INFO - wsgiref == 0.1.2 03:37:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:38 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 0x7fa9d72bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, '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': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', '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:37:38 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:37:38 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:37:38 INFO - Using env: {'DISPLAY': ':0', 03:37:38 INFO - 'HOME': '/home/cltbld', 03:37:38 INFO - 'LANG': 'en_US.UTF-8', 03:37:38 INFO - 'LANGUAGE': 'en_US:en', 03:37:38 INFO - 'LOGNAME': 'cltbld', 03:37:38 INFO - 'MAIL': '/var/mail/cltbld', 03:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:38 INFO - 'MOZ_NO_REMOTE': '1', 03:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:38 INFO - 'NO_EM_RESTART': '1', 03:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:38 INFO - 'PWD': '/builds/slave/test', 03:37:38 INFO - 'SHELL': '/bin/bash', 03:37:38 INFO - 'SHLVL': '1', 03:37:38 INFO - 'TERM': 'linux', 03:37:38 INFO - 'TMOUT': '86400', 03:37:38 INFO - 'USER': 'cltbld', 03:37:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:38 INFO - '_': '/tools/buildbot/bin/python'} 03:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:38 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:37:38 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:37:38 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:37:38 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:37:38 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:37:38 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:37:38 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:37:38 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:37:38 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:37:38 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:37:38 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:37:38 INFO - Cleaning up... 03:37:38 INFO - Return code: 0 03:37:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:38 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 0x7fa9d72bef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2776ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, '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': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', '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:37:38 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:37:38 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:37:39 INFO - Using env: {'DISPLAY': ':0', 03:37:39 INFO - 'HOME': '/home/cltbld', 03:37:39 INFO - 'LANG': 'en_US.UTF-8', 03:37:39 INFO - 'LANGUAGE': 'en_US:en', 03:37:39 INFO - 'LOGNAME': 'cltbld', 03:37:39 INFO - 'MAIL': '/var/mail/cltbld', 03:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:39 INFO - 'MOZ_NO_REMOTE': '1', 03:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:39 INFO - 'NO_EM_RESTART': '1', 03:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:39 INFO - 'PWD': '/builds/slave/test', 03:37:39 INFO - 'SHELL': '/bin/bash', 03:37:39 INFO - 'SHLVL': '1', 03:37:39 INFO - 'TERM': 'linux', 03:37:39 INFO - 'TMOUT': '86400', 03:37:39 INFO - 'USER': 'cltbld', 03:37:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:39 INFO - '_': '/tools/buildbot/bin/python'} 03:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:37:39 INFO - Cleaning up... 03:37:39 INFO - Return code: 0 03:37:39 INFO - Running post-action listener: _resource_record_post_action 03:37:39 INFO - Running post-action listener: _start_resource_monitoring 03:37:39 INFO - Starting resource monitoring. 03:37:39 INFO - [mozharness: 2016-09-28 10:37:39.248573Z] Finished create-virtualenv step (success) 03:37:39 INFO - [mozharness: 2016-09-28 10:37:39.249068Z] Running install step. 03:37:39 INFO - Running pre-action listener: _resource_record_pre_action 03:37:39 INFO - Running main action method: install 03:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:39 INFO - Reading from file tmpfile_stdout 03:37:39 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:39 INFO - Reading from file tmpfile_stdout 03:37:39 INFO - Output received: 03:37:39 INFO - Usage: mozinstall [options] installer 03:37:39 INFO - Options: 03:37:39 INFO - -h, --help show this help message and exit 03:37:39 INFO - -d DEST, --destination=DEST 03:37:39 INFO - Directory to install application into. [default: 03:37:39 INFO - "/builds/slave/test"] 03:37:39 INFO - --app=APP Application being installed. [default: firefox] 03:37:39 INFO - mkdir: /builds/slave/test/build/application 03:37:39 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:37:39 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:37:55 INFO - Reading from file tmpfile_stdout 03:37:55 INFO - Output received: 03:37:55 INFO - /builds/slave/test/build/application/firefox/firefox 03:37:55 INFO - Running post-action listener: _resource_record_post_action 03:37:55 INFO - [mozharness: 2016-09-28 10:37:55.499544Z] Finished install step (success) 03:37:55 INFO - [mozharness: 2016-09-28 10:37:55.499786Z] Running run-tests step. 03:37:55 INFO - Running pre-action listener: _resource_record_pre_action 03:37:55 INFO - Running main action method: run_tests 03:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:55 INFO - Python 2.7.3 03:37:55 INFO - Return code: 0 03:37:55 INFO - grabbing minidump binary from tooltool 03:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:55 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 0x2773f60>, '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 0x2774d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27751d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:55 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:37:55 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:37:55 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:37:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:55 INFO - Return code: 0 03:37:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:37:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:37:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:55 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/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:37:55 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/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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:37:55 INFO - Using env: {'DISPLAY': ':0', 03:37:55 INFO - 'HOME': '/home/cltbld', 03:37:55 INFO - 'LANG': 'en_US.UTF-8', 03:37:55 INFO - 'LANGUAGE': 'en_US:en', 03:37:55 INFO - 'LOGNAME': 'cltbld', 03:37:55 INFO - 'MAIL': '/var/mail/cltbld', 03:37:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:55 INFO - 'MOZ_NO_REMOTE': '1', 03:37:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:55 INFO - 'NO_EM_RESTART': '1', 03:37:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:55 INFO - 'PWD': '/builds/slave/test', 03:37:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:55 INFO - 'SHELL': '/bin/bash', 03:37:55 INFO - 'SHLVL': '1', 03:37:55 INFO - 'TERM': 'linux', 03:37:55 INFO - 'TMOUT': '86400', 03:37:55 INFO - 'USER': 'cltbld', 03:37:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813', 03:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:55 INFO - '_': '/tools/buildbot/bin/python'} 03:37:55 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/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:37:55 INFO - mozversion application_buildid: 20160928004008 03:37:55 INFO - mozversion application_changeset: 3db11822d83f7a97cb882ec8338578f50b51a994 03:37:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:37:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:55 INFO - mozversion application_name: Firefox 03:37:55 INFO - mozversion application_remotingname: firefox-dev 03:37:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:37:55 INFO - mozversion application_vendor: Mozilla 03:37:55 INFO - mozversion application_version: 51.0a2 03:37:55 INFO - mozversion platform_buildid: 20160928004008 03:37:55 INFO - mozversion platform_changeset: 3db11822d83f7a97cb882ec8338578f50b51a994 03:37:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:37:55 INFO - mozversion platform_version: 51.0a2 03:37:55 INFO - using testdate: 1475059075 03:37:55 INFO - actual date: 1475059075 03:37:55 INFO - starting webserver on 'localhost:56403' 03:37:55 INFO - SUITE-START | Running 2 tests 03:37:55 INFO - TEST-START | dromaeo_css 03:37:55 INFO - operating with platform_type : linux_ 03:37:55 INFO - Initialising browser for dromaeo_css test... 03:37:55 INFO - TEST-INFO | started process 16490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUqsO35/profile http://localhost:56403/getInfo.html) 03:37:59 INFO - PROCESS | 16490 | __metrics Screen width/height:1600/1200 03:37:59 INFO - PROCESS | 16490 | colorDepth:24 03:37:59 INFO - PROCESS | 16490 | Browser inner width/height: 1024/697 03:37:59 INFO - PROCESS | 16490 | __metrics 03:38:00 INFO - PROCESS | 16490 | 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:38:00 INFO - PROCESS | 16490 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:38:00 INFO - PROCESS | 16490 | console.error: PushService: 03:38:00 INFO - PROCESS | 16490 | stateChangeProcessEnqueue: Error transitioning state 03:38:00 INFO - PROCESS | 16490 | UnknownError 03:38:01 INFO - TEST-INFO | 16490: exit 0 03:38:01 INFO - Browser initialized. 03:38:01 INFO - Running cycle 1/1 for dromaeo_css test... 03:38:01 INFO - TEST-INFO | started process 16581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUqsO35/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:13 INFO - PROCESS | 16581 | RSS: Main: 144695296 03:38:13 INFO - PROCESS | 16581 | 03:39:04 INFO - PROCESS | 16581 | 1475059144259 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:41:13 INFO - PROCESS | 16581 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56403/tests/dromaeo/cssquery-ext.html) 03:41:14 INFO - PROCESS | 16581 | RSS: Main: 240697344 03:41:14 INFO - PROCESS | 16581 | 03:44:16 INFO - PROCESS | 16581 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-ext.html (next: http://localhost:56403/tests/dromaeo/cssquery-jquery.html) 03:44:17 INFO - PROCESS | 16581 | RSS: Main: 225529856 03:44:17 INFO - PROCESS | 16581 | 03:47:19 INFO - PROCESS | 16581 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56403/tests/dromaeo/cssquery-mootools.html) 03:47:19 INFO - PROCESS | 16581 | RSS: Main: 216965120 03:47:19 INFO - PROCESS | 16581 | 03:50:21 INFO - PROCESS | 16581 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56403/tests/dromaeo/cssquery-prototype.html) 03:50:22 INFO - PROCESS | 16581 | RSS: Main: 218304512 03:50:22 INFO - PROCESS | 16581 | 03:53:25 INFO - PROCESS | 16581 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56403/tests/dromaeo/cssquery-yui.html) 03:53:25 INFO - PROCESS | 16581 | RSS: Main: 176783360 03:53:25 INFO - PROCESS | 16581 | 03:56:28 INFO - PROCESS | 16581 | Cycle 1(1): loaded http://localhost:56403/tests/dromaeo/cssquery-yui.html (next: http://localhost:56403/tests/dromaeo/cssquery-dojo.html) 03:56:28 INFO - PROCESS | 16581 | RSS: Main: 261857280 03:56:28 INFO - PROCESS | 16581 | 03:56:28 INFO - PROCESS | 16581 | __start_tp_report 03:56:28 INFO - PROCESS | 16581 | _x_x_mozilla_page_load 03:56:28 INFO - PROCESS | 16581 | _x_x_mozilla_page_load_details 03:56:28 INFO - PROCESS | 16581 | |i|pagename|runs| 03:56:28 INFO - PROCESS | 16581 | |0;dojo.html;3077.4614442472566;3095.613048368954;3121.188490992343;3140.544621029949;3142.5914631097953;5480.561555075595;5575.330960284771;5601.60788744787;5607.803726869555;5615.943840561598;5508.614396992212;5580.832575022746;5588.944110558893;5590.804321848736;5594.748236329365;5092.363454568188;5120.820771273006;5152.562032227246;5202.713850738208;5214.687118772867;5047.621428392867;5164.431912489623;5220.112580861262;5220.164773636219;5222.686638801665;5025.773840177182;5034.672746271499;5050.267711181877;5069.087564238435;5088.974555127219;5113.667611605234;5201.1678131498775;5208.661437006583;5217.973910130463;5221.530062294374;5042.647014708972;5122.154844450662;5174.353205849269;5179.300794392747;5211.348581427322;5372.113601255788;5379.5427388671615;5428.538574221196;5432.1580155075635;5481.5340696040885;5775.537956963475;5788.82633520995;5791.131330300446;5855.677937713424;5871.853203669943;5911.852203694899;5913.05391137416;5913.674747888865;5924.081767326072;5924.526037916957;5362.65142765719;5405.702686352249;5453.018456677796;5480.424555421703;5500.7524661390335;6041.78853740117;6048.395160484004;6062.272527296753;6063;6063.211782468251;5805.651660900275;5806.912896306559;5808.30300363959;5809.041508151107;5814.418558144152;5698.7435565399655;5776.277965254343;5778.595498315078;5847.210626565445;5858.121281807763;5879.617824841372;5880.176775251468;5887.8233652990475;5888.352281249059;5905.202797622352;5833.620814647034;5879.412058794172;5887.234659494238;5890.734916928748;5917.201177840936;4474.552544745499;4479.910401791946;4525.434320709911;4557.361969324297;4578.519255478193;4046.2109888572036;4068.7762173080764;4087.5912408758886;4089;4106.753594784323;5623.606347555714;5631.690257035821;5636.549076073904;5639.661620302713;5640.689762063126;5757.65454072757;5811.767529298865;5816.534677225812;5930.169776231331;5934.8813023739285;5562.16567514876;5595.160725891067;5595.468430499096;5645.4072322405555;5652.85867853307;5138.665986710852;5143.8456846294675;5147.459516750762;5151.5363617274625;5176.611754118456;5880.676562789174;5988.790392336247;6114.480269177081;6136.079588061826;6138.0179171332375;5872.618279811799;5909.113632955091;5911.822645320647;6006.279246490449;6048.274207095001;6215.192025036717;6243.219597550306;6247.5001999840815;6254.8123556293385;6256.530760192913;5668.744906479136;5892.381299963442;5897.498712609477;5900.586958912835;5935.317438494629;5693.117566777156;5744.080947048619;5895.6462612241685;5937.584369094122;6029.457348838626;5821.79623713168;5860.472557469848;5864.824055278348;5867.970660146672;5869.354371019099;5847.649141051551;5854.824355269348;5861.6189947653265;5864.32560255576;5865.266841644794;5544.22380866687;5551.8889622208135;5693.3168019837885;5701.287339082614;5746.9712651436475;5875.882482350415;5876.147958546072;5876.676782776988;5880.500157486662;5904.793332233351;5492.313460817398;5722.942770572241;5727.6849773262875;5728.971355143198;5730.856728581819 03:56:28 INFO - PROCESS | 16581 | |1;ext.html;580.5210701171532;626.1359324132696;641.6599202422717;650.5088658063163;652.8270008447762;34189.65810341896;36767.81616091919;44594.777026114905;45243.32135017977;45555.31667024997;46546.767266163624;46948.765256173756;46951.29573056407;47014.29478557824;47031.52968470314;9337.813243735121;9505.14453699167;9505.762355941122;9509.04909509047;9510.762230944247;8577.39958202926;8758.912410875873;8762.737117886441;8996;9251.259899208047;10963.232573719843;11308.886911130907;11315.038221751161;11680.415979201049;11700;11219.719507012309;11238.438078096104;11284.661460156209;11302.717432064183;11318.490667919963;8430.4520206187;8633.223009929137;10704.036636702656;11106.555737770479;11174.832377514344;41365.79317103425;45304.3204351935;45385.31922021172;45398.319025214645;45440.54559454396;3833.4058220975794;3834.5015148030857;3914.393269043303;4150.522689890671;4326.221280169569;33767.324653506796;33893.83053084744;33910.11764000063;33921.83039084813;33937.32125357479;4414.470263568361;4415.050764085705;4425.645948324126;4432.401625780511;4454.57681520255;247642;247917;248337;248721;248735.75632121906;53888;55290.44709552934;59600.70199649061;62103.689481552305;62482.68758656178;59618;63538.68230658817;64110.679446602466;64219.357806422275;64225;17032.914835425992;17148.571285717706;17149.142542872807;17150.57123571896;17157;14224.28878556068;14363.138211707332;14363.928180359031;14370.56888293332;14370.856291436952;15228.390864365523;15551.22243887801;16335.591610209602;16723.662107031407;16915.661686766194;6156.846078848064;6291.653959032297;6413.583117097373;6420.101185833987;6439.871202575922;1058.5077938758513;1122.1920217443428;1130.2935665209245;1130.8739569609081;1168.415792103948;33117;33495.665043349254;33723.49414758781;33830.830845845616;33900.118489928136;1149.3621040322535;1160.7446361800392;1161.848959635242;1171.8066519024435;1184.9644510664693;17316.39392621252;17320.30718771235;17453.912730436266;17580.736288955675;17735.73396399055;540064;545232;545516;545996;547948;59665.701671492236;59836.401635983086;59950.70024649849;59970;60515.69742151261;1439.8560143985728;1457.227669335254;1459.5596732710617;1477.2392218007735;1481.8740407065304;31401.214969625944;32936.835315823264;33068;33279.66720332862;33400.498992514644;52553.47446525639;52914.73542632262;52943.73528132489;52998.73500632472;52999.73500132475;422347;423252;423670;424896;425119;43116.784416078975;43513.78243108764;44063.11873762443;44076.77961610172;44332;40319.59680403276;42937.5706242946;50123.24815127703;53098.469015309354;53766;42115;42523.36214956716;43072.60400800446;43073;44123.33814992842;44041.559584405026;44247.77876110599;44511;45230;45601.77199113983;41759.7912010438;41785.37321940234;41791.7910410446;41883.581164189185;41921;36346.63653363432;38798.80600596979;38889.80555097319;39000.414993774546;39174.09657468311;27892.721072789824;28140.71859281381;29252;29364.853175733984;29430.26424339323 03:56:28 INFO - PROCESS | 16581 | |2;jquery.html;417.94566706328175;420.7832966022497;422.8308676529389;431.9935200971985;443.0982949697366;19062.42812715619;19165.904170479127;20662.17351305948;20771.480712982182;20812.271570495035;19856.503587410323;20048.69926951097;20529.076191571377;20540.48648783781;20682.793172068275;5685.289338832646;6009.669468179249;6020.819375418744;6021.1570380146595;6031.065184896326;5791.247137872092;5922.851928701795;5967.075103358965;5973;5978.133170690269;5946.375630558794;5951.642901425928;5952.434518720715;5952.434518720715;5952.761889524414;5752.28096487939;5960.701964901759;5969.552283578727;6015.518758499309;6028.5478589106;5389.353277606673;5390.649607775482;5405.675659460445;5431.674099553999;5432.348118225838;23436.64845027326;23746.40633984147;23988.520229595484;23999.760002399926;24197;2476.7151777545632;2482.379405148713;2507.6865391826022;2533.3033415810614;2572.717001129874;15040.623984400478;15125.16811575363;15465.845341546554;15539.378424862993;15991.440299589574;1991.930282440122;1997.4107638246753;2021.0501064499808;2041.6631255842767;2125.064971412589;80029.59985200036;81700.59149704273;82551;82618;86735.56632216861;10854.891451085547;11146.665600032013;11151.72120696989;11233.269837460703;11424.200305978668;16076.839231607768;16116.597085072966;16151.353945842035;16158.676826463405;16169;8845.778855528662;8996.775080622905;9025.05236950124;9091.499967501719;9176;8842.646294148291;8864.822703545893;8868.201861832466;9097.636094556276;9117.088291170963;6767.526273160832;6805.4895882808;6899.482538809509;6905.343992320722;6928.480363972722;2009.6282187795305;2037.5517386175313;2049.6413127702594;2102.737157855268;2114.270576651053;964.262339310428;984.478226539935;1001.4892404873567;1015.4821041269006;1083.312096818526;20093;20353.185872565227;20685;21760.238391656218;21762.564748704935;1043.7547176413536;1047.1308813684623;1069.4652673663168;1081.9350838949688;1083.4853444613902;10092.495375231209;11725.589604363806;11736.823947640793;11778.175527712978;11849.644510664693;510136;518827;522262;526477;528060;68133.65933170401;73238;75997.86003209956;96337.51831240939;99287.50356248317;1038.553422028535;1068.796928583551;1104.4698544698429;1113.4599719136213;1119.8936101070385;18425.81574184241;18700.625987480445;18849.90575047116;18990.382219564348;19139.330123445612;39458.40812387874;41186.38220426636;46375;47136.29295560501;47441.762791187204;59213.703931480064;59951.400485996324;60025.699871500365;61156;61602.07596885961;8118.107008228972;8206.794830129294;8693.434926729742;8968.372213944962;9156.542172891195;12842.35788210567;13136.934315328363;13170.934145329213;13439.664008399868;13936.512222072179;11937.343446110548;12254;12285.815712764137;12465.93767031159;12682.873171268538;11985.101117416403;12133.393330333625;12325.260484370967;12503.374831258583;12557.43491542901;11971;12036.277823330629;12180.695482613006;12228.816567751668;12382.5666101686;9254.796876406024;9357.157855792739;9360.251179905456;9529.142377186086;9778.85331720039;9496.43021418717;11935.880641193477;12316.384180791103;12440.37798110109;12506.312152831682 03:56:28 INFO - PROCESS | 16581 | |3;mootools.html;1546.3350759173552;1587.0001898803753;1741.1729428521453;1838.319821665983;1844.0687452836316;8750;9418.952905235472;9419;9430.481323527203;9440.386374885627;8241.83516329673;8523.659053637863;8827;9153.359264851462;9161.358704890661;2473.6413220083123;2488.6142647889515;2496.3759060234943;2502.049221295905;2507.9373015674573;2067.214458505766;2431.4043059450373;2508.8745562721883;2516.9119080832174;2520.332111990324;2086.7287252657134;2428.514297140579;2476.761619190405;2480.119557557068;2495.3761559610098;2427.3324835670155;2444.498877730061;2445.0586524188225;2456.3736247257016;2459.2622213335926;2397.6883005209384;2400.50789588134;2401.2916189724074;2408.915687950931;2422.370183752237;9435.103665151799;9512.619495220182;9520.476373799438;9523.28575356851;9530.18993385563;5239.449857764918;5429.538489228381;5430.076886929192;5433.375161856358;5442.564594832404;3449;3520.2959408118477;3582.265635544707;3610.295992281506;3635.781853088823;1117.8490903728054;1142.737170450801;1147.1854982962107;1165.35905252111;1166.8658104318026;13396.732065358638;13520.053596248266;13534.661633459144;13582.185068895898;13621.182729036389;4791.736454494967;4792.257200133985;4887.902241955141;4986.576141028053;5004.149294619923;11361.602343917923;11363.602273920373;11364.715882102848;11365.715857103638;11373.715657108638;5507.173923911365;5544.112941929272;5544.91682624761;5546.251256080377;5548.5838562108;4952.257161425815;5002.099622068063;5026.2460630904925;5077.746112694351;5105.566026887756;4178.463922749098;4181.853635122756;4266.87199384019;4304.139172165579;4305.827766889352;1196.6051203102954;1239;1317.9341032948505;1349.352310890778;1366.3919555797575;867.0765634599131;867.9913200868036;887.8845750052452;892.5983307511646;902.9232515236279;5928.9407105928385;5995.61028533144;6012.068129439944;6012.909806352908;6161.537884658668;941.3081385181886;960.9855852162223;978.1294647763497;992.5979978108877;1037.0355569320604;4180.979095104505;4205.11692544563;4260.339647354665;4261.595148460891;4305.5048669402795;11853.940730296294;11933.403329833647;12060.819087713691;12084.214526055779;12090;11214.831777523344;11696.88303116958;11708;11922.582709605296;11931.522739090338;8652.178043085896;8848.1151884811;8856.424332418372;8869.64521419136;8872.600732967032;6005;6005.849853753516;6141.907871382022;6172.105044768573;6201.81394558164;10864.674059778219;11043.171762117712;11046.668599942015;11171.497282622464;11197.832032519356;11059.391733454737;11074.062039142957;11347.716307092389;11414.029807466459;11457.828132578185;8532.360072994426;8605.612747426256;8612.78468038279;8613.82772344537;8621.827563448822;8439.746807595782;8682.652693892174;8707.042225355079;9154.221891139328;9217.723468295962;7079.327463890922;7885.960570197112;7996.04047514302;8030.83938321242;8266.090730019572;7719.614019299125;7949.562774047483;7986.401019923413;7996.24035716606;8187.672493100447;7203.675834587351;7222.96388518054;7283.635818209174;7305.232950540117;7312.41500679955;4894.730789806595;5054.924176137288;5069.645124841226;5218.4259731430275;5271.630985830955;5120.462351453044;5163.380394352702;5202.375714914235;5283.4452382499285;5318.335208098988 03:56:28 INFO - PROCESS | 16581 | |4;prototype.html;336.7524869221122;340.2667252071785;343.07027954243995;349.7936217631597;350.34310667498426;5337.813176538822;5515.751791169397;5555.138953462209;5590.720463976805;5592.356878958921;5260.973695131529;5388.461153884609;5421.156806685726;5432.83701488955;5440.510354068133;4300.8709738707885;4307.569243075699;4309.138172365524;4314.6332561732215;4339.980104675399;4272.65818734502;4343.630791382736;4347.869563913072;4355.303151495761;4375.978120109395;4258.53156152823;4295.312749960007;4327.978360108195;4336.067745434731;4349.913001739963;4318.589733975283;4320.611144996934;4332.617060616648;4337.783110844445;4343.739375637472;3739.862493341251;3849.3840985442475;3875.418687196915;3875.709321800848;3876.391297611488;5321.388040375367;5338.733063346856;5353.892922141536;5374.193870919355;5377.838664840061;4959.231319145538;4962.131626965267;4964.627652926045;4977.477364876709;4978.850634480971;5518.834434966958;5746.454086861741;5772.971135144339;5810.012297909366;5819.185314056035;4188.4555007849085;4191.832326706928;4210.51579068408;4236.322188449864;4258.318669012974;5951.166836642873;5968.492678122365;5994.310654274771;6012.278526576839;6038.826022631805;4158.376243563429;4303.612674859278;4361.80371883266;4372.934405983913;4378.956210437918;4382.846600368972;4404.581564751344;4406.5593440655675;4410.470743510799;4420.535843736361;4969.18008528596;4987.950120498821;4992.500749924979;4994.051130285234;4995.750212489361;5594.964931487688;5759.107338362561;5824.650520968756;5844.240248767633;5876.118582212703;1422.7154569086224;1449.9637509062147;1467.3470305713854;1513.0392200952474;1522.4975757999835;1027.5119318323736;1048.1981284317503;1059.4914441068177;1068.038765111406;1073.5115522437272;5529.336479622471;5543.501084902297;5550.389457159709;5579.832605021775;5585.916211256835;5848.3274423441;5880.882382352329;5884.264466941632;5893.174955506232;5895.35151133375;5390.649607775482;5577.776888924398;5578.2748242728185;5661.971690141523;5694.775623241023;3140.4975203967256;3156.5738625285753;3158.921026974344;3164.9525257121163;3174.9682503175136;6089.8479511391015;6102.420270074336;6217.844553886189;6232.376762323732;6235.563510554309;6068.544859135583;6091.269047714214;6095;6098.54260930432;6106.603070800384;6179.856726505611;6210.534209934182;6210.813675589739;6215.10439316013;6225.875482490324;5637.548996080386;5938.970305148447;5967.850803729942;5978.8206353809455;5983.401659833982;5904.9704751475965;5908.822735317947;5914.112883067574;5915.704214789157;5936.1986131871645;5908.675022873783;6157.907631385622;6234.316734481755;6245.0328146633665;6252.718627661857;4152.1072969311745;4167.5832416758085;4206.768627725504;4219.966108303485;4241.4062031315025;5781.82654520365;5923.496502797138;6028.969855150696;6044.4915360126815;6044.667543285162;5693.202951586698;5717.828465146053;5821.253623912894;5840.795572154954;5855.092460668603;5778.682172480386;5808.576898659855;5825.970870145622;5835.854103647443;5850.7074646266665;5618.634788738719;5741.25363702716;5767.798127065533;5777.595568310346;5801.593888427769;5859.242227331869;5867.9413205867395;5881.235439392852;5886.175935368966;5889.204957330877;5606.18710286998;5617.483279514427;5692.886142277049;5738.626989245686;5760.683162425939 03:56:28 INFO - PROCESS | 16581 | |5;yui.html;768.2049079203025;785.5757890739;794.610640786015;801.5551368990211;803.5580430763079;16324;17112.144392780374;17320.22059007343;17321.826781732194;17978;14844.406223751064;15122.092674439515;15130.243487825592;15138.848611513882;15143.924280378611;705.6612825843598;706.5442789400834;829.9875501867476;834.724540901504;855.0893298636963;846.0439703135448;855.3542075732844;870.1646419437348;870.5386145342947;873.0832625742976;914.2548822709504;914.4467597103757;915.1443400420595;915.5102020419077;915.6886658536097;731.9048523691939;908.8909330880336;910.2945217456491;910.3581974707848;910.7222297199352;553.9806106786243;647.2394935950286;654.326044174501;666.5600703535691;669.3406994110796;16490.83509164905;16574.254158562773;16577.66844663112;16597.751033734505;16614.418495352606;14284.285785710777;14527.85472145286;14667.853321466862;14804.259787010606;14838.33227504754;13284.933575332157;13294.534691285855;13768.586942391745;13970.511032113827;14297.28432588096;4618.95381046192;4684.742339171345;4770.0936822003705;4785.042991401699;4791.47293797682;92889.07110928872;95625.52187239019;95718.52140739321;95853.9999999993;95892.52053739756;11165.83251251232;11226.775464490827;11423.543058277575;12526.874731252754;12708.809367859489;22577.322680319616;22611.321660350215;22636.207732729275;22682.206122785952;22721.431964200696;8743.562821859008;8804.779880503038;8844.73465796027;8910.86633700495;9041.954790226007;4927.975360123248;5099.464556221544;5132.127538318495;5147.536721695065;5195.038917800219;3632.1282892105705;3799.2781371539318;3802.1445174835994;3807.8667246646232;4067.2882245607493;711.3739908880256;716.1299021688674;721.2210812322679;735.4557627355825;746.1270313732946;711.9608421536865;736.9336759691654;772.4091070331201;779.2441331908041;820.4175233275282;9665.806683866283;9798.412095274307;9817.558209880572;9859.211263098934;9869.21046316293;657.7927952694886;661.4377778887907;691.5332150798191;759.5328872743333;783.5690370296314;4583.564561366665;4880.121578115903;4958.41330774156;4958.899346859697;5013.874653133628;122319;127811;131300;131490.34254828666;133093;111276.44361778139;114436.42781786037;114565;114602;118378.40810796063;96028.51985740167;97186;98293.5085324583;99777;102347;9156.862647060432;9162.129597688208;9207.953960230156;9313.767155821159;9423.717288481357;52487.73756131348;56332.73711954043;57661.13508297463;58544;59142.70428647829;52859.471405287;53325;53916;58259.70870145622;82439.5878020606;12966.481340746264;14256.572302830931;14344.85655143477;14404.495842645458;14835.480758173411;15516.301766420313;15811.841881581036;15993.760093598372;15998.9200053999;16218.270177841789;14273.224043715847;14334.713305734036;14407.927960360132;14828.925855370655;14833.110013399231;15509.379624814881;15565.299561519532;16204.918975405048;16260.918695406921;16726.58183545421;13996.930015349859;14084.436622535393;15188.46840360582;15202.467913623412;15232.619184520032;12028.63914082579;12407.813882791947;12513.43689533955;12782.169159005007;13596.168017685774;10678.8398174029;11292.887071129184;12443.751124977269;12781.105322627327;13167.078304518593 03:56:28 INFO - PROCESS | 16581 | __end_tp_report 03:56:28 INFO - PROCESS | 16581 | __start_cc_report 03:56:28 INFO - PROCESS | 16581 | _x_x_mozilla_cycle_collect,811 03:56:28 INFO - PROCESS | 16581 | __end_cc_report 03:56:28 INFO - PROCESS | 16581 | __startTimestamp1475060188711__endTimestamp 03:56:28 INFO - PROCESS | 16581 | 03:56:28 INFO - PROCESS | 16581 | ------- Summary: start ------- 03:56:28 INFO - PROCESS | 16581 | Number of tests: 6 03:56:28 INFO - PROCESS | 16581 | 03:56:28 INFO - PROCESS | 16581 | [#0] dojo.html Cycles:165 Average:5507.50 Median:5701.29 stddev:617.81 (10.8%) stddev-sans-first:589.56 03:56:28 INFO - PROCESS | 16581 | Values: 3077.5 3095.6 3121.2 3140.5 3142.6 5480.6 5575.3 5601.6 5607.8 5615.9 5508.6 5580.8 5588.9 5590.8 5594.7 5092.4 5120.8 5152.6 5202.7 5214.7 5047.6 5164.4 5220.1 5220.2 5222.7 5025.8 5034.7 5050.3 5069.1 5089.0 5113.7 5201.2 5208.7 5218.0 5221.5 5042.6 5122.2 5174.4 5179.3 5211.3 5372.1 5379.5 5428.5 5432.2 5481.5 5775.5 5788.8 5791.1 5855.7 5871.9 5911.9 5913.1 5913.7 5924.1 5924.5 5362.7 5405.7 5453.0 5480.4 5500.8 6041.8 6048.4 6062.3 6063.0 6063.2 5805.7 5806.9 5808.3 5809.0 5814.4 5698.7 5776.3 5778.6 5847.2 5858.1 5879.6 5880.2 5887.8 5888.4 5905.2 5833.6 5879.4 5887.2 5890.7 5917.2 4474.6 4479.9 4525.4 4557.4 4578.5 4046.2 4068.8 4087.6 4089.0 4106.8 5623.6 5631.7 5636.5 5639.7 5640.7 5757.7 5811.8 5816.5 5930.2 5934.9 5562.2 5595.2 5595.5 5645.4 5652.9 5138.7 5143.8 5147.5 5151.5 5176.6 5880.7 5988.8 6114.5 6136.1 6138.0 5872.6 5909.1 5911.8 6006.3 6048.3 6215.2 6243.2 6247.5 6254.8 6256.5 5668.7 5892.4 5897.5 5900.6 5935.3 5693.1 5744.1 5895.6 5937.6 6029.5 5821.8 5860.5 5864.8 5868.0 5869.4 5847.6 5854.8 5861.6 5864.3 5865.3 5544.2 5551.9 5693.3 5701.3 5747.0 5875.9 5876.1 5876.7 5880.5 5904.8 5492.3 5722.9 5727.7 5729.0 5730.9 03:56:28 INFO - PROCESS | 16581 | 03:56:28 INFO - PROCESS | 16581 | [#1] ext.html Cycles:180 Average:58577.09 Median:42018.00 stddev:112326.75 (267.3%) stddev-sans-first:112557.46 03:56:28 INFO - PROCESS | 16581 | Values: 580.5 626.1 641.7 650.5 652.8 34189.7 36767.8 44594.8 45243.3 45555.3 46546.8 46948.8 46951.3 47014.3 47031.5 9337.8 9505.1 9505.8 9509.0 9510.8 8577.4 8758.9 8762.7 8996.0 9251.3 10963.2 11308.9 11315.0 11680.4 11700.0 11219.7 11238.4 11284.7 11302.7 11318.5 8430.5 8633.2 10704.0 11106.6 11174.8 41365.8 45304.3 45385.3 45398.3 45440.5 3833.4 3834.5 3914.4 4150.5 4326.2 33767.3 33893.8 33910.1 33921.8 33937.3 4414.5 4415.1 4425.6 4432.4 4454.6 247642.0 247917.0 248337.0 248721.0 248735.8 53888.0 55290.4 59600.7 62103.7 62482.7 59618.0 63538.7 64110.7 64219.4 64225.0 17032.9 17148.6 17149.1 17150.6 17157.0 14224.3 14363.1 14363.9 14370.6 14370.9 15228.4 15551.2 16335.6 16723.7 16915.7 6156.8 6291.7 6413.6 6420.1 6439.9 1058.5 1122.2 1130.3 1130.9 1168.4 33117.0 33495.7 33723.5 33830.8 33900.1 1149.4 1160.7 1161.8 1171.8 1185.0 17316.4 17320.3 17453.9 17580.7 17735.7 540064.0 545232.0 545516.0 545996.0 547948.0 59665.7 59836.4 59950.7 59970.0 60515.7 1439.9 1457.2 1459.6 1477.2 1481.9 31401.2 32936.8 33068.0 33279.7 33400.5 52553.5 52914.7 52943.7 52998.7 52999.7 422347.0 423252.0 423670.0 424896.0 425119.0 43116.8 43513.8 44063.1 44076.8 44332.0 40319.6 42937.6 50123.2 53098.5 53766.0 42115.0 42523.4 43072.6 43073.0 44123.3 44041.6 44247.8 44511.0 45230.0 45601.8 41759.8 41785.4 41791.8 41883.6 41921.0 36346.6 38798.8 38889.8 39000.4 39174.1 27892.7 28140.7 29252.0 29364.9 29430.3 03:56:28 INFO - PROCESS | 16581 | 03:56:28 INFO - PROCESS | 16581 | [#2] jquery.html Cycles:180 Average:30376.59 Median:24098.38 stddev:85571.10 (355.1%) stddev-sans-first:85781.59 03:56:28 INFO - PROCESS | 16581 | Values: 417.9 420.8 422.8 432.0 443.1 19062.4 19165.9 20662.2 20771.5 20812.3 19856.5 20048.7 20529.1 20540.5 20682.8 5685.3 6009.7 6020.8 6021.2 6031.1 5791.2 5922.9 5967.1 5973.0 5978.1 5946.4 5951.6 5952.4 5952.4 5952.8 5752.3 5960.7 5969.6 6015.5 6028.5 5389.4 5390.6 5405.7 5431.7 5432.3 23436.6 23746.4 23988.5 23999.8 24197.0 2476.7 2482.4 2507.7 2533.3 2572.7 15040.6 15125.2 15465.8 15539.4 15991.4 1991.9 1997.4 2021.1 2041.7 2125.1 80029.6 81700.6 82551.0 82618.0 86735.6 10854.9 11146.7 11151.7 11233.3 11424.2 16076.8 16116.6 16151.4 16158.7 16169.0 8845.8 8996.8 9025.1 9091.5 9176.0 8842.6 8864.8 8868.2 9097.6 9117.1 6767.5 6805.5 6899.5 6905.3 6928.5 2009.6 2037.6 2049.6 2102.7 2114.3 964.3 984.5 1001.5 1015.5 1083.3 20093.0 20353.2 20685.0 21760.2 21762.6 1043.8 1047.1 1069.5 1081.9 1083.5 10092.5 11725.6 11736.8 11778.2 11849.6 510136.0 518827.0 522262.0 526477.0 528060.0 68133.7 73238.0 75997.9 96337.5 99287.5 1038.6 1068.8 1104.5 1113.5 1119.9 18425.8 18700.6 18849.9 18990.4 19139.3 39458.4 41186.4 46375.0 47136.3 47441.8 59213.7 59951.4 60025.7 61156.0 61602.1 8118.1 8206.8 8693.4 8968.4 9156.5 12842.4 13136.9 13170.9 13439.7 13936.5 11937.3 12254.0 12285.8 12465.9 12682.9 11985.1 12133.4 12325.3 12503.4 12557.4 11971.0 12036.3 12180.7 12228.8 12382.6 9254.8 9357.2 9360.3 9529.1 9778.9 9496.4 11935.9 12316.4 12440.4 12506.3 03:56:28 INFO - PROCESS | 16581 | 03:56:28 INFO - PROCESS | 16581 | [#3] mootools.html Cycles:180 Average:6149.29 Median:4969.42 stddev:3605.39 (72.6%) stddev-sans-first:3598.92 03:56:28 INFO - PROCESS | 16581 | Values: 1546.3 1587.0 1741.2 1838.3 1844.1 8750.0 9419.0 9419.0 9430.5 9440.4 8241.8 8523.7 8827.0 9153.4 9161.4 2473.6 2488.6 2496.4 2502.0 2507.9 2067.2 2431.4 2508.9 2516.9 2520.3 2086.7 2428.5 2476.8 2480.1 2495.4 2427.3 2444.5 2445.1 2456.4 2459.3 2397.7 2400.5 2401.3 2408.9 2422.4 9435.1 9512.6 9520.5 9523.3 9530.2 5239.4 5429.5 5430.1 5433.4 5442.6 3449.0 3520.3 3582.3 3610.3 3635.8 1117.8 1142.7 1147.2 1165.4 1166.9 13396.7 13520.1 13534.7 13582.2 13621.2 4791.7 4792.3 4887.9 4986.6 5004.1 11361.6 11363.6 11364.7 11365.7 11373.7 5507.2 5544.1 5544.9 5546.3 5548.6 4952.3 5002.1 5026.2 5077.7 5105.6 4178.5 4181.9 4266.9 4304.1 4305.8 1196.6 1239.0 1317.9 1349.4 1366.4 867.1 868.0 887.9 892.6 902.9 5928.9 5995.6 6012.1 6012.9 6161.5 941.3 961.0 978.1 992.6 1037.0 4181.0 4205.1 4260.3 4261.6 4305.5 11853.9 11933.4 12060.8 12084.2 12090.0 11214.8 11696.9 11708.0 11922.6 11931.5 8652.2 8848.1 8856.4 8869.6 8872.6 6005.0 6005.8 6141.9 6172.1 6201.8 10864.7 11043.2 11046.7 11171.5 11197.8 11059.4 11074.1 11347.7 11414.0 11457.8 8532.4 8605.6 8612.8 8613.8 8621.8 8439.7 8682.7 8707.0 9154.2 9217.7 7079.3 7886.0 7996.0 8030.8 8266.1 7719.6 7949.6 7986.4 7996.2 8187.7 7203.7 7223.0 7283.6 7305.2 7312.4 4894.7 5054.9 5069.6 5218.4 5271.6 5120.5 5163.4 5202.4 5283.4 5318.3 03:56:28 INFO - PROCESS | 16581 | 03:56:28 INFO - PROCESS | 16581 | [#4] prototype.html Cycles:180 Average:4899.34 Median:5546.95 stddev:1429.89 (25.8%) stddev-sans-first:1392.29 03:56:28 INFO - PROCESS | 16581 | Values: 336.8 340.3 343.1 349.8 350.3 5337.8 5515.8 5555.1 5590.7 5592.4 5261.0 5388.5 5421.2 5432.8 5440.5 4300.9 4307.6 4309.1 4314.6 4340.0 4272.7 4343.6 4347.9 4355.3 4376.0 4258.5 4295.3 4328.0 4336.1 4349.9 4318.6 4320.6 4332.6 4337.8 4343.7 3739.9 3849.4 3875.4 3875.7 3876.4 5321.4 5338.7 5353.9 5374.2 5377.8 4959.2 4962.1 4964.6 4977.5 4978.9 5518.8 5746.5 5773.0 5810.0 5819.2 4188.5 4191.8 4210.5 4236.3 4258.3 5951.2 5968.5 5994.3 6012.3 6038.8 4158.4 4303.6 4361.8 4372.9 4379.0 4382.8 4404.6 4406.6 4410.5 4420.5 4969.2 4988.0 4992.5 4994.1 4995.8 5595.0 5759.1 5824.7 5844.2 5876.1 1422.7 1450.0 1467.3 1513.0 1522.5 1027.5 1048.2 1059.5 1068.0 1073.5 5529.3 5543.5 5550.4 5579.8 5585.9 5848.3 5880.9 5884.3 5893.2 5895.4 5390.6 5577.8 5578.3 5662.0 5694.8 3140.5 3156.6 3158.9 3165.0 3175.0 6089.8 6102.4 6217.8 6232.4 6235.6 6068.5 6091.3 6095.0 6098.5 6106.6 6179.9 6210.5 6210.8 6215.1 6225.9 5637.5 5939.0 5967.9 5978.8 5983.4 5905.0 5908.8 5914.1 5915.7 5936.2 5908.7 6157.9 6234.3 6245.0 6252.7 4152.1 4167.6 4206.8 4220.0 4241.4 5781.8 5923.5 6029.0 6044.5 6044.7 5693.2 5717.8 5821.3 5840.8 5855.1 5778.7 5808.6 5826.0 5835.9 5850.7 5618.6 5741.3 5767.8 5777.6 5801.6 5859.2 5867.9 5881.2 5886.2 5889.2 5606.2 5617.5 5692.9 5738.6 5760.7 03:56:28 INFO - PROCESS | 16581 | 03:56:28 INFO - PROCESS | 16581 | [#5] yui.html Cycles:180 Average:22780.39 Median:4788.26 stddev:33688.05 (703.6%) stddev-sans-first:33742.01 03:56:28 INFO - PROCESS | 16581 | Values: 768.2 785.6 794.6 801.6 803.6 16324.0 17112.1 17320.2 17321.8 17978.0 14844.4 15122.1 15130.2 15138.8 15143.9 705.7 706.5 830.0 834.7 855.1 846.0 855.4 870.2 870.5 873.1 914.3 914.4 915.1 915.5 915.7 731.9 908.9 910.3 910.4 910.7 554.0 647.2 654.3 666.6 669.3 16490.8 16574.3 16577.7 16597.8 16614.4 14284.3 14527.9 14667.9 14804.3 14838.3 13284.9 13294.5 13768.6 13970.5 14297.3 4619.0 4684.7 4770.1 4785.0 4791.5 92889.1 95625.5 95718.5 95854.0 95892.5 11165.8 11226.8 11423.5 12526.9 12708.8 22577.3 22611.3 22636.2 22682.2 22721.4 8743.6 8804.8 8844.7 8910.9 9042.0 4928.0 5099.5 5132.1 5147.5 5195.0 3632.1 3799.3 3802.1 3807.9 4067.3 711.4 716.1 721.2 735.5 746.1 712.0 736.9 772.4 779.2 820.4 9665.8 9798.4 9817.6 9859.2 9869.2 657.8 661.4 691.5 759.5 783.6 4583.6 4880.1 4958.4 4958.9 5013.9 122319.0 127811.0 131300.0 131490.3 133093.0 111276.4 114436.4 114565.0 114602.0 118378.4 96028.5 97186.0 98293.5 99777.0 102347.0 9156.9 9162.1 9208.0 9313.8 9423.7 52487.7 56332.7 57661.1 58544.0 59142.7 52859.5 53325.0 53916.0 58259.7 82439.6 12966.5 14256.6 14344.9 14404.5 14835.5 15516.3 15811.8 15993.8 15998.9 16218.3 14273.2 14334.7 14407.9 14828.9 14833.1 15509.4 15565.3 16204.9 16260.9 16726.6 13996.9 14084.4 15188.5 15202.5 15232.6 12028.6 12407.8 12513.4 12782.2 13596.2 10678.8 11292.9 12443.8 12781.1 13167.1 03:56:28 INFO - PROCESS | 16581 | -------- Summary: end -------- 03:56:28 INFO - PROCESS | 16581 | 03:56:29 INFO - TEST-INFO | 16581: exit 0 03:56:29 INFO - TEST-OK | dromaeo_css | took 1113701ms 03:56:29 INFO - TEST-START | kraken 03:56:29 INFO - operating with platform_type : linux_ 03:56:29 INFO - Initialising browser for kraken test... 03:56:29 INFO - TEST-INFO | started process 16899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpalbR4M/profile http://localhost:56403/getInfo.html) 03:56:33 INFO - PROCESS | 16899 | __metrics Screen width/height:1600/1200 03:56:33 INFO - PROCESS | 16899 | colorDepth:24 03:56:33 INFO - PROCESS | 16899 | Browser inner width/height: 1024/697 03:56:33 INFO - PROCESS | 16899 | __metrics 03:56:33 INFO - PROCESS | 16899 | 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:56:33 INFO - PROCESS | 16899 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:56:34 INFO - PROCESS | 16899 | console.error: PushService: 03:56:34 INFO - PROCESS | 16899 | stateChangeProcessEnqueue: Error transitioning state 03:56:34 INFO - PROCESS | 16899 | UnknownError 03:56:34 INFO - TEST-INFO | 16899: exit 0 03:56:34 INFO - Browser initialized. 03:56:34 INFO - Running cycle 1/1 for kraken test... 03:56:34 INFO - TEST-INFO | started process 16990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpalbR4M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:46 INFO - PROCESS | 16990 | RSS: Main: 144211968 03:56:46 INFO - PROCESS | 16990 | 03:56:49 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56403/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:50 INFO - PROCESS | 16990 | RSS: Main: 186273792 03:56:50 INFO - PROCESS | 16990 | 03:56:52 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56403/tests/kraken/driver.html?testName=audio-dft) 03:56:53 INFO - PROCESS | 16990 | RSS: Main: 175681536 03:56:53 INFO - PROCESS | 16990 | 03:56:56 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56403/tests/kraken/driver.html?testName=audio-fft) 03:56:56 INFO - PROCESS | 16990 | RSS: Main: 267165696 03:56:56 INFO - PROCESS | 16990 | 03:56:58 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56403/tests/kraken/driver.html?testName=audio-oscillator) 03:56:59 INFO - PROCESS | 16990 | RSS: Main: 173142016 03:56:59 INFO - PROCESS | 16990 | 03:57:01 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56403/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:02 INFO - PROCESS | 16990 | RSS: Main: 174632960 03:57:02 INFO - PROCESS | 16990 | 03:57:04 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56403/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:05 INFO - PROCESS | 16990 | RSS: Main: 210685952 03:57:05 INFO - PROCESS | 16990 | 03:57:08 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56403/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:09 INFO - PROCESS | 16990 | RSS: Main: 209780736 03:57:09 INFO - PROCESS | 16990 | 03:57:12 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56403/tests/kraken/driver.html?testName=json-parse-financial) 03:57:12 INFO - PROCESS | 16990 | RSS: Main: 209027072 03:57:12 INFO - PROCESS | 16990 | 03:57:14 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56403/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:14 INFO - PROCESS | 16990 | RSS: Main: 171012096 03:57:14 INFO - PROCESS | 16990 | 03:57:16 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:17 INFO - PROCESS | 16990 | RSS: Main: 179007488 03:57:17 INFO - PROCESS | 16990 | 03:57:19 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:19 INFO - PROCESS | 16990 | RSS: Main: 183316480 03:57:19 INFO - PROCESS | 16990 | 03:57:22 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:22 INFO - PROCESS | 16990 | RSS: Main: 184270848 03:57:22 INFO - PROCESS | 16990 | 03:57:25 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:26 INFO - PROCESS | 16990 | RSS: Main: 182091776 03:57:26 INFO - PROCESS | 16990 | 03:57:27 INFO - PROCESS | 16990 | Cycle 1(1): loaded http://localhost:56403/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56403/tests/kraken/driver.html?testName=ai-astar) 03:57:28 INFO - PROCESS | 16990 | RSS: Main: 234078208 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | __start_tp_report 03:57:28 INFO - PROCESS | 16990 | _x_x_mozilla_page_load 03:57:28 INFO - PROCESS | 16990 | _x_x_mozilla_page_load_details 03:57:28 INFO - PROCESS | 16990 | |i|pagename|runs| 03:57:28 INFO - PROCESS | 16990 | |0;ai-astar;112;112;110;111;110;112;110;110;111;111 03:57:28 INFO - PROCESS | 16990 | |1;audio-beat-detection;150;117;118;166;126;132;116;116;143;117 03:57:28 INFO - PROCESS | 16990 | |2;audio-dft;160;160;160;161;163;160;161;160;161;160 03:57:28 INFO - PROCESS | 16990 | |3;audio-fft;75;76;75;105;76;75;74;77;108;74 03:57:28 INFO - PROCESS | 16990 | |4;audio-oscillator;82;81;123;81;81;80;111;82;80;117 03:57:28 INFO - PROCESS | 16990 | |5;imaging-gaussian-blur;117;116;117;116;117;116;117;116;116;117 03:57:28 INFO - PROCESS | 16990 | |6;imaging-darkroom;146;147;145;146;147;146;146;146;145;146 03:57:28 INFO - PROCESS | 16990 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 03:57:28 INFO - PROCESS | 16990 | |8;json-parse-financial;50;48;49;47;48;50;49;48;49;48 03:57:28 INFO - PROCESS | 16990 | |9;json-stringify-tinderbox;60;60;60;59;60;59;59;60;59;59 03:57:28 INFO - PROCESS | 16990 | |10;stanford-crypto-aes;73;78;73;74;72;78;72;73;73;72 03:57:28 INFO - PROCESS | 16990 | |11;stanford-crypto-ccm;121;136;124;119;119;117;125;128;158;128 03:57:28 INFO - PROCESS | 16990 | |12;stanford-crypto-pbkdf2;149;155;150;152;152;149;149;149;150;150 03:57:28 INFO - PROCESS | 16990 | |13;stanford-crypto-sha256-iterative;61;62;63;61;61;61;62;62;61;60 03:57:28 INFO - PROCESS | 16990 | __end_tp_report 03:57:28 INFO - PROCESS | 16990 | __start_cc_report 03:57:28 INFO - PROCESS | 16990 | _x_x_mozilla_cycle_collect,1574 03:57:28 INFO - PROCESS | 16990 | __end_cc_report 03:57:28 INFO - PROCESS | 16990 | __startTimestamp1475060248015__endTimestamp 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | ------- Summary: start ------- 03:57:28 INFO - PROCESS | 16990 | Number of tests: 14 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:0.88 (0.8%) stddev-sans-first:0.83 03:57:28 INFO - PROCESS | 16990 | Values: 112.0 112.0 110.0 111.0 110.0 112.0 110.0 110.0 111.0 111.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#1] audio-beat-detection Cycles:10 Average:130.10 Median:129.00 stddev:17.51 (13.6%) stddev-sans-first:17.03 03:57:28 INFO - PROCESS | 16990 | Values: 150.0 117.0 118.0 166.0 126.0 132.0 116.0 116.0 143.0 117.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.00 03:57:28 INFO - PROCESS | 16990 | Values: 160.0 160.0 160.0 161.0 163.0 160.0 161.0 160.0 161.0 160.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:13.23 (17.6%) stddev-sans-first:13.82 03:57:28 INFO - PROCESS | 16990 | Values: 75.0 76.0 75.0 105.0 76.0 75.0 74.0 77.0 108.0 74.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:81.00 stddev:17.63 (21.8%) stddev-sans-first:18.34 03:57:28 INFO - PROCESS | 16990 | Values: 82.0 81.0 123.0 81.0 81.0 80.0 111.0 82.0 80.0 117.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:57:28 INFO - PROCESS | 16990 | Values: 117.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 117.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:57:28 INFO - PROCESS | 16990 | Values: 146.0 147.0 145.0 146.0 147.0 146.0 146.0 146.0 145.0 146.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 03:57:28 INFO - PROCESS | 16990 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#8] json-parse-financial Cycles:10 Average:48.60 Median:49.00 stddev:0.97 (2.0%) stddev-sans-first:0.88 03:57:28 INFO - PROCESS | 16990 | Values: 50.0 48.0 49.0 47.0 48.0 50.0 49.0 48.0 49.0 48.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 03:57:28 INFO - PROCESS | 16990 | Values: 60.0 60.0 60.0 59.0 60.0 59.0 59.0 60.0 59.0 59.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.00 stddev:2.30 (3.2%) stddev-sans-first:2.42 03:57:28 INFO - PROCESS | 16990 | Values: 73.0 78.0 73.0 74.0 72.0 78.0 72.0 73.0 73.0 72.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:126.50 stddev:12.10 (9.6%) stddev-sans-first:12.61 03:57:28 INFO - PROCESS | 16990 | Values: 121.0 136.0 124.0 119.0 119.0 117.0 125.0 128.0 158.0 128.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:150.00 stddev:1.96 (1.3%) stddev-sans-first:2.00 03:57:28 INFO - PROCESS | 16990 | Values: 149.0 155.0 150.0 152.0 152.0 149.0 149.0 149.0 150.0 150.0 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - PROCESS | 16990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 03:57:28 INFO - PROCESS | 16990 | Values: 61.0 62.0 63.0 61.0 61.0 61.0 62.0 62.0 61.0 60.0 03:57:28 INFO - PROCESS | 16990 | -------- Summary: end -------- 03:57:28 INFO - PROCESS | 16990 | 03:57:28 INFO - TEST-INFO | 16990: exit 0 03:57:29 INFO - TEST-OK | kraken | took 59557ms 03:57:29 INFO - SUITE-END | took 1173s 03:57:29 INFO - Completed test suite (00:19:33) 03:57:29 INFO - javascript benchmark 03:57:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.4614442472566, 3095.613048368954, 3121.188490992343, 3140.544621029949, 3142.5914631097953, 5480.561555075595, 5575.330960284771, 5601.60788744787, 5607.803726869555, 5615.943840561598, 5508.614396992212, 5580.832575022746, 5588.944110558893, 5590.804321848736, 5594.748236329365, 5092.363454568188, 5120.820771273006, 5152.562032227246, 5202.713850738208, 5214.687118772867, 5047.621428392867, 5164.431912489623, 5220.112580861262, 5220.164773636219, 5222.686638801665, 5025.773840177182, 5034.672746271499, 5050.267711181877, 5069.087564238435, 5088.974555127219, 5113.667611605234, 5201.1678131498775, 5208.661437006583, 5217.973910130463, 5221.530062294374, 5042.647014708972, 5122.154844450662, 5174.353205849269, 5179.300794392747, 5211.348581427322, 5372.113601255788, 5379.5427388671615, 5428.538574221196, 5432.1580155075635, 5481.5340696040885, 5775.537956963475, 5788.82633520995, 5791.131330300446, 5855.677937713424, 5871.853203669943, 5911.852203694899, 5913.05391137416, 5913.674747888865, 5924.081767326072, 5924.526037916957, 5362.65142765719, 5405.702686352249, 5453.018456677796, 5480.424555421703, 5500.7524661390335, 6041.78853740117, 6048.395160484004, 6062.272527296753, 6063.0, 6063.211782468251, 5805.651660900275, 5806.912896306559, 5808.30300363959, 5809.041508151107, 5814.418558144152, 5698.7435565399655, 5776.277965254343, 5778.595498315078, 5847.210626565445, 5858.121281807763, 5879.617824841372, 5880.176775251468, 5887.8233652990475, 5888.352281249059, 5905.202797622352, 5833.620814647034, 5879.412058794172, 5887.234659494238, 5890.734916928748, 5917.201177840936, 4474.552544745499, 4479.910401791946, 4525.434320709911, 4557.361969324297, 4578.519255478193, 4046.2109888572036, 4068.7762173080764, 4087.5912408758886, 4089.0, 4106.753594784323, 5623.606347555714, 5631.690257035821, 5636.549076073904, 5639.661620302713, 5640.689762063126, 5757.65454072757, 5811.767529298865, 5816.534677225812, 5930.169776231331, 5934.8813023739285, 5562.16567514876, 5595.160725891067, 5595.468430499096, 5645.4072322405555, 5652.85867853307, 5138.665986710852, 5143.8456846294675, 5147.459516750762, 5151.5363617274625, 5176.611754118456, 5880.676562789174, 5988.790392336247, 6114.480269177081, 6136.079588061826, 6138.0179171332375, 5872.618279811799, 5909.113632955091, 5911.822645320647, 6006.279246490449, 6048.274207095001, 6215.192025036717, 6243.219597550306, 6247.5001999840815, 6254.8123556293385, 6256.530760192913, 5668.744906479136, 5892.381299963442, 5897.498712609477, 5900.586958912835, 5935.317438494629, 5693.117566777156, 5744.080947048619, 5895.6462612241685, 5937.584369094122, 6029.457348838626, 5821.79623713168, 5860.472557469848, 5864.824055278348, 5867.970660146672, 5869.354371019099, 5847.649141051551, 5854.824355269348, 5861.6189947653265, 5864.32560255576, 5865.266841644794, 5544.22380866687, 5551.8889622208135, 5693.3168019837885, 5701.287339082614, 5746.9712651436475, 5875.882482350415, 5876.147958546072, 5876.676782776988, 5880.500157486662, 5904.793332233351, 5492.313460817398, 5722.942770572241, 5727.6849773262875, 5728.971355143198, 5730.856728581819], "value": 5465.359874323665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.5210701171532, 626.1359324132696, 641.6599202422717, 650.5088658063163, 652.8270008447762, 34189.65810341896, 36767.81616091919, 44594.777026114905, 45243.32135017977, 45555.31667024997, 46546.767266163624, 46948.765256173756, 46951.29573056407, 47014.29478557824, 47031.52968470314, 9337.813243735121, 9505.14453699167, 9505.762355941122, 9509.04909509047, 9510.762230944247, 8577.39958202926, 8758.912410875873, 8762.737117886441, 8996.0, 9251.259899208047, 10963.232573719843, 11308.886911130907, 11315.038221751161, 11680.415979201049, 11700.0, 11219.719507012309, 11238.438078096104, 11284.661460156209, 11302.717432064183, 11318.490667919963, 8430.4520206187, 8633.223009929137, 10704.036636702656, 11106.555737770479, 11174.832377514344, 41365.79317103425, 45304.3204351935, 45385.31922021172, 45398.319025214645, 45440.54559454396, 3833.4058220975794, 3834.5015148030857, 3914.393269043303, 4150.522689890671, 4326.221280169569, 33767.324653506796, 33893.83053084744, 33910.11764000063, 33921.83039084813, 33937.32125357479, 4414.470263568361, 4415.050764085705, 4425.645948324126, 4432.401625780511, 4454.57681520255, 247642.0, 247917.0, 248337.0, 248721.0, 248735.75632121906, 53888.0, 55290.44709552934, 59600.70199649061, 62103.689481552305, 62482.68758656178, 59618.0, 63538.68230658817, 64110.679446602466, 64219.357806422275, 64225.0, 17032.914835425992, 17148.571285717706, 17149.142542872807, 17150.57123571896, 17157.0, 14224.28878556068, 14363.138211707332, 14363.928180359031, 14370.56888293332, 14370.856291436952, 15228.390864365523, 15551.22243887801, 16335.591610209602, 16723.662107031407, 16915.661686766194, 6156.846078848064, 6291.653959032297, 6413.583117097373, 6420.101185833987, 6439.871202575922, 1058.5077938758513, 1122.1920217443428, 1130.2935665209245, 1130.8739569609081, 1168.415792103948, 33117.0, 33495.665043349254, 33723.49414758781, 33830.830845845616, 33900.118489928136, 1149.3621040322535, 1160.7446361800392, 1161.848959635242, 1171.8066519024435, 1184.9644510664693, 17316.39392621252, 17320.30718771235, 17453.912730436266, 17580.736288955675, 17735.73396399055, 540064.0, 545232.0, 545516.0, 545996.0, 547948.0, 59665.701671492236, 59836.401635983086, 59950.70024649849, 59970.0, 60515.69742151261, 1439.8560143985728, 1457.227669335254, 1459.5596732710617, 1477.2392218007735, 1481.8740407065304, 31401.214969625944, 32936.835315823264, 33068.0, 33279.66720332862, 33400.498992514644, 52553.47446525639, 52914.73542632262, 52943.73528132489, 52998.73500632472, 52999.73500132475, 422347.0, 423252.0, 423670.0, 424896.0, 425119.0, 43116.784416078975, 43513.78243108764, 44063.11873762443, 44076.77961610172, 44332.0, 40319.59680403276, 42937.5706242946, 50123.24815127703, 53098.469015309354, 53766.0, 42115.0, 42523.36214956716, 43072.60400800446, 43073.0, 44123.33814992842, 44041.559584405026, 44247.77876110599, 44511.0, 45230.0, 45601.77199113983, 41759.7912010438, 41785.37321940234, 41791.7910410446, 41883.581164189185, 41921.0, 36346.63653363432, 38798.80600596979, 38889.80555097319, 39000.414993774546, 39174.09657468311, 27892.721072789824, 28140.71859281381, 29252.0, 29364.853175733984, 29430.26424339323], "value": 21027.08082773312, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.94566706328175, 420.7832966022497, 422.8308676529389, 431.9935200971985, 443.0982949697366, 19062.42812715619, 19165.904170479127, 20662.17351305948, 20771.480712982182, 20812.271570495035, 19856.503587410323, 20048.69926951097, 20529.076191571377, 20540.48648783781, 20682.793172068275, 5685.289338832646, 6009.669468179249, 6020.819375418744, 6021.1570380146595, 6031.065184896326, 5791.247137872092, 5922.851928701795, 5967.075103358965, 5973.0, 5978.133170690269, 5946.375630558794, 5951.642901425928, 5952.434518720715, 5952.434518720715, 5952.761889524414, 5752.28096487939, 5960.701964901759, 5969.552283578727, 6015.518758499309, 6028.5478589106, 5389.353277606673, 5390.649607775482, 5405.675659460445, 5431.674099553999, 5432.348118225838, 23436.64845027326, 23746.40633984147, 23988.520229595484, 23999.760002399926, 24197.0, 2476.7151777545632, 2482.379405148713, 2507.6865391826022, 2533.3033415810614, 2572.717001129874, 15040.623984400478, 15125.16811575363, 15465.845341546554, 15539.378424862993, 15991.440299589574, 1991.930282440122, 1997.4107638246753, 2021.0501064499808, 2041.6631255842767, 2125.064971412589, 80029.59985200036, 81700.59149704273, 82551.0, 82618.0, 86735.56632216861, 10854.891451085547, 11146.665600032013, 11151.72120696989, 11233.269837460703, 11424.200305978668, 16076.839231607768, 16116.597085072966, 16151.353945842035, 16158.676826463405, 16169.0, 8845.778855528662, 8996.775080622905, 9025.05236950124, 9091.499967501719, 9176.0, 8842.646294148291, 8864.822703545893, 8868.201861832466, 9097.636094556276, 9117.088291170963, 6767.526273160832, 6805.4895882808, 6899.482538809509, 6905.343992320722, 6928.480363972722, 2009.6282187795305, 2037.5517386175313, 2049.6413127702594, 2102.737157855268, 2114.270576651053, 964.262339310428, 984.478226539935, 1001.4892404873567, 1015.4821041269006, 1083.312096818526, 20093.0, 20353.185872565227, 20685.0, 21760.238391656218, 21762.564748704935, 1043.7547176413536, 1047.1308813684623, 1069.4652673663168, 1081.9350838949688, 1083.4853444613902, 10092.495375231209, 11725.589604363806, 11736.823947640793, 11778.175527712978, 11849.644510664693, 510136.0, 518827.0, 522262.0, 526477.0, 528060.0, 68133.65933170401, 73238.0, 75997.86003209956, 96337.51831240939, 99287.50356248317, 1038.553422028535, 1068.796928583551, 1104.4698544698429, 1113.4599719136213, 1119.8936101070385, 18425.81574184241, 18700.625987480445, 18849.90575047116, 18990.382219564348, 19139.330123445612, 39458.40812387874, 41186.38220426636, 46375.0, 47136.29295560501, 47441.762791187204, 59213.703931480064, 59951.400485996324, 60025.699871500365, 61156.0, 61602.07596885961, 8118.107008228972, 8206.794830129294, 8693.434926729742, 8968.372213944962, 9156.542172891195, 12842.35788210567, 13136.934315328363, 13170.934145329213, 13439.664008399868, 13936.512222072179, 11937.343446110548, 12254.0, 12285.815712764137, 12465.93767031159, 12682.873171268538, 11985.101117416403, 12133.393330333625, 12325.260484370967, 12503.374831258583, 12557.43491542901, 11971.0, 12036.277823330629, 12180.695482613006, 12228.816567751668, 12382.5666101686, 9254.796876406024, 9357.157855792739, 9360.251179905456, 9529.142377186086, 9778.85331720039, 9496.43021418717, 11935.880641193477, 12316.384180791103, 12440.37798110109, 12506.312152831682], "value": 9832.568769806383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1546.3350759173552, 1587.0001898803753, 1741.1729428521453, 1838.319821665983, 1844.0687452836316, 8750.0, 9418.952905235472, 9419.0, 9430.481323527203, 9440.386374885627, 8241.83516329673, 8523.659053637863, 8827.0, 9153.359264851462, 9161.358704890661, 2473.6413220083123, 2488.6142647889515, 2496.3759060234943, 2502.049221295905, 2507.9373015674573, 2067.214458505766, 2431.4043059450373, 2508.8745562721883, 2516.9119080832174, 2520.332111990324, 2086.7287252657134, 2428.514297140579, 2476.761619190405, 2480.119557557068, 2495.3761559610098, 2427.3324835670155, 2444.498877730061, 2445.0586524188225, 2456.3736247257016, 2459.2622213335926, 2397.6883005209384, 2400.50789588134, 2401.2916189724074, 2408.915687950931, 2422.370183752237, 9435.103665151799, 9512.619495220182, 9520.476373799438, 9523.28575356851, 9530.18993385563, 5239.449857764918, 5429.538489228381, 5430.076886929192, 5433.375161856358, 5442.564594832404, 3449.0, 3520.2959408118477, 3582.265635544707, 3610.295992281506, 3635.781853088823, 1117.8490903728054, 1142.737170450801, 1147.1854982962107, 1165.35905252111, 1166.8658104318026, 13396.732065358638, 13520.053596248266, 13534.661633459144, 13582.185068895898, 13621.182729036389, 4791.736454494967, 4792.257200133985, 4887.902241955141, 4986.576141028053, 5004.149294619923, 11361.602343917923, 11363.602273920373, 11364.715882102848, 11365.715857103638, 11373.715657108638, 5507.173923911365, 5544.112941929272, 5544.91682624761, 5546.251256080377, 5548.5838562108, 4952.257161425815, 5002.099622068063, 5026.2460630904925, 5077.746112694351, 5105.566026887756, 4178.463922749098, 4181.853635122756, 4266.87199384019, 4304.139172165579, 4305.827766889352, 1196.6051203102954, 1239.0, 1317.9341032948505, 1349.352310890778, 1366.3919555797575, 867.0765634599131, 867.9913200868036, 887.8845750052452, 892.5983307511646, 902.9232515236279, 5928.9407105928385, 5995.61028533144, 6012.068129439944, 6012.909806352908, 6161.537884658668, 941.3081385181886, 960.9855852162223, 978.1294647763497, 992.5979978108877, 1037.0355569320604, 4180.979095104505, 4205.11692544563, 4260.339647354665, 4261.595148460891, 4305.5048669402795, 11853.940730296294, 11933.403329833647, 12060.819087713691, 12084.214526055779, 12090.0, 11214.831777523344, 11696.88303116958, 11708.0, 11922.582709605296, 11931.522739090338, 8652.178043085896, 8848.1151884811, 8856.424332418372, 8869.64521419136, 8872.600732967032, 6005.0, 6005.849853753516, 6141.907871382022, 6172.105044768573, 6201.81394558164, 10864.674059778219, 11043.171762117712, 11046.668599942015, 11171.497282622464, 11197.832032519356, 11059.391733454737, 11074.062039142957, 11347.716307092389, 11414.029807466459, 11457.828132578185, 8532.360072994426, 8605.612747426256, 8612.78468038279, 8613.82772344537, 8621.827563448822, 8439.746807595782, 8682.652693892174, 8707.042225355079, 9154.221891139328, 9217.723468295962, 7079.327463890922, 7885.960570197112, 7996.04047514302, 8030.83938321242, 8266.090730019572, 7719.614019299125, 7949.562774047483, 7986.401019923413, 7996.24035716606, 8187.672493100447, 7203.675834587351, 7222.96388518054, 7283.635818209174, 7305.232950540117, 7312.41500679955, 4894.730789806595, 5054.924176137288, 5069.645124841226, 5218.4259731430275, 5271.630985830955, 5120.462351453044, 5163.380394352702, 5202.375714914235, 5283.4452382499285, 5318.335208098988], "value": 4866.729525281616, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.7524869221122, 340.2667252071785, 343.07027954243995, 349.7936217631597, 350.34310667498426, 5337.813176538822, 5515.751791169397, 5555.138953462209, 5590.720463976805, 5592.356878958921, 5260.973695131529, 5388.461153884609, 5421.156806685726, 5432.83701488955, 5440.510354068133, 4300.8709738707885, 4307.569243075699, 4309.138172365524, 4314.6332561732215, 4339.980104675399, 4272.65818734502, 4343.630791382736, 4347.869563913072, 4355.303151495761, 4375.978120109395, 4258.53156152823, 4295.312749960007, 4327.978360108195, 4336.067745434731, 4349.913001739963, 4318.589733975283, 4320.611144996934, 4332.617060616648, 4337.783110844445, 4343.739375637472, 3739.862493341251, 3849.3840985442475, 3875.418687196915, 3875.709321800848, 3876.391297611488, 5321.388040375367, 5338.733063346856, 5353.892922141536, 5374.193870919355, 5377.838664840061, 4959.231319145538, 4962.131626965267, 4964.627652926045, 4977.477364876709, 4978.850634480971, 5518.834434966958, 5746.454086861741, 5772.971135144339, 5810.012297909366, 5819.185314056035, 4188.4555007849085, 4191.832326706928, 4210.51579068408, 4236.322188449864, 4258.318669012974, 5951.166836642873, 5968.492678122365, 5994.310654274771, 6012.278526576839, 6038.826022631805, 4158.376243563429, 4303.612674859278, 4361.80371883266, 4372.934405983913, 4378.956210437918, 4382.846600368972, 4404.581564751344, 4406.5593440655675, 4410.470743510799, 4420.535843736361, 4969.18008528596, 4987.950120498821, 4992.500749924979, 4994.051130285234, 4995.750212489361, 5594.964931487688, 5759.107338362561, 5824.650520968756, 5844.240248767633, 5876.118582212703, 1422.7154569086224, 1449.9637509062147, 1467.3470305713854, 1513.0392200952474, 1522.4975757999835, 1027.5119318323736, 1048.1981284317503, 1059.4914441068177, 1068.038765111406, 1073.5115522437272, 5529.336479622471, 5543.501084902297, 5550.389457159709, 5579.832605021775, 5585.916211256835, 5848.3274423441, 5880.882382352329, 5884.264466941632, 5893.174955506232, 5895.35151133375, 5390.649607775482, 5577.776888924398, 5578.2748242728185, 5661.971690141523, 5694.775623241023, 3140.4975203967256, 3156.5738625285753, 3158.921026974344, 3164.9525257121163, 3174.9682503175136, 6089.8479511391015, 6102.420270074336, 6217.844553886189, 6232.376762323732, 6235.563510554309, 6068.544859135583, 6091.269047714214, 6095.0, 6098.54260930432, 6106.603070800384, 6179.856726505611, 6210.534209934182, 6210.813675589739, 6215.10439316013, 6225.875482490324, 5637.548996080386, 5938.970305148447, 5967.850803729942, 5978.8206353809455, 5983.401659833982, 5904.9704751475965, 5908.822735317947, 5914.112883067574, 5915.704214789157, 5936.1986131871645, 5908.675022873783, 6157.907631385622, 6234.316734481755, 6245.0328146633665, 6252.718627661857, 4152.1072969311745, 4167.5832416758085, 4206.768627725504, 4219.966108303485, 4241.4062031315025, 5781.82654520365, 5923.496502797138, 6028.969855150696, 6044.4915360126815, 6044.667543285162, 5693.202951586698, 5717.828465146053, 5821.253623912894, 5840.795572154954, 5855.092460668603, 5778.682172480386, 5808.576898659855, 5825.970870145622, 5835.854103647443, 5850.7074646266665, 5618.634788738719, 5741.25363702716, 5767.798127065533, 5777.595568310346, 5801.593888427769, 5859.242227331869, 5867.9413205867395, 5881.235439392852, 5886.175935368966, 5889.204957330877, 5606.18710286998, 5617.483279514427, 5692.886142277049, 5738.626989245686, 5760.683162425939], "value": 4445.923211498053, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.2049079203025, 785.5757890739, 794.610640786015, 801.5551368990211, 803.5580430763079, 16324.0, 17112.144392780374, 17320.22059007343, 17321.826781732194, 17978.0, 14844.406223751064, 15122.092674439515, 15130.243487825592, 15138.848611513882, 15143.924280378611, 705.6612825843598, 706.5442789400834, 829.9875501867476, 834.724540901504, 855.0893298636963, 846.0439703135448, 855.3542075732844, 870.1646419437348, 870.5386145342947, 873.0832625742976, 914.2548822709504, 914.4467597103757, 915.1443400420595, 915.5102020419077, 915.6886658536097, 731.9048523691939, 908.8909330880336, 910.2945217456491, 910.3581974707848, 910.7222297199352, 553.9806106786243, 647.2394935950286, 654.326044174501, 666.5600703535691, 669.3406994110796, 16490.83509164905, 16574.254158562773, 16577.66844663112, 16597.751033734505, 16614.418495352606, 14284.285785710777, 14527.85472145286, 14667.853321466862, 14804.259787010606, 14838.33227504754, 13284.933575332157, 13294.534691285855, 13768.586942391745, 13970.511032113827, 14297.28432588096, 4618.95381046192, 4684.742339171345, 4770.0936822003705, 4785.042991401699, 4791.47293797682, 92889.07110928872, 95625.52187239019, 95718.52140739321, 95853.9999999993, 95892.52053739756, 11165.83251251232, 11226.775464490827, 11423.543058277575, 12526.874731252754, 12708.809367859489, 22577.322680319616, 22611.321660350215, 22636.207732729275, 22682.206122785952, 22721.431964200696, 8743.562821859008, 8804.779880503038, 8844.73465796027, 8910.86633700495, 9041.954790226007, 4927.975360123248, 5099.464556221544, 5132.127538318495, 5147.536721695065, 5195.038917800219, 3632.1282892105705, 3799.2781371539318, 3802.1445174835994, 3807.8667246646232, 4067.2882245607493, 711.3739908880256, 716.1299021688674, 721.2210812322679, 735.4557627355825, 746.1270313732946, 711.9608421536865, 736.9336759691654, 772.4091070331201, 779.2441331908041, 820.4175233275282, 9665.806683866283, 9798.412095274307, 9817.558209880572, 9859.211263098934, 9869.21046316293, 657.7927952694886, 661.4377778887907, 691.5332150798191, 759.5328872743333, 783.5690370296314, 4583.564561366665, 4880.121578115903, 4958.41330774156, 4958.899346859697, 5013.874653133628, 122319.0, 127811.0, 131300.0, 131490.34254828666, 133093.0, 111276.44361778139, 114436.42781786037, 114565.0, 114602.0, 118378.40810796063, 96028.51985740167, 97186.0, 98293.5085324583, 99777.0, 102347.0, 9156.862647060432, 9162.129597688208, 9207.953960230156, 9313.767155821159, 9423.717288481357, 52487.73756131348, 56332.73711954043, 57661.13508297463, 58544.0, 59142.70428647829, 52859.471405287, 53325.0, 53916.0, 58259.70870145622, 82439.5878020606, 12966.481340746264, 14256.572302830931, 14344.85655143477, 14404.495842645458, 14835.480758173411, 15516.301766420313, 15811.841881581036, 15993.760093598372, 15998.9200053999, 16218.270177841789, 14273.224043715847, 14334.713305734036, 14407.927960360132, 14828.925855370655, 14833.110013399231, 15509.379624814881, 15565.299561519532, 16204.918975405048, 16260.918695406921, 16726.58183545421, 13996.930015349859, 14084.436622535393, 15188.46840360582, 15202.467913623412, 15232.619184520032, 12028.63914082579, 12407.813882791947, 12513.43689533955, 12782.169159005007, 13596.168017685774, 10678.8398174029, 11292.887071129184, 12443.751124977269, 12781.105322627327, 13167.078304518593], "value": 8102.815976663866, "unit": "score"}], "name": "dromaeo_css", "value": 7635.261215963723, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 110.0, 111.0, 110.0, 112.0, 110.0, 110.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 118.0, 166.0, 126.0, 132.0, 116.0, 116.0, 143.0, 117.0], "value": 130.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 163.0, 160.0, 161.0, 160.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 105.0, 76.0, 75.0, 74.0, 77.0, 108.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 123.0, 81.0, 81.0, 80.0, 111.0, 82.0, 80.0, 117.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 49.0, 47.0, 48.0, 50.0, 49.0, 48.0, 49.0, 48.0], "value": 48.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 73.0, 74.0, 72.0, 78.0, 72.0, 73.0, 73.0, 72.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 136.0, 124.0, 119.0, 119.0, 117.0, 125.0, 128.0, 158.0, 128.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 155.0, 150.0, 152.0, 152.0, 149.0, 149.0, 149.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 60.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1453.6000000000001, "alertThreshold": 2.0}]} 03:57:29 INFO - Return code: 0 03:57:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:57:29 INFO - # TBPL SUCCESS # 03:57:29 INFO - Running post-action listener: _resource_record_post_action 03:57:29 INFO - [mozharness: 2016-09-28 10:57:29.339389Z] Finished run-tests step (success) 03:57:29 INFO - Running post-run listener: _resource_record_post_run 03:57:29 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 346955776; Read time: 8; Write time: 216028 03:57:29 INFO - TinderboxPrint: CPU usage
12.9% 03:57:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:57:29 INFO - TinderboxPrint: I/O write bytes / time
346,955,776 / 216,028 03:57:29 INFO - TinderboxPrint: CPU idle
8,264.4 (87.1%) 03:57:29 INFO - TinderboxPrint: CPU user
1,182.7 (12.5%) 03:57:29 INFO - TinderboxPrint: Swap in / out
0 / 0 03:57:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108068864; Read time: 0; Write time: 85840 03:57:29 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 238878720; Read time: 0; Write time: 130188 03:57:29 INFO - Running post-run listener: _upload_blobber_files 03:57:29 INFO - Blob upload gear active. 03:57:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:29 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:57:29 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:57:29 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:57:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:57:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:33 INFO - (blobuploader) - INFO - Done attempting. 03:57:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:57:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:57:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:34 INFO - (blobuploader) - INFO - Done attempting. 03:57:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:57:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:57:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:35 INFO - (blobuploader) - INFO - Done attempting. 03:57:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:35 INFO - Return code: 0 03:57:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff0d8d9119521d0bf80931c61547aac345d8e544a8f451e2efe4af7e34c471133209db6e628bfabf642fb007f296fb817db0cd19e4a09d785550403f46f21214", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf678cd924d1b8dbbe58cd22984afac0f2549edec28b6aa56c00975b1efc08de9f3363119023eac70a0dcf223d53eb270bb187a4d9d43469cca852b728cf0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d512c9d1e6278e74ae3e51272cd77f46ff12553a1fa5c832985e3b15215bc5868a7a673d289075b77ccfdbab6abe713ee9d883d8dc4e2acaed3388b78372dc98"} 03:57:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:35 INFO - Contents: 03:57:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff0d8d9119521d0bf80931c61547aac345d8e544a8f451e2efe4af7e34c471133209db6e628bfabf642fb007f296fb817db0cd19e4a09d785550403f46f21214", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf678cd924d1b8dbbe58cd22984afac0f2549edec28b6aa56c00975b1efc08de9f3363119023eac70a0dcf223d53eb270bb187a4d9d43469cca852b728cf0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d512c9d1e6278e74ae3e51272cd77f46ff12553a1fa5c832985e3b15215bc5868a7a673d289075b77ccfdbab6abe713ee9d883d8dc4e2acaed3388b78372dc98"} 03:57:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:35 INFO - Copying logs to upload dir... 03:57:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.344547 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-09-28 03:57:34.248534) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 03:57:34.251602) ========= 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=32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813 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/ff0d8d9119521d0bf80931c61547aac345d8e544a8f451e2efe4af7e34c471133209db6e628bfabf642fb007f296fb817db0cd19e4a09d785550403f46f21214", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf678cd924d1b8dbbe58cd22984afac0f2549edec28b6aa56c00975b1efc08de9f3363119023eac70a0dcf223d53eb270bb187a4d9d43469cca852b728cf0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d512c9d1e6278e74ae3e51272cd77f46ff12553a1fa5c832985e3b15215bc5868a7a673d289075b77ccfdbab6abe713ee9d883d8dc4e2acaed3388b78372dc98"} build_url:https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/fxTRiYe3R3uLIefcEk1Oew/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/ff0d8d9119521d0bf80931c61547aac345d8e544a8f451e2efe4af7e34c471133209db6e628bfabf642fb007f296fb817db0cd19e4a09d785550403f46f21214", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf678cd924d1b8dbbe58cd22984afac0f2549edec28b6aa56c00975b1efc08de9f3363119023eac70a0dcf223d53eb270bb187a4d9d43469cca852b728cf0e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d512c9d1e6278e74ae3e51272cd77f46ff12553a1fa5c832985e3b15215bc5868a7a673d289075b77ccfdbab6abe713ee9d883d8dc4e2acaed3388b78372dc98"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 03:57:34.282110) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 03:57:34.282456) ========= 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=32c5991c409366f7fec8a718000001d2-1475059020.26889-136611813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 03:57:34.364202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 03:57:34.364563) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 03:57:34.364875) ========= ========= Total master_lag: 0.18 =========