builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1475522339.2 results: success (0) buildid: 20161003103758 builduid: 6183b50226804d739c1f6e0a8019ce1c revision: ba4c1706898b4b7edcca633e2844e6ee12556cb9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:59.202550) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:59.203072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:59.203422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:59.236283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:59.236684) ========= 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=41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 12:18:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-10-03 12:18:59 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:59.362978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:59.363328) ========= 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=41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014837 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:59.413286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:59.413692) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ba4c1706898b4b7edcca633e2844e6ee12556cb9 --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 ba4c1706898b4b7edcca633e2844e6ee12556cb9 --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=41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 12:18:59,994 truncating revision to first 12 chars 2016-10-03 12:18:59,995 Setting DEBUG logging. 2016-10-03 12:18:59,995 attempt 1/10 2016-10-03 12:18:59,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ba4c1706898b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 12:19:00,303 unpacking tar archive at: mozilla-aurora-ba4c1706898b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657765 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:19:00.093095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 12:19:00.093659) ========= script_repo_revision: ba4c1706898b4b7edcca633e2844e6ee12556cb9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 12:19:00.094369) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 12:19:00.094882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 12:19:00.118777) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-03 12:19:00.119103) ========= /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=41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:19:00 INFO - MultiFileLogger online at 20161003 12:19:00 in /builds/slave/test 12:19:00 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 12:19:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:19:00 INFO - {'append_to_log': False, 12:19:00 INFO - 'base_work_dir': '/builds/slave/test', 12:19:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:19:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:19:00 INFO - 'branch': 'Mozilla-Aurora', 12:19:00 INFO - 'buildbot_json_path': 'buildprops.json', 12:19:00 INFO - 'config_files': ('talos/linux_config.py',), 12:19:00 INFO - 'default_actions': ('clobber', 12:19:00 INFO - 'read-buildbot-config', 12:19:00 INFO - 'download-and-extract', 12:19:00 INFO - 'populate-webroot', 12:19:00 INFO - 'create-virtualenv', 12:19:00 INFO - 'install', 12:19:00 INFO - 'run-tests'), 12:19:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:19:00 INFO - 'download_minidump_stackwalk': True, 12:19:00 INFO - 'download_symbols': 'ondemand', 12:19:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:19:00 INFO - 'tooltool.py': '/tools/tooltool.py', 12:19:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:19:00 INFO - '/tools/misc-python/virtualenv.py')}, 12:19:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:19:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:19:00 INFO - 'installer_path': 'installer.exe', 12:19:00 INFO - 'log_level': 'info', 12:19:00 INFO - 'log_name': 'talos', 12:19:00 INFO - 'log_to_console': True, 12:19:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:19:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:19:00 INFO - 'opt_config_files': (), 12:19:00 INFO - 'pip_index': False, 12:19:00 INFO - 'sps_profile': False, 12:19:00 INFO - 'sps_profile_interval': 0, 12:19:00 INFO - 'suite': 'dromaeojs', 12:19:00 INFO - 'system_bits': '32', 12:19:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:19:00 INFO - 'title': 'talos-linux64-ix-026', 12:19:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:19:00 INFO - 'use_talos_json': True, 12:19:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:19:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:19:00 INFO - 'work_dir': 'build'} 12:19:00 INFO - [mozharness: 2016-10-03 19:19:00.801670Z] Running clobber step. 12:19:00 INFO - Running pre-action listener: _resource_record_pre_action 12:19:00 INFO - Running main action method: clobber 12:19:00 INFO - rmtree: /builds/slave/test/build 12:19:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:19:01 INFO - Running post-action listener: _resource_record_post_action 12:19:01 INFO - [mozharness: 2016-10-03 19:19:01.795698Z] Finished clobber step (success) 12:19:01 INFO - [mozharness: 2016-10-03 19:19:01.795797Z] Running read-buildbot-config step. 12:19:01 INFO - Running pre-action listener: _resource_record_pre_action 12:19:01 INFO - Running main action method: read_buildbot_config 12:19:01 INFO - Using buildbot properties: 12:19:01 INFO - { 12:19:01 INFO - "project": "", 12:19:01 INFO - "product": "firefox", 12:19:01 INFO - "script_repo_revision": "production", 12:19:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:19:01 INFO - "repository": "", 12:19:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:19:01 INFO - "buildid": "20161003103758", 12:19:01 INFO - "pgo_build": "True", 12:19:01 INFO - "basedir": "/builds/slave/test", 12:19:01 INFO - "buildnumber": 499, 12:19:01 INFO - "slavename": "talos-linux64-ix-026", 12:19:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:19:01 INFO - "platform": "ubuntu64_hw", 12:19:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:19:01 INFO - "branch": "mozilla-aurora", 12:19:01 INFO - "repo_path": "releases/mozilla-aurora", 12:19:01 INFO - "revision": "ba4c1706898b4b7edcca633e2844e6ee12556cb9", 12:19:01 INFO - "stage_platform": "linux64-pgo", 12:19:01 INFO - "builduid": "6183b50226804d739c1f6e0a8019ce1c", 12:19:01 INFO - "slavebuilddir": "test" 12:19:01 INFO - } 12:19:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 12:19:01 INFO - Running post-action listener: _resource_record_post_action 12:19:01 INFO - [mozharness: 2016-10-03 19:19:01.798871Z] Finished read-buildbot-config step (success) 12:19:01 INFO - [mozharness: 2016-10-03 19:19:01.798961Z] Running download-and-extract step. 12:19:01 INFO - Running pre-action listener: _resource_record_pre_action 12:19:01 INFO - Running main action method: download_and_extract 12:19:01 INFO - mkdir: /builds/slave/test/build/tests 12:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:01 INFO - trying https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:19:01 INFO - Downloading https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/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 12:19:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/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 12:19:02 INFO - Downloaded 1361 bytes. 12:19:02 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 12:19:02 INFO - Using the following test package requirements: 12:19:02 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 12:19:02 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:19:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:19:02 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:19:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:19:02 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:19:02 INFO - u'jsshell-linux-x86_64.zip'], 12:19:02 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:19:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:19:02 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 12:19:02 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:19:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:19:02 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:19:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:19:02 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:19:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:19:02 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 12:19:02 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:19:02 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:19:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 12:19:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:19:02 INFO - Fetch https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 12:19:02 INFO - Expected file size: 21901822 12:19:07 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 12:19:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 12:19:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:19:07 INFO - Fetch https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 12:19:07 INFO - Expected file size: 21901822 12:19:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 12:19:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:19:12 INFO - Fetch https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 12:19:13 INFO - Expected file size: 14414059 12:19:13 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')]} 12:19:13 INFO - trying https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:19:13 INFO - Downloading https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/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 12:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/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 12:19:14 INFO - Downloaded 63903987 bytes. 12:19:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:19:14 INFO - mkdir: /builds/slave/test/properties 12:19:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:19:14 INFO - Writing to file /builds/slave/test/properties/build_url 12:19:14 INFO - Contents: 12:19:14 INFO - build_url:https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 12:19:15 INFO - Running post-action listener: _resource_record_post_action 12:19:15 INFO - Running post-action listener: set_extra_try_arguments 12:19:15 INFO - [mozharness: 2016-10-03 19:19:15.549789Z] Finished download-and-extract step (success) 12:19:15 INFO - [mozharness: 2016-10-03 19:19:15.550019Z] Running populate-webroot step. 12:19:15 INFO - Running pre-action listener: _resource_record_pre_action 12:19:15 INFO - Running main action method: populate_webroot 12:19:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:19:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:19:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:19:15 INFO - '--tppagecycles', 12:19:15 INFO - '7'], 12:19:15 INFO - 'tests': ['tsvgm']}}, 12:19:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:19:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:19:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:19:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:19:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:15 INFO - 'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:19:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:15 INFO - 'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['damp', 'tps']}, 12:19:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:15 INFO - 'tests': ['damp', 'tps']}, 12:19:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['dromaeo_dom']}, 12:19:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:19:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['basic_compositor_video']}, 12:19:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:19:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['a11yr', 12:19:15 INFO - 'ts_paint', 12:19:15 INFO - 'tpaint', 12:19:15 INFO - 'sessionrestore', 12:19:15 INFO - 'sessionrestore_no_auto_restore', 12:19:15 INFO - 'tabpaint']}, 12:19:15 INFO - 'other-e10s': {'tests': ['a11yr', 12:19:15 INFO - 'ts_paint', 12:19:15 INFO - 'tpaint', 12:19:15 INFO - 'sessionrestore', 12:19:15 INFO - 'sessionrestore_no_auto_restore', 12:19:15 INFO - 'tabpaint']}, 12:19:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:19:15 INFO - 'ts_paint', 12:19:15 INFO - 'tpaint', 12:19:15 INFO - 'sessionrestore', 12:19:15 INFO - 'sessionrestore_no_auto_restore', 12:19:15 INFO - 'tabpaint']}, 12:19:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:19:15 INFO - 'ts_paint', 12:19:15 INFO - 'tpaint', 12:19:15 INFO - 'sessionrestore', 12:19:15 INFO - 'sessionrestore_no_auto_restore', 12:19:15 INFO - 'tabpaint']}, 12:19:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['a11yr', 12:19:15 INFO - 'ts_paint', 12:19:15 INFO - 'tpaint', 12:19:15 INFO - 'sessionrestore', 12:19:15 INFO - 'sessionrestore_no_auto_restore', 12:19:15 INFO - 'tabpaint']}, 12:19:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['a11yr', 12:19:15 INFO - 'ts_paint', 12:19:15 INFO - 'tpaint', 12:19:15 INFO - 'sessionrestore', 12:19:15 INFO - 'sessionrestore_no_auto_restore', 12:19:15 INFO - 'tabpaint']}, 12:19:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['tsvgx', 12:19:15 INFO - 'tsvgr_opacity', 12:19:15 INFO - 'tart', 12:19:15 INFO - 'tscrollx', 12:19:15 INFO - 'cart']}, 12:19:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:19:15 INFO - 'tsvgr_opacity', 12:19:15 INFO - 'tart', 12:19:15 INFO - 'tscrollx', 12:19:15 INFO - 'cart']}, 12:19:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:15 INFO - 'talos_options': ['--disable-e10s'], 12:19:15 INFO - 'tests': ['tp5o']}, 12:19:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:15 INFO - 'tests': ['tp5o']}, 12:19:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:15 INFO - 'talos_options': ['--disable-e10s', 12:19:15 INFO - '--xperf_path', 12:19:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:15 INFO - 'tests': ['tp5n']}, 12:19:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:19:15 INFO - 'talos_options': ['--xperf_path', 12:19:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:19:15 INFO - 'tests': ['tp5n']}}, 12:19:15 INFO - 'talos.zip': {'path': '', 12:19:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:19:15 INFO - Running post-action listener: _resource_record_post_action 12:19:15 INFO - [mozharness: 2016-10-03 19:19:15.570087Z] Finished populate-webroot step (success) 12:19:15 INFO - [mozharness: 2016-10-03 19:19:15.570176Z] Running create-virtualenv step. 12:19:15 INFO - Running pre-action listener: _resource_record_pre_action 12:19:15 INFO - Running main action method: create_virtualenv 12:19:15 INFO - Creating virtualenv /builds/slave/test/build/venv 12:19:15 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 12:19:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:19:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:19:15 INFO - Using real prefix '/usr' 12:19:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:19:16 INFO - Installing distribute.............................................................................................................................................................................................done. 12:19:18 INFO - Installing pip.................done. 12:19:18 INFO - Return code: 0 12:19:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:18 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 0x7fa9892c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, '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': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', '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 12:19:18 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 12:19:18 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 12:19:18 INFO - Using env: {'DISPLAY': ':0', 12:19:18 INFO - 'HOME': '/home/cltbld', 12:19:18 INFO - 'LANG': 'en_US.UTF-8', 12:19:18 INFO - 'LANGUAGE': 'en_US:en', 12:19:18 INFO - 'LOGNAME': 'cltbld', 12:19:18 INFO - 'MAIL': '/var/mail/cltbld', 12:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:18 INFO - 'MOZ_NO_REMOTE': '1', 12:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:18 INFO - 'NO_EM_RESTART': '1', 12:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:18 INFO - 'PWD': '/builds/slave/test', 12:19:18 INFO - 'SHELL': '/bin/bash', 12:19:18 INFO - 'SHLVL': '1', 12:19:18 INFO - 'TERM': 'linux', 12:19:18 INFO - 'TMOUT': '86400', 12:19:18 INFO - 'USER': 'cltbld', 12:19:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:18 INFO - '_': '/tools/buildbot/bin/python'} 12:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:18 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 12:19:18 INFO - Cleaning up... 12:19:18 INFO - Return code: 0 12:19:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:18 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 0x7fa9892c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, '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': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', '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 12:19:18 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 12:19:18 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 12:19:18 INFO - Using env: {'DISPLAY': ':0', 12:19:18 INFO - 'HOME': '/home/cltbld', 12:19:18 INFO - 'LANG': 'en_US.UTF-8', 12:19:18 INFO - 'LANGUAGE': 'en_US:en', 12:19:18 INFO - 'LOGNAME': 'cltbld', 12:19:18 INFO - 'MAIL': '/var/mail/cltbld', 12:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:18 INFO - 'MOZ_NO_REMOTE': '1', 12:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:18 INFO - 'NO_EM_RESTART': '1', 12:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:18 INFO - 'PWD': '/builds/slave/test', 12:19:18 INFO - 'SHELL': '/bin/bash', 12:19:18 INFO - 'SHLVL': '1', 12:19:18 INFO - 'TERM': 'linux', 12:19:18 INFO - 'TMOUT': '86400', 12:19:18 INFO - 'USER': 'cltbld', 12:19:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:18 INFO - '_': '/tools/buildbot/bin/python'} 12:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:18 INFO - Downloading/unpacking psutil>=3.1.1 12:19:18 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 12:19:18 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 12:19:18 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 12:19:18 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 12:19:18 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 12:19:18 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 12:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:19:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:20 INFO - Installing collected packages: psutil 12:19:20 INFO - Running setup.py install for psutil 12:19:20 INFO - building 'psutil._psutil_linux' extension 12:19:20 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 12:19:20 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 12:19:20 INFO - building 'psutil._psutil_posix' extension 12:19:20 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 12:19:20 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 12:19:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:19:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:19:21 INFO - Successfully installed psutil 12:19:21 INFO - Cleaning up... 12:19:21 INFO - Return code: 0 12:19:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:19:21 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')]} 12:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:21 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')]} 12:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:21 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 0x7fa9892c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, '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': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', '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 12:19:21 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 12:19:21 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 12:19:21 INFO - Using env: {'DISPLAY': ':0', 12:19:21 INFO - 'HOME': '/home/cltbld', 12:19:21 INFO - 'LANG': 'en_US.UTF-8', 12:19:21 INFO - 'LANGUAGE': 'en_US:en', 12:19:21 INFO - 'LOGNAME': 'cltbld', 12:19:21 INFO - 'MAIL': '/var/mail/cltbld', 12:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:21 INFO - 'MOZ_NO_REMOTE': '1', 12:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:21 INFO - 'NO_EM_RESTART': '1', 12:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:21 INFO - 'PWD': '/builds/slave/test', 12:19:21 INFO - 'SHELL': '/bin/bash', 12:19:21 INFO - 'SHLVL': '1', 12:19:21 INFO - 'TERM': 'linux', 12:19:21 INFO - 'TMOUT': '86400', 12:19:21 INFO - 'USER': 'cltbld', 12:19:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:21 INFO - '_': '/tools/buildbot/bin/python'} 12:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:19:21 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 12:19:21 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 12:19:21 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 12:19:21 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 12:19:21 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 12:19:21 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 12:19:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:19:23 INFO - Installing collected packages: mozsystemmonitor 12:19:23 INFO - Running setup.py install for mozsystemmonitor 12:19:23 INFO - Successfully installed mozsystemmonitor 12:19:23 INFO - Cleaning up... 12:19:23 INFO - Return code: 0 12:19:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa9892c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, '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': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', '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 12:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:19:23 INFO - Using env: {'DISPLAY': ':0', 12:19:23 INFO - 'HOME': '/home/cltbld', 12:19:23 INFO - 'LANG': 'en_US.UTF-8', 12:19:23 INFO - 'LANGUAGE': 'en_US:en', 12:19:23 INFO - 'LOGNAME': 'cltbld', 12:19:23 INFO - 'MAIL': '/var/mail/cltbld', 12:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:23 INFO - 'MOZ_NO_REMOTE': '1', 12:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:23 INFO - 'NO_EM_RESTART': '1', 12:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:23 INFO - 'PWD': '/builds/slave/test', 12:19:23 INFO - 'SHELL': '/bin/bash', 12:19:23 INFO - 'SHLVL': '1', 12:19:23 INFO - 'TERM': 'linux', 12:19:23 INFO - 'TMOUT': '86400', 12:19:23 INFO - 'USER': 'cltbld', 12:19:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:23 INFO - '_': '/tools/buildbot/bin/python'} 12:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:23 INFO - Downloading/unpacking jsonschema==2.5.1 12:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:19:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:25 INFO - Downloading functools32-3.2.3-2.tar.gz 12:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:19:25 INFO - warning: no files found matching '*.txt' 12:19:25 INFO - no previously-included directories found matching 'build' 12:19:25 INFO - no previously-included directories found matching 'dist' 12:19:25 INFO - no previously-included directories found matching '.git*' 12:19:25 INFO - Installing collected packages: jsonschema, functools32 12:19:25 INFO - Running setup.py install for functools32 12:19:25 INFO - warning: no files found matching '*.txt' 12:19:25 INFO - no previously-included directories found matching 'build' 12:19:25 INFO - no previously-included directories found matching 'dist' 12:19:25 INFO - no previously-included directories found matching '.git*' 12:19:25 INFO - Successfully installed jsonschema functools32 12:19:25 INFO - Cleaning up... 12:19:25 INFO - Return code: 0 12:19:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa9892c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, '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': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', '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 12:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:19:25 INFO - Using env: {'DISPLAY': ':0', 12:19:25 INFO - 'HOME': '/home/cltbld', 12:19:25 INFO - 'LANG': 'en_US.UTF-8', 12:19:25 INFO - 'LANGUAGE': 'en_US:en', 12:19:25 INFO - 'LOGNAME': 'cltbld', 12:19:25 INFO - 'MAIL': '/var/mail/cltbld', 12:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:25 INFO - 'MOZ_NO_REMOTE': '1', 12:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:25 INFO - 'NO_EM_RESTART': '1', 12:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:25 INFO - 'PWD': '/builds/slave/test', 12:19:25 INFO - 'SHELL': '/bin/bash', 12:19:25 INFO - 'SHLVL': '1', 12:19:25 INFO - 'TERM': 'linux', 12:19:25 INFO - 'TMOUT': '86400', 12:19:25 INFO - 'USER': 'cltbld', 12:19:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:25 INFO - '_': '/tools/buildbot/bin/python'} 12:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:19:26 INFO - Cleaning up... 12:19:26 INFO - Return code: 0 12:19:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:26 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 0x7fa9892c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, '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': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', '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 12:19:26 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 12:19:26 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 12:19:26 INFO - Using env: {'DISPLAY': ':0', 12:19:26 INFO - 'HOME': '/home/cltbld', 12:19:26 INFO - 'LANG': 'en_US.UTF-8', 12:19:26 INFO - 'LANGUAGE': 'en_US:en', 12:19:26 INFO - 'LOGNAME': 'cltbld', 12:19:26 INFO - 'MAIL': '/var/mail/cltbld', 12:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:26 INFO - 'MOZ_NO_REMOTE': '1', 12:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:26 INFO - 'NO_EM_RESTART': '1', 12:19:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:26 INFO - 'PWD': '/builds/slave/test', 12:19:26 INFO - 'SHELL': '/bin/bash', 12:19:26 INFO - 'SHLVL': '1', 12:19:26 INFO - 'TERM': 'linux', 12:19:26 INFO - 'TMOUT': '86400', 12:19:26 INFO - 'USER': 'cltbld', 12:19:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:26 INFO - '_': '/tools/buildbot/bin/python'} 12:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:26 INFO - Downloading/unpacking blobuploader==1.2.4 12:19:26 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 12:19:26 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 12:19:26 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 12:19:26 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 12:19:26 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 12:19:26 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 12:19:28 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:29 INFO - Downloading docopt-0.6.1.tar.gz 12:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:29 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:29 INFO - Running setup.py install for blobuploader 12:19:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:29 INFO - Running setup.py install for requests 12:19:29 INFO - Running setup.py install for docopt 12:19:29 INFO - Successfully installed blobuploader requests docopt 12:19:29 INFO - Cleaning up... 12:19:29 INFO - Return code: 0 12:19:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:29 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')]} 12:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:29 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')]} 12:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:29 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 0x7fa9892c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, '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': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', '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 12:19:29 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 12:19:29 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 12:19:29 INFO - Using env: {'DISPLAY': ':0', 12:19:29 INFO - 'HOME': '/home/cltbld', 12:19:29 INFO - 'LANG': 'en_US.UTF-8', 12:19:29 INFO - 'LANGUAGE': 'en_US:en', 12:19:29 INFO - 'LOGNAME': 'cltbld', 12:19:29 INFO - 'MAIL': '/var/mail/cltbld', 12:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:29 INFO - 'MOZ_NO_REMOTE': '1', 12:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:29 INFO - 'NO_EM_RESTART': '1', 12:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:29 INFO - 'PWD': '/builds/slave/test', 12:19:29 INFO - 'SHELL': '/bin/bash', 12:19:29 INFO - 'SHLVL': '1', 12:19:29 INFO - 'TERM': 'linux', 12:19:29 INFO - 'TMOUT': '86400', 12:19:29 INFO - 'USER': 'cltbld', 12:19:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:29 INFO - '_': '/tools/buildbot/bin/python'} 12:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:29 INFO - Running setup.py (path:/tmp/pip-XTZ7ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:29 INFO - Running setup.py (path:/tmp/pip-12CoWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:30 INFO - Running setup.py (path:/tmp/pip-MePz4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:30 INFO - Running setup.py (path:/tmp/pip-vQmpzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:30 INFO - Running setup.py (path:/tmp/pip-9qpg7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:30 INFO - Running setup.py (path:/tmp/pip-B213e2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:30 INFO - Running setup.py (path:/tmp/pip-er4yvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:30 INFO - Running setup.py (path:/tmp/pip-ew06QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:30 INFO - Running setup.py (path:/tmp/pip-UHhm5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:30 INFO - Running setup.py (path:/tmp/pip-XU06z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:30 INFO - Running setup.py (path:/tmp/pip-gIT3xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:30 INFO - Running setup.py (path:/tmp/pip-Wk6gD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:30 INFO - Running setup.py (path:/tmp/pip-937m3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:30 INFO - Running setup.py (path:/tmp/pip-3t8fC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:30 INFO - Running setup.py (path:/tmp/pip-XFVwBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:30 INFO - Running setup.py (path:/tmp/pip-FAGSsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:31 INFO - Running setup.py (path:/tmp/pip-u5XH9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:31 INFO - Running setup.py install for manifestparser 12:19:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:31 INFO - Running setup.py install for mozcrash 12:19:31 INFO - Running setup.py install for mozdebug 12:19:31 INFO - Running setup.py install for mozdevice 12:19:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:19:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:31 INFO - Running setup.py install for mozfile 12:19:31 INFO - Running setup.py install for mozhttpd 12:19:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:31 INFO - Running setup.py install for mozinfo 12:19:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:31 INFO - Running setup.py install for mozInstall 12:19:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:31 INFO - Running setup.py install for mozleak 12:19:32 INFO - Running setup.py install for mozlog 12:19:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:32 INFO - Running setup.py install for moznetwork 12:19:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:32 INFO - Running setup.py install for mozprocess 12:19:32 INFO - Running setup.py install for mozprofile 12:19:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:32 INFO - Running setup.py install for mozrunner 12:19:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:32 INFO - Running setup.py install for mozscreenshot 12:19:32 INFO - Running setup.py install for moztest 12:19:32 INFO - Running setup.py install for mozversion 12:19:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:32 INFO - Cleaning up... 12:19:32 INFO - Return code: 0 12:19:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:32 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')]} 12:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:32 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')]} 12:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:32 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 0x7fa9892c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, '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': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', '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 12:19:32 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 12:19:32 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 12:19:32 INFO - Using env: {'DISPLAY': ':0', 12:19:32 INFO - 'HOME': '/home/cltbld', 12:19:32 INFO - 'LANG': 'en_US.UTF-8', 12:19:32 INFO - 'LANGUAGE': 'en_US:en', 12:19:32 INFO - 'LOGNAME': 'cltbld', 12:19:32 INFO - 'MAIL': '/var/mail/cltbld', 12:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:32 INFO - 'MOZ_NO_REMOTE': '1', 12:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:32 INFO - 'NO_EM_RESTART': '1', 12:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:32 INFO - 'PWD': '/builds/slave/test', 12:19:32 INFO - 'SHELL': '/bin/bash', 12:19:32 INFO - 'SHLVL': '1', 12:19:32 INFO - 'TERM': 'linux', 12:19:32 INFO - 'TMOUT': '86400', 12:19:32 INFO - 'USER': 'cltbld', 12:19:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:32 INFO - '_': '/tools/buildbot/bin/python'} 12:19:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:33 INFO - Running setup.py (path:/tmp/pip-AjRsOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:33 INFO - Running setup.py (path:/tmp/pip-9qqHwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:33 INFO - Running setup.py (path:/tmp/pip-q7_TME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:33 INFO - Running setup.py (path:/tmp/pip-EQlAPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:33 INFO - Running setup.py (path:/tmp/pip-9XpFqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:33 INFO - Running setup.py (path:/tmp/pip-quhtEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:33 INFO - Running setup.py (path:/tmp/pip-Sc8wIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:33 INFO - Running setup.py (path:/tmp/pip-9tkvcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:33 INFO - Running setup.py (path:/tmp/pip-VgS5h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:33 INFO - Running setup.py (path:/tmp/pip-QO570V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:33 INFO - Running setup.py (path:/tmp/pip-i852wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:33 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)) 12:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:33 INFO - Running setup.py (path:/tmp/pip-v3q5l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:34 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)) 12:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:34 INFO - Running setup.py (path:/tmp/pip-Baam2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:34 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)) 12:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:34 INFO - Running setup.py (path:/tmp/pip-isC6Sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:34 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)) 12:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:34 INFO - Running setup.py (path:/tmp/pip-RDAkwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:34 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)) 12:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:34 INFO - Running setup.py (path:/tmp/pip-ra2Kd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:34 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)) 12:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:34 INFO - Running setup.py (path:/tmp/pip-tOEu9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:34 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)) 12:19:34 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)) 12:19:34 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)) 12:19:34 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)) 12:19:34 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)) 12:19:34 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)) 12:19:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:34 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 12:19:34 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 12:19:34 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 12:19:34 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 12:19:34 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 12:19:34 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 12:19:36 INFO - Downloading blessings-1.6.tar.gz 12:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:36 INFO - Installing collected packages: blessings 12:19:36 INFO - Running setup.py install for blessings 12:19:36 INFO - Successfully installed blessings 12:19:36 INFO - Cleaning up... 12:19:36 INFO - Return code: 0 12:19:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:36 INFO - Reading from file tmpfile_stdout 12:19:36 INFO - Current package versions: 12:19:36 INFO - argparse == 1.2.1 12:19:36 INFO - blessings == 1.6 12:19:36 INFO - blobuploader == 1.2.4 12:19:36 INFO - docopt == 0.6.1 12:19:36 INFO - functools32 == 3.2.3-2 12:19:36 INFO - jsonschema == 2.5.1 12:19:36 INFO - manifestparser == 1.1 12:19:36 INFO - mozInstall == 1.12 12:19:36 INFO - mozcrash == 0.17 12:19:36 INFO - mozdebug == 0.1 12:19:36 INFO - mozdevice == 0.48 12:19:36 INFO - mozfile == 1.2 12:19:36 INFO - mozhttpd == 0.7 12:19:36 INFO - mozinfo == 0.9 12:19:36 INFO - mozleak == 0.1 12:19:36 INFO - mozlog == 3.4 12:19:36 INFO - moznetwork == 0.27 12:19:36 INFO - mozprocess == 0.23 12:19:36 INFO - mozprofile == 0.28 12:19:36 INFO - mozrunner == 6.12 12:19:36 INFO - mozscreenshot == 0.1 12:19:36 INFO - mozsystemmonitor == 0.3 12:19:36 INFO - moztest == 0.7 12:19:36 INFO - mozversion == 1.4 12:19:36 INFO - psutil == 3.1.1 12:19:36 INFO - requests == 1.2.3 12:19:36 INFO - wsgiref == 0.1.2 12:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:36 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 0x7fa9892c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, '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': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', '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 12:19:36 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 12:19:36 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 12:19:36 INFO - Using env: {'DISPLAY': ':0', 12:19:36 INFO - 'HOME': '/home/cltbld', 12:19:36 INFO - 'LANG': 'en_US.UTF-8', 12:19:36 INFO - 'LANGUAGE': 'en_US:en', 12:19:36 INFO - 'LOGNAME': 'cltbld', 12:19:36 INFO - 'MAIL': '/var/mail/cltbld', 12:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:36 INFO - 'MOZ_NO_REMOTE': '1', 12:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:36 INFO - 'NO_EM_RESTART': '1', 12:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:36 INFO - 'PWD': '/builds/slave/test', 12:19:36 INFO - 'SHELL': '/bin/bash', 12:19:36 INFO - 'SHLVL': '1', 12:19:36 INFO - 'TERM': 'linux', 12:19:36 INFO - 'TMOUT': '86400', 12:19:36 INFO - 'USER': 'cltbld', 12:19:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:36 INFO - '_': '/tools/buildbot/bin/python'} 12:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:36 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)) 12:19:36 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)) 12:19:36 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)) 12:19:36 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)) 12:19:36 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)) 12:19:36 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)) 12:19:36 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)) 12:19:36 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)) 12:19:36 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)) 12:19:36 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)) 12:19:36 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)) 12:19:36 INFO - Cleaning up... 12:19:36 INFO - Return code: 0 12:19:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9892c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2271ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, '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': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', '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 12:19: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', 'jsonschema'] in /builds/slave/test/build 12:19: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 jsonschema 12:19:36 INFO - Using env: {'DISPLAY': ':0', 12:19:36 INFO - 'HOME': '/home/cltbld', 12:19:36 INFO - 'LANG': 'en_US.UTF-8', 12:19:36 INFO - 'LANGUAGE': 'en_US:en', 12:19:36 INFO - 'LOGNAME': 'cltbld', 12:19:36 INFO - 'MAIL': '/var/mail/cltbld', 12:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:36 INFO - 'MOZ_NO_REMOTE': '1', 12:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:36 INFO - 'NO_EM_RESTART': '1', 12:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:36 INFO - 'PWD': '/builds/slave/test', 12:19:36 INFO - 'SHELL': '/bin/bash', 12:19:36 INFO - 'SHLVL': '1', 12:19:36 INFO - 'TERM': 'linux', 12:19:36 INFO - 'TMOUT': '86400', 12:19:36 INFO - 'USER': 'cltbld', 12:19:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:36 INFO - '_': '/tools/buildbot/bin/python'} 12:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:19:37 INFO - Cleaning up... 12:19:37 INFO - Return code: 0 12:19:37 INFO - Running post-action listener: _resource_record_post_action 12:19:37 INFO - Running post-action listener: _start_resource_monitoring 12:19:37 INFO - Starting resource monitoring. 12:19:37 INFO - [mozharness: 2016-10-03 19:19:37.235734Z] Finished create-virtualenv step (success) 12:19:37 INFO - [mozharness: 2016-10-03 19:19:37.236187Z] Running install step. 12:19:37 INFO - Running pre-action listener: _resource_record_pre_action 12:19:37 INFO - Running main action method: install 12:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:37 INFO - Reading from file tmpfile_stdout 12:19:37 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:37 INFO - Reading from file tmpfile_stdout 12:19:37 INFO - Output received: 12:19:37 INFO - Usage: mozinstall [options] installer 12:19:37 INFO - Options: 12:19:37 INFO - -h, --help show this help message and exit 12:19:37 INFO - -d DEST, --destination=DEST 12:19:37 INFO - Directory to install application into. [default: 12:19:37 INFO - "/builds/slave/test"] 12:19:37 INFO - --app=APP Application being installed. [default: firefox] 12:19:37 INFO - mkdir: /builds/slave/test/build/application 12:19:37 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'] 12:19:37 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 12:19:53 INFO - Reading from file tmpfile_stdout 12:19:53 INFO - Output received: 12:19:53 INFO - /builds/slave/test/build/application/firefox/firefox 12:19:53 INFO - Running post-action listener: _resource_record_post_action 12:19:53 INFO - [mozharness: 2016-10-03 19:19:53.506437Z] Finished install step (success) 12:19:53 INFO - [mozharness: 2016-10-03 19:19:53.506684Z] Running run-tests step. 12:19:53 INFO - Running pre-action listener: _resource_record_pre_action 12:19:53 INFO - Running main action method: run_tests 12:19:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:19:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:19:53 INFO - Python 2.7.3 12:19:53 INFO - Return code: 0 12:19:53 INFO - grabbing minidump binary from tooltool 12:19:53 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')]} 12:19:53 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 0x226ef60>, '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 0x226fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22701d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:19:53 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 12:19:53 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 12:19:53 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 12:19:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:19:53 INFO - Return code: 0 12:19:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:19:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:19:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:19:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:19:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:19:53 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/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 12:19:53 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/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 12:19:53 INFO - Using env: {'DISPLAY': ':0', 12:19:53 INFO - 'HOME': '/home/cltbld', 12:19:53 INFO - 'LANG': 'en_US.UTF-8', 12:19:53 INFO - 'LANGUAGE': 'en_US:en', 12:19:53 INFO - 'LOGNAME': 'cltbld', 12:19:53 INFO - 'MAIL': '/var/mail/cltbld', 12:19:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:19:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:53 INFO - 'MOZ_NO_REMOTE': '1', 12:19:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:53 INFO - 'NO_EM_RESTART': '1', 12:19:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:53 INFO - 'PWD': '/builds/slave/test', 12:19:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:19:53 INFO - 'SHELL': '/bin/bash', 12:19:53 INFO - 'SHLVL': '1', 12:19:53 INFO - 'TERM': 'linux', 12:19:53 INFO - 'TMOUT': '86400', 12:19:53 INFO - 'USER': 'cltbld', 12:19:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556', 12:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:53 INFO - '_': '/tools/buildbot/bin/python'} 12:19:53 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/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 12:19:53 INFO - mozversion application_buildid: 20161003103758 12:19:53 INFO - mozversion application_changeset: ba4c1706898b4b7edcca633e2844e6ee12556cb9 12:19:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:19:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:19:53 INFO - mozversion application_name: Firefox 12:19:53 INFO - mozversion application_remotingname: firefox-dev 12:19:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:19:53 INFO - mozversion application_vendor: Mozilla 12:19:53 INFO - mozversion application_version: 51.0a2 12:19:53 INFO - mozversion platform_buildid: 20161003103758 12:19:53 INFO - mozversion platform_changeset: ba4c1706898b4b7edcca633e2844e6ee12556cb9 12:19:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:19:53 INFO - mozversion platform_version: 51.0a2 12:19:53 INFO - using testdate: 1475522393 12:19:53 INFO - actual date: 1475522393 12:19:53 INFO - starting webserver on 'localhost:48967' 12:19:53 INFO - SUITE-START | Running 2 tests 12:19:53 INFO - TEST-START | dromaeo_css 12:19:53 INFO - operating with platform_type : linux_ 12:19:53 INFO - Initialising browser for dromaeo_css test... 12:19:53 INFO - TEST-INFO | started process 10243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnzWlEA/profile http://localhost:48967/getInfo.html) 12:19:57 INFO - PROCESS | 10243 | __metrics Screen width/height:1600/1200 12:19:57 INFO - PROCESS | 10243 | colorDepth:24 12:19:57 INFO - PROCESS | 10243 | Browser inner width/height: 1024/697 12:19:57 INFO - PROCESS | 10243 | __metrics 12:19:58 INFO - PROCESS | 10243 | 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" 12:19:58 INFO - PROCESS | 10243 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:19:58 INFO - PROCESS | 10243 | console.error: PushService: 12:19:58 INFO - PROCESS | 10243 | stateChangeProcessEnqueue: Error transitioning state 12:19:58 INFO - PROCESS | 10243 | UnknownError 12:19:59 INFO - TEST-INFO | 10243: exit 0 12:19:59 INFO - Browser initialized. 12:19:59 INFO - Running cycle 1/1 for dromaeo_css test... 12:19:59 INFO - TEST-INFO | started process 10335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnzWlEA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:11 INFO - PROCESS | 10335 | RSS: Main: 145059840 12:20:11 INFO - PROCESS | 10335 | 12:21:02 INFO - PROCESS | 10335 | 1475522462562 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] 12:23:11 INFO - PROCESS | 10335 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48967/tests/dromaeo/cssquery-ext.html) 12:23:13 INFO - PROCESS | 10335 | RSS: Main: 230391808 12:23:13 INFO - PROCESS | 10335 | 12:26:15 INFO - PROCESS | 10335 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-ext.html (next: http://localhost:48967/tests/dromaeo/cssquery-jquery.html) 12:26:15 INFO - PROCESS | 10335 | RSS: Main: 238764032 12:26:15 INFO - PROCESS | 10335 | 12:29:17 INFO - PROCESS | 10335 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48967/tests/dromaeo/cssquery-mootools.html) 12:29:18 INFO - PROCESS | 10335 | RSS: Main: 174260224 12:29:18 INFO - PROCESS | 10335 | 12:32:20 INFO - PROCESS | 10335 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48967/tests/dromaeo/cssquery-prototype.html) 12:32:20 INFO - PROCESS | 10335 | RSS: Main: 221179904 12:32:20 INFO - PROCESS | 10335 | 12:35:23 INFO - PROCESS | 10335 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48967/tests/dromaeo/cssquery-yui.html) 12:35:24 INFO - PROCESS | 10335 | RSS: Main: 176455680 12:35:24 INFO - PROCESS | 10335 | 12:38:26 INFO - PROCESS | 10335 | Cycle 1(1): loaded http://localhost:48967/tests/dromaeo/cssquery-yui.html (next: http://localhost:48967/tests/dromaeo/cssquery-dojo.html) 12:38:27 INFO - PROCESS | 10335 | RSS: Main: 259543040 12:38:27 INFO - PROCESS | 10335 | 12:38:27 INFO - PROCESS | 10335 | __start_tp_report 12:38:27 INFO - PROCESS | 10335 | _x_x_mozilla_page_load 12:38:27 INFO - PROCESS | 10335 | _x_x_mozilla_page_load_details 12:38:27 INFO - PROCESS | 10335 | |i|pagename|runs| 12:38:27 INFO - PROCESS | 10335 | |0;dojo.html;3197.072848873827;3233.563468931695;3234.6927041931017;3251.658575849537;3272.427325218088;5730.7707691692285;5796.159556864252;5823.330317013545;5834.445727655866;5838.153467747175;5792.102224155252;5837.1536127261625;5848.03507421276;5851.473367396933;5858.1505681676235;5205.297284866542;5254.474552544734;5290.470952904717;5294.1529355303155;5338.91991620126;5164.302819119427;5330.253764472957;5361.946380536184;5362.0616392131415;5386.91919621206;5137.023965446553;5214.296070030554;5216.426193118754;5231.973840130794;5250.816221432251;5258.894822103574;5286.841394758144;5298.258243845865;5371.919421208685;5373.973130134364;5039.647224694273;5196.29849970253;5281.683099014033;5290.761915713763;5362.892742145174;5590.133529302964;5661.943380566183;5663.915041274384;5723.627964182357;5829.854253643651;6114.908276375858;6158.322584515699;6169.105479705418;6171.475424588915;6180.536459765535;6059.606125601866;6200.87598248037;6217.316095229521;6217.96891015542;6224.87550248997;5687.601867869251;5695.658260504341;5741.052726300114;5743.798967036134;5769.769209231667;6329.778457754049;6362.300146983828;6365.49076073913;6370.713317900706;6374.745010199633;5872.471477567039;5929.881402372014;6100.969495152496;6101.298350689727;6110.083487476914;6135.938640613626;6155.1075094112;6162.506999440034;6190.164327815777;6259.624422534663;6155.4767844732805;6160.630362178284;6162.815115546541;6167.629942203482;6169.660668663267;5951.077582974646;6110.794972396109;6167.414095660905;6174.691265436711;6175.84560385994;4627.051454451829;4652.488226295105;4654.394928659252;4655.906881862344;4656.0920620479355;4088.550259471456;4120.464339635828;4154.709170358046;4182.769947652909;4278.336857787048;5737.225474560964;5738.081906894877;5764;5789.739461724233;5818.5054270386645;6168.19813424261;6176.258848938066;6185.690715464209;6188.195534580565;6188.257409110935;5596.524295434852;5699.316082070178;5773.220615216976;5829.8251052468495;5842.328132264844;5366.221897824794;5378.354597448253;5378.91931621026;5382.085045542267;5398.217258497574;6361.840953976188;6487.643179625072;6492.5455218134275;6496.35036496356;6497.707603157869;6061.605995610271;6118.174046503665;6128.142060111499;6249.062640603764;6249.687515624109;6402.775902843378;6505.479561635152;6521.478281737354;6524.4780417565535;6526.575772574767;6122.877542449037;6124.510039196943;6133.539984501091;6136.662483563447;6141.7543298267565;6055.9091613626715;6116.143739876332;6209.937900621117;6265.27949285838;6269.717862696099;6001.7599296027665;6039.516838652809;6125.509959203342;6179.567430279837;6186.072089186658;6071.2714474263375;6072.757089716361;6075.2405949256345;6083.330833608211;6110.969445152746;5833.883322333445;6033.215681961317;6085.330613632408;6091.7258723358445;6099.329073801967;5917.37867523921;6024.819255422344;6086.6652334122045;6097.664628445301;6158.476529495043;5934.851628709317;5950.642961422329;5982.192404025401;5989.311229208697;6005.489533389711 12:38:27 INFO - PROCESS | 10335 | |1;ext.html;589.811260396673;608.4736702752119;628.2398298059345;637.4963778614895;643.4112786800079;35072.824635876816;47036.76481617591;48430.75784621072;48449.51550484503;48474.27288590674;48056;48380.27429588559;48536;48561;48590.51409485904;8436.114208008163;9373.43759374438;9509.619615215383;9518.762030949247;9524.761880952963;8346.332293416543;10917;11278.661640150809;11282.548698052067;11662.241954272988;11464.19750617457;11469.426528673575;11535.192536522447;11598.884011159866;11609;11282.661520154408;11339.092872570174;11345.829812552776;11361.091112711047;11362.545498180105;11140.721481963015;11183.776324473547;11252.26860254081;11258.268212566158;11262;45341.77329113333;45611.77194114041;45703.54296457026;46158.53841461576;46262.07475850464;3793.715471339661;3910.7849068301234;4071.694622903294;4101.753894766323;4395.406620106277;34886.651133488594;35140.472892906626;35183.82408087943;35301.21262566102;36065.81967090174;4540.909181816345;4571.862844114682;4594.196015697273;4626.976865115686;4695.835645752382;361792;362078;362272;363212.9999999974;366058;66338;66508.33491665118;66816.6659166701;66975;67079;41223.587764122574;41885.58114418878;42112;44113.338299924886;44113.77943110264;19604.509887252934;19756.407307780788;19793.505162371057;19798.70301945472;19832.50418739514;13430.664233394244;13777.380017899219;14494;14600.904932130134;14663.706725865637;20343;21044.47388815292;21305.36083917485;21349.679754803692;21449.249276275255;7340.073060912387;7544.886826697604;7568.470207085561;7614.390848732088;7684.923150768533;980.1570649241646;1067.1356201476674;1096.2381145104237;1146.3293973025873;1153.6366044695894;34960.475592866125;35114;35115.413845687646;35317.29365412677;35425.29149416997;1103.8730545987153;1131.7962766702074;1135.074913945132;1192.7495226002463;1234.9876501234874;18177.454676359732;18184.36354727578;18299.451016469528;18322.358717444826;18372.448826535227;523970;600477;608043;609226;853867;64275;64755.352446474935;64877.35122648808;64882.675586621765;64969;1346.6296768388574;1384.0865029080758;1420.8934329925296;1472.271225743264;1476.2692467228576;33832.49251261282;36109.81945090258;36365.45451818278;36367.27265454729;36462.27075458529;54868.17697734457;55382;55633;55633.165502518306;55837;424593;428249;428400;428573;430464;31349.216269593442;32439;32510.51234231441;33620.831895841344;33643.83178084094;51755.48244517507;51772.482275176764;51782.48217517776;51869.7406512965;52206.47793522168;43337.56662433461;44670.55329446664;44696.776516117214;45168.54831451775;46306.53693463157;43903.34144987764;45004.549954500035;45065.098698026515;45678.54321456876;46170.7691461554;43892.78053609712;44250;44555;44664.77667611641;44974.55025449704;37263.813680931424;39837;40106.39840402455;40190;40653.59346406498;29588.704112959455;29759;29886.402271954874;30221;30234.395312094075 12:38:27 INFO - PROCESS | 10335 | |2;jquery.html;391.23318296139564;432.75549314637226;440.80604534005033;443.4988463036769;447.9584964956477;16743.83256167438;19527.70708439373;19767.703484447746;20306.492337691565;20366.69449958248;19073.332433364834;19904.40286791395;19985.500362490944;20119.899400502978;20511.794882051174;5876.794312199074;6028.005379112441;6083.209182806229;6088.573799834014;6093.146959425661;5683.119116536923;5979;6003.489703375219;6071.3625069367745;6071.51427885768;5740.971295143519;6060.909086363708;6064.605800622945;6073.301570319403;6078;5940.851478713045;6078.1186727924205;6114.144019837227;6115.510759139281;6124.295705993779;5795.1886735857015;5887.676177810219;5950.494207992326;5973.402659733992;5976.910346344765;14974.700505989927;15071.4724984625;15074.472393466176;15171.544853654408;15183.392664293415;2337.4623836517526;2395.5927492326346;2456.4350199454047;2803.3832556837465;3056.969430305691;10949.343039417581;12880.677983050406;12930.030247731458;14842.628934276621;15008.174550399724;2037.215671966289;2104.6316894543547;2206.8565543239797;2261.197274967379;2325.8370814592704;86423;87129.56435217784;87519.56240218758;88007;88757.55621221918;10560.313579617301;11755.471003804849;11853;12107.697307567381;12204.206726562745;15334.156621385931;15395.769063464057;16214.75677864833;16232.350705971865;16846;7259.087378449811;7290.125184977731;7337.376323012603;8403.285720713686;9167.724968250963;8877.156670116328;8911.821763564822;8957.731268061969;9132.81734365309;9133.588988495401;5080.466551012164;5131.179011358165;5132.897342053213;5163.793448262102;5249.580033597303;2119.1417475922276;2121.0985331234165;2142.258746559236;2166.3176099528596;2176.096919778306;1007.969760907174;1018.9592416303414;1039.262123892045;1083.3175099687305;1083.4636854756945;20115.29596464146;20296.797032029786;20376.184952602027;20542.486437839172;20663.276785312442;1053.7260312318851;1053.8629978102797;1077.8006068877282;1090.1170052257696;1145.0724912820642;10490.947545262377;11396.373199473943;11396.544138234543;11458.885411145782;11510.136739744552;511148;546580;546679;547477;547729;57849;69951.30048699549;96291;96764.51617741866;96896;1012.772126271583;1048.9475526223657;1058.6030238660503;1058.867641544807;1072.5120070367964;17648.64702705913;17988;18079.36722214716;18184.818151818312;18357.3574924877;42765.78617106895;43089;43228.351574727036;43672.56327436685;43697.56302436935;60160.2687475938;60239;60808.695956519936;61274.69362653158;62173.37826621857;6034.818955431344;6331.176946996861;9033.096690330914;9082.682106126254;9093.590788414405;12081.214721043456;13416.262105583895;13527.256000920044;13541.864581354454;13668.726625467634;11917.22538035025;11929.880701192877;11959.103067269816;12006.75986480248;12082.818757718816;11373.886261137282;11721.706957326134;11828.645140645795;11936.343501107522;11965.102617303563;11289.887101128883;11751.647450576496;11893.286402815858;11932.164748467523;11937.82093268619;8460.703875364332;8853.07042760501;8898.377113601986;8909.198172164537;8931.285497160081;11267.323960562393;12220.572279970158;12224.388780561114;12391.62825115248;12474.812877806658 12:38:27 INFO - PROCESS | 10335 | |3;mootools.html;1266.1263728027654;1488.6427257458206;1552.9689406211874;1679.7984241890974;1794.0760508338208;7811.492253003558;9330.766730831732;9719.222462203024;9750.804983900318;9955.153811925995;9776.951115244432;9839.75400614985;9846.655367062154;9860.30977831552;9861.457619830906;2583.987080064597;2601.544729672309;2609.465059662774;2609.5302845487804;2612.555865502869;2539.5555777738914;2590.702069262031;2594.44219492809;2594.455164415466;2595.636610874479;2512.095645567594;2524.116559204282;2547.426828963478;2548.3374322676145;2548.617707343904;2490.9750902491014;2517.2322441655288;2520.5589021921273;2524.368907773057;2527.027094568586;2470.295965649781;2490.3276115448725;2494.750524947509;2497.31323885931;2498.0132847525306;9767.316287859852;9774.462404567746;9804.117629413387;9809.754756131153;9813.362131461503;5551.195076713894;5743.885122297573;5755.136729490568;5757.827265182052;5803.506701930341;3785.413260944558;3849.7305188636806;3915.647591716759;3963.7225394222414;3994.3409337459284;1308.653206900172;1358.714669919318;1378.800073989266;1390.7288078824633;1445.9927700361432;13548.661283467894;13771;13775.931120344434;13814;13815.792763108562;5155.097857874857;5332.866678333073;5344.732763361816;5378.838634840961;5472.534834539029;10927.125829933586;11003.889961100447;11022.063124634496;11025.338479691245;11037.061849742862;5623.297087864017;5706.657600543897;5717.399673034354;5721.8569535761935;5723.771049157987;4340.891477713019;4565.338025986213;4722.220833562424;5326.067938110815;5368.812091576776;4321.0709697415205;4346.456692913386;4379.802908869108;4425.203463376559;4478.955210447919;1307.9738405231842;1318.7692153873033;1325.4168166006925;1338.2840180503383;1344.1531834943924;956.2350119904049;956.933014688979;981.9018098190267;987.8555385502165;999.3304485994402;6066.241719785027;6127.969360153171;6164.445199931938;6169.167162433014;6456.870862582722;1015.8171529124828;1031.2059714020163;1053.3627155570769;1058.5236643510298;1065.9200559957878;4169.687273454503;4241.63946064588;4308.719933204332;4364.4980827204645;4425;12151.270923744603;12544.310062946442;12663.303518306397;12671.936640316924;12673.049521285757;12522.937385313015;12541.811872821914;12567.434465449076;12568.685782855502;12568.81146782799;8646.178613031752;9072.228860546928;9073.319501037317;9230.53847307632;9260.259179265777;6218.782342618168;6286.5599408041;6364.109024736448;6449.032645103272;6472.320406357265;11038.613648522263;11204.775904481701;11205.60780372683;11227.887721122685;11366.261193022427;9652.27607929394;9961.153301969414;10995.680518337851;11416.600418985296;11798.41007949582;8421.073681894864;8612.698555550525;8679.826403471769;8705.608247629;8911.930568331842;9544.761380965254;9574.090461406155;9587.520623968912;9594.472304023346;9612.038796120332;8339.874901876356;8364.289035432057;8428.536430496382;8454.535000575028;8472.872906906525;8481.10948350439;8515.701950431705;8528.360372971927;8550.657973680984;8560.743177704679;6801;6948.409385202314;7020.5787652741;7230;7288.198298187302;5495.945040549704;5554.583406244467;5576.163575463713;5636.549076073822;5791.739371728198;5483.067878460751;5483.479069488392;5485.122380419114;5534.640248383842;5601.915971260353 12:38:27 INFO - PROCESS | 10335 | |4;prototype.html;352.3428805278157;357.4959307376599;359.5721091900638;364.5607043512568;367.25630598038987;5665.688387138705;5689.2319536862515;5689.516391106756;5702.771889124435;5712.171735098408;5343.251944727741;5418.9458105418935;5456.990456765501;5551.916721249175;5620.185073164389;4400.933985990213;4409.338599210112;4409.977950110245;4420.403245561856;4444.155610434023;4399.758013309267;4422.385829172345;4430.556944305576;4446.7554284514335;4450.643948484114;4305.160807778609;4365.323374876899;4366.432363792703;4375.496817865955;4398.780060996954;4354.738715677069;4362.1493808707;4364.89087772805;4371.9999999999845;4384.846530371454;3921.490206273195;3925.234579257046;3928.9017774555864;3932.233214523169;3942.3100957332354;5243.973780131075;5456.536194423479;5474.7810087596445;5490.752916118784;5505.476979686963;5008.348914641109;5009.599232061426;5028.647994640377;5034;5036.244563315532;5854.092615644582;5857.121431785224;5864.530837532987;5897;5934.5845790794665;4151.190517849021;4199.286121359376;4230.17511585241;4245.299525578276;4251.256030194734;6064.817360614682;6089.299730531001;6098;6102.389761023906;6120.704735724059;4335.913281734348;4341.978290108529;4345.283028300295;4352.7823608819435;4355.562664320766;4289.120730250291;4381.079973205662;4390.7705842364185;4414.161309351213;4426.690131690815;4991.176455884738;4997.800087996439;5005.374328208974;5006.4492905780335;5040;5769.365369809318;5892.878563717059;5972.432618901197;5979.880402391927;5981.700914954235;1443;1468.097120271047;1501.3919362658141;1521.2697905005439;1532.440659159421;976.6239997600833;1002.7128189279208;1003.4512338659722;1009.3187098708343;1025.487256371814;5605.243292155588;5635.408282130399;5637.859053523613;5651.513334132968;5654.491095801398;5915.852103697356;5925.170476133345;5942.286925568959;5958.7914422995855;5962.761489540369;5410.756515956791;5540.3683250455715;5588.2455868458055;5603.030393891244;5611.354694210137;3163.2724473371254;3179.7138257556467;3181.66592507788;3191.5850939377733;3192.537082123079;5966.49284810796;6165.383461653889;6169.637547536603;6182.69086545671;6204.534659900525;6073.240844894388;6079.331273559905;6087.29996050451;6105.603135796159;6106;6186.041163619646;6197.4732147767045;6201.937980620136;6220.968895155495;6244.094606282155;5790.218320526844;5935.495482884004;5958.821235362946;5964.852653044813;5986.820395387971;5804.593678442468;5895.528357731457;5902.321233058082;5946.672932988728;5949.370883760989;6018.3379828217985;6182.876342473215;6214.751409943552;6269.780557680641;6286.15136956505;4316.287812510901;4319.870403887889;4320.697551171388;4325.480942286946;4331.978340108405;5952.821415357546;5980.34216236205;5993.310769261417;6004.249468816398;6008.446410275703;5626.774929002958;5698.601097923106;5714.485696287354;5869.618474799125;5917.467427931335;5887.911681324869;5888.705564721661;5903.675297858659;5910.349861515316;5910.408959104056;5648.662014396356;5804.970975145097;5847.649141051551;5877.794277200277;5933.495652869555;5875.265591801025;5885.470307672159;5898.8230353089475;5946.464818166386;5953.732082056405;5793.710314484175;5802.47777700009;5811.56413268998;5824.388439213822;5841.853953651193 12:38:27 INFO - PROCESS | 10335 | |5;yui.html;809.5264270401815;822.4900561651776;874.8075423406848;908.462231155379;932.2122806228737;14816.111033337993;15853.3658653654;15860.682786344281;15866.286017129229;15908.602284942883;14988.550343489685;15120.092794432314;15164.090154590733;15172.468963586276;15189.848101518981;690.1717938473839;731.1920328037522;843.7510934274404;868.6525389844081;873.153041549699;870.3776799588325;872.5026734761188;873.3624454148476;873.4191762477944;873.5151990645189;730.8501757139774;926.4348747264163;927.3184209605968;929.0106037070532;929.6420877961966;774.3302043732159;880.9691660791874;911.9224865886441;922.7416323429451;926.2543652359848;675.9526833121683;676.9356911093488;677.2279601254573;677.5088061155672;677.8339306869799;15881.205939702968;15899.205039747967;15930.761038584431;15939.123348215844;15951.601209969727;14288.642783930381;14865.736412404958;15155.318010689545;15429.151396673178;15587.376504939788;13831.308434578332;13866.029377943549;14155.787663185061;14265.928670356581;14437.855621443861;4190.308599081179;4196.874093777192;4232.195882782262;4306.397104405386;4394.07724377881;60479;70394.56962157831;77222;77562;78408.60795695985;11613.6515904523;11742.70643233909;11810.763784724257;11882.702932426759;11956.581519646945;20893.268735594484;20901;20907.68638470424;20925.89537052305;20935.16259349609;9042.321825862955;9058.230050445654;9067.229285510673;9225.354225204306;9568.56941437623;5092.668976516515;5119.539241468286;5167.715775632376;5174.482551744795;5322.121849894724;3748.231612519427;3890.1636148228267;3900.531936167621;3901.668358189586;3902.024493876531;675.2673349415841;675.2976904019863;685.1059367525427;689.6689588997309;691.0739608924066;761.4936067515151;777.3780975219802;799.6921185343568;799.9280064794197;803.3533005930283;9577.653474898556;9823.36148150368;10158.916541450571;10659.307145035547;10888.67333979982;715.742332760206;777.5606782168057;787.9763607091681;791.5211297165247;793.500094940184;4730.9763451182525;4792.9281060784115;4864.6594738368685;4892.094962431962;4892.828750993769;79379;121164.39417802854;130308.3484582571;131409.34295328462;137699.31150344384;115509;117205.41397292959;118875;118980;122332;102105.48947255364;103578;103612;104755;105824;9028.548572571213;9038.141376569216;9169.587368568564;9226.308026898143;9265.861012084959;46676;47140.93583917034;49523.25715114204;52442.724814165136;62984.68507657432;73833;78675.21324786679;79825.2017479841;82531.17468825474;85011;13771.311434428038;13820.585382438543;13943.093698909539;14102.506412275521;14331.856681433052;14143.64640883986;14393.568192954228;14528.782068269196;14924.552263432115;15201.771973420186;15148.394064237307;15791.921040394724;16053;16055.308248986224;16448.506544803677;13309.401076951754;13592.660183495096;13605.183688978694;13959.092658977133;14462.421503139756;15139.394424223348;15209.239538023276;15229.923850380677;16370.099644519665;16627.916860416106;10796.514156862802;11317.320960742381;11326.263792853439;11383;11695.064394848561;12344.074194435274;12367.814482782585;12562.59168096239;12652.936735316265;12669.619911402673 12:38:27 INFO - PROCESS | 10335 | __end_tp_report 12:38:27 INFO - PROCESS | 10335 | __start_cc_report 12:38:27 INFO - PROCESS | 10335 | _x_x_mozilla_cycle_collect,1097 12:38:27 INFO - PROCESS | 10335 | __end_cc_report 12:38:27 INFO - PROCESS | 10335 | __startTimestamp1475523507221__endTimestamp 12:38:27 INFO - PROCESS | 10335 | 12:38:27 INFO - PROCESS | 10335 | ------- Summary: start ------- 12:38:27 INFO - PROCESS | 10335 | Number of tests: 6 12:38:27 INFO - PROCESS | 10335 | 12:38:27 INFO - PROCESS | 10335 | [#0] dojo.html Cycles:165 Average:5740.28 Median:5982.19 stddev:675.37 (11.3%) stddev-sans-first:647.30 12:38:27 INFO - PROCESS | 10335 | Values: 3197.1 3233.6 3234.7 3251.7 3272.4 5730.8 5796.2 5823.3 5834.4 5838.2 5792.1 5837.2 5848.0 5851.5 5858.2 5205.3 5254.5 5290.5 5294.2 5338.9 5164.3 5330.3 5361.9 5362.1 5386.9 5137.0 5214.3 5216.4 5232.0 5250.8 5258.9 5286.8 5298.3 5371.9 5374.0 5039.6 5196.3 5281.7 5290.8 5362.9 5590.1 5661.9 5663.9 5723.6 5829.9 6114.9 6158.3 6169.1 6171.5 6180.5 6059.6 6200.9 6217.3 6218.0 6224.9 5687.6 5695.7 5741.1 5743.8 5769.8 6329.8 6362.3 6365.5 6370.7 6374.7 5872.5 5929.9 6101.0 6101.3 6110.1 6135.9 6155.1 6162.5 6190.2 6259.6 6155.5 6160.6 6162.8 6167.6 6169.7 5951.1 6110.8 6167.4 6174.7 6175.8 4627.1 4652.5 4654.4 4655.9 4656.1 4088.6 4120.5 4154.7 4182.8 4278.3 5737.2 5738.1 5764.0 5789.7 5818.5 6168.2 6176.3 6185.7 6188.2 6188.3 5596.5 5699.3 5773.2 5829.8 5842.3 5366.2 5378.4 5378.9 5382.1 5398.2 6361.8 6487.6 6492.5 6496.4 6497.7 6061.6 6118.2 6128.1 6249.1 6249.7 6402.8 6505.5 6521.5 6524.5 6526.6 6122.9 6124.5 6133.5 6136.7 6141.8 6055.9 6116.1 6209.9 6265.3 6269.7 6001.8 6039.5 6125.5 6179.6 6186.1 6071.3 6072.8 6075.2 6083.3 6111.0 5833.9 6033.2 6085.3 6091.7 6099.3 5917.4 6024.8 6086.7 6097.7 6158.5 5934.9 5950.6 5982.2 5989.3 6005.5 12:38:27 INFO - PROCESS | 10335 | 12:38:27 INFO - PROCESS | 10335 | [#1] ext.html Cycles:180 Average:65068.42 Median:22362.64 stddev:131794.70 (589.4%) stddev-sans-first:132075.51 12:38:27 INFO - PROCESS | 10335 | Values: 589.8 608.5 628.2 637.5 643.4 35072.8 47036.8 48430.8 48449.5 48474.3 48056.0 48380.3 48536.0 48561.0 48590.5 8436.1 9373.4 9509.6 9518.8 9524.8 8346.3 10917.0 11278.7 11282.5 11662.2 11464.2 11469.4 11535.2 11598.9 11609.0 11282.7 11339.1 11345.8 11361.1 11362.5 11140.7 11183.8 11252.3 11258.3 11262.0 45341.8 45611.8 45703.5 46158.5 46262.1 3793.7 3910.8 4071.7 4101.8 4395.4 34886.7 35140.5 35183.8 35301.2 36065.8 4540.9 4571.9 4594.2 4627.0 4695.8 361792.0 362078.0 362272.0 363213.0 366058.0 66338.0 66508.3 66816.7 66975.0 67079.0 41223.6 41885.6 42112.0 44113.3 44113.8 19604.5 19756.4 19793.5 19798.7 19832.5 13430.7 13777.4 14494.0 14600.9 14663.7 20343.0 21044.5 21305.4 21349.7 21449.2 7340.1 7544.9 7568.5 7614.4 7684.9 980.2 1067.1 1096.2 1146.3 1153.6 34960.5 35114.0 35115.4 35317.3 35425.3 1103.9 1131.8 1135.1 1192.7 1235.0 18177.5 18184.4 18299.5 18322.4 18372.4 523970.0 600477.0 608043.0 609226.0 853867.0 64275.0 64755.4 64877.4 64882.7 64969.0 1346.6 1384.1 1420.9 1472.3 1476.3 33832.5 36109.8 36365.5 36367.3 36462.3 54868.2 55382.0 55633.0 55633.2 55837.0 424593.0 428249.0 428400.0 428573.0 430464.0 31349.2 32439.0 32510.5 33620.8 33643.8 51755.5 51772.5 51782.5 51869.7 52206.5 43337.6 44670.6 44696.8 45168.5 46306.5 43903.3 45004.5 45065.1 45678.5 46170.8 43892.8 44250.0 44555.0 44664.8 44974.6 37263.8 39837.0 40106.4 40190.0 40653.6 29588.7 29759.0 29886.4 30221.0 30234.4 12:38:27 INFO - PROCESS | 10335 | 12:38:27 INFO - PROCESS | 10335 | [#2] jquery.html Cycles:180 Average:30570.19 Median:2171.21 stddev:88798.26 (4089.8%) stddev-sans-first:89018.45 12:38:27 INFO - PROCESS | 10335 | Values: 391.2 432.8 440.8 443.5 448.0 16743.8 19527.7 19767.7 20306.5 20366.7 19073.3 19904.4 19985.5 20119.9 20511.8 5876.8 6028.0 6083.2 6088.6 6093.1 5683.1 5979.0 6003.5 6071.4 6071.5 5741.0 6060.9 6064.6 6073.3 6078.0 5940.9 6078.1 6114.1 6115.5 6124.3 5795.2 5887.7 5950.5 5973.4 5976.9 14974.7 15071.5 15074.5 15171.5 15183.4 2337.5 2395.6 2456.4 2803.4 3057.0 10949.3 12880.7 12930.0 14842.6 15008.2 2037.2 2104.6 2206.9 2261.2 2325.8 86423.0 87129.6 87519.6 88007.0 88757.6 10560.3 11755.5 11853.0 12107.7 12204.2 15334.2 15395.8 16214.8 16232.4 16846.0 7259.1 7290.1 7337.4 8403.3 9167.7 8877.2 8911.8 8957.7 9132.8 9133.6 5080.5 5131.2 5132.9 5163.8 5249.6 2119.1 2121.1 2142.3 2166.3 2176.1 1008.0 1019.0 1039.3 1083.3 1083.5 20115.3 20296.8 20376.2 20542.5 20663.3 1053.7 1053.9 1077.8 1090.1 1145.1 10490.9 11396.4 11396.5 11458.9 11510.1 511148.0 546580.0 546679.0 547477.0 547729.0 57849.0 69951.3 96291.0 96764.5 96896.0 1012.8 1048.9 1058.6 1058.9 1072.5 17648.6 17988.0 18079.4 18184.8 18357.4 42765.8 43089.0 43228.4 43672.6 43697.6 60160.3 60239.0 60808.7 61274.7 62173.4 6034.8 6331.2 9033.1 9082.7 9093.6 12081.2 13416.3 13527.3 13541.9 13668.7 11917.2 11929.9 11959.1 12006.8 12082.8 11373.9 11721.7 11828.6 11936.3 11965.1 11289.9 11751.6 11893.3 11932.2 11937.8 8460.7 8853.1 8898.4 8909.2 8931.3 11267.3 12220.6 12224.4 12391.6 12474.8 12:38:27 INFO - PROCESS | 10335 | 12:38:27 INFO - PROCESS | 10335 | [#3] mootools.html Cycles:180 Average:6360.36 Median:4938.66 stddev:3681.09 (74.5%) stddev-sans-first:3671.51 12:38:27 INFO - PROCESS | 10335 | Values: 1266.1 1488.6 1553.0 1679.8 1794.1 7811.5 9330.8 9719.2 9750.8 9955.2 9777.0 9839.8 9846.7 9860.3 9861.5 2584.0 2601.5 2609.5 2609.5 2612.6 2539.6 2590.7 2594.4 2594.5 2595.6 2512.1 2524.1 2547.4 2548.3 2548.6 2491.0 2517.2 2520.6 2524.4 2527.0 2470.3 2490.3 2494.8 2497.3 2498.0 9767.3 9774.5 9804.1 9809.8 9813.4 5551.2 5743.9 5755.1 5757.8 5803.5 3785.4 3849.7 3915.6 3963.7 3994.3 1308.7 1358.7 1378.8 1390.7 1446.0 13548.7 13771.0 13775.9 13814.0 13815.8 5155.1 5332.9 5344.7 5378.8 5472.5 10927.1 11003.9 11022.1 11025.3 11037.1 5623.3 5706.7 5717.4 5721.9 5723.8 4340.9 4565.3 4722.2 5326.1 5368.8 4321.1 4346.5 4379.8 4425.2 4479.0 1308.0 1318.8 1325.4 1338.3 1344.2 956.2 956.9 981.9 987.9 999.3 6066.2 6128.0 6164.4 6169.2 6456.9 1015.8 1031.2 1053.4 1058.5 1065.9 4169.7 4241.6 4308.7 4364.5 4425.0 12151.3 12544.3 12663.3 12671.9 12673.0 12522.9 12541.8 12567.4 12568.7 12568.8 8646.2 9072.2 9073.3 9230.5 9260.3 6218.8 6286.6 6364.1 6449.0 6472.3 11038.6 11204.8 11205.6 11227.9 11366.3 9652.3 9961.2 10995.7 11416.6 11798.4 8421.1 8612.7 8679.8 8705.6 8911.9 9544.8 9574.1 9587.5 9594.5 9612.0 8339.9 8364.3 8428.5 8454.5 8472.9 8481.1 8515.7 8528.4 8550.7 8560.7 6801.0 6948.4 7020.6 7230.0 7288.2 5495.9 5554.6 5576.2 5636.5 5791.7 5483.1 5483.5 5485.1 5534.6 5601.9 12:38:27 INFO - PROCESS | 10335 | 12:38:27 INFO - PROCESS | 10335 | [#4] prototype.html Cycles:180 Average:4948.15 Median:5631.09 stddev:1442.53 (25.6%) stddev-sans-first:1404.72 12:38:27 INFO - PROCESS | 10335 | Values: 352.3 357.5 359.6 364.6 367.3 5665.7 5689.2 5689.5 5702.8 5712.2 5343.3 5418.9 5457.0 5551.9 5620.2 4400.9 4409.3 4410.0 4420.4 4444.2 4399.8 4422.4 4430.6 4446.8 4450.6 4305.2 4365.3 4366.4 4375.5 4398.8 4354.7 4362.1 4364.9 4372.0 4384.8 3921.5 3925.2 3928.9 3932.2 3942.3 5244.0 5456.5 5474.8 5490.8 5505.5 5008.3 5009.6 5028.6 5034.0 5036.2 5854.1 5857.1 5864.5 5897.0 5934.6 4151.2 4199.3 4230.2 4245.3 4251.3 6064.8 6089.3 6098.0 6102.4 6120.7 4335.9 4342.0 4345.3 4352.8 4355.6 4289.1 4381.1 4390.8 4414.2 4426.7 4991.2 4997.8 5005.4 5006.4 5040.0 5769.4 5892.9 5972.4 5979.9 5981.7 1443.0 1468.1 1501.4 1521.3 1532.4 976.6 1002.7 1003.5 1009.3 1025.5 5605.2 5635.4 5637.9 5651.5 5654.5 5915.9 5925.2 5942.3 5958.8 5962.8 5410.8 5540.4 5588.2 5603.0 5611.4 3163.3 3179.7 3181.7 3191.6 3192.5 5966.5 6165.4 6169.6 6182.7 6204.5 6073.2 6079.3 6087.3 6105.6 6106.0 6186.0 6197.5 6201.9 6221.0 6244.1 5790.2 5935.5 5958.8 5964.9 5986.8 5804.6 5895.5 5902.3 5946.7 5949.4 6018.3 6182.9 6214.8 6269.8 6286.2 4316.3 4319.9 4320.7 4325.5 4332.0 5952.8 5980.3 5993.3 6004.2 6008.4 5626.8 5698.6 5714.5 5869.6 5917.5 5887.9 5888.7 5903.7 5910.3 5910.4 5648.7 5805.0 5847.6 5877.8 5933.5 5875.3 5885.5 5898.8 5946.5 5953.7 5793.7 5802.5 5811.6 5824.4 5841.9 12:38:27 INFO - PROCESS | 10335 | 12:38:27 INFO - PROCESS | 10335 | [#5] yui.html Cycles:180 Average:22430.10 Median:3901.85 stddev:33240.25 (851.9%) stddev-sans-first:33293.86 12:38:27 INFO - PROCESS | 10335 | Values: 809.5 822.5 874.8 908.5 932.2 14816.1 15853.4 15860.7 15866.3 15908.6 14988.6 15120.1 15164.1 15172.5 15189.8 690.2 731.2 843.8 868.7 873.2 870.4 872.5 873.4 873.4 873.5 730.9 926.4 927.3 929.0 929.6 774.3 881.0 911.9 922.7 926.3 676.0 676.9 677.2 677.5 677.8 15881.2 15899.2 15930.8 15939.1 15951.6 14288.6 14865.7 15155.3 15429.2 15587.4 13831.3 13866.0 14155.8 14265.9 14437.9 4190.3 4196.9 4232.2 4306.4 4394.1 60479.0 70394.6 77222.0 77562.0 78408.6 11613.7 11742.7 11810.8 11882.7 11956.6 20893.3 20901.0 20907.7 20925.9 20935.2 9042.3 9058.2 9067.2 9225.4 9568.6 5092.7 5119.5 5167.7 5174.5 5322.1 3748.2 3890.2 3900.5 3901.7 3902.0 675.3 675.3 685.1 689.7 691.1 761.5 777.4 799.7 799.9 803.4 9577.7 9823.4 10158.9 10659.3 10888.7 715.7 777.6 788.0 791.5 793.5 4731.0 4792.9 4864.7 4892.1 4892.8 79379.0 121164.4 130308.3 131409.3 137699.3 115509.0 117205.4 118875.0 118980.0 122332.0 102105.5 103578.0 103612.0 104755.0 105824.0 9028.5 9038.1 9169.6 9226.3 9265.9 46676.0 47140.9 49523.3 52442.7 62984.7 73833.0 78675.2 79825.2 82531.2 85011.0 13771.3 13820.6 13943.1 14102.5 14331.9 14143.6 14393.6 14528.8 14924.6 15201.8 15148.4 15791.9 16053.0 16055.3 16448.5 13309.4 13592.7 13605.2 13959.1 14462.4 15139.4 15209.2 15229.9 16370.1 16627.9 10796.5 11317.3 11326.3 11383.0 11695.1 12344.1 12367.8 12562.6 12652.9 12669.6 12:38:27 INFO - PROCESS | 10335 | -------- Summary: end -------- 12:38:27 INFO - PROCESS | 10335 | 12:38:27 INFO - TEST-INFO | 10335: exit 0 12:38:27 INFO - TEST-OK | dromaeo_css | took 1114135ms 12:38:27 INFO - TEST-START | kraken 12:38:27 INFO - operating with platform_type : linux_ 12:38:27 INFO - Initialising browser for kraken test... 12:38:27 INFO - TEST-INFO | started process 10652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUiyCLR/profile http://localhost:48967/getInfo.html) 12:38:31 INFO - PROCESS | 10652 | __metrics Screen width/height:1600/1200 12:38:31 INFO - PROCESS | 10652 | colorDepth:24 12:38:31 INFO - PROCESS | 10652 | Browser inner width/height: 1024/697 12:38:31 INFO - PROCESS | 10652 | __metrics 12:38:32 INFO - PROCESS | 10652 | 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" 12:38:32 INFO - PROCESS | 10652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:38:32 INFO - PROCESS | 10652 | console.error: PushService: 12:38:32 INFO - PROCESS | 10652 | stateChangeProcessEnqueue: Error transitioning state 12:38:32 INFO - PROCESS | 10652 | UnknownError 12:38:33 INFO - TEST-INFO | 10652: exit 0 12:38:33 INFO - Browser initialized. 12:38:33 INFO - Running cycle 1/1 for kraken test... 12:38:33 INFO - TEST-INFO | started process 10748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUiyCLR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:45 INFO - PROCESS | 10748 | RSS: Main: 144027648 12:38:45 INFO - PROCESS | 10748 | 12:38:47 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48967/tests/kraken/driver.html?testName=audio-beat-detection) 12:38:48 INFO - PROCESS | 10748 | RSS: Main: 185700352 12:38:48 INFO - PROCESS | 10748 | 12:38:51 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48967/tests/kraken/driver.html?testName=audio-dft) 12:38:51 INFO - PROCESS | 10748 | RSS: Main: 174702592 12:38:51 INFO - PROCESS | 10748 | 12:38:54 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48967/tests/kraken/driver.html?testName=audio-fft) 12:38:55 INFO - PROCESS | 10748 | RSS: Main: 266280960 12:38:55 INFO - PROCESS | 10748 | 12:38:57 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48967/tests/kraken/driver.html?testName=audio-oscillator) 12:38:57 INFO - PROCESS | 10748 | RSS: Main: 172617728 12:38:57 INFO - PROCESS | 10748 | 12:38:59 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48967/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:39:00 INFO - PROCESS | 10748 | RSS: Main: 174051328 12:39:00 INFO - PROCESS | 10748 | 12:39:03 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48967/tests/kraken/driver.html?testName=imaging-darkroom) 12:39:04 INFO - PROCESS | 10748 | RSS: Main: 210092032 12:39:04 INFO - PROCESS | 10748 | 12:39:07 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48967/tests/kraken/driver.html?testName=imaging-desaturate) 12:39:08 INFO - PROCESS | 10748 | RSS: Main: 209670144 12:39:08 INFO - PROCESS | 10748 | 12:39:10 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48967/tests/kraken/driver.html?testName=json-parse-financial) 12:39:11 INFO - PROCESS | 10748 | RSS: Main: 208535552 12:39:11 INFO - PROCESS | 10748 | 12:39:12 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48967/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:39:13 INFO - PROCESS | 10748 | RSS: Main: 170885120 12:39:13 INFO - PROCESS | 10748 | 12:39:15 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:15 INFO - PROCESS | 10748 | RSS: Main: 178147328 12:39:15 INFO - PROCESS | 10748 | 12:39:17 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:18 INFO - PROCESS | 10748 | RSS: Main: 183865344 12:39:18 INFO - PROCESS | 10748 | 12:39:20 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:21 INFO - PROCESS | 10748 | RSS: Main: 184766464 12:39:21 INFO - PROCESS | 10748 | 12:39:24 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:39:24 INFO - PROCESS | 10748 | RSS: Main: 182292480 12:39:24 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | Cycle 1(1): loaded http://localhost:48967/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48967/tests/kraken/driver.html?testName=ai-astar) 12:39:26 INFO - PROCESS | 10748 | RSS: Main: 233070592 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | __start_tp_report 12:39:26 INFO - PROCESS | 10748 | _x_x_mozilla_page_load 12:39:26 INFO - PROCESS | 10748 | _x_x_mozilla_page_load_details 12:39:26 INFO - PROCESS | 10748 | |i|pagename|runs| 12:39:26 INFO - PROCESS | 10748 | |0;ai-astar;108;112;110;110;111;109;109;110;109;109 12:39:26 INFO - PROCESS | 10748 | |1;audio-beat-detection;139;120;117;147;121;118;118;115;142;120 12:39:26 INFO - PROCESS | 10748 | |2;audio-dft;160;161;160;161;161;161;161;160;162;161 12:39:26 INFO - PROCESS | 10748 | |3;audio-fft;75;74;77;110;76;77;76;75;95;76 12:39:26 INFO - PROCESS | 10748 | |4;audio-oscillator;81;81;111;82;82;82;98;82;81;117 12:39:26 INFO - PROCESS | 10748 | |5;imaging-gaussian-blur;117;117;118;116;117;118;117;117;117;117 12:39:26 INFO - PROCESS | 10748 | |6;imaging-darkroom;146;147;146;146;146;146;147;146;147;147 12:39:26 INFO - PROCESS | 10748 | |7;imaging-desaturate;94;94;95;94;95;95;95;95;94;94 12:39:26 INFO - PROCESS | 10748 | |8;json-parse-financial;52;52;51;51;51;51;51;51;50;50 12:39:26 INFO - PROCESS | 10748 | |9;json-stringify-tinderbox;59;61;59;58;60;58;60;59;60;60 12:39:26 INFO - PROCESS | 10748 | |10;stanford-crypto-aes;73;72;72;72;73;73;73;78;72;73 12:39:26 INFO - PROCESS | 10748 | |11;stanford-crypto-ccm;126;125;119;114;116;116;114;116;154;119 12:39:26 INFO - PROCESS | 10748 | |12;stanford-crypto-pbkdf2;153;150;156;149;152;148;149;149;148;155 12:39:26 INFO - PROCESS | 10748 | |13;stanford-crypto-sha256-iterative;63;62;63;61;61;61;61;61;60;60 12:39:26 INFO - PROCESS | 10748 | __end_tp_report 12:39:26 INFO - PROCESS | 10748 | __start_cc_report 12:39:26 INFO - PROCESS | 10748 | _x_x_mozilla_cycle_collect,1582 12:39:26 INFO - PROCESS | 10748 | __end_cc_report 12:39:26 INFO - PROCESS | 10748 | __startTimestamp1475523566502__endTimestamp 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | ------- Summary: start ------- 12:39:26 INFO - PROCESS | 10748 | Number of tests: 14 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.16 (1.1%) stddev-sans-first:1.05 12:39:26 INFO - PROCESS | 10748 | Values: 108.0 112.0 110.0 110.0 111.0 109.0 109.0 110.0 109.0 109.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#1] audio-beat-detection Cycles:10 Average:125.70 Median:120.50 stddev:11.98 (9.9%) stddev-sans-first:11.70 12:39:26 INFO - PROCESS | 10748 | Values: 139.0 120.0 117.0 147.0 121.0 118.0 118.0 115.0 142.0 120.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 12:39:26 INFO - PROCESS | 10748 | Values: 160.0 161.0 160.0 161.0 161.0 161.0 161.0 160.0 162.0 161.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.86 (15.6%) stddev-sans-first:12.37 12:39:26 INFO - PROCESS | 10748 | Values: 75.0 74.0 77.0 110.0 76.0 77.0 76.0 75.0 95.0 76.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.00 stddev:13.87 (16.9%) stddev-sans-first:14.35 12:39:26 INFO - PROCESS | 10748 | Values: 81.0 81.0 111.0 82.0 82.0 82.0 98.0 82.0 81.0 117.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 12:39:26 INFO - PROCESS | 10748 | Values: 117.0 117.0 118.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:39:26 INFO - PROCESS | 10748 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 12:39:26 INFO - PROCESS | 10748 | Values: 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:0.67 (1.3%) stddev-sans-first:0.60 12:39:26 INFO - PROCESS | 10748 | Values: 52.0 52.0 51.0 51.0 51.0 51.0 51.0 51.0 50.0 50.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:60.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 12:39:26 INFO - PROCESS | 10748 | Values: 59.0 61.0 59.0 58.0 60.0 58.0 60.0 59.0 60.0 60.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:1.79 (2.5%) stddev-sans-first:1.90 12:39:26 INFO - PROCESS | 10748 | Values: 73.0 72.0 72.0 72.0 73.0 73.0 73.0 78.0 72.0 73.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:119.00 stddev:12.03 (10.1%) stddev-sans-first:12.67 12:39:26 INFO - PROCESS | 10748 | Values: 126.0 125.0 119.0 114.0 116.0 116.0 114.0 116.0 154.0 119.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:151.00 stddev:2.92 (1.9%) stddev-sans-first:3.00 12:39:26 INFO - PROCESS | 10748 | Values: 153.0 150.0 156.0 149.0 152.0 148.0 149.0 149.0 148.0 155.0 12:39:26 INFO - PROCESS | 10748 | 12:39:26 INFO - PROCESS | 10748 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:1.06 (1.7%) stddev-sans-first:0.93 12:39:26 INFO - PROCESS | 10748 | Values: 63.0 62.0 63.0 61.0 61.0 61.0 61.0 61.0 60.0 60.0 12:39:26 INFO - PROCESS | 10748 | -------- Summary: end -------- 12:39:26 INFO - PROCESS | 10748 | 12:39:27 INFO - TEST-INFO | 10748: exit 0 12:39:27 INFO - TEST-OK | kraken | took 59564ms 12:39:27 INFO - SUITE-END | took 1173s 12:39:27 INFO - Completed test suite (00:19:33) 12:39:27 INFO - javascript benchmark 12:39:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3197.072848873827, 3233.563468931695, 3234.6927041931017, 3251.658575849537, 3272.427325218088, 5730.7707691692285, 5796.159556864252, 5823.330317013545, 5834.445727655866, 5838.153467747175, 5792.102224155252, 5837.1536127261625, 5848.03507421276, 5851.473367396933, 5858.1505681676235, 5205.297284866542, 5254.474552544734, 5290.470952904717, 5294.1529355303155, 5338.91991620126, 5164.302819119427, 5330.253764472957, 5361.946380536184, 5362.0616392131415, 5386.91919621206, 5137.023965446553, 5214.296070030554, 5216.426193118754, 5231.973840130794, 5250.816221432251, 5258.894822103574, 5286.841394758144, 5298.258243845865, 5371.919421208685, 5373.973130134364, 5039.647224694273, 5196.29849970253, 5281.683099014033, 5290.761915713763, 5362.892742145174, 5590.133529302964, 5661.943380566183, 5663.915041274384, 5723.627964182357, 5829.854253643651, 6114.908276375858, 6158.322584515699, 6169.105479705418, 6171.475424588915, 6180.536459765535, 6059.606125601866, 6200.87598248037, 6217.316095229521, 6217.96891015542, 6224.87550248997, 5687.601867869251, 5695.658260504341, 5741.052726300114, 5743.798967036134, 5769.769209231667, 6329.778457754049, 6362.300146983828, 6365.49076073913, 6370.713317900706, 6374.745010199633, 5872.471477567039, 5929.881402372014, 6100.969495152496, 6101.298350689727, 6110.083487476914, 6135.938640613626, 6155.1075094112, 6162.506999440034, 6190.164327815777, 6259.624422534663, 6155.4767844732805, 6160.630362178284, 6162.815115546541, 6167.629942203482, 6169.660668663267, 5951.077582974646, 6110.794972396109, 6167.414095660905, 6174.691265436711, 6175.84560385994, 4627.051454451829, 4652.488226295105, 4654.394928659252, 4655.906881862344, 4656.0920620479355, 4088.550259471456, 4120.464339635828, 4154.709170358046, 4182.769947652909, 4278.336857787048, 5737.225474560964, 5738.081906894877, 5764.0, 5789.739461724233, 5818.5054270386645, 6168.19813424261, 6176.258848938066, 6185.690715464209, 6188.195534580565, 6188.257409110935, 5596.524295434852, 5699.316082070178, 5773.220615216976, 5829.8251052468495, 5842.328132264844, 5366.221897824794, 5378.354597448253, 5378.91931621026, 5382.085045542267, 5398.217258497574, 6361.840953976188, 6487.643179625072, 6492.5455218134275, 6496.35036496356, 6497.707603157869, 6061.605995610271, 6118.174046503665, 6128.142060111499, 6249.062640603764, 6249.687515624109, 6402.775902843378, 6505.479561635152, 6521.478281737354, 6524.4780417565535, 6526.575772574767, 6122.877542449037, 6124.510039196943, 6133.539984501091, 6136.662483563447, 6141.7543298267565, 6055.9091613626715, 6116.143739876332, 6209.937900621117, 6265.27949285838, 6269.717862696099, 6001.7599296027665, 6039.516838652809, 6125.509959203342, 6179.567430279837, 6186.072089186658, 6071.2714474263375, 6072.757089716361, 6075.2405949256345, 6083.330833608211, 6110.969445152746, 5833.883322333445, 6033.215681961317, 6085.330613632408, 6091.7258723358445, 6099.329073801967, 5917.37867523921, 6024.819255422344, 6086.6652334122045, 6097.664628445301, 6158.476529495043, 5934.851628709317, 5950.642961422329, 5982.192404025401, 5989.311229208697, 6005.489533389711], "value": 5692.437650016796, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.811260396673, 608.4736702752119, 628.2398298059345, 637.4963778614895, 643.4112786800079, 35072.824635876816, 47036.76481617591, 48430.75784621072, 48449.51550484503, 48474.27288590674, 48056.0, 48380.27429588559, 48536.0, 48561.0, 48590.51409485904, 8436.114208008163, 9373.43759374438, 9509.619615215383, 9518.762030949247, 9524.761880952963, 8346.332293416543, 10917.0, 11278.661640150809, 11282.548698052067, 11662.241954272988, 11464.19750617457, 11469.426528673575, 11535.192536522447, 11598.884011159866, 11609.0, 11282.661520154408, 11339.092872570174, 11345.829812552776, 11361.091112711047, 11362.545498180105, 11140.721481963015, 11183.776324473547, 11252.26860254081, 11258.268212566158, 11262.0, 45341.77329113333, 45611.77194114041, 45703.54296457026, 46158.53841461576, 46262.07475850464, 3793.715471339661, 3910.7849068301234, 4071.694622903294, 4101.753894766323, 4395.406620106277, 34886.651133488594, 35140.472892906626, 35183.82408087943, 35301.21262566102, 36065.81967090174, 4540.909181816345, 4571.862844114682, 4594.196015697273, 4626.976865115686, 4695.835645752382, 361792.0, 362078.0, 362272.0, 363212.9999999974, 366058.0, 66338.0, 66508.33491665118, 66816.6659166701, 66975.0, 67079.0, 41223.587764122574, 41885.58114418878, 42112.0, 44113.338299924886, 44113.77943110264, 19604.509887252934, 19756.407307780788, 19793.505162371057, 19798.70301945472, 19832.50418739514, 13430.664233394244, 13777.380017899219, 14494.0, 14600.904932130134, 14663.706725865637, 20343.0, 21044.47388815292, 21305.36083917485, 21349.679754803692, 21449.249276275255, 7340.073060912387, 7544.886826697604, 7568.470207085561, 7614.390848732088, 7684.923150768533, 980.1570649241646, 1067.1356201476674, 1096.2381145104237, 1146.3293973025873, 1153.6366044695894, 34960.475592866125, 35114.0, 35115.413845687646, 35317.29365412677, 35425.29149416997, 1103.8730545987153, 1131.7962766702074, 1135.074913945132, 1192.7495226002463, 1234.9876501234874, 18177.454676359732, 18184.36354727578, 18299.451016469528, 18322.358717444826, 18372.448826535227, 523970.0, 600477.0, 608043.0, 609226.0, 853867.0, 64275.0, 64755.352446474935, 64877.35122648808, 64882.675586621765, 64969.0, 1346.6296768388574, 1384.0865029080758, 1420.8934329925296, 1472.271225743264, 1476.2692467228576, 33832.49251261282, 36109.81945090258, 36365.45451818278, 36367.27265454729, 36462.27075458529, 54868.17697734457, 55382.0, 55633.0, 55633.165502518306, 55837.0, 424593.0, 428249.0, 428400.0, 428573.0, 430464.0, 31349.216269593442, 32439.0, 32510.51234231441, 33620.831895841344, 33643.83178084094, 51755.48244517507, 51772.482275176764, 51782.48217517776, 51869.7406512965, 52206.47793522168, 43337.56662433461, 44670.55329446664, 44696.776516117214, 45168.54831451775, 46306.53693463157, 43903.34144987764, 45004.549954500035, 45065.098698026515, 45678.54321456876, 46170.7691461554, 43892.78053609712, 44250.0, 44555.0, 44664.77667611641, 44974.55025449704, 37263.813680931424, 39837.0, 40106.39840402455, 40190.0, 40653.59346406498, 29588.704112959455, 29759.0, 29886.402271954874, 30221.0, 30234.395312094075], "value": 21979.696904116077, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.23318296139564, 432.75549314637226, 440.80604534005033, 443.4988463036769, 447.9584964956477, 16743.83256167438, 19527.70708439373, 19767.703484447746, 20306.492337691565, 20366.69449958248, 19073.332433364834, 19904.40286791395, 19985.500362490944, 20119.899400502978, 20511.794882051174, 5876.794312199074, 6028.005379112441, 6083.209182806229, 6088.573799834014, 6093.146959425661, 5683.119116536923, 5979.0, 6003.489703375219, 6071.3625069367745, 6071.51427885768, 5740.971295143519, 6060.909086363708, 6064.605800622945, 6073.301570319403, 6078.0, 5940.851478713045, 6078.1186727924205, 6114.144019837227, 6115.510759139281, 6124.295705993779, 5795.1886735857015, 5887.676177810219, 5950.494207992326, 5973.402659733992, 5976.910346344765, 14974.700505989927, 15071.4724984625, 15074.472393466176, 15171.544853654408, 15183.392664293415, 2337.4623836517526, 2395.5927492326346, 2456.4350199454047, 2803.3832556837465, 3056.969430305691, 10949.343039417581, 12880.677983050406, 12930.030247731458, 14842.628934276621, 15008.174550399724, 2037.215671966289, 2104.6316894543547, 2206.8565543239797, 2261.197274967379, 2325.8370814592704, 86423.0, 87129.56435217784, 87519.56240218758, 88007.0, 88757.55621221918, 10560.313579617301, 11755.471003804849, 11853.0, 12107.697307567381, 12204.206726562745, 15334.156621385931, 15395.769063464057, 16214.75677864833, 16232.350705971865, 16846.0, 7259.087378449811, 7290.125184977731, 7337.376323012603, 8403.285720713686, 9167.724968250963, 8877.156670116328, 8911.821763564822, 8957.731268061969, 9132.81734365309, 9133.588988495401, 5080.466551012164, 5131.179011358165, 5132.897342053213, 5163.793448262102, 5249.580033597303, 2119.1417475922276, 2121.0985331234165, 2142.258746559236, 2166.3176099528596, 2176.096919778306, 1007.969760907174, 1018.9592416303414, 1039.262123892045, 1083.3175099687305, 1083.4636854756945, 20115.29596464146, 20296.797032029786, 20376.184952602027, 20542.486437839172, 20663.276785312442, 1053.7260312318851, 1053.8629978102797, 1077.8006068877282, 1090.1170052257696, 1145.0724912820642, 10490.947545262377, 11396.373199473943, 11396.544138234543, 11458.885411145782, 11510.136739744552, 511148.0, 546580.0, 546679.0, 547477.0, 547729.0, 57849.0, 69951.30048699549, 96291.0, 96764.51617741866, 96896.0, 1012.772126271583, 1048.9475526223657, 1058.6030238660503, 1058.867641544807, 1072.5120070367964, 17648.64702705913, 17988.0, 18079.36722214716, 18184.818151818312, 18357.3574924877, 42765.78617106895, 43089.0, 43228.351574727036, 43672.56327436685, 43697.56302436935, 60160.2687475938, 60239.0, 60808.695956519936, 61274.69362653158, 62173.37826621857, 6034.818955431344, 6331.176946996861, 9033.096690330914, 9082.682106126254, 9093.590788414405, 12081.214721043456, 13416.262105583895, 13527.256000920044, 13541.864581354454, 13668.726625467634, 11917.22538035025, 11929.880701192877, 11959.103067269816, 12006.75986480248, 12082.818757718816, 11373.886261137282, 11721.706957326134, 11828.645140645795, 11936.343501107522, 11965.102617303563, 11289.887101128883, 11751.647450576496, 11893.286402815858, 11932.164748467523, 11937.82093268619, 8460.703875364332, 8853.07042760501, 8898.377113601986, 8909.198172164537, 8931.285497160081, 11267.323960562393, 12220.572279970158, 12224.388780561114, 12391.62825115248, 12474.812877806658], "value": 9574.148941487218, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.1263728027654, 1488.6427257458206, 1552.9689406211874, 1679.7984241890974, 1794.0760508338208, 7811.492253003558, 9330.766730831732, 9719.222462203024, 9750.804983900318, 9955.153811925995, 9776.951115244432, 9839.75400614985, 9846.655367062154, 9860.30977831552, 9861.457619830906, 2583.987080064597, 2601.544729672309, 2609.465059662774, 2609.5302845487804, 2612.555865502869, 2539.5555777738914, 2590.702069262031, 2594.44219492809, 2594.455164415466, 2595.636610874479, 2512.095645567594, 2524.116559204282, 2547.426828963478, 2548.3374322676145, 2548.617707343904, 2490.9750902491014, 2517.2322441655288, 2520.5589021921273, 2524.368907773057, 2527.027094568586, 2470.295965649781, 2490.3276115448725, 2494.750524947509, 2497.31323885931, 2498.0132847525306, 9767.316287859852, 9774.462404567746, 9804.117629413387, 9809.754756131153, 9813.362131461503, 5551.195076713894, 5743.885122297573, 5755.136729490568, 5757.827265182052, 5803.506701930341, 3785.413260944558, 3849.7305188636806, 3915.647591716759, 3963.7225394222414, 3994.3409337459284, 1308.653206900172, 1358.714669919318, 1378.800073989266, 1390.7288078824633, 1445.9927700361432, 13548.661283467894, 13771.0, 13775.931120344434, 13814.0, 13815.792763108562, 5155.097857874857, 5332.866678333073, 5344.732763361816, 5378.838634840961, 5472.534834539029, 10927.125829933586, 11003.889961100447, 11022.063124634496, 11025.338479691245, 11037.061849742862, 5623.297087864017, 5706.657600543897, 5717.399673034354, 5721.8569535761935, 5723.771049157987, 4340.891477713019, 4565.338025986213, 4722.220833562424, 5326.067938110815, 5368.812091576776, 4321.0709697415205, 4346.456692913386, 4379.802908869108, 4425.203463376559, 4478.955210447919, 1307.9738405231842, 1318.7692153873033, 1325.4168166006925, 1338.2840180503383, 1344.1531834943924, 956.2350119904049, 956.933014688979, 981.9018098190267, 987.8555385502165, 999.3304485994402, 6066.241719785027, 6127.969360153171, 6164.445199931938, 6169.167162433014, 6456.870862582722, 1015.8171529124828, 1031.2059714020163, 1053.3627155570769, 1058.5236643510298, 1065.9200559957878, 4169.687273454503, 4241.63946064588, 4308.719933204332, 4364.4980827204645, 4425.0, 12151.270923744603, 12544.310062946442, 12663.303518306397, 12671.936640316924, 12673.049521285757, 12522.937385313015, 12541.811872821914, 12567.434465449076, 12568.685782855502, 12568.81146782799, 8646.178613031752, 9072.228860546928, 9073.319501037317, 9230.53847307632, 9260.259179265777, 6218.782342618168, 6286.5599408041, 6364.109024736448, 6449.032645103272, 6472.320406357265, 11038.613648522263, 11204.775904481701, 11205.60780372683, 11227.887721122685, 11366.261193022427, 9652.27607929394, 9961.153301969414, 10995.680518337851, 11416.600418985296, 11798.41007949582, 8421.073681894864, 8612.698555550525, 8679.826403471769, 8705.608247629, 8911.930568331842, 9544.761380965254, 9574.090461406155, 9587.520623968912, 9594.472304023346, 9612.038796120332, 8339.874901876356, 8364.289035432057, 8428.536430496382, 8454.535000575028, 8472.872906906525, 8481.10948350439, 8515.701950431705, 8528.360372971927, 8550.657973680984, 8560.743177704679, 6801.0, 6948.409385202314, 7020.5787652741, 7230.0, 7288.198298187302, 5495.945040549704, 5554.583406244467, 5576.163575463713, 5636.549076073822, 5791.739371728198, 5483.067878460751, 5483.479069488392, 5485.122380419114, 5534.640248383842, 5601.915971260353], "value": 5065.271721209926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.3428805278157, 357.4959307376599, 359.5721091900638, 364.5607043512568, 367.25630598038987, 5665.688387138705, 5689.2319536862515, 5689.516391106756, 5702.771889124435, 5712.171735098408, 5343.251944727741, 5418.9458105418935, 5456.990456765501, 5551.916721249175, 5620.185073164389, 4400.933985990213, 4409.338599210112, 4409.977950110245, 4420.403245561856, 4444.155610434023, 4399.758013309267, 4422.385829172345, 4430.556944305576, 4446.7554284514335, 4450.643948484114, 4305.160807778609, 4365.323374876899, 4366.432363792703, 4375.496817865955, 4398.780060996954, 4354.738715677069, 4362.1493808707, 4364.89087772805, 4371.9999999999845, 4384.846530371454, 3921.490206273195, 3925.234579257046, 3928.9017774555864, 3932.233214523169, 3942.3100957332354, 5243.973780131075, 5456.536194423479, 5474.7810087596445, 5490.752916118784, 5505.476979686963, 5008.348914641109, 5009.599232061426, 5028.647994640377, 5034.0, 5036.244563315532, 5854.092615644582, 5857.121431785224, 5864.530837532987, 5897.0, 5934.5845790794665, 4151.190517849021, 4199.286121359376, 4230.17511585241, 4245.299525578276, 4251.256030194734, 6064.817360614682, 6089.299730531001, 6098.0, 6102.389761023906, 6120.704735724059, 4335.913281734348, 4341.978290108529, 4345.283028300295, 4352.7823608819435, 4355.562664320766, 4289.120730250291, 4381.079973205662, 4390.7705842364185, 4414.161309351213, 4426.690131690815, 4991.176455884738, 4997.800087996439, 5005.374328208974, 5006.4492905780335, 5040.0, 5769.365369809318, 5892.878563717059, 5972.432618901197, 5979.880402391927, 5981.700914954235, 1443.0, 1468.097120271047, 1501.3919362658141, 1521.2697905005439, 1532.440659159421, 976.6239997600833, 1002.7128189279208, 1003.4512338659722, 1009.3187098708343, 1025.487256371814, 5605.243292155588, 5635.408282130399, 5637.859053523613, 5651.513334132968, 5654.491095801398, 5915.852103697356, 5925.170476133345, 5942.286925568959, 5958.7914422995855, 5962.761489540369, 5410.756515956791, 5540.3683250455715, 5588.2455868458055, 5603.030393891244, 5611.354694210137, 3163.2724473371254, 3179.7138257556467, 3181.66592507788, 3191.5850939377733, 3192.537082123079, 5966.49284810796, 6165.383461653889, 6169.637547536603, 6182.69086545671, 6204.534659900525, 6073.240844894388, 6079.331273559905, 6087.29996050451, 6105.603135796159, 6106.0, 6186.041163619646, 6197.4732147767045, 6201.937980620136, 6220.968895155495, 6244.094606282155, 5790.218320526844, 5935.495482884004, 5958.821235362946, 5964.852653044813, 5986.820395387971, 5804.593678442468, 5895.528357731457, 5902.321233058082, 5946.672932988728, 5949.370883760989, 6018.3379828217985, 6182.876342473215, 6214.751409943552, 6269.780557680641, 6286.15136956505, 4316.287812510901, 4319.870403887889, 4320.697551171388, 4325.480942286946, 4331.978340108405, 5952.821415357546, 5980.34216236205, 5993.310769261417, 6004.249468816398, 6008.446410275703, 5626.774929002958, 5698.601097923106, 5714.485696287354, 5869.618474799125, 5917.467427931335, 5887.911681324869, 5888.705564721661, 5903.675297858659, 5910.349861515316, 5910.408959104056, 5648.662014396356, 5804.970975145097, 5847.649141051551, 5877.794277200277, 5933.495652869555, 5875.265591801025, 5885.470307672159, 5898.8230353089475, 5946.464818166386, 5953.732082056405, 5793.710314484175, 5802.47777700009, 5811.56413268998, 5824.388439213822, 5841.853953651193], "value": 4489.675047572992, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.5264270401815, 822.4900561651776, 874.8075423406848, 908.462231155379, 932.2122806228737, 14816.111033337993, 15853.3658653654, 15860.682786344281, 15866.286017129229, 15908.602284942883, 14988.550343489685, 15120.092794432314, 15164.090154590733, 15172.468963586276, 15189.848101518981, 690.1717938473839, 731.1920328037522, 843.7510934274404, 868.6525389844081, 873.153041549699, 870.3776799588325, 872.5026734761188, 873.3624454148476, 873.4191762477944, 873.5151990645189, 730.8501757139774, 926.4348747264163, 927.3184209605968, 929.0106037070532, 929.6420877961966, 774.3302043732159, 880.9691660791874, 911.9224865886441, 922.7416323429451, 926.2543652359848, 675.9526833121683, 676.9356911093488, 677.2279601254573, 677.5088061155672, 677.8339306869799, 15881.205939702968, 15899.205039747967, 15930.761038584431, 15939.123348215844, 15951.601209969727, 14288.642783930381, 14865.736412404958, 15155.318010689545, 15429.151396673178, 15587.376504939788, 13831.308434578332, 13866.029377943549, 14155.787663185061, 14265.928670356581, 14437.855621443861, 4190.308599081179, 4196.874093777192, 4232.195882782262, 4306.397104405386, 4394.07724377881, 60479.0, 70394.56962157831, 77222.0, 77562.0, 78408.60795695985, 11613.6515904523, 11742.70643233909, 11810.763784724257, 11882.702932426759, 11956.581519646945, 20893.268735594484, 20901.0, 20907.68638470424, 20925.89537052305, 20935.16259349609, 9042.321825862955, 9058.230050445654, 9067.229285510673, 9225.354225204306, 9568.56941437623, 5092.668976516515, 5119.539241468286, 5167.715775632376, 5174.482551744795, 5322.121849894724, 3748.231612519427, 3890.1636148228267, 3900.531936167621, 3901.668358189586, 3902.024493876531, 675.2673349415841, 675.2976904019863, 685.1059367525427, 689.6689588997309, 691.0739608924066, 761.4936067515151, 777.3780975219802, 799.6921185343568, 799.9280064794197, 803.3533005930283, 9577.653474898556, 9823.36148150368, 10158.916541450571, 10659.307145035547, 10888.67333979982, 715.742332760206, 777.5606782168057, 787.9763607091681, 791.5211297165247, 793.500094940184, 4730.9763451182525, 4792.9281060784115, 4864.6594738368685, 4892.094962431962, 4892.828750993769, 79379.0, 121164.39417802854, 130308.3484582571, 131409.34295328462, 137699.31150344384, 115509.0, 117205.41397292959, 118875.0, 118980.0, 122332.0, 102105.48947255364, 103578.0, 103612.0, 104755.0, 105824.0, 9028.548572571213, 9038.141376569216, 9169.587368568564, 9226.308026898143, 9265.861012084959, 46676.0, 47140.93583917034, 49523.25715114204, 52442.724814165136, 62984.68507657432, 73833.0, 78675.21324786679, 79825.2017479841, 82531.17468825474, 85011.0, 13771.311434428038, 13820.585382438543, 13943.093698909539, 14102.506412275521, 14331.856681433052, 14143.64640883986, 14393.568192954228, 14528.782068269196, 14924.552263432115, 15201.771973420186, 15148.394064237307, 15791.921040394724, 16053.0, 16055.308248986224, 16448.506544803677, 13309.401076951754, 13592.660183495096, 13605.183688978694, 13959.092658977133, 14462.421503139756, 15139.394424223348, 15209.239538023276, 15229.923850380677, 16370.099644519665, 16627.916860416106, 10796.514156862802, 11317.320960742381, 11326.263792853439, 11383.0, 11695.064394848561, 12344.074194435274, 12367.814482782585, 12562.59168096239, 12652.936735316265, 12669.619911402673], "value": 8059.867924740739, "unit": "score"}], "name": "dromaeo_css", "value": 7767.262868832398, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 110.0, 110.0, 111.0, 109.0, 109.0, 110.0, 109.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 120.0, 117.0, 147.0, 121.0, 118.0, 118.0, 115.0, 142.0, 120.0], "value": 125.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 110.0, 76.0, 77.0, 76.0, 75.0, 95.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 111.0, 82.0, 82.0, 82.0, 98.0, 82.0, 81.0, 117.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0, 50.0, 50.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 58.0, 60.0, 58.0, 60.0, 59.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 73.0, 73.0, 73.0, 78.0, 72.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 119.0, 114.0, 116.0, 116.0, 114.0, 116.0, 154.0, 119.0], "value": 121.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 156.0, 149.0, 152.0, 148.0, 149.0, 149.0, 148.0, 155.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0], "value": 61.3, "unit": "score"}], "name": "kraken", "value": 1442.6000000000001, "alertThreshold": 2.0}]} 12:39:27 INFO - Return code: 0 12:39:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:39:27 INFO - # TBPL SUCCESS # 12:39:27 INFO - Running post-action listener: _resource_record_post_action 12:39:27 INFO - [mozharness: 2016-10-03 19:39:27.803947Z] Finished run-tests step (success) 12:39:27 INFO - Running post-run listener: _resource_record_post_run 12:39:27 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 374771712; Read time: 12; Write time: 203760 12:39:27 INFO - TinderboxPrint: CPU usage
12.9% 12:39:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:39:27 INFO - TinderboxPrint: I/O write bytes / time
374,771,712 / 203,760 12:39:27 INFO - TinderboxPrint: CPU idle
8,269.1 (87.0%) 12:39:27 INFO - TinderboxPrint: CPU user
1,186.7 (12.5%) 12:39:27 INFO - TinderboxPrint: Swap in / out
0 / 0 12:39:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124260352; Read time: 0; Write time: 64908 12:39:27 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 250511360; Read time: 0; Write time: 138852 12:39:28 INFO - Running post-run listener: _upload_blobber_files 12:39:28 INFO - Blob upload gear active. 12:39:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:39:28 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 12:39:28 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'] 12:39:28 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 12:39:28 INFO - (blobuploader) - INFO - Open directory for files ... 12:39:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:39:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:39:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:29 INFO - (blobuploader) - INFO - Done attempting. 12:39:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:39:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:30 INFO - (blobuploader) - INFO - Done attempting. 12:39:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:39:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:39:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:33 INFO - (blobuploader) - INFO - Done attempting. 12:39:33 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:33 INFO - Return code: 0 12:39:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d49e37ba6a337d68760b2216a782a07e735e68a4bc1199bc2e3e94ce0dd7d0bab3a57e649915bb4f8cec7a4002f77db070d43d04bc5316c56f85b4f073fdb4ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/432ea0da1d80298bd6d99b66693020ef4ca909c7f855702cdc1cd1c43a9155f1a2f08658967a1d8a6edf0e690eacc6057e297fd24df28b1c98ee6a0239275f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44f2edfad02059e20947dfe1272b43f0b965f472408a33aaa5a681cc1a463a3cca72fd9e6f4de192ddc10bb55903f05130ca55db7a81b2879614dc8a7ee2ebcd"} 12:39:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:33 INFO - Contents: 12:39:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d49e37ba6a337d68760b2216a782a07e735e68a4bc1199bc2e3e94ce0dd7d0bab3a57e649915bb4f8cec7a4002f77db070d43d04bc5316c56f85b4f073fdb4ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/432ea0da1d80298bd6d99b66693020ef4ca909c7f855702cdc1cd1c43a9155f1a2f08658967a1d8a6edf0e690eacc6057e297fd24df28b1c98ee6a0239275f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44f2edfad02059e20947dfe1272b43f0b965f472408a33aaa5a681cc1a463a3cca72fd9e6f4de192ddc10bb55903f05130ca55db7a81b2879614dc8a7ee2ebcd"} 12:39:33 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:33 INFO - Copying logs to upload dir... 12:39:33 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.360604 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-10-03 12:39:33.554995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 12:39:33.559613) ========= 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=41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556 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/d49e37ba6a337d68760b2216a782a07e735e68a4bc1199bc2e3e94ce0dd7d0bab3a57e649915bb4f8cec7a4002f77db070d43d04bc5316c56f85b4f073fdb4ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/432ea0da1d80298bd6d99b66693020ef4ca909c7f855702cdc1cd1c43a9155f1a2f08658967a1d8a6edf0e690eacc6057e297fd24df28b1c98ee6a0239275f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44f2edfad02059e20947dfe1272b43f0b965f472408a33aaa5a681cc1a463a3cca72fd9e6f4de192ddc10bb55903f05130ca55db7a81b2879614dc8a7ee2ebcd"} build_url:https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/E6dhxkIET_6ak2R2lRKYbw/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/d49e37ba6a337d68760b2216a782a07e735e68a4bc1199bc2e3e94ce0dd7d0bab3a57e649915bb4f8cec7a4002f77db070d43d04bc5316c56f85b4f073fdb4ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/432ea0da1d80298bd6d99b66693020ef4ca909c7f855702cdc1cd1c43a9155f1a2f08658967a1d8a6edf0e690eacc6057e297fd24df28b1c98ee6a0239275f4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44f2edfad02059e20947dfe1272b43f0b965f472408a33aaa5a681cc1a463a3cca72fd9e6f4de192ddc10bb55903f05130ca55db7a81b2879614dc8a7ee2ebcd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 12:39:33.592553) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:39:33.592906) ========= 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=41bf3e9aed84707956354da8000001c5-1475522053.725655-79121556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:39:33.678214) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 12:39:33.678585) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 12:39:33.678925) ========= ========= Total master_lag: 0.25 =========