builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1476182415.15 results: success (0) buildid: 20161011004015 builduid: 493ec98de2734c049c659a825a86cd7f revision: 9a452e8fde0ffd76d25179f5d6165265444a2247 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:15.151776) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:15.152704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:15.153038) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:15.168307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:15.168599) ========= 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=1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 03:40:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-10-11 03:40:16 (214 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125771 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:15.311313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:15.312061) ========= 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=1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014234 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:15.366323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 03:40:15.367138) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a452e8fde0ffd76d25179f5d6165265444a2247 --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 9a452e8fde0ffd76d25179f5d6165265444a2247 --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=1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 03:40:16,521 truncating revision to first 12 chars 2016-10-11 03:40:16,521 Setting DEBUG logging. 2016-10-11 03:40:16,521 attempt 1/10 2016-10-11 03:40:16,521 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a452e8fde0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 03:40:17,931 unpacking tar archive at: mozilla-aurora-9a452e8fde0f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.752496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 03:40:17.134760) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:17.135133) ========= script_repo_revision: 9a452e8fde0ffd76d25179f5d6165265444a2247 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:17.135601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:17.135923) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 03:40:17.146781) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-11 03:40:17.147097) ========= /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=1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:40:18 INFO - MultiFileLogger online at 20161011 03:40:18 in /builds/slave/test 03:40:18 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:40:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:40:18 INFO - {'append_to_log': False, 03:40:18 INFO - 'base_work_dir': '/builds/slave/test', 03:40:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:40:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:40:18 INFO - 'branch': 'Mozilla-Aurora', 03:40:18 INFO - 'buildbot_json_path': 'buildprops.json', 03:40:18 INFO - 'config_files': ('talos/linux_config.py',), 03:40:18 INFO - 'default_actions': ('clobber', 03:40:18 INFO - 'read-buildbot-config', 03:40:18 INFO - 'download-and-extract', 03:40:18 INFO - 'populate-webroot', 03:40:18 INFO - 'create-virtualenv', 03:40:18 INFO - 'install', 03:40:18 INFO - 'run-tests'), 03:40:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:40:18 INFO - 'download_minidump_stackwalk': True, 03:40:18 INFO - 'download_symbols': 'ondemand', 03:40:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:40:18 INFO - 'tooltool.py': '/tools/tooltool.py', 03:40:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:40:18 INFO - '/tools/misc-python/virtualenv.py')}, 03:40:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:40:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:40:18 INFO - 'installer_path': 'installer.exe', 03:40:18 INFO - 'log_level': 'info', 03:40:18 INFO - 'log_name': 'talos', 03:40:18 INFO - 'log_to_console': True, 03:40:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:40:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:40:18 INFO - 'opt_config_files': (), 03:40:18 INFO - 'pip_index': False, 03:40:18 INFO - 'sps_profile': False, 03:40:18 INFO - 'sps_profile_interval': 0, 03:40:18 INFO - 'suite': 'dromaeojs', 03:40:18 INFO - 'system_bits': '32', 03:40:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:40:18 INFO - 'title': 'talos-linux64-ix-027', 03:40:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:40:18 INFO - 'use_talos_json': True, 03:40:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:40:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:40:18 INFO - 'work_dir': 'build'} 03:40:18 INFO - [mozharness: 2016-10-11 10:40:18.397503Z] Running clobber step. 03:40:18 INFO - Running pre-action listener: _resource_record_pre_action 03:40:18 INFO - Running main action method: clobber 03:40:18 INFO - rmtree: /builds/slave/test/build 03:40:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:40:19 INFO - Running post-action listener: _resource_record_post_action 03:40:19 INFO - [mozharness: 2016-10-11 10:40:19.395543Z] Finished clobber step (success) 03:40:19 INFO - [mozharness: 2016-10-11 10:40:19.395643Z] Running read-buildbot-config step. 03:40:19 INFO - Running pre-action listener: _resource_record_pre_action 03:40:19 INFO - Running main action method: read_buildbot_config 03:40:19 INFO - Using buildbot properties: 03:40:19 INFO - { 03:40:19 INFO - "project": "", 03:40:19 INFO - "product": "firefox", 03:40:19 INFO - "script_repo_revision": "production", 03:40:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:40:19 INFO - "repository": "", 03:40:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:40:19 INFO - "buildid": "20161011004015", 03:40:19 INFO - "stage_platform": "linux64-pgo", 03:40:19 INFO - "basedir": "/builds/slave/test", 03:40:19 INFO - "nightly_build": "True", 03:40:19 INFO - "buildnumber": 560, 03:40:19 INFO - "slavename": "talos-linux64-ix-027", 03:40:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:40:19 INFO - "platform": "ubuntu64_hw", 03:40:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:40:19 INFO - "branch": "mozilla-aurora", 03:40:19 INFO - "repo_path": "releases/mozilla-aurora", 03:40:19 INFO - "revision": "9a452e8fde0ffd76d25179f5d6165265444a2247", 03:40:19 INFO - "pgo_build": "True", 03:40:19 INFO - "builduid": "493ec98de2734c049c659a825a86cd7f", 03:40:19 INFO - "slavebuilddir": "test" 03:40:19 INFO - } 03:40:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 03:40:19 INFO - Running post-action listener: _resource_record_post_action 03:40:19 INFO - [mozharness: 2016-10-11 10:40:19.398188Z] Finished read-buildbot-config step (success) 03:40:19 INFO - [mozharness: 2016-10-11 10:40:19.398278Z] Running download-and-extract step. 03:40:19 INFO - Running pre-action listener: _resource_record_pre_action 03:40:19 INFO - Running main action method: download_and_extract 03:40:19 INFO - mkdir: /builds/slave/test/build/tests 03:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:19 INFO - trying https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:40:19 INFO - Downloading https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/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:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/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:40:19 INFO - Downloaded 1361 bytes. 03:40:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 03:40:19 INFO - Using the following test package requirements: 03:40:19 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:19 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:40:19 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:40:19 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:19 INFO - u'jsshell-linux-x86_64.zip'], 03:40:19 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:40:19 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 03:40:19 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:40:19 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:40:19 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:40:19 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 03:40:19 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:40:19 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:40:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:40:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:19 INFO - Fetch https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:40:20 INFO - Expected file size: 21907149 03:40:24 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:40:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 03:40:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:40:24 INFO - Fetch https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:40:25 INFO - Expected file size: 21907149 03:40:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 03:40:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:40:30 INFO - Fetch https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:40:30 INFO - Expected file size: 14414059 03:40: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:40:31 INFO - trying https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:40:31 INFO - Downloading https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/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:40:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/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:40:32 INFO - Downloaded 63952206 bytes. 03:40:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:40:32 INFO - mkdir: /builds/slave/test/properties 03:40:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:32 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:32 INFO - Contents: 03:40:32 INFO - build_url:https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 03:40:33 INFO - Running post-action listener: _resource_record_post_action 03:40:33 INFO - Running post-action listener: set_extra_try_arguments 03:40:33 INFO - [mozharness: 2016-10-11 10:40:33.675733Z] Finished download-and-extract step (success) 03:40:33 INFO - [mozharness: 2016-10-11 10:40:33.675960Z] Running populate-webroot step. 03:40:33 INFO - Running pre-action listener: _resource_record_pre_action 03:40:33 INFO - Running main action method: populate_webroot 03:40:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:33 INFO - '--tppagecycles', 03:40:33 INFO - '7'], 03:40:33 INFO - 'tests': ['tsvgm']}}, 03:40:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:40:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:40:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:33 INFO - 'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:33 INFO - 'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['damp', 'tps']}, 03:40:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:33 INFO - 'tests': ['damp', 'tps']}, 03:40:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['dromaeo_dom']}, 03:40:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['basic_compositor_video']}, 03:40:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:40:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['a11yr', 03:40:33 INFO - 'ts_paint', 03:40:33 INFO - 'tpaint', 03:40:33 INFO - 'sessionrestore', 03:40:33 INFO - 'sessionrestore_no_auto_restore', 03:40:33 INFO - 'tabpaint']}, 03:40:33 INFO - 'other-e10s': {'tests': ['a11yr', 03:40:33 INFO - 'ts_paint', 03:40:33 INFO - 'tpaint', 03:40:33 INFO - 'sessionrestore', 03:40:33 INFO - 'sessionrestore_no_auto_restore', 03:40:33 INFO - 'tabpaint']}, 03:40:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:40:33 INFO - 'ts_paint', 03:40:33 INFO - 'tpaint', 03:40:33 INFO - 'sessionrestore', 03:40:33 INFO - 'sessionrestore_no_auto_restore', 03:40:33 INFO - 'tabpaint']}, 03:40:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:40:33 INFO - 'ts_paint', 03:40:33 INFO - 'tpaint', 03:40:33 INFO - 'sessionrestore', 03:40:33 INFO - 'sessionrestore_no_auto_restore', 03:40:33 INFO - 'tabpaint']}, 03:40:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['a11yr', 03:40:33 INFO - 'ts_paint', 03:40:33 INFO - 'tpaint', 03:40:33 INFO - 'sessionrestore', 03:40:33 INFO - 'sessionrestore_no_auto_restore', 03:40:33 INFO - 'tabpaint']}, 03:40:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['a11yr', 03:40:33 INFO - 'ts_paint', 03:40:33 INFO - 'tpaint', 03:40:33 INFO - 'sessionrestore', 03:40:33 INFO - 'sessionrestore_no_auto_restore', 03:40:33 INFO - 'tabpaint']}, 03:40:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['tsvgx', 03:40:33 INFO - 'tsvgr_opacity', 03:40:33 INFO - 'tart', 03:40:33 INFO - 'tscrollx', 03:40:33 INFO - 'cart']}, 03:40:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:40:33 INFO - 'tsvgr_opacity', 03:40:33 INFO - 'tart', 03:40:33 INFO - 'tscrollx', 03:40:33 INFO - 'cart']}, 03:40:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:33 INFO - 'talos_options': ['--disable-e10s'], 03:40:33 INFO - 'tests': ['tp5o']}, 03:40:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:33 INFO - 'tests': ['tp5o']}, 03:40:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:33 INFO - 'talos_options': ['--disable-e10s', 03:40:33 INFO - '--xperf_path', 03:40:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:33 INFO - 'tests': ['tp5n']}, 03:40:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:33 INFO - 'talos_options': ['--xperf_path', 03:40:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:33 INFO - 'tests': ['tp5n']}}, 03:40:33 INFO - 'talos.zip': {'path': '', 03:40:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:33 INFO - Running post-action listener: _resource_record_post_action 03:40:33 INFO - [mozharness: 2016-10-11 10:40:33.692364Z] Finished populate-webroot step (success) 03:40:33 INFO - [mozharness: 2016-10-11 10:40:33.692453Z] Running create-virtualenv step. 03:40:33 INFO - Running pre-action listener: _resource_record_pre_action 03:40:33 INFO - Running main action method: create_virtualenv 03:40:33 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:33 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:40:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:33 INFO - Using real prefix '/usr' 03:40:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:36 INFO - Installing pip.................done. 03:40:36 INFO - Return code: 0 03:40:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40:36 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:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:36 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:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:36 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 0x7fabdde6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, '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': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', '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:40:36 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:40:36 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:40:36 INFO - Using env: {'DISPLAY': ':0', 03:40:36 INFO - 'HOME': '/home/cltbld', 03:40:36 INFO - 'LANG': 'en_US.UTF-8', 03:40:36 INFO - 'LANGUAGE': 'en_US:en', 03:40:36 INFO - 'LOGNAME': 'cltbld', 03:40:36 INFO - 'MAIL': '/var/mail/cltbld', 03:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:36 INFO - 'MOZ_NO_REMOTE': '1', 03:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:36 INFO - 'NO_EM_RESTART': '1', 03:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:36 INFO - 'PWD': '/builds/slave/test', 03:40:36 INFO - 'SHELL': '/bin/bash', 03:40:36 INFO - 'SHLVL': '1', 03:40:36 INFO - 'TERM': 'linux', 03:40:36 INFO - 'TMOUT': '86400', 03:40:36 INFO - 'USER': 'cltbld', 03:40:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:36 INFO - '_': '/tools/buildbot/bin/python'} 03:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:36 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:40:36 INFO - Cleaning up... 03:40:36 INFO - Return code: 0 03:40:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:40:36 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:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:36 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:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:36 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 0x7fabdde6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, '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': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', '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:40:36 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:40:36 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:40:36 INFO - Using env: {'DISPLAY': ':0', 03:40:36 INFO - 'HOME': '/home/cltbld', 03:40:36 INFO - 'LANG': 'en_US.UTF-8', 03:40:36 INFO - 'LANGUAGE': 'en_US:en', 03:40:36 INFO - 'LOGNAME': 'cltbld', 03:40:36 INFO - 'MAIL': '/var/mail/cltbld', 03:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:36 INFO - 'MOZ_NO_REMOTE': '1', 03:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:36 INFO - 'NO_EM_RESTART': '1', 03:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:36 INFO - 'PWD': '/builds/slave/test', 03:40:36 INFO - 'SHELL': '/bin/bash', 03:40:36 INFO - 'SHLVL': '1', 03:40:36 INFO - 'TERM': 'linux', 03:40:36 INFO - 'TMOUT': '86400', 03:40:36 INFO - 'USER': 'cltbld', 03:40:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:36 INFO - '_': '/tools/buildbot/bin/python'} 03:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:36 INFO - Downloading/unpacking psutil>=3.1.1 03:40: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:40: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:40: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:40: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:40: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:40: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:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:38 INFO - Installing collected packages: psutil 03:40:38 INFO - Running setup.py install for psutil 03:40:38 INFO - building 'psutil._psutil_linux' extension 03:40:38 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:40:38 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:40:39 INFO - building 'psutil._psutil_posix' extension 03:40:39 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:40:39 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:40:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:39 INFO - Successfully installed psutil 03:40:39 INFO - Cleaning up... 03:40:39 INFO - Return code: 0 03:40:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:40:39 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:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:39 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:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:39 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 0x7fabdde6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, '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': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', '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:40:39 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:40:39 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:40:39 INFO - Using env: {'DISPLAY': ':0', 03:40:39 INFO - 'HOME': '/home/cltbld', 03:40:39 INFO - 'LANG': 'en_US.UTF-8', 03:40:39 INFO - 'LANGUAGE': 'en_US:en', 03:40:39 INFO - 'LOGNAME': 'cltbld', 03:40:39 INFO - 'MAIL': '/var/mail/cltbld', 03:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:39 INFO - 'MOZ_NO_REMOTE': '1', 03:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:39 INFO - 'NO_EM_RESTART': '1', 03:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:39 INFO - 'PWD': '/builds/slave/test', 03:40:39 INFO - 'SHELL': '/bin/bash', 03:40:39 INFO - 'SHLVL': '1', 03:40:39 INFO - 'TERM': 'linux', 03:40:39 INFO - 'TMOUT': '86400', 03:40:39 INFO - 'USER': 'cltbld', 03:40:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:39 INFO - '_': '/tools/buildbot/bin/python'} 03:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:40:41 INFO - Installing collected packages: mozsystemmonitor 03:40:41 INFO - Running setup.py install for mozsystemmonitor 03:40:41 INFO - Successfully installed mozsystemmonitor 03:40:41 INFO - Cleaning up... 03:40:41 INFO - Return code: 0 03:40:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:40:41 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:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:41 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:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:41 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 0x7fabdde6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, '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': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', '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:40:41 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:40:41 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:40:41 INFO - Using env: {'DISPLAY': ':0', 03:40:41 INFO - 'HOME': '/home/cltbld', 03:40:41 INFO - 'LANG': 'en_US.UTF-8', 03:40:41 INFO - 'LANGUAGE': 'en_US:en', 03:40:41 INFO - 'LOGNAME': 'cltbld', 03:40:41 INFO - 'MAIL': '/var/mail/cltbld', 03:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:41 INFO - 'MOZ_NO_REMOTE': '1', 03:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:41 INFO - 'NO_EM_RESTART': '1', 03:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:41 INFO - 'PWD': '/builds/slave/test', 03:40:41 INFO - 'SHELL': '/bin/bash', 03:40:41 INFO - 'SHLVL': '1', 03:40:41 INFO - 'TERM': 'linux', 03:40:41 INFO - 'TMOUT': '86400', 03:40:41 INFO - 'USER': 'cltbld', 03:40:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:41 INFO - '_': '/tools/buildbot/bin/python'} 03:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:41 INFO - Downloading/unpacking jsonschema==2.5.1 03:40:41 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:40:41 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:40:41 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:40:41 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:40:41 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:40:41 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:40:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:40:43 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:40:43 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:40:43 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:40:43 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:40:43 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:40:43 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:40:43 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:44 INFO - warning: no files found matching '*.txt' 03:40:44 INFO - no previously-included directories found matching 'build' 03:40:44 INFO - no previously-included directories found matching 'dist' 03:40:44 INFO - no previously-included directories found matching '.git*' 03:40:44 INFO - Installing collected packages: jsonschema, functools32 03:40:44 INFO - Running setup.py install for functools32 03:40:44 INFO - warning: no files found matching '*.txt' 03:40:44 INFO - no previously-included directories found matching 'build' 03:40:44 INFO - no previously-included directories found matching 'dist' 03:40:44 INFO - no previously-included directories found matching '.git*' 03:40:44 INFO - Successfully installed jsonschema functools32 03:40:44 INFO - Cleaning up... 03:40:44 INFO - Return code: 0 03:40:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:40:44 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:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:44 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:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:44 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 0x7fabdde6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, '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': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', '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:40:44 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:40:44 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:40:44 INFO - Using env: {'DISPLAY': ':0', 03:40:44 INFO - 'HOME': '/home/cltbld', 03:40:44 INFO - 'LANG': 'en_US.UTF-8', 03:40:44 INFO - 'LANGUAGE': 'en_US:en', 03:40:44 INFO - 'LOGNAME': 'cltbld', 03:40:44 INFO - 'MAIL': '/var/mail/cltbld', 03:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:44 INFO - 'MOZ_NO_REMOTE': '1', 03:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:44 INFO - 'NO_EM_RESTART': '1', 03:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:44 INFO - 'PWD': '/builds/slave/test', 03:40:44 INFO - 'SHELL': '/bin/bash', 03:40:44 INFO - 'SHLVL': '1', 03:40:44 INFO - 'TERM': 'linux', 03:40:44 INFO - 'TMOUT': '86400', 03:40:44 INFO - 'USER': 'cltbld', 03:40:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:44 INFO - '_': '/tools/buildbot/bin/python'} 03:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:40:44 INFO - Cleaning up... 03:40:44 INFO - Return code: 0 03:40:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40:44 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:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:44 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:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:44 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 0x7fabdde6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, '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': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', '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:40:44 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:40:44 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:40:44 INFO - Using env: {'DISPLAY': ':0', 03:40:44 INFO - 'HOME': '/home/cltbld', 03:40:44 INFO - 'LANG': 'en_US.UTF-8', 03:40:44 INFO - 'LANGUAGE': 'en_US:en', 03:40:44 INFO - 'LOGNAME': 'cltbld', 03:40:44 INFO - 'MAIL': '/var/mail/cltbld', 03:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:44 INFO - 'MOZ_NO_REMOTE': '1', 03:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:44 INFO - 'NO_EM_RESTART': '1', 03:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:44 INFO - 'PWD': '/builds/slave/test', 03:40:44 INFO - 'SHELL': '/bin/bash', 03:40:44 INFO - 'SHLVL': '1', 03:40:44 INFO - 'TERM': 'linux', 03:40:44 INFO - 'TMOUT': '86400', 03:40:44 INFO - 'USER': 'cltbld', 03:40:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:44 INFO - '_': '/tools/buildbot/bin/python'} 03:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:44 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:44 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:40:44 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:40:44 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:40:44 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:40:44 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:40:44 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:40:46 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40:46 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:40:46 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:40:46 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:40:46 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:40:46 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:40:46 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:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40:47 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:40:47 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:40:47 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:40:47 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:40:47 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:40:47 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:40:47 INFO - Downloading docopt-0.6.1.tar.gz 03:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:47 INFO - Running setup.py install for blobuploader 03:40:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:47 INFO - Running setup.py install for requests 03:40:47 INFO - Running setup.py install for docopt 03:40:47 INFO - Successfully installed blobuploader requests docopt 03:40:47 INFO - Cleaning up... 03:40:47 INFO - Return code: 0 03:40:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:47 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 0x7fabdde6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, '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': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', '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:40:47 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:40:47 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:40:47 INFO - Using env: {'DISPLAY': ':0', 03:40:47 INFO - 'HOME': '/home/cltbld', 03:40:47 INFO - 'LANG': 'en_US.UTF-8', 03:40:47 INFO - 'LANGUAGE': 'en_US:en', 03:40:47 INFO - 'LOGNAME': 'cltbld', 03:40:47 INFO - 'MAIL': '/var/mail/cltbld', 03:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:47 INFO - 'MOZ_NO_REMOTE': '1', 03:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:47 INFO - 'NO_EM_RESTART': '1', 03:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:47 INFO - 'PWD': '/builds/slave/test', 03:40:47 INFO - 'SHELL': '/bin/bash', 03:40:47 INFO - 'SHLVL': '1', 03:40:47 INFO - 'TERM': 'linux', 03:40:47 INFO - 'TMOUT': '86400', 03:40:47 INFO - 'USER': 'cltbld', 03:40:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:47 INFO - '_': '/tools/buildbot/bin/python'} 03:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:48 INFO - Running setup.py (path:/tmp/pip-uC_oqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:48 INFO - Running setup.py (path:/tmp/pip-mvjgyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:48 INFO - Running setup.py (path:/tmp/pip-0NdMOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:48 INFO - Running setup.py (path:/tmp/pip-qSCYm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:48 INFO - Running setup.py (path:/tmp/pip-RH3CKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:48 INFO - Running setup.py (path:/tmp/pip-E5Nxxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:48 INFO - Running setup.py (path:/tmp/pip-poq9vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:48 INFO - Running setup.py (path:/tmp/pip-fokPLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:48 INFO - Running setup.py (path:/tmp/pip-xQTsdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:48 INFO - Running setup.py (path:/tmp/pip-40JUn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:48 INFO - Running setup.py (path:/tmp/pip-kEUdd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:48 INFO - Running setup.py (path:/tmp/pip-63TE_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:49 INFO - Running setup.py (path:/tmp/pip-2vkv2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:49 INFO - Running setup.py (path:/tmp/pip-6hEO6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:49 INFO - Running setup.py (path:/tmp/pip-0ZDQ60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:49 INFO - Running setup.py (path:/tmp/pip-SMvJcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:49 INFO - Running setup.py (path:/tmp/pip-xaY7oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:49 INFO - Running setup.py install for manifestparser 03:40:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:49 INFO - Running setup.py install for mozcrash 03:40:49 INFO - Running setup.py install for mozdebug 03:40:49 INFO - Running setup.py install for mozdevice 03:40:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:49 INFO - Running setup.py install for mozfile 03:40:49 INFO - Running setup.py install for mozhttpd 03:40:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Running setup.py install for mozinfo 03:40:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Running setup.py install for mozInstall 03:40:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Running setup.py install for mozleak 03:40:50 INFO - Running setup.py install for mozlog 03:40:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Running setup.py install for moznetwork 03:40:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Running setup.py install for mozprocess 03:40:50 INFO - Running setup.py install for mozprofile 03:40:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Running setup.py install for mozrunner 03:40:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:50 INFO - Running setup.py install for mozscreenshot 03:40:51 INFO - Running setup.py install for moztest 03:40:51 INFO - Running setup.py install for mozversion 03:40:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:51 INFO - Cleaning up... 03:40:51 INFO - Return code: 0 03:40:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:51 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 0x7fabdde6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, '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': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', '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:40:51 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:40:51 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:40:51 INFO - Using env: {'DISPLAY': ':0', 03:40:51 INFO - 'HOME': '/home/cltbld', 03:40:51 INFO - 'LANG': 'en_US.UTF-8', 03:40:51 INFO - 'LANGUAGE': 'en_US:en', 03:40:51 INFO - 'LOGNAME': 'cltbld', 03:40:51 INFO - 'MAIL': '/var/mail/cltbld', 03:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:51 INFO - 'MOZ_NO_REMOTE': '1', 03:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:51 INFO - 'NO_EM_RESTART': '1', 03:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:51 INFO - 'PWD': '/builds/slave/test', 03:40:51 INFO - 'SHELL': '/bin/bash', 03:40:51 INFO - 'SHLVL': '1', 03:40:51 INFO - 'TERM': 'linux', 03:40:51 INFO - 'TMOUT': '86400', 03:40:51 INFO - 'USER': 'cltbld', 03:40:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:51 INFO - '_': '/tools/buildbot/bin/python'} 03:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:51 INFO - Running setup.py (path:/tmp/pip-BKumBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:51 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:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:51 INFO - Running setup.py (path:/tmp/pip-8bGnsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:51 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:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:51 INFO - Running setup.py (path:/tmp/pip-AUNh90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:51 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:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:51 INFO - Running setup.py (path:/tmp/pip-iPia4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:51 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:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:51 INFO - Running setup.py (path:/tmp/pip-0CeFBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:51 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:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:51 INFO - Running setup.py (path:/tmp/pip-kBus9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:51 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:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:51 INFO - Running setup.py (path:/tmp/pip-RfupOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:51 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:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:51 INFO - Running setup.py (path:/tmp/pip-dDw3iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:52 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:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:52 INFO - Running setup.py (path:/tmp/pip-L3akd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:52 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:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:52 INFO - Running setup.py (path:/tmp/pip-7g86IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:52 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:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:52 INFO - Running setup.py (path:/tmp/pip-6kldZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:52 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:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:52 INFO - Running setup.py (path:/tmp/pip-YiEYUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:52 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:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:52 INFO - Running setup.py (path:/tmp/pip-r5S50c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:52 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:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:52 INFO - Running setup.py (path:/tmp/pip-ycX7Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:52 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:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:52 INFO - Running setup.py (path:/tmp/pip-WOt7gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:52 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:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:52 INFO - Running setup.py (path:/tmp/pip-pPAH2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:52 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:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:52 INFO - Running setup.py (path:/tmp/pip-X1_X4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:54 INFO - Downloading blessings-1.6.tar.gz 03:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:54 INFO - Installing collected packages: blessings 03:40:54 INFO - Running setup.py install for blessings 03:40:54 INFO - Successfully installed blessings 03:40:54 INFO - Cleaning up... 03:40:54 INFO - Return code: 0 03:40:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:55 INFO - Reading from file tmpfile_stdout 03:40:55 INFO - Current package versions: 03:40:55 INFO - argparse == 1.2.1 03:40:55 INFO - blessings == 1.6 03:40:55 INFO - blobuploader == 1.2.4 03:40:55 INFO - docopt == 0.6.1 03:40:55 INFO - functools32 == 3.2.3-2 03:40:55 INFO - jsonschema == 2.5.1 03:40:55 INFO - manifestparser == 1.1 03:40:55 INFO - mozInstall == 1.12 03:40:55 INFO - mozcrash == 0.17 03:40:55 INFO - mozdebug == 0.1 03:40:55 INFO - mozdevice == 0.48 03:40:55 INFO - mozfile == 1.2 03:40:55 INFO - mozhttpd == 0.7 03:40:55 INFO - mozinfo == 0.9 03:40:55 INFO - mozleak == 0.1 03:40:55 INFO - mozlog == 3.4 03:40:55 INFO - moznetwork == 0.27 03:40:55 INFO - mozprocess == 0.23 03:40:55 INFO - mozprofile == 0.28 03:40:55 INFO - mozrunner == 6.12 03:40:55 INFO - mozscreenshot == 0.1 03:40:55 INFO - mozsystemmonitor == 0.3 03:40:55 INFO - moztest == 0.7 03:40:55 INFO - mozversion == 1.4 03:40:55 INFO - psutil == 3.1.1 03:40:55 INFO - requests == 1.2.3 03:40:55 INFO - wsgiref == 0.1.2 03:40:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:55 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 0x7fabdde6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, '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': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', '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:40:55 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:40:55 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:40:55 INFO - Using env: {'DISPLAY': ':0', 03:40:55 INFO - 'HOME': '/home/cltbld', 03:40:55 INFO - 'LANG': 'en_US.UTF-8', 03:40:55 INFO - 'LANGUAGE': 'en_US:en', 03:40:55 INFO - 'LOGNAME': 'cltbld', 03:40:55 INFO - 'MAIL': '/var/mail/cltbld', 03:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:55 INFO - 'MOZ_NO_REMOTE': '1', 03:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:55 INFO - 'NO_EM_RESTART': '1', 03:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:55 INFO - 'PWD': '/builds/slave/test', 03:40:55 INFO - 'SHELL': '/bin/bash', 03:40:55 INFO - 'SHLVL': '1', 03:40:55 INFO - 'TERM': 'linux', 03:40:55 INFO - 'TMOUT': '86400', 03:40:55 INFO - 'USER': 'cltbld', 03:40:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:55 INFO - '_': '/tools/buildbot/bin/python'} 03:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 INFO - Cleaning up... 03:40:55 INFO - Return code: 0 03:40:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabdde6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, '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': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', '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:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:40:55 INFO - Using env: {'DISPLAY': ':0', 03:40:55 INFO - 'HOME': '/home/cltbld', 03:40:55 INFO - 'LANG': 'en_US.UTF-8', 03:40:55 INFO - 'LANGUAGE': 'en_US:en', 03:40:55 INFO - 'LOGNAME': 'cltbld', 03:40:55 INFO - 'MAIL': '/var/mail/cltbld', 03:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:55 INFO - 'MOZ_NO_REMOTE': '1', 03:40:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:55 INFO - 'NO_EM_RESTART': '1', 03:40:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:55 INFO - 'PWD': '/builds/slave/test', 03:40:55 INFO - 'SHELL': '/bin/bash', 03:40:55 INFO - 'SHLVL': '1', 03:40:55 INFO - 'TERM': 'linux', 03:40:55 INFO - 'TMOUT': '86400', 03:40:55 INFO - 'USER': 'cltbld', 03:40:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:55 INFO - '_': '/tools/buildbot/bin/python'} 03:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:40:55 INFO - Cleaning up... 03:40:55 INFO - Return code: 0 03:40:55 INFO - Running post-action listener: _resource_record_post_action 03:40:55 INFO - Running post-action listener: _start_resource_monitoring 03:40:55 INFO - Starting resource monitoring. 03:40:55 INFO - [mozharness: 2016-10-11 10:40:55.561155Z] Finished create-virtualenv step (success) 03:40:55 INFO - [mozharness: 2016-10-11 10:40:55.561607Z] Running install step. 03:40:55 INFO - Running pre-action listener: _resource_record_pre_action 03:40:55 INFO - Running main action method: install 03:40:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:55 INFO - Reading from file tmpfile_stdout 03:40:55 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:55 INFO - Reading from file tmpfile_stdout 03:40:55 INFO - Output received: 03:40:55 INFO - Usage: mozinstall [options] installer 03:40:55 INFO - Options: 03:40:55 INFO - -h, --help show this help message and exit 03:40:55 INFO - -d DEST, --destination=DEST 03:40:55 INFO - Directory to install application into. [default: 03:40:55 INFO - "/builds/slave/test"] 03:40:55 INFO - --app=APP Application being installed. [default: firefox] 03:40:55 INFO - mkdir: /builds/slave/test/build/application 03:40:55 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:40:55 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:41:12 INFO - Reading from file tmpfile_stdout 03:41:12 INFO - Output received: 03:41:12 INFO - /builds/slave/test/build/application/firefox/firefox 03:41:12 INFO - Running post-action listener: _resource_record_post_action 03:41:12 INFO - [mozharness: 2016-10-11 10:41:12.223094Z] Finished install step (success) 03:41:12 INFO - [mozharness: 2016-10-11 10:41:12.223340Z] Running run-tests step. 03:41:12 INFO - Running pre-action listener: _resource_record_pre_action 03:41:12 INFO - Running main action method: run_tests 03:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:12 INFO - Python 2.7.3 03:41:12 INFO - Return code: 0 03:41:12 INFO - grabbing minidump binary from tooltool 03:41:12 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:41:12 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 0x1a2ef60>, '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 0x1a2fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a301d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41:12 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:41:12 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:41:12 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:41:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:12 INFO - Return code: 0 03:41:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:41:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:41:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:12 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/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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:41:12 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/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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:41:12 INFO - Using env: {'DISPLAY': ':0', 03:41:12 INFO - 'HOME': '/home/cltbld', 03:41:12 INFO - 'LANG': 'en_US.UTF-8', 03:41:12 INFO - 'LANGUAGE': 'en_US:en', 03:41:12 INFO - 'LOGNAME': 'cltbld', 03:41:12 INFO - 'MAIL': '/var/mail/cltbld', 03:41:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:12 INFO - 'MOZ_NO_REMOTE': '1', 03:41:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:12 INFO - 'NO_EM_RESTART': '1', 03:41:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:12 INFO - 'PWD': '/builds/slave/test', 03:41:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:12 INFO - 'SHELL': '/bin/bash', 03:41:12 INFO - 'SHLVL': '1', 03:41:12 INFO - 'TERM': 'linux', 03:41:12 INFO - 'TMOUT': '86400', 03:41:12 INFO - 'USER': 'cltbld', 03:41:12 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103', 03:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:12 INFO - '_': '/tools/buildbot/bin/python'} 03:41:12 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/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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:41:12 INFO - mozversion application_buildid: 20161011004015 03:41:12 INFO - mozversion application_changeset: 9a452e8fde0ffd76d25179f5d6165265444a2247 03:41:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:12 INFO - mozversion application_name: Firefox 03:41:12 INFO - mozversion application_remotingname: firefox-dev 03:41:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:12 INFO - mozversion application_vendor: Mozilla 03:41:12 INFO - mozversion application_version: 51.0a2 03:41:12 INFO - mozversion platform_buildid: 20161011004015 03:41:12 INFO - mozversion platform_changeset: 9a452e8fde0ffd76d25179f5d6165265444a2247 03:41:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:12 INFO - mozversion platform_version: 51.0a2 03:41:12 INFO - using testdate: 1476182472 03:41:12 INFO - actual date: 1476182472 03:41:12 INFO - starting webserver on 'localhost:58182' 03:41:12 INFO - SUITE-START | Running 2 tests 03:41:12 INFO - TEST-START | dromaeo_css 03:41:12 INFO - operating with platform_type : linux_ 03:41:12 INFO - Initialising browser for dromaeo_css test... 03:41:12 INFO - TEST-INFO | started process 28822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmoeEv/profile http://localhost:58182/getInfo.html) 03:41:16 INFO - PROCESS | 28822 | __metrics Screen width/height:1600/1200 03:41:16 INFO - PROCESS | 28822 | colorDepth:24 03:41:16 INFO - PROCESS | 28822 | Browser inner width/height: 1024/697 03:41:16 INFO - PROCESS | 28822 | __metrics 03:41:16 INFO - PROCESS | 28822 | 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:41:16 INFO - PROCESS | 28822 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:41:17 INFO - PROCESS | 28822 | console.error: PushService: 03:41:17 INFO - PROCESS | 28822 | stateChangeProcessEnqueue: Error transitioning state 03:41:17 INFO - PROCESS | 28822 | UnknownError 03:41:17 INFO - TEST-INFO | 28822: exit 0 03:41:17 INFO - Browser initialized. 03:41:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:17 INFO - TEST-INFO | started process 28911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmoeEv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:29 INFO - PROCESS | 28911 | RSS: Main: 144797696 03:41:29 INFO - PROCESS | 28911 | 03:42:20 INFO - PROCESS | 28911 | 1476182540974 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:44:30 INFO - PROCESS | 28911 | Cycle 1(1): loaded http://localhost:58182/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58182/tests/dromaeo/cssquery-ext.html) 03:44:31 INFO - PROCESS | 28911 | RSS: Main: 247369728 03:44:31 INFO - PROCESS | 28911 | 03:47:33 INFO - PROCESS | 28911 | Cycle 1(1): loaded http://localhost:58182/tests/dromaeo/cssquery-ext.html (next: http://localhost:58182/tests/dromaeo/cssquery-jquery.html) 03:47:34 INFO - PROCESS | 28911 | RSS: Main: 227811328 03:47:34 INFO - PROCESS | 28911 | 03:50:36 INFO - PROCESS | 28911 | Cycle 1(1): loaded http://localhost:58182/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58182/tests/dromaeo/cssquery-mootools.html) 03:50:36 INFO - PROCESS | 28911 | RSS: Main: 209281024 03:50:36 INFO - PROCESS | 28911 | 03:53:38 INFO - PROCESS | 28911 | Cycle 1(1): loaded http://localhost:58182/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58182/tests/dromaeo/cssquery-prototype.html) 03:53:39 INFO - PROCESS | 28911 | RSS: Main: 175292416 03:53:39 INFO - PROCESS | 28911 | 03:56:41 INFO - PROCESS | 28911 | Cycle 1(1): loaded http://localhost:58182/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58182/tests/dromaeo/cssquery-yui.html) 03:56:42 INFO - PROCESS | 28911 | RSS: Main: 176537600 03:56:42 INFO - PROCESS | 28911 | 03:59:45 INFO - PROCESS | 28911 | Cycle 1(1): loaded http://localhost:58182/tests/dromaeo/cssquery-yui.html (next: http://localhost:58182/tests/dromaeo/cssquery-dojo.html) 03:59:45 INFO - PROCESS | 28911 | RSS: Main: 260972544 03:59:45 INFO - PROCESS | 28911 | 03:59:45 INFO - PROCESS | 28911 | __start_tp_report 03:59:45 INFO - PROCESS | 28911 | _x_x_mozilla_page_load 03:59:45 INFO - PROCESS | 28911 | _x_x_mozilla_page_load_details 03:59:45 INFO - PROCESS | 28911 | |i|pagename|runs| 03:59:45 INFO - PROCESS | 28911 | |0;dojo.html;3161.430942430363;3220.7423406127514;3233.6119665640113;3249.074013906037;3269.2971011232594;5664.5468362531;5770.3075630924295;5770.711464426783;5785.247917770695;5806.651600903949;5671.234383358255;5716.8284951451415;5754.424557544244;5756.280464941882;5756.625819321741;5197.584193264549;5208.244804503344;5211.42674305826;5238.371395432534;5287.682739035651;5073.644844860862;5086.694798312114;5289;5303.178007408857;5329.333833270841;5149.124648809692;5149.845504634867;5173.224016397533;5182.922256166161;5194.558462530689;5226.947730522703;5231.163013917774;5282.920756188661;5293.444188360205;5320.680759154463;4959.876003099916;5134.358205224347;5199.974000129975;5248.422673505911;5263.157894736823;5425.9728701356635;5436.945630543683;5486;5561.5272701820395;5657.886842263173;5835.066389377679;5835.883282334329;5953.987822070215;5957.106434034886;5958.7616495340135;5781.392953739839;5976.46211840932;6006.399360063959;6006.729697163638;6007.189029481008;5452.563794896439;5661.7735290588735;5707.543396528268;5734.2258795062135;5760.308762948473;6308.323815318929;6335.461485773761;6339.619622822645;6345.650989195638;6346;5795.623284486495;6064.575479716377;6080.7567697291615;6083.7870674526175;6099.9085013724825;5934.940650593525;6058.4244496772735;6095.603785753912;6099.3900609938655;6148.354422785633;6119.804644672563;6120.262154551624;6124.036419119016;6126.641866217211;6128.811800681408;6104.511639068864;6114.084479019511;6122.20411346531;6129.295131059986;6138.508919286535;4528.252838281713;4557.134144512532;4578.061497393093;4614.861554153381;4615.215413379734;4120.320147175742;4124.608162224584;4127.587241275908;4130.752154870717;4148.253314403436;5785.739641716133;5786.276715410574;5793.8551536211935;5795.594308398456;5800.187973683687;5833.533317334688;5881.558883083786;6136.20229370179;6140.754369825157;6162.506999440034;5805.071188609802;5807.68057756819;5810.273715785527;5814.418558144152;5851.444112809277;5278.49854263852;5283.313169287968;5288.867778305573;5289.550388217045;5292.311999440049;6135.630783975157;6200.968995155085;6225.190725205875;6309.242890853127;6363;6155;6222.439980401786;6227.252729672287;6231.781887633911;6232.594881332699;6368.681565921593;6373.968130159505;6384.425401713868;6384.712687928962;6389.233292004803;5839.299284085767;5952.97023514897;6060.757569697163;6060.818175454743;6075.544334175043;6040.486558642565;6093.75624974996;6110.480609148094;6137.508999280136;6155.47678447337;5946.554008449297;5992.250968628921;5992.820215393545;5994.610350327215;6013.548983826318;5758.942410576008;5950.732217050157;5978.4021597839865;5981.1327357532045;5981.970090149522;5794.768209271582;5795.043817770189;5810.099434587646;5840.678762668094;5950.880982380241;5960.105984102419;5982.282126144891;6013.338532761481;6013.759449621966;6023.1567580537885;5586.888262234814;5616.66300022;5840.707964601668;5844.649321040752;5845.649261044351 03:59:45 INFO - PROCESS | 28911 | |1;ext.html;581.7731084876899;607.2409488139825;646.3375040583403;658.8122385120241;660.5442244851049;33707.15732106699;46746.53253467464;47541;47541.28688069682;47592.762036189815;48776.2683559746;49272.2609160862;49275.75362123193;49295.26057109137;49330.75334623331;8494;9370.625174992992;9522.0954009369;9533.237341012737;9535.95232023839;8406.83186336273;10962.068224200913;11321.886781132207;11343.886561134406;11697.239679420853;11460.426978651076;11512.654620361403;11526.250793698424;11528.365939873303;11543.422828858565;8559.828803423896;8807.295416366675;10874.510647020863;10936.726581835439;10940.23418360715;8686.652533898636;10745.62390316343;11137.220394572383;11140.941610546985;11526.481308341145;45325.32012019822;45543;45561.08877822425;45563.31655025177;45727.08545829065;3839.2897313996723;3983.382575700771;4195.244855925932;4228.725132866354;4486.057927835159;34167.48748768771;34555.82722086398;34629.30741385158;35038.649613503796;35698.464523031915;4606.401167848192;4654.138984287918;4658.068386322715;4682.08699303636;4685.953140468586;355183.99999999744;356511;356877;358537;359647;40060.79969600133;40514;41059.38410923839;64109.679451602446;64818.67590662016;43066.569334306885;43083;43203.35194972078;43211.78394108072;43230.35154472685;17907;18068.18693158811;18121.275148993893;18124.093795310444;18127.818721812877;13436.395362208725;13596.864031359757;13924.930375348058;14291.213983231022;14407.567772966828;9590.08894155054;9625;9660.130588247092;9776.902230977741;9792.55933482995;3580.7672501287334;3687.483752274684;3689.6679298863232;3723.553173619183;3757.812109394519;1029.7013865978931;1120.3613940054254;1133.52958522214;1149.3391300002531;1186.211169572242;35173.64826351755;35315.851848900995;35474.46788298178;35758.8212058938;36086.639133608856;1101.9669409917715;1157.571698471571;1216.2216181643578;1227.0796902323257;1286.88684288092;17213.31146754116;18314.26742930268;18404.815951840577;18586.628267434575;18619.255229790655;609307;609519;615985;616534;620012;63999.680001600624;64184;64408.35591644117;64481;64497;1357.966050848717;1402.9017968742294;1435.2464955898029;1437.367558274356;1477.7783332499996;33833.83083084569;35847.82076089603;36234.637653623126;36240.637593623724;36369.90890273296;55419.16871247015;55649.721751390985;56307;56345.43654563402;56464.717676411354;451377;455361;456079;457320;803700;48315.275270871665;48698.26952595643;50027.749861250464;50138.247926280404;50798;54713.72643136759;55113.44886551244;55476.44523554713;55530;55563.72218138883;42887;44312.335314970944;45200.32199516944;46007;47147;45305.77347113243;46130.308045380014;46412.76793616146;47619.523804762895;48168.5183148164;45524.54475455203;46097.078058437975;46502.76748616235;46627;48571.27143092786;38404;40904.590954090076;41638.791806040776;41665;42038.36942445927;30884;30931;31099.222519437197;31182.37635247328;31589.52615710812 03:59:45 INFO - PROCESS | 28911 | |2;jquery.html;396.2728393398114;428.07579928222646;436.48276792001474;442.08884495596504;447.38037817622603;16543.917280413596;18872.150753216105;20521.179152833905;21082.051307691152;21166.89416552915;20021.399358019284;20777.896110519425;20834.166633334688;20836.8958155209;21063.2627858025;5844.1818145459665;5885.558583106263;6096.116063170837;6103.938960610403;6104.877902441948;5946.970265148668;5968.1346204800275;6000.159977603139;6007;6039.184710064151;5765.164051212571;5953.3748956359605;5969;5984;5986.551008674345;5939.990201665727;5958.404159584029;5977.551683623746;5980.581359304851;6001.819945401667;5255.211718242256;5335.759890804923;5359.169328754049;5379.542738867201;5383.16560933056;22775.316740497812;23321;23488.412789680395;24714.505709885703;24848.627270590954;2299.1378233162563;2435.366804630791;2457.4225057111566;2564.512742578904;2932.501474749298;10361.585536578528;10402.583896644124;10905.890941090567;11165.776684466346;11251.606193783178;1988.5923385705896;1997.9100940457715;2004.3085135628185;2014.446027342478;2085.1450905128822;88467;88670;93517.53241233819;95560;95993.52003240009;9888.604455821687;10591.928340781087;10668.413237271869;12026.939865300617;12338.136330456962;15539.689206215813;15856.60358491047;16651.084190369646;16804.411845585346;16824.831751682326;9000.8649870252;9152.084791520927;9175.954120229357;9286;9326;8608.655653773903;8811.251043661361;8896.59965301563;8957.820843583091;9040.773980650536;5146.897062058738;5246.947530524646;5262.394824595144;5269.814291784394;5384.9730751346;2150.7096541966635;2175.8912054397533;2178.1396348442277;2188.507585793184;2194.133317339674;936.6674830435097;1026.2303272545591;1059.7668512927144;1061.3525749292926;1081.2755453845941;19959.800401996086;20592;20597.176112955614;20876.269330573356;20918.686219706717;1031.7008067660295;1044.5247412427327;1076.4079756134095;1088.7495875948418;1099.4008265495324;10415.218858585637;11361.602343917923;11363.886361136283;11474;11479.4260286987;478164;479928;491855;498040;505515;94394.52802735943;94731.52634236784;95141.52429237949;97399;97659;1021.4280003198232;1055.7096798380508;1121.7924683933497;1132.116948779953;1140.948657310423;17808.198631061376;17878;18239.908800455913;18435.631287373908;18505.444836654922;42507.18161506553;43251;43713.12573748571;43753.34369984389;44257.33613995857;56114.71942640424;56243.718781405834;56945;61954.38045619666;62599.37400625936;12714.936425317814;12744.362781861055;13085.214887106804;13131.60605181846;13168.539101131415;14970.775438368652;15225.314860831511;15324;15327;15708.76436853471;6308.905366419415;9073.775040369466;12525.93737031309;13549.86450135486;13578.524751633646;12850.807237891253;13325.267110308638;13327.200367977952;13583.79624305656;13659.726805464034;7936.6428510718315;12660;13447.260400677666;13515;13743.725125497635;13554.728905422033;13583.117097388638;13719.862801371859;13731.656708582366;14080;12942.80585791195;13087.607371778862;13107;13201.801972970605;13532.188068715908 03:59:45 INFO - PROCESS | 28911 | |3;mootools.html;1347.7708789505782;1497.348653335799;1542.0439327616875;1648.3159488812144;1809.918553665085;8245.422820402575;9061.411008284465;9393.90606093939;9400.62397504099;9672.61309547619;9451.763705907355;9533.285003624722;9536.761580960461;9539.236861051117;9541.475218862959;2552.808539359546;2577.613357996306;2581.6256642786784;2582.5738753105716;2583.7287084856102;2569.075132952136;2637.9472410551775;2638.2217245912407;2639.8944042238286;2642.537555927705;2543.74562543746;2547.197632745679;2586.0560895273184;2590.4689538644625;2591.870406479678;2505.749425057498;2522.4198434360014;2535.8732063396756;2536.657551230588;2542.6058960861096;2441.438469152105;2453.0800949643885;2465.0755966512556;2511.748825117492;2514.371407148213;9326.673566425143;9537.52312384385;9551.90448095517;9672.081152290591;9676.661316853946;5742.856428589277;5923.822285331447;5968.820935371902;5976.372480889488;5986.640801551921;3731.2350968051483;3820.789856557888;3829.215010922782;3886.805659717031;3893.493845800028;1303.0683061610994;1315.7763180259378;1319.083237150181;1331.2944139606025;1353.810466534686;13430.865691343157;13683.04218704691;13688.52090176849;13695.589132325946;13708.3831227595;4894.902101958012;5055.368078990126;5175.404828444702;5196.350456192976;5214.0875346814155;10542.894571054192;10545.894541054644;10554.630587929385;10556;10558.155347572176;5876.059830427112;5877.118432235199;5880.323762767336;5883.294004719461;5884.823455296348;4712.410948631421;4797.304390863305;5375.247465354853;5435.42927992563;5501;4213.599708027732;4235.2800023996;4297.91404171921;4340.544242854518;4354.216241076637;1305.934703264852;1335.9732805344033;1338.3642769684323;1344.2405041151717;1344.6302266876492;902.8510295801119;1060.8090543702208;1061.9734506637396;1087.9075278601408;1091.5633746501462;6513.706883190268;6653.168353955755;6682.866342673216;6843.965780171067;6966.9303306967295;525.569033392622;529.5895680847298;530.4271386902136;530.6656806212139;535.7803300646716;4616.515265897033;4643.86068417948;4676.95323046772;4739.075880203396;4748.406449193851;11826.76346473083;12121.878781212252;12204.511819527297;12229;12259.019278457701;11536.307821530734;12023.398830058637;12043;12111.091668124925;12386.81419778704;8907.866382004275;9074.364794464456;9090.409123406956;9113.134252246025;9113.544322783835;6504.15445992018;6915.792526224222;6921.134858142732;6960.129983752031;7011.894821577783;11292.43537823122;11346.262492937933;11555.537778488766;11561.942190288995;11581.594644187413;11497.712557186138;11509.251898626562;11551.826722599;11630.302181869114;11667.766644667228;7658.195889431529;7938.960305198437;8220.424570280024;8637.740867773977;8767.60545775429;9255.398399104037;9628.18160456369;9628.66299679536;9632.614695412105;9635.421874687541;8496.957515212385;8532.530710810965;8536.74389768308;8540.74377768668;8595.226429621114;8096.635651395819;8132.308753755997;8142.51144931306;8144.796380090308;8291.917080829357;7718.845623087619;7755.72854950074;7851.175626559358;7873.015873015873;7878.803029924297;5664.688442135722;5819.243498345188;5842.766289348378;5898.498627616701;5923.911141332969;5823.5923485355615;5839.649621022752;5904;5969.52243820502;5997.16039754426 03:59:45 INFO - PROCESS | 28911 | |4;prototype.html;339.28241768659285;354.45591017787694;366.98715544955917;369.1343798791832;370.7275152762721;5625.578081643877;5677.914831277534;5693.747375577376;5696.287964004505;5736;5286.550643195333;5537.6954267515375;5539.972300138504;5616.129499927508;5632.155176723493;3912.3349030664785;4251.80866860992;4394.97802510987;4397.362382454542;4406.955930440703;4400.273954797454;4407.449068866392;4421.182081314967;4450.354698568722;4456.59890609845;4388.297872340426;4411.1398277335775;4419.779011049451;4429.269170586849;4429.5348988356245;4052.675785937133;4134.586541345871;4314.80583373749;4332.566743325674;4382;3851.5378154621344;3864.9227015459815;3891.708121890841;3898.941515877264;3904.609539046101;5461.481159289861;5471.37079235889;5494.066008778477;5498.972505137449;5508.889822203533;4907.2393778964315;5001.349824522825;5005.774740136702;5047.167217409123;5055.443901170868;5755.251817263771;5771.855703607402;5773;5775.826725198251;5786.826395208151;4283.721558098714;4300.763458009808;4307.203167414007;4326.329418940069;4327.900968030503;5801.795317779217;5850.502707269887;5934.792282270143;6100.877982440371;6149.200603921507;4255.170241802881;4374.475062992397;4379.627731642782;4393.319035549495;4416.779161041935;4419.801108950105;4452.532484089189;4453.643708503312;4471.374007638933;4475.813909313969;4961.6526843121355;5008.248762685554;5051.924221136685;5063.683442305027;5071.833478300012;5890.49930755882;5934.19888315072;5939.287285525765;5951.732172052268;5968.820935371946;1522.5584580471539;1542.2365928865283;1551.534539638104;1558.7194305025205;1561.843815618429;945.4941606240628;986.9161121304626;990.4153354632674;994.5623925472769;1009.9091081802673;5005.899882002413;5069.543741063322;5071.808125090601;5074.23886417033;5082.288479612857;5269.235960785664;5277.340332458442;5295.947040529622;5305.575553955674;5307.124324486416;4886.82896098642;5019.749012549358;5027.497250274943;5047.621428392885;5083.440821509631;2807.7753779697982;2812.1282402454895;2840.261532001653;2853.429314137181;2858.1139846647607;5446.564274858002;5448.972755136199;5492.633356481527;5495.890082198413;5537.667739935536;5298.284731561267;5391.110466773017;5394.894046720413;5412.621116521806;5495.505404513533;5432.456754324536;5513.696746678891;5520.751566179531;5526.530244929146;5534.4742249486235;5179.585633149414;5181.455947125648;5310.442403547727;5317.059273365271;5617.264519094756;5983.341832398346;5992.580519363602;6000.969995150171;6009.639421634541;6019.458248757633;5944.762209511571;6080.510274982657;6102.877942441215;6248.281447633399;6248.375162483715;4377.737335759864;4411.889702757457;4413.757243351646;4419.933700994552;4425.977870110629;5733.741981610921;6132.8773424532155;6138.907916381348;6139.140520327247;6141.508679305734;5812.680302583399;5818.476337129509;5930.703464826827;5945.851353716192;5950.166976623363;5906.228131560601;5912.935671579157;5926.318473375617;5927.555433342603;5933.169356290036;5680.68756218412;5842.561807864512;5849.795257165979;5865.765369385177;5897.174395584708;5926.822195334147;5929.495992840657;5963.940360596339;5983.072623743326;5987.161797348288;5684.687342196219;5692.573057020657;5815.244018277597;5828.76684932598;5837.67892765902 03:59:45 INFO - PROCESS | 28911 | |5;yui.html;788.668759121169;810.0481933727868;821.852066628007;834.2616784146037;888.857782754759;16279.267432965515;16304.798852154956;16323.428679996203;16375.508734737978;16550.91724541377;16197.514074577752;16340.264688089035;16346.34614615417;16356;16357.427490037851;715.81746654603;739.7780665800266;854.6410507586797;863.3783675753463;897.0625696147541;880.2034159086005;883.3772190605607;883.4699180491718;883.6465413834453;883.6553744039829;939.229831538139;939.2955283537347;940.0458534587399;940.1022023967095;940.666063547441;763.9885401718979;785.19909692114;787.7518581646821;790.4506368074191;936.4989730494187;658.427168363522;674.6188403552027;674.9493787965873;678.372505432473;678.9422899053586;16420.096894670787;16450.506484805475;16471.34114635413;16492.092934888577;16514.091724955124;15281.465148719853;15401.460948866848;15600.988675979817;15788.526344209693;15874.444394446255;14408.567742967727;14494.42022319106;14557.927210363987;14977.625559360995;15559.144247066406;4649.8372556960685;4674.696144750615;4765.737884416356;4818.855434336975;4886.60907127429;82621;85589;86365.56817215937;86931.69602456031;87863.56068219618;12175.939120304341;12280.938595306967;12284.570040048555;12576.056795740356;12609.30648814324;23630.64554031691;23691;23741.406464838517;23816.404589885045;23951.7604823953;9093.40892841963;9118.179363857285;9424.340296179202;9603.183729383081;9709.174720148725;4964.081644895634;5035.395752509722;5066.16408292635;5091.516305950929;5128.051310507568;3613.9880833366174;3715.702743780491;3716.089558058239;3716.7955762432784;3718.0890681783135;660.3957378998259;668.8963210702349;670.8960111182774;685.5852209413333;728.8505856299446;643.6868787673094;747.4543583184197;769.819092513259;785.5051317669946;810.6271115286916;10899.564017439372;10918.344899306067;11091.944540277409;11112.333260004425;11451.828222576669;702.9894551581731;767.5279702982625;796.1083586383288;801.8636831738619;813.6867306087199;5441.129419292894;5536.446355364431;5552.111662134039;5618.91571626426;5667.914981275284;131633;132120.3393983024;136430;137226.31386843;139259;115708;116144.41927790476;117451;117824;121831;100819;103299;104032;105919.47040264904;107581.46209268903;9673.854892176763;9794.314397992071;9833.311668183158;9865.358751681119;9879.901200988186;56614.433855660915;57043.42956570381;58302.4169758297;58633;58743.4125658738;84593.57703211691;91038.54480727554;91576;92529;94162.52918735362;11397.829032564685;12165.452554634885;12183.451744671689;12557.686057848627;12628;13398.789199781926;14389.568312950629;14959.92520037393;14991.2504374783;15127.39490420415;14467.92766036163;15297.235138243266;15323.77014344808;16301.59246018859;16531.91734041322;15153.772693409828;15427.305771240097;16377.918110409371;16399.508014759576;16491.83508164903;13655.180689158682;14676;14877;14988.47540336083;16430.424935127212;11825.349605771766;12034.75930481403;12050.337231452004;13287.13633613812;13405.731885362433;13176.298858734128;13330.133541319783;13439.126456780277;13495.460181592627;13688.178709277077 03:59:45 INFO - PROCESS | 28911 | __end_tp_report 03:59:45 INFO - PROCESS | 28911 | __start_cc_report 03:59:45 INFO - PROCESS | 28911 | _x_x_mozilla_cycle_collect,883 03:59:45 INFO - PROCESS | 28911 | __end_cc_report 03:59:45 INFO - PROCESS | 28911 | __startTimestamp1476183585458__endTimestamp 03:59:45 INFO - PROCESS | 28911 | 03:59:45 INFO - PROCESS | 28911 | ------- Summary: start ------- 03:59:45 INFO - PROCESS | 28911 | Number of tests: 6 03:59:45 INFO - PROCESS | 28911 | 03:59:45 INFO - PROCESS | 28911 | [#0] dojo.html Cycles:165 Average:5653.42 Median:5833.53 stddev:655.77 (11.2%) stddev-sans-first:627.97 03:59:45 INFO - PROCESS | 28911 | Values: 3161.4 3220.7 3233.6 3249.1 3269.3 5664.5 5770.3 5770.7 5785.2 5806.7 5671.2 5716.8 5754.4 5756.3 5756.6 5197.6 5208.2 5211.4 5238.4 5287.7 5073.6 5086.7 5289.0 5303.2 5329.3 5149.1 5149.8 5173.2 5182.9 5194.6 5226.9 5231.2 5282.9 5293.4 5320.7 4959.9 5134.4 5200.0 5248.4 5263.2 5426.0 5436.9 5486.0 5561.5 5657.9 5835.1 5835.9 5954.0 5957.1 5958.8 5781.4 5976.5 6006.4 6006.7 6007.2 5452.6 5661.8 5707.5 5734.2 5760.3 6308.3 6335.5 6339.6 6345.7 6346.0 5795.6 6064.6 6080.8 6083.8 6099.9 5934.9 6058.4 6095.6 6099.4 6148.4 6119.8 6120.3 6124.0 6126.6 6128.8 6104.5 6114.1 6122.2 6129.3 6138.5 4528.3 4557.1 4578.1 4614.9 4615.2 4120.3 4124.6 4127.6 4130.8 4148.3 5785.7 5786.3 5793.9 5795.6 5800.2 5833.5 5881.6 6136.2 6140.8 6162.5 5805.1 5807.7 5810.3 5814.4 5851.4 5278.5 5283.3 5288.9 5289.6 5292.3 6135.6 6201.0 6225.2 6309.2 6363.0 6155.0 6222.4 6227.3 6231.8 6232.6 6368.7 6374.0 6384.4 6384.7 6389.2 5839.3 5953.0 6060.8 6060.8 6075.5 6040.5 6093.8 6110.5 6137.5 6155.5 5946.6 5992.3 5992.8 5994.6 6013.5 5758.9 5950.7 5978.4 5981.1 5982.0 5794.8 5795.0 5810.1 5840.7 5950.9 5960.1 5982.3 6013.3 6013.8 6023.2 5586.9 5616.7 5840.7 5844.6 5845.6 03:59:45 INFO - PROCESS | 28911 | 03:59:45 INFO - PROCESS | 28911 | [#1] ext.html Cycles:180 Average:66664.17 Median:43074.78 stddev:137624.88 (319.5%) stddev-sans-first:137921.52 03:59:45 INFO - PROCESS | 28911 | Values: 581.8 607.2 646.3 658.8 660.5 33707.2 46746.5 47541.0 47541.3 47592.8 48776.3 49272.3 49275.8 49295.3 49330.8 8494.0 9370.6 9522.1 9533.2 9536.0 8406.8 10962.1 11321.9 11343.9 11697.2 11460.4 11512.7 11526.3 11528.4 11543.4 8559.8 8807.3 10874.5 10936.7 10940.2 8686.7 10745.6 11137.2 11140.9 11526.5 45325.3 45543.0 45561.1 45563.3 45727.1 3839.3 3983.4 4195.2 4228.7 4486.1 34167.5 34555.8 34629.3 35038.6 35698.5 4606.4 4654.1 4658.1 4682.1 4686.0 355184.0 356511.0 356877.0 358537.0 359647.0 40060.8 40514.0 41059.4 64109.7 64818.7 43066.6 43083.0 43203.4 43211.8 43230.4 17907.0 18068.2 18121.3 18124.1 18127.8 13436.4 13596.9 13924.9 14291.2 14407.6 9590.1 9625.0 9660.1 9776.9 9792.6 3580.8 3687.5 3689.7 3723.6 3757.8 1029.7 1120.4 1133.5 1149.3 1186.2 35173.6 35315.9 35474.5 35758.8 36086.6 1102.0 1157.6 1216.2 1227.1 1286.9 17213.3 18314.3 18404.8 18586.6 18619.3 609307.0 609519.0 615985.0 616534.0 620012.0 63999.7 64184.0 64408.4 64481.0 64497.0 1358.0 1402.9 1435.2 1437.4 1477.8 33833.8 35847.8 36234.6 36240.6 36369.9 55419.2 55649.7 56307.0 56345.4 56464.7 451377.0 455361.0 456079.0 457320.0 803700.0 48315.3 48698.3 50027.7 50138.2 50798.0 54713.7 55113.4 55476.4 55530.0 55563.7 42887.0 44312.3 45200.3 46007.0 47147.0 45305.8 46130.3 46412.8 47619.5 48168.5 45524.5 46097.1 46502.8 46627.0 48571.3 38404.0 40904.6 41638.8 41665.0 42038.4 30884.0 30931.0 31099.2 31182.4 31589.5 03:59:45 INFO - PROCESS | 28911 | 03:59:45 INFO - PROCESS | 28911 | [#2] jquery.html Cycles:180 Average:30233.56 Median:2163.30 stddev:81102.15 (3749.0%) stddev-sans-first:81298.72 03:59:45 INFO - PROCESS | 28911 | Values: 396.3 428.1 436.5 442.1 447.4 16543.9 18872.2 20521.2 21082.1 21166.9 20021.4 20777.9 20834.2 20836.9 21063.3 5844.2 5885.6 6096.1 6103.9 6104.9 5947.0 5968.1 6000.2 6007.0 6039.2 5765.2 5953.4 5969.0 5984.0 5986.6 5940.0 5958.4 5977.6 5980.6 6001.8 5255.2 5335.8 5359.2 5379.5 5383.2 22775.3 23321.0 23488.4 24714.5 24848.6 2299.1 2435.4 2457.4 2564.5 2932.5 10361.6 10402.6 10905.9 11165.8 11251.6 1988.6 1997.9 2004.3 2014.4 2085.1 88467.0 88670.0 93517.5 95560.0 95993.5 9888.6 10591.9 10668.4 12026.9 12338.1 15539.7 15856.6 16651.1 16804.4 16824.8 9000.9 9152.1 9176.0 9286.0 9326.0 8608.7 8811.3 8896.6 8957.8 9040.8 5146.9 5246.9 5262.4 5269.8 5385.0 2150.7 2175.9 2178.1 2188.5 2194.1 936.7 1026.2 1059.8 1061.4 1081.3 19959.8 20592.0 20597.2 20876.3 20918.7 1031.7 1044.5 1076.4 1088.7 1099.4 10415.2 11361.6 11363.9 11474.0 11479.4 478164.0 479928.0 491855.0 498040.0 505515.0 94394.5 94731.5 95141.5 97399.0 97659.0 1021.4 1055.7 1121.8 1132.1 1140.9 17808.2 17878.0 18239.9 18435.6 18505.4 42507.2 43251.0 43713.1 43753.3 44257.3 56114.7 56243.7 56945.0 61954.4 62599.4 12714.9 12744.4 13085.2 13131.6 13168.5 14970.8 15225.3 15324.0 15327.0 15708.8 6308.9 9073.8 12525.9 13549.9 13578.5 12850.8 13325.3 13327.2 13583.8 13659.7 7936.6 12660.0 13447.3 13515.0 13743.7 13554.7 13583.1 13719.9 13731.7 14080.0 12942.8 13087.6 13107.0 13201.8 13532.2 03:59:45 INFO - PROCESS | 28911 | 03:59:45 INFO - PROCESS | 28911 | [#3] mootools.html Cycles:180 Average:6382.58 Median:4846.10 stddev:3643.13 (75.2%) stddev-sans-first:3633.70 03:59:45 INFO - PROCESS | 28911 | Values: 1347.8 1497.3 1542.0 1648.3 1809.9 8245.4 9061.4 9393.9 9400.6 9672.6 9451.8 9533.3 9536.8 9539.2 9541.5 2552.8 2577.6 2581.6 2582.6 2583.7 2569.1 2637.9 2638.2 2639.9 2642.5 2543.7 2547.2 2586.1 2590.5 2591.9 2505.7 2522.4 2535.9 2536.7 2542.6 2441.4 2453.1 2465.1 2511.7 2514.4 9326.7 9537.5 9551.9 9672.1 9676.7 5742.9 5923.8 5968.8 5976.4 5986.6 3731.2 3820.8 3829.2 3886.8 3893.5 1303.1 1315.8 1319.1 1331.3 1353.8 13430.9 13683.0 13688.5 13695.6 13708.4 4894.9 5055.4 5175.4 5196.4 5214.1 10542.9 10545.9 10554.6 10556.0 10558.2 5876.1 5877.1 5880.3 5883.3 5884.8 4712.4 4797.3 5375.2 5435.4 5501.0 4213.6 4235.3 4297.9 4340.5 4354.2 1305.9 1336.0 1338.4 1344.2 1344.6 902.9 1060.8 1062.0 1087.9 1091.6 6513.7 6653.2 6682.9 6844.0 6966.9 525.6 529.6 530.4 530.7 535.8 4616.5 4643.9 4677.0 4739.1 4748.4 11826.8 12121.9 12204.5 12229.0 12259.0 11536.3 12023.4 12043.0 12111.1 12386.8 8907.9 9074.4 9090.4 9113.1 9113.5 6504.2 6915.8 6921.1 6960.1 7011.9 11292.4 11346.3 11555.5 11561.9 11581.6 11497.7 11509.3 11551.8 11630.3 11667.8 7658.2 7939.0 8220.4 8637.7 8767.6 9255.4 9628.2 9628.7 9632.6 9635.4 8497.0 8532.5 8536.7 8540.7 8595.2 8096.6 8132.3 8142.5 8144.8 8291.9 7718.8 7755.7 7851.2 7873.0 7878.8 5664.7 5819.2 5842.8 5898.5 5923.9 5823.6 5839.6 5904.0 5969.5 5997.2 03:59:45 INFO - PROCESS | 28911 | 03:59:45 INFO - PROCESS | 28911 | [#4] prototype.html Cycles:180 Average:4820.58 Median:5313.75 stddev:1391.27 (26.2%) stddev-sans-first:1353.91 03:59:45 INFO - PROCESS | 28911 | Values: 339.3 354.5 367.0 369.1 370.7 5625.6 5677.9 5693.7 5696.3 5736.0 5286.6 5537.7 5540.0 5616.1 5632.2 3912.3 4251.8 4395.0 4397.4 4407.0 4400.3 4407.4 4421.2 4450.4 4456.6 4388.3 4411.1 4419.8 4429.3 4429.5 4052.7 4134.6 4314.8 4332.6 4382.0 3851.5 3864.9 3891.7 3898.9 3904.6 5461.5 5471.4 5494.1 5499.0 5508.9 4907.2 5001.3 5005.8 5047.2 5055.4 5755.3 5771.9 5773.0 5775.8 5786.8 4283.7 4300.8 4307.2 4326.3 4327.9 5801.8 5850.5 5934.8 6100.9 6149.2 4255.2 4374.5 4379.6 4393.3 4416.8 4419.8 4452.5 4453.6 4471.4 4475.8 4961.7 5008.2 5051.9 5063.7 5071.8 5890.5 5934.2 5939.3 5951.7 5968.8 1522.6 1542.2 1551.5 1558.7 1561.8 945.5 986.9 990.4 994.6 1009.9 5005.9 5069.5 5071.8 5074.2 5082.3 5269.2 5277.3 5295.9 5305.6 5307.1 4886.8 5019.7 5027.5 5047.6 5083.4 2807.8 2812.1 2840.3 2853.4 2858.1 5446.6 5449.0 5492.6 5495.9 5537.7 5298.3 5391.1 5394.9 5412.6 5495.5 5432.5 5513.7 5520.8 5526.5 5534.5 5179.6 5181.5 5310.4 5317.1 5617.3 5983.3 5992.6 6001.0 6009.6 6019.5 5944.8 6080.5 6102.9 6248.3 6248.4 4377.7 4411.9 4413.8 4419.9 4426.0 5733.7 6132.9 6138.9 6139.1 6141.5 5812.7 5818.5 5930.7 5945.9 5950.2 5906.2 5912.9 5926.3 5927.6 5933.2 5680.7 5842.6 5849.8 5865.8 5897.2 5926.8 5929.5 5963.9 5983.1 5987.2 5684.7 5692.6 5815.2 5828.8 5837.7 03:59:45 INFO - PROCESS | 28911 | 03:59:45 INFO - PROCESS | 28911 | [#5] yui.html Cycles:180 Average:23983.10 Median:3664.85 stddev:35524.48 (969.3%) stddev-sans-first:35581.44 03:59:45 INFO - PROCESS | 28911 | Values: 788.7 810.0 821.9 834.3 888.9 16279.3 16304.8 16323.4 16375.5 16550.9 16197.5 16340.3 16346.3 16356.0 16357.4 715.8 739.8 854.6 863.4 897.1 880.2 883.4 883.5 883.6 883.7 939.2 939.3 940.0 940.1 940.7 764.0 785.2 787.8 790.5 936.5 658.4 674.6 674.9 678.4 678.9 16420.1 16450.5 16471.3 16492.1 16514.1 15281.5 15401.5 15601.0 15788.5 15874.4 14408.6 14494.4 14557.9 14977.6 15559.1 4649.8 4674.7 4765.7 4818.9 4886.6 82621.0 85589.0 86365.6 86931.7 87863.6 12175.9 12280.9 12284.6 12576.1 12609.3 23630.6 23691.0 23741.4 23816.4 23951.8 9093.4 9118.2 9424.3 9603.2 9709.2 4964.1 5035.4 5066.2 5091.5 5128.1 3614.0 3715.7 3716.1 3716.8 3718.1 660.4 668.9 670.9 685.6 728.9 643.7 747.5 769.8 785.5 810.6 10899.6 10918.3 11091.9 11112.3 11451.8 703.0 767.5 796.1 801.9 813.7 5441.1 5536.4 5552.1 5618.9 5667.9 131633.0 132120.3 136430.0 137226.3 139259.0 115708.0 116144.4 117451.0 117824.0 121831.0 100819.0 103299.0 104032.0 105919.5 107581.5 9673.9 9794.3 9833.3 9865.4 9879.9 56614.4 57043.4 58302.4 58633.0 58743.4 84593.6 91038.5 91576.0 92529.0 94162.5 11397.8 12165.5 12183.5 12557.7 12628.0 13398.8 14389.6 14959.9 14991.3 15127.4 14467.9 15297.2 15323.8 16301.6 16531.9 15153.8 15427.3 16377.9 16399.5 16491.8 13655.2 14676.0 14877.0 14988.5 16430.4 11825.3 12034.8 12050.3 13287.1 13405.7 13176.3 13330.1 13439.1 13495.5 13688.2 03:59:45 INFO - PROCESS | 28911 | -------- Summary: end -------- 03:59:45 INFO - PROCESS | 28911 | 03:59:46 INFO - TEST-INFO | 28911: exit 0 03:59:46 INFO - TEST-OK | dromaeo_css | took 1113741ms 03:59:46 INFO - TEST-START | kraken 03:59:46 INFO - operating with platform_type : linux_ 03:59:46 INFO - Initialising browser for kraken test... 03:59:46 INFO - TEST-INFO | started process 29231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUBnhDu/profile http://localhost:58182/getInfo.html) 03:59:49 INFO - PROCESS | 29231 | __metrics Screen width/height:1600/1200 03:59:49 INFO - PROCESS | 29231 | colorDepth:24 03:59:49 INFO - PROCESS | 29231 | Browser inner width/height: 1024/697 03:59:49 INFO - PROCESS | 29231 | __metrics 03:59:50 INFO - PROCESS | 29231 | 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:59:50 INFO - PROCESS | 29231 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:51 INFO - PROCESS | 29231 | console.error: PushService: 03:59:51 INFO - PROCESS | 29231 | stateChangeProcessEnqueue: Error transitioning state 03:59:51 INFO - PROCESS | 29231 | UnknownError 03:59:51 INFO - TEST-INFO | 29231: exit 0 03:59:51 INFO - Browser initialized. 03:59:51 INFO - Running cycle 1/1 for kraken test... 03:59:51 INFO - TEST-INFO | started process 29324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUBnhDu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:03 INFO - PROCESS | 29324 | RSS: Main: 145268736 04:00:03 INFO - PROCESS | 29324 | 04:00:05 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58182/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:06 INFO - PROCESS | 29324 | RSS: Main: 186978304 04:00:06 INFO - PROCESS | 29324 | 04:00:09 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58182/tests/kraken/driver.html?testName=audio-dft) 04:00:09 INFO - PROCESS | 29324 | RSS: Main: 175816704 04:00:09 INFO - PROCESS | 29324 | 04:00:12 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58182/tests/kraken/driver.html?testName=audio-fft) 04:00:13 INFO - PROCESS | 29324 | RSS: Main: 267300864 04:00:13 INFO - PROCESS | 29324 | 04:00:15 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58182/tests/kraken/driver.html?testName=audio-oscillator) 04:00:15 INFO - PROCESS | 29324 | RSS: Main: 173518848 04:00:15 INFO - PROCESS | 29324 | 04:00:17 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58182/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:18 INFO - PROCESS | 29324 | RSS: Main: 175390720 04:00:18 INFO - PROCESS | 29324 | 04:00:21 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58182/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:22 INFO - PROCESS | 29324 | RSS: Main: 210423808 04:00:22 INFO - PROCESS | 29324 | 04:00:25 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58182/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:26 INFO - PROCESS | 29324 | RSS: Main: 209645568 04:00:26 INFO - PROCESS | 29324 | 04:00:28 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58182/tests/kraken/driver.html?testName=json-parse-financial) 04:00:29 INFO - PROCESS | 29324 | RSS: Main: 209289216 04:00:29 INFO - PROCESS | 29324 | 04:00:30 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58182/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:31 INFO - PROCESS | 29324 | RSS: Main: 171806720 04:00:31 INFO - PROCESS | 29324 | 04:00:33 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58182/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:33 INFO - PROCESS | 29324 | RSS: Main: 180289536 04:00:33 INFO - PROCESS | 29324 | 04:00:35 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58182/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:36 INFO - PROCESS | 29324 | RSS: Main: 189022208 04:00:36 INFO - PROCESS | 29324 | 04:00:38 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:39 INFO - PROCESS | 29324 | RSS: Main: 197820416 04:00:39 INFO - PROCESS | 29324 | 04:00:42 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:42 INFO - PROCESS | 29324 | RSS: Main: 194146304 04:00:42 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | Cycle 1(1): loaded http://localhost:58182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58182/tests/kraken/driver.html?testName=ai-astar) 04:00:44 INFO - PROCESS | 29324 | RSS: Main: 246083584 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | __start_tp_report 04:00:44 INFO - PROCESS | 29324 | _x_x_mozilla_page_load 04:00:44 INFO - PROCESS | 29324 | _x_x_mozilla_page_load_details 04:00:44 INFO - PROCESS | 29324 | |i|pagename|runs| 04:00:44 INFO - PROCESS | 29324 | |0;ai-astar;109;110;111;109;109;110;110;110;110;110 04:00:44 INFO - PROCESS | 29324 | |1;audio-beat-detection;148;120;121;150;117;119;117;120;156;116 04:00:44 INFO - PROCESS | 29324 | |2;audio-dft;161;160;161;160;161;161;160;162;162;163 04:00:44 INFO - PROCESS | 29324 | |3;audio-fft;76;75;75;107;75;76;75;75;101;74 04:00:44 INFO - PROCESS | 29324 | |4;audio-oscillator;83;82;107;82;82;83;105;83;83;107 04:00:44 INFO - PROCESS | 29324 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;116;116 04:00:44 INFO - PROCESS | 29324 | |6;imaging-darkroom;146;146;146;147;146;146;146;146;145;145 04:00:44 INFO - PROCESS | 29324 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 04:00:44 INFO - PROCESS | 29324 | |8;json-parse-financial;50;50;50;48;49;50;49;49;48;50 04:00:44 INFO - PROCESS | 29324 | |9;json-stringify-tinderbox;59;60;59;59;59;60;58;58;61;59 04:00:44 INFO - PROCESS | 29324 | |10;stanford-crypto-aes;72;79;74;75;72;72;72;75;72;77 04:00:44 INFO - PROCESS | 29324 | |11;stanford-crypto-ccm;122;124;136;133;129;119;120;129;158;123 04:00:44 INFO - PROCESS | 29324 | |12;stanford-crypto-pbkdf2;151;149;150;150;154;152;152;160;149;147 04:00:44 INFO - PROCESS | 29324 | |13;stanford-crypto-sha256-iterative;62;63;67;61;62;61;62;62;62;60 04:00:44 INFO - PROCESS | 29324 | __end_tp_report 04:00:44 INFO - PROCESS | 29324 | __start_cc_report 04:00:44 INFO - PROCESS | 29324 | _x_x_mozilla_cycle_collect,1558 04:00:44 INFO - PROCESS | 29324 | __end_cc_report 04:00:44 INFO - PROCESS | 29324 | __startTimestamp1476183644533__endTimestamp 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | ------- Summary: start ------- 04:00:44 INFO - PROCESS | 29324 | Number of tests: 14 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 04:00:44 INFO - PROCESS | 29324 | Values: 109.0 110.0 111.0 109.0 109.0 110.0 110.0 110.0 110.0 110.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:120.50 stddev:16.02 (13.3%) stddev-sans-first:15.34 04:00:44 INFO - PROCESS | 29324 | Values: 148.0 120.0 121.0 150.0 117.0 119.0 117.0 120.0 156.0 116.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 04:00:44 INFO - PROCESS | 29324 | Values: 161.0 160.0 161.0 160.0 161.0 161.0 160.0 162.0 162.0 163.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.27 (16.4%) stddev-sans-first:12.89 04:00:44 INFO - PROCESS | 29324 | Values: 76.0 75.0 75.0 107.0 75.0 76.0 75.0 75.0 101.0 74.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.50 stddev:11.50 (13.9%) stddev-sans-first:11.94 04:00:44 INFO - PROCESS | 29324 | Values: 83.0 82.0 107.0 82.0 82.0 83.0 105.0 83.0 83.0 107.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:00:44 INFO - PROCESS | 29324 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:00:44 INFO - PROCESS | 29324 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 145.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:00:44 INFO - PROCESS | 29324 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#8] json-parse-financial Cycles:10 Average:49.30 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 04:00:44 INFO - PROCESS | 29324 | Values: 50.0 50.0 50.0 48.0 49.0 50.0 49.0 49.0 48.0 50.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 04:00:44 INFO - PROCESS | 29324 | Values: 59.0 60.0 59.0 59.0 59.0 60.0 58.0 58.0 61.0 59.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.50 stddev:2.49 (3.3%) stddev-sans-first:2.54 04:00:44 INFO - PROCESS | 29324 | Values: 72.0 79.0 74.0 75.0 72.0 72.0 72.0 75.0 72.0 77.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:129.00 stddev:11.53 (8.9%) stddev-sans-first:11.92 04:00:44 INFO - PROCESS | 29324 | Values: 122.0 124.0 136.0 133.0 129.0 119.0 120.0 129.0 158.0 123.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.40 Median:151.50 stddev:3.60 (2.4%) stddev-sans-first:3.81 04:00:44 INFO - PROCESS | 29324 | Values: 151.0 149.0 150.0 150.0 154.0 152.0 152.0 160.0 149.0 147.0 04:00:44 INFO - PROCESS | 29324 | 04:00:44 INFO - PROCESS | 29324 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.87 (3.0%) stddev-sans-first:1.99 04:00:44 INFO - PROCESS | 29324 | Values: 62.0 63.0 67.0 61.0 62.0 61.0 62.0 62.0 62.0 60.0 04:00:44 INFO - PROCESS | 29324 | -------- Summary: end -------- 04:00:44 INFO - PROCESS | 29324 | 04:00:45 INFO - TEST-INFO | 29324: exit 0 04:00:45 INFO - TEST-OK | kraken | took 59387ms 04:00:45 INFO - SUITE-END | took 1173s 04:00:45 INFO - Completed test suite (00:19:33) 04:00:45 INFO - javascript benchmark 04:00:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3161.430942430363, 3220.7423406127514, 3233.6119665640113, 3249.074013906037, 3269.2971011232594, 5664.5468362531, 5770.3075630924295, 5770.711464426783, 5785.247917770695, 5806.651600903949, 5671.234383358255, 5716.8284951451415, 5754.424557544244, 5756.280464941882, 5756.625819321741, 5197.584193264549, 5208.244804503344, 5211.42674305826, 5238.371395432534, 5287.682739035651, 5073.644844860862, 5086.694798312114, 5289.0, 5303.178007408857, 5329.333833270841, 5149.124648809692, 5149.845504634867, 5173.224016397533, 5182.922256166161, 5194.558462530689, 5226.947730522703, 5231.163013917774, 5282.920756188661, 5293.444188360205, 5320.680759154463, 4959.876003099916, 5134.358205224347, 5199.974000129975, 5248.422673505911, 5263.157894736823, 5425.9728701356635, 5436.945630543683, 5486.0, 5561.5272701820395, 5657.886842263173, 5835.066389377679, 5835.883282334329, 5953.987822070215, 5957.106434034886, 5958.7616495340135, 5781.392953739839, 5976.46211840932, 6006.399360063959, 6006.729697163638, 6007.189029481008, 5452.563794896439, 5661.7735290588735, 5707.543396528268, 5734.2258795062135, 5760.308762948473, 6308.323815318929, 6335.461485773761, 6339.619622822645, 6345.650989195638, 6346.0, 5795.623284486495, 6064.575479716377, 6080.7567697291615, 6083.7870674526175, 6099.9085013724825, 5934.940650593525, 6058.4244496772735, 6095.603785753912, 6099.3900609938655, 6148.354422785633, 6119.804644672563, 6120.262154551624, 6124.036419119016, 6126.641866217211, 6128.811800681408, 6104.511639068864, 6114.084479019511, 6122.20411346531, 6129.295131059986, 6138.508919286535, 4528.252838281713, 4557.134144512532, 4578.061497393093, 4614.861554153381, 4615.215413379734, 4120.320147175742, 4124.608162224584, 4127.587241275908, 4130.752154870717, 4148.253314403436, 5785.739641716133, 5786.276715410574, 5793.8551536211935, 5795.594308398456, 5800.187973683687, 5833.533317334688, 5881.558883083786, 6136.20229370179, 6140.754369825157, 6162.506999440034, 5805.071188609802, 5807.68057756819, 5810.273715785527, 5814.418558144152, 5851.444112809277, 5278.49854263852, 5283.313169287968, 5288.867778305573, 5289.550388217045, 5292.311999440049, 6135.630783975157, 6200.968995155085, 6225.190725205875, 6309.242890853127, 6363.0, 6155.0, 6222.439980401786, 6227.252729672287, 6231.781887633911, 6232.594881332699, 6368.681565921593, 6373.968130159505, 6384.425401713868, 6384.712687928962, 6389.233292004803, 5839.299284085767, 5952.97023514897, 6060.757569697163, 6060.818175454743, 6075.544334175043, 6040.486558642565, 6093.75624974996, 6110.480609148094, 6137.508999280136, 6155.47678447337, 5946.554008449297, 5992.250968628921, 5992.820215393545, 5994.610350327215, 6013.548983826318, 5758.942410576008, 5950.732217050157, 5978.4021597839865, 5981.1327357532045, 5981.970090149522, 5794.768209271582, 5795.043817770189, 5810.099434587646, 5840.678762668094, 5950.880982380241, 5960.105984102419, 5982.282126144891, 6013.338532761481, 6013.759449621966, 6023.1567580537885, 5586.888262234814, 5616.66300022, 5840.707964601668, 5844.649321040752, 5845.649261044351], "value": 5607.94238156726, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.7731084876899, 607.2409488139825, 646.3375040583403, 658.8122385120241, 660.5442244851049, 33707.15732106699, 46746.53253467464, 47541.0, 47541.28688069682, 47592.762036189815, 48776.2683559746, 49272.2609160862, 49275.75362123193, 49295.26057109137, 49330.75334623331, 8494.0, 9370.625174992992, 9522.0954009369, 9533.237341012737, 9535.95232023839, 8406.83186336273, 10962.068224200913, 11321.886781132207, 11343.886561134406, 11697.239679420853, 11460.426978651076, 11512.654620361403, 11526.250793698424, 11528.365939873303, 11543.422828858565, 8559.828803423896, 8807.295416366675, 10874.510647020863, 10936.726581835439, 10940.23418360715, 8686.652533898636, 10745.62390316343, 11137.220394572383, 11140.941610546985, 11526.481308341145, 45325.32012019822, 45543.0, 45561.08877822425, 45563.31655025177, 45727.08545829065, 3839.2897313996723, 3983.382575700771, 4195.244855925932, 4228.725132866354, 4486.057927835159, 34167.48748768771, 34555.82722086398, 34629.30741385158, 35038.649613503796, 35698.464523031915, 4606.401167848192, 4654.138984287918, 4658.068386322715, 4682.08699303636, 4685.953140468586, 355183.99999999744, 356511.0, 356877.0, 358537.0, 359647.0, 40060.79969600133, 40514.0, 41059.38410923839, 64109.679451602446, 64818.67590662016, 43066.569334306885, 43083.0, 43203.35194972078, 43211.78394108072, 43230.35154472685, 17907.0, 18068.18693158811, 18121.275148993893, 18124.093795310444, 18127.818721812877, 13436.395362208725, 13596.864031359757, 13924.930375348058, 14291.213983231022, 14407.567772966828, 9590.08894155054, 9625.0, 9660.130588247092, 9776.902230977741, 9792.55933482995, 3580.7672501287334, 3687.483752274684, 3689.6679298863232, 3723.553173619183, 3757.812109394519, 1029.7013865978931, 1120.3613940054254, 1133.52958522214, 1149.3391300002531, 1186.211169572242, 35173.64826351755, 35315.851848900995, 35474.46788298178, 35758.8212058938, 36086.639133608856, 1101.9669409917715, 1157.571698471571, 1216.2216181643578, 1227.0796902323257, 1286.88684288092, 17213.31146754116, 18314.26742930268, 18404.815951840577, 18586.628267434575, 18619.255229790655, 609307.0, 609519.0, 615985.0, 616534.0, 620012.0, 63999.680001600624, 64184.0, 64408.35591644117, 64481.0, 64497.0, 1357.966050848717, 1402.9017968742294, 1435.2464955898029, 1437.367558274356, 1477.7783332499996, 33833.83083084569, 35847.82076089603, 36234.637653623126, 36240.637593623724, 36369.90890273296, 55419.16871247015, 55649.721751390985, 56307.0, 56345.43654563402, 56464.717676411354, 451377.0, 455361.0, 456079.0, 457320.0, 803700.0, 48315.275270871665, 48698.26952595643, 50027.749861250464, 50138.247926280404, 50798.0, 54713.72643136759, 55113.44886551244, 55476.44523554713, 55530.0, 55563.72218138883, 42887.0, 44312.335314970944, 45200.32199516944, 46007.0, 47147.0, 45305.77347113243, 46130.308045380014, 46412.76793616146, 47619.523804762895, 48168.5183148164, 45524.54475455203, 46097.078058437975, 46502.76748616235, 46627.0, 48571.27143092786, 38404.0, 40904.590954090076, 41638.791806040776, 41665.0, 42038.36942445927, 30884.0, 30931.0, 31099.222519437197, 31182.37635247328, 31589.52615710812], "value": 21281.556595777452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.2728393398114, 428.07579928222646, 436.48276792001474, 442.08884495596504, 447.38037817622603, 16543.917280413596, 18872.150753216105, 20521.179152833905, 21082.051307691152, 21166.89416552915, 20021.399358019284, 20777.896110519425, 20834.166633334688, 20836.8958155209, 21063.2627858025, 5844.1818145459665, 5885.558583106263, 6096.116063170837, 6103.938960610403, 6104.877902441948, 5946.970265148668, 5968.1346204800275, 6000.159977603139, 6007.0, 6039.184710064151, 5765.164051212571, 5953.3748956359605, 5969.0, 5984.0, 5986.551008674345, 5939.990201665727, 5958.404159584029, 5977.551683623746, 5980.581359304851, 6001.819945401667, 5255.211718242256, 5335.759890804923, 5359.169328754049, 5379.542738867201, 5383.16560933056, 22775.316740497812, 23321.0, 23488.412789680395, 24714.505709885703, 24848.627270590954, 2299.1378233162563, 2435.366804630791, 2457.4225057111566, 2564.512742578904, 2932.501474749298, 10361.585536578528, 10402.583896644124, 10905.890941090567, 11165.776684466346, 11251.606193783178, 1988.5923385705896, 1997.9100940457715, 2004.3085135628185, 2014.446027342478, 2085.1450905128822, 88467.0, 88670.0, 93517.53241233819, 95560.0, 95993.52003240009, 9888.604455821687, 10591.928340781087, 10668.413237271869, 12026.939865300617, 12338.136330456962, 15539.689206215813, 15856.60358491047, 16651.084190369646, 16804.411845585346, 16824.831751682326, 9000.8649870252, 9152.084791520927, 9175.954120229357, 9286.0, 9326.0, 8608.655653773903, 8811.251043661361, 8896.59965301563, 8957.820843583091, 9040.773980650536, 5146.897062058738, 5246.947530524646, 5262.394824595144, 5269.814291784394, 5384.9730751346, 2150.7096541966635, 2175.8912054397533, 2178.1396348442277, 2188.507585793184, 2194.133317339674, 936.6674830435097, 1026.2303272545591, 1059.7668512927144, 1061.3525749292926, 1081.2755453845941, 19959.800401996086, 20592.0, 20597.176112955614, 20876.269330573356, 20918.686219706717, 1031.7008067660295, 1044.5247412427327, 1076.4079756134095, 1088.7495875948418, 1099.4008265495324, 10415.218858585637, 11361.602343917923, 11363.886361136283, 11474.0, 11479.4260286987, 478164.0, 479928.0, 491855.0, 498040.0, 505515.0, 94394.52802735943, 94731.52634236784, 95141.52429237949, 97399.0, 97659.0, 1021.4280003198232, 1055.7096798380508, 1121.7924683933497, 1132.116948779953, 1140.948657310423, 17808.198631061376, 17878.0, 18239.908800455913, 18435.631287373908, 18505.444836654922, 42507.18161506553, 43251.0, 43713.12573748571, 43753.34369984389, 44257.33613995857, 56114.71942640424, 56243.718781405834, 56945.0, 61954.38045619666, 62599.37400625936, 12714.936425317814, 12744.362781861055, 13085.214887106804, 13131.60605181846, 13168.539101131415, 14970.775438368652, 15225.314860831511, 15324.0, 15327.0, 15708.76436853471, 6308.905366419415, 9073.775040369466, 12525.93737031309, 13549.86450135486, 13578.524751633646, 12850.807237891253, 13325.267110308638, 13327.200367977952, 13583.79624305656, 13659.726805464034, 7936.6428510718315, 12660.0, 13447.260400677666, 13515.0, 13743.725125497635, 13554.728905422033, 13583.117097388638, 13719.862801371859, 13731.656708582366, 14080.0, 12942.80585791195, 13087.607371778862, 13107.0, 13201.801972970605, 13532.188068715908], "value": 9993.243794450766, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.7708789505782, 1497.348653335799, 1542.0439327616875, 1648.3159488812144, 1809.918553665085, 8245.422820402575, 9061.411008284465, 9393.90606093939, 9400.62397504099, 9672.61309547619, 9451.763705907355, 9533.285003624722, 9536.761580960461, 9539.236861051117, 9541.475218862959, 2552.808539359546, 2577.613357996306, 2581.6256642786784, 2582.5738753105716, 2583.7287084856102, 2569.075132952136, 2637.9472410551775, 2638.2217245912407, 2639.8944042238286, 2642.537555927705, 2543.74562543746, 2547.197632745679, 2586.0560895273184, 2590.4689538644625, 2591.870406479678, 2505.749425057498, 2522.4198434360014, 2535.8732063396756, 2536.657551230588, 2542.6058960861096, 2441.438469152105, 2453.0800949643885, 2465.0755966512556, 2511.748825117492, 2514.371407148213, 9326.673566425143, 9537.52312384385, 9551.90448095517, 9672.081152290591, 9676.661316853946, 5742.856428589277, 5923.822285331447, 5968.820935371902, 5976.372480889488, 5986.640801551921, 3731.2350968051483, 3820.789856557888, 3829.215010922782, 3886.805659717031, 3893.493845800028, 1303.0683061610994, 1315.7763180259378, 1319.083237150181, 1331.2944139606025, 1353.810466534686, 13430.865691343157, 13683.04218704691, 13688.52090176849, 13695.589132325946, 13708.3831227595, 4894.902101958012, 5055.368078990126, 5175.404828444702, 5196.350456192976, 5214.0875346814155, 10542.894571054192, 10545.894541054644, 10554.630587929385, 10556.0, 10558.155347572176, 5876.059830427112, 5877.118432235199, 5880.323762767336, 5883.294004719461, 5884.823455296348, 4712.410948631421, 4797.304390863305, 5375.247465354853, 5435.42927992563, 5501.0, 4213.599708027732, 4235.2800023996, 4297.91404171921, 4340.544242854518, 4354.216241076637, 1305.934703264852, 1335.9732805344033, 1338.3642769684323, 1344.2405041151717, 1344.6302266876492, 902.8510295801119, 1060.8090543702208, 1061.9734506637396, 1087.9075278601408, 1091.5633746501462, 6513.706883190268, 6653.168353955755, 6682.866342673216, 6843.965780171067, 6966.9303306967295, 525.569033392622, 529.5895680847298, 530.4271386902136, 530.6656806212139, 535.7803300646716, 4616.515265897033, 4643.86068417948, 4676.95323046772, 4739.075880203396, 4748.406449193851, 11826.76346473083, 12121.878781212252, 12204.511819527297, 12229.0, 12259.019278457701, 11536.307821530734, 12023.398830058637, 12043.0, 12111.091668124925, 12386.81419778704, 8907.866382004275, 9074.364794464456, 9090.409123406956, 9113.134252246025, 9113.544322783835, 6504.15445992018, 6915.792526224222, 6921.134858142732, 6960.129983752031, 7011.894821577783, 11292.43537823122, 11346.262492937933, 11555.537778488766, 11561.942190288995, 11581.594644187413, 11497.712557186138, 11509.251898626562, 11551.826722599, 11630.302181869114, 11667.766644667228, 7658.195889431529, 7938.960305198437, 8220.424570280024, 8637.740867773977, 8767.60545775429, 9255.398399104037, 9628.18160456369, 9628.66299679536, 9632.614695412105, 9635.421874687541, 8496.957515212385, 8532.530710810965, 8536.74389768308, 8540.74377768668, 8595.226429621114, 8096.635651395819, 8132.308753755997, 8142.51144931306, 8144.796380090308, 8291.917080829357, 7718.845623087619, 7755.72854950074, 7851.175626559358, 7873.015873015873, 7878.803029924297, 5664.688442135722, 5819.243498345188, 5842.766289348378, 5898.498627616701, 5923.911141332969, 5823.5923485355615, 5839.649621022752, 5904.0, 5969.52243820502, 5997.16039754426], "value": 5021.345578002094, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.28241768659285, 354.45591017787694, 366.98715544955917, 369.1343798791832, 370.7275152762721, 5625.578081643877, 5677.914831277534, 5693.747375577376, 5696.287964004505, 5736.0, 5286.550643195333, 5537.6954267515375, 5539.972300138504, 5616.129499927508, 5632.155176723493, 3912.3349030664785, 4251.80866860992, 4394.97802510987, 4397.362382454542, 4406.955930440703, 4400.273954797454, 4407.449068866392, 4421.182081314967, 4450.354698568722, 4456.59890609845, 4388.297872340426, 4411.1398277335775, 4419.779011049451, 4429.269170586849, 4429.5348988356245, 4052.675785937133, 4134.586541345871, 4314.80583373749, 4332.566743325674, 4382.0, 3851.5378154621344, 3864.9227015459815, 3891.708121890841, 3898.941515877264, 3904.609539046101, 5461.481159289861, 5471.37079235889, 5494.066008778477, 5498.972505137449, 5508.889822203533, 4907.2393778964315, 5001.349824522825, 5005.774740136702, 5047.167217409123, 5055.443901170868, 5755.251817263771, 5771.855703607402, 5773.0, 5775.826725198251, 5786.826395208151, 4283.721558098714, 4300.763458009808, 4307.203167414007, 4326.329418940069, 4327.900968030503, 5801.795317779217, 5850.502707269887, 5934.792282270143, 6100.877982440371, 6149.200603921507, 4255.170241802881, 4374.475062992397, 4379.627731642782, 4393.319035549495, 4416.779161041935, 4419.801108950105, 4452.532484089189, 4453.643708503312, 4471.374007638933, 4475.813909313969, 4961.6526843121355, 5008.248762685554, 5051.924221136685, 5063.683442305027, 5071.833478300012, 5890.49930755882, 5934.19888315072, 5939.287285525765, 5951.732172052268, 5968.820935371946, 1522.5584580471539, 1542.2365928865283, 1551.534539638104, 1558.7194305025205, 1561.843815618429, 945.4941606240628, 986.9161121304626, 990.4153354632674, 994.5623925472769, 1009.9091081802673, 5005.899882002413, 5069.543741063322, 5071.808125090601, 5074.23886417033, 5082.288479612857, 5269.235960785664, 5277.340332458442, 5295.947040529622, 5305.575553955674, 5307.124324486416, 4886.82896098642, 5019.749012549358, 5027.497250274943, 5047.621428392885, 5083.440821509631, 2807.7753779697982, 2812.1282402454895, 2840.261532001653, 2853.429314137181, 2858.1139846647607, 5446.564274858002, 5448.972755136199, 5492.633356481527, 5495.890082198413, 5537.667739935536, 5298.284731561267, 5391.110466773017, 5394.894046720413, 5412.621116521806, 5495.505404513533, 5432.456754324536, 5513.696746678891, 5520.751566179531, 5526.530244929146, 5534.4742249486235, 5179.585633149414, 5181.455947125648, 5310.442403547727, 5317.059273365271, 5617.264519094756, 5983.341832398346, 5992.580519363602, 6000.969995150171, 6009.639421634541, 6019.458248757633, 5944.762209511571, 6080.510274982657, 6102.877942441215, 6248.281447633399, 6248.375162483715, 4377.737335759864, 4411.889702757457, 4413.757243351646, 4419.933700994552, 4425.977870110629, 5733.741981610921, 6132.8773424532155, 6138.907916381348, 6139.140520327247, 6141.508679305734, 5812.680302583399, 5818.476337129509, 5930.703464826827, 5945.851353716192, 5950.166976623363, 5906.228131560601, 5912.935671579157, 5926.318473375617, 5927.555433342603, 5933.169356290036, 5680.68756218412, 5842.561807864512, 5849.795257165979, 5865.765369385177, 5897.174395584708, 5926.822195334147, 5929.495992840657, 5963.940360596339, 5983.072623743326, 5987.161797348288, 5684.687342196219, 5692.573057020657, 5815.244018277597, 5828.76684932598, 5837.67892765902], "value": 4383.5137604800975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.668759121169, 810.0481933727868, 821.852066628007, 834.2616784146037, 888.857782754759, 16279.267432965515, 16304.798852154956, 16323.428679996203, 16375.508734737978, 16550.91724541377, 16197.514074577752, 16340.264688089035, 16346.34614615417, 16356.0, 16357.427490037851, 715.81746654603, 739.7780665800266, 854.6410507586797, 863.3783675753463, 897.0625696147541, 880.2034159086005, 883.3772190605607, 883.4699180491718, 883.6465413834453, 883.6553744039829, 939.229831538139, 939.2955283537347, 940.0458534587399, 940.1022023967095, 940.666063547441, 763.9885401718979, 785.19909692114, 787.7518581646821, 790.4506368074191, 936.4989730494187, 658.427168363522, 674.6188403552027, 674.9493787965873, 678.372505432473, 678.9422899053586, 16420.096894670787, 16450.506484805475, 16471.34114635413, 16492.092934888577, 16514.091724955124, 15281.465148719853, 15401.460948866848, 15600.988675979817, 15788.526344209693, 15874.444394446255, 14408.567742967727, 14494.42022319106, 14557.927210363987, 14977.625559360995, 15559.144247066406, 4649.8372556960685, 4674.696144750615, 4765.737884416356, 4818.855434336975, 4886.60907127429, 82621.0, 85589.0, 86365.56817215937, 86931.69602456031, 87863.56068219618, 12175.939120304341, 12280.938595306967, 12284.570040048555, 12576.056795740356, 12609.30648814324, 23630.64554031691, 23691.0, 23741.406464838517, 23816.404589885045, 23951.7604823953, 9093.40892841963, 9118.179363857285, 9424.340296179202, 9603.183729383081, 9709.174720148725, 4964.081644895634, 5035.395752509722, 5066.16408292635, 5091.516305950929, 5128.051310507568, 3613.9880833366174, 3715.702743780491, 3716.089558058239, 3716.7955762432784, 3718.0890681783135, 660.3957378998259, 668.8963210702349, 670.8960111182774, 685.5852209413333, 728.8505856299446, 643.6868787673094, 747.4543583184197, 769.819092513259, 785.5051317669946, 810.6271115286916, 10899.564017439372, 10918.344899306067, 11091.944540277409, 11112.333260004425, 11451.828222576669, 702.9894551581731, 767.5279702982625, 796.1083586383288, 801.8636831738619, 813.6867306087199, 5441.129419292894, 5536.446355364431, 5552.111662134039, 5618.91571626426, 5667.914981275284, 131633.0, 132120.3393983024, 136430.0, 137226.31386843, 139259.0, 115708.0, 116144.41927790476, 117451.0, 117824.0, 121831.0, 100819.0, 103299.0, 104032.0, 105919.47040264904, 107581.46209268903, 9673.854892176763, 9794.314397992071, 9833.311668183158, 9865.358751681119, 9879.901200988186, 56614.433855660915, 57043.42956570381, 58302.4169758297, 58633.0, 58743.4125658738, 84593.57703211691, 91038.54480727554, 91576.0, 92529.0, 94162.52918735362, 11397.829032564685, 12165.452554634885, 12183.451744671689, 12557.686057848627, 12628.0, 13398.789199781926, 14389.568312950629, 14959.92520037393, 14991.2504374783, 15127.39490420415, 14467.92766036163, 15297.235138243266, 15323.77014344808, 16301.59246018859, 16531.91734041322, 15153.772693409828, 15427.305771240097, 16377.918110409371, 16399.508014759576, 16491.83508164903, 13655.180689158682, 14676.0, 14877.0, 14988.47540336083, 16430.424935127212, 11825.349605771766, 12034.75930481403, 12050.337231452004, 13287.13633613812, 13405.731885362433, 13176.298858734128, 13330.133541319783, 13439.126456780277, 13495.460181592627, 13688.178709277077], "value": 8354.88530203403, "unit": "score"}], "name": "dromaeo_css", "value": 7765.867013446111, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 111.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 121.0, 150.0, 117.0, 119.0, 117.0, 120.0, 156.0, 116.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 162.0, 162.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 107.0, 75.0, 76.0, 75.0, 75.0, 101.0, 74.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 107.0, 82.0, 82.0, 83.0, 105.0, 83.0, 83.0, 107.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 48.0, 49.0, 50.0, 49.0, 49.0, 48.0, 50.0], "value": 49.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 58.0, 58.0, 61.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 74.0, 75.0, 72.0, 72.0, 72.0, 75.0, 72.0, 77.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 136.0, 133.0, 129.0, 119.0, 120.0, 129.0, 158.0, 123.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 150.0, 150.0, 154.0, 152.0, 152.0, 160.0, 149.0, 147.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 67.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 60.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1453.0, "alertThreshold": 2.0}]} 04:00:45 INFO - Return code: 0 04:00:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:45 INFO - # TBPL SUCCESS # 04:00:45 INFO - Running post-action listener: _resource_record_post_action 04:00:45 INFO - [mozharness: 2016-10-11 11:00:45.867289Z] Finished run-tests step (success) 04:00:45 INFO - Running post-run listener: _resource_record_post_run 04:00:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 375529472; Read time: 20; Write time: 214480 04:00:45 INFO - TinderboxPrint: CPU usage
13.0% 04:00:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:00:45 INFO - TinderboxPrint: I/O write bytes / time
375,529,472 / 214,480 04:00:45 INFO - TinderboxPrint: CPU idle
8,263.7 (87.0%) 04:00:45 INFO - TinderboxPrint: CPU user
1,190.3 (12.5%) 04:00:45 INFO - TinderboxPrint: Swap in / out
0 / 0 04:00:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108150784; Read time: 0; Write time: 94908 04:00:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 250544128; Read time: 0; Write time: 115536 04:00:46 INFO - Running post-run listener: _upload_blobber_files 04:00:46 INFO - Blob upload gear active. 04:00:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:46 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 04:00:46 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'] 04:00:46 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 04:00:46 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:50 INFO - (blobuploader) - INFO - Done attempting. 04:00:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:00:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:00:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:50 INFO - (blobuploader) - INFO - Done attempting. 04:00:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:00:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:00:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:51 INFO - (blobuploader) - INFO - Done attempting. 04:00:51 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:51 INFO - Return code: 0 04:00:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/676375091b8fca93974cf316cd89ac6d395ea5511a931f19795db77f348384a0644860ed4130e59f84a4d6bbd0dbd0e89e6d1f1ff4c96206bf3f36e6682a7321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bddacd46b50f25fca8f2adad9d0b6f9ecc50d737d5ae045591cfcedf91c33abfa9842a2990b4892703e3ea2feb87b36eea90f5903e90e994f0da9332e6912af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf0bfa11eab7804fb422d6797c20cad14b0fe6e71dfe5e7b946f83e3718ac0a0dcf294d01d1cd0f9113424c5fb0dcef3a2384159296fde5f135defbdc79da813"} 04:00:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:51 INFO - Contents: 04:00:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/676375091b8fca93974cf316cd89ac6d395ea5511a931f19795db77f348384a0644860ed4130e59f84a4d6bbd0dbd0e89e6d1f1ff4c96206bf3f36e6682a7321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bddacd46b50f25fca8f2adad9d0b6f9ecc50d737d5ae045591cfcedf91c33abfa9842a2990b4892703e3ea2feb87b36eea90f5903e90e994f0da9332e6912af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf0bfa11eab7804fb422d6797c20cad14b0fe6e71dfe5e7b946f83e3718ac0a0dcf294d01d1cd0f9113424c5fb0dcef3a2384159296fde5f135defbdc79da813"} 04:00:51 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:51 INFO - Copying logs to upload dir... 04:00:51 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.335843 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-11 04:00:50.498196) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 04:00:50.502046) ========= 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=1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103 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/676375091b8fca93974cf316cd89ac6d395ea5511a931f19795db77f348384a0644860ed4130e59f84a4d6bbd0dbd0e89e6d1f1ff4c96206bf3f36e6682a7321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bddacd46b50f25fca8f2adad9d0b6f9ecc50d737d5ae045591cfcedf91c33abfa9842a2990b4892703e3ea2feb87b36eea90f5903e90e994f0da9332e6912af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf0bfa11eab7804fb422d6797c20cad14b0fe6e71dfe5e7b946f83e3718ac0a0dcf294d01d1cd0f9113424c5fb0dcef3a2384159296fde5f135defbdc79da813"} build_url:https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011777 build_url: 'https://queue.taskcluster.net/v1/task/N3cL0ORIR5SyaNWv7vqa3w/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/676375091b8fca93974cf316cd89ac6d395ea5511a931f19795db77f348384a0644860ed4130e59f84a4d6bbd0dbd0e89e6d1f1ff4c96206bf3f36e6682a7321", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bddacd46b50f25fca8f2adad9d0b6f9ecc50d737d5ae045591cfcedf91c33abfa9842a2990b4892703e3ea2feb87b36eea90f5903e90e994f0da9332e6912af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf0bfa11eab7804fb422d6797c20cad14b0fe6e71dfe5e7b946f83e3718ac0a0dcf294d01d1cd0f9113424c5fb0dcef3a2384159296fde5f135defbdc79da813"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 04:00:50.526958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:00:50.527245) ========= 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=1f5564757af27664ca02d71f000001b0-1476166905.32534-842496103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:00:50.612367) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 04:00:50.612668) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 04:00:50.612946) ========= ========= Total master_lag: 0.18 =========