builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1479136724.09 results: success (0) buildid: 20161114015620 builduid: 7575ab475a3f4481a1ee0dc2e232252d revision: 0f867a8846778f927cfb3871e58cc61f6193ad5d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:44.094604) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:44.095118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:44.095430) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:44.110387) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:44.110713) ========= 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-1479136723.576059-1881575041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 07:18:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.4M=0s 2016-11-14 07:18:44 (45.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.099157 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:44.224435) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:44.224830) ========= 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-1479136723.576059-1881575041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017130 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:44.274804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 07:18:44.275290) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f867a8846778f927cfb3871e58cc61f6193ad5d --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 0f867a8846778f927cfb3871e58cc61f6193ad5d --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-1479136723.576059-1881575041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 07:18:44,497 truncating revision to first 12 chars 2016-11-14 07:18:44,497 Setting DEBUG logging. 2016-11-14 07:18:44,498 attempt 1/10 2016-11-14 07:18:44,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0f867a884677?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 07:18:45,885 unpacking tar archive at: mozilla-aurora-0f867a884677/testing/mozharness/ program finished with exit code 0 elapsedTime=1.721750 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 07:18:46.011272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:46.011667) ========= script_repo_revision: 0f867a8846778f927cfb3871e58cc61f6193ad5d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:46.012137) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:46.012439) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 07:18:46.023984) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-14 07:18:46.024527) ========= /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-1479136723.576059-1881575041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:18:46 INFO - MultiFileLogger online at 20161114 07:18:46 in /builds/slave/test 07:18:46 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 07:18:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:18:46 INFO - {'append_to_log': False, 07:18:46 INFO - 'base_work_dir': '/builds/slave/test', 07:18:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:18:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:18:46 INFO - 'branch': 'Mozilla-Aurora', 07:18:46 INFO - 'buildbot_json_path': 'buildprops.json', 07:18:46 INFO - 'config_files': ('talos/linux_config.py',), 07:18:46 INFO - 'default_actions': ('clobber', 07:18:46 INFO - 'read-buildbot-config', 07:18:46 INFO - 'download-and-extract', 07:18:46 INFO - 'populate-webroot', 07:18:46 INFO - 'create-virtualenv', 07:18:46 INFO - 'install', 07:18:46 INFO - 'run-tests'), 07:18:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:18:46 INFO - 'download_minidump_stackwalk': True, 07:18:46 INFO - 'download_symbols': 'ondemand', 07:18:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:18:46 INFO - 'tooltool.py': '/tools/tooltool.py', 07:18:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:18:46 INFO - '/tools/misc-python/virtualenv.py')}, 07:18:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:18:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:18:46 INFO - 'installer_path': 'installer.exe', 07:18:46 INFO - 'log_level': 'info', 07:18:46 INFO - 'log_name': 'talos', 07:18:46 INFO - 'log_to_console': True, 07:18:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:18:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:18:46 INFO - 'opt_config_files': (), 07:18:46 INFO - 'pip_index': False, 07:18:46 INFO - 'sps_profile': False, 07:18:46 INFO - 'sps_profile_interval': 0, 07:18:46 INFO - 'suite': 'dromaeojs', 07:18:46 INFO - 'system_bits': '32', 07:18:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:18:46 INFO - 'title': 'talos-linux64-ix-026', 07:18:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:18:46 INFO - 'use_talos_json': True, 07:18:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:18:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:18:46 INFO - 'work_dir': 'build'} 07:18:46 INFO - [mozharness: 2016-11-14 15:18:46.340492Z] Running clobber step. 07:18:46 INFO - Running pre-action listener: _resource_record_pre_action 07:18:46 INFO - Running main action method: clobber 07:18:46 INFO - rmtree: /builds/slave/test/build 07:18:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:18:46 INFO - Running post-action listener: _resource_record_post_action 07:18:46 INFO - [mozharness: 2016-11-14 15:18:46.793351Z] Finished clobber step (success) 07:18:46 INFO - [mozharness: 2016-11-14 15:18:46.793451Z] Running read-buildbot-config step. 07:18:46 INFO - Running pre-action listener: _resource_record_pre_action 07:18:46 INFO - Running main action method: read_buildbot_config 07:18:46 INFO - Using buildbot properties: 07:18:46 INFO - { 07:18:46 INFO - "project": "", 07:18:46 INFO - "product": "firefox", 07:18:46 INFO - "script_repo_revision": "production", 07:18:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:18:46 INFO - "repository": "", 07:18:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:18:46 INFO - "buildid": "20161114015620", 07:18:46 INFO - "pgo_build": "True", 07:18:46 INFO - "basedir": "/builds/slave/test", 07:18:46 INFO - "buildnumber": 897, 07:18:46 INFO - "slavename": "talos-linux64-ix-026", 07:18:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:18:46 INFO - "platform": "ubuntu64_hw", 07:18:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:18:46 INFO - "branch": "mozilla-aurora", 07:18:46 INFO - "repo_path": "releases/mozilla-aurora", 07:18:46 INFO - "revision": "0f867a8846778f927cfb3871e58cc61f6193ad5d", 07:18:46 INFO - "stage_platform": "linux64-pgo", 07:18:46 INFO - "builduid": "7575ab475a3f4481a1ee0dc2e232252d", 07:18:46 INFO - "slavebuilddir": "test" 07:18:46 INFO - } 07:18:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 07:18:46 INFO - Running post-action listener: _resource_record_post_action 07:18:46 INFO - [mozharness: 2016-11-14 15:18:46.795923Z] Finished read-buildbot-config step (success) 07:18:46 INFO - [mozharness: 2016-11-14 15:18:46.796012Z] Running download-and-extract step. 07:18:46 INFO - Running pre-action listener: _resource_record_pre_action 07:18:46 INFO - Running main action method: download_and_extract 07:18:46 INFO - mkdir: /builds/slave/test/build/tests 07:18:46 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')]} 07:18:46 INFO - trying https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:18:46 INFO - Downloading https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/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 07:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/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 07:18:47 INFO - Downloaded 1361 bytes. 07:18:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:18:47 INFO - Using the following test package requirements: 07:18:47 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:18:47 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:18:47 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:18:47 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:47 INFO - u'jsshell-linux-x86_64.zip'], 07:18:47 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:18:47 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:18:47 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:18:47 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:18:47 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:18:47 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:47 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:18:47 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:18:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 07:18:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:18:47 INFO - Fetch https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:18:47 INFO - Expected file size: 21962623 07:18:52 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 07:18:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 07:18:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:18:52 INFO - Fetch https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:18:52 INFO - Expected file size: 21962623 07:18:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 07:18:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:18:57 INFO - Fetch https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:18:58 INFO - Expected file size: 14414089 07:18:58 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')]} 07:18:58 INFO - trying https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:18:58 INFO - Downloading https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/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 07:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/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 07:18:59 INFO - Downloaded 64070902 bytes. 07:18:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:18:59 INFO - mkdir: /builds/slave/test/properties 07:18:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:18:59 INFO - Writing to file /builds/slave/test/properties/build_url 07:18:59 INFO - Contents: 07:18:59 INFO - build_url:https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:19:00 INFO - Running post-action listener: _resource_record_post_action 07:19:00 INFO - Running post-action listener: set_extra_try_arguments 07:19:00 INFO - [mozharness: 2016-11-14 15:19:00.437163Z] Finished download-and-extract step (success) 07:19:00 INFO - [mozharness: 2016-11-14 15:19:00.437390Z] Running populate-webroot step. 07:19:00 INFO - Running pre-action listener: _resource_record_pre_action 07:19:00 INFO - Running main action method: populate_webroot 07:19:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:19:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:19:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:19:00 INFO - '--tppagecycles', 07:19:00 INFO - '7'], 07:19:00 INFO - 'tests': ['tsvgm']}}, 07:19:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:19:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:19:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:19:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:19:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:00 INFO - 'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:19:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:19:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:00 INFO - 'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['damp', 'tps']}, 07:19:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:00 INFO - 'tests': ['damp', 'tps']}, 07:19:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['dromaeo_dom']}, 07:19:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:19:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['basic_compositor_video']}, 07:19:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:19:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['a11yr', 07:19:00 INFO - 'ts_paint', 07:19:00 INFO - 'tpaint', 07:19:00 INFO - 'sessionrestore', 07:19:00 INFO - 'sessionrestore_no_auto_restore', 07:19:00 INFO - 'tabpaint']}, 07:19:00 INFO - 'other-e10s': {'tests': ['a11yr', 07:19:00 INFO - 'ts_paint', 07:19:00 INFO - 'tpaint', 07:19:00 INFO - 'sessionrestore', 07:19:00 INFO - 'sessionrestore_no_auto_restore', 07:19:00 INFO - 'tabpaint']}, 07:19:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:19:00 INFO - 'ts_paint', 07:19:00 INFO - 'tpaint', 07:19:00 INFO - 'sessionrestore', 07:19:00 INFO - 'sessionrestore_no_auto_restore', 07:19:00 INFO - 'tabpaint']}, 07:19:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:19:00 INFO - 'ts_paint', 07:19:00 INFO - 'tpaint', 07:19:00 INFO - 'sessionrestore', 07:19:00 INFO - 'sessionrestore_no_auto_restore', 07:19:00 INFO - 'tabpaint']}, 07:19:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['a11yr', 07:19:00 INFO - 'ts_paint', 07:19:00 INFO - 'tpaint', 07:19:00 INFO - 'sessionrestore', 07:19:00 INFO - 'sessionrestore_no_auto_restore', 07:19:00 INFO - 'tabpaint']}, 07:19:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['a11yr', 07:19:00 INFO - 'ts_paint', 07:19:00 INFO - 'tpaint', 07:19:00 INFO - 'sessionrestore', 07:19:00 INFO - 'sessionrestore_no_auto_restore', 07:19:00 INFO - 'tabpaint']}, 07:19:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['tsvgx', 07:19:00 INFO - 'tsvgr_opacity', 07:19:00 INFO - 'tart', 07:19:00 INFO - 'tscrollx', 07:19:00 INFO - 'cart']}, 07:19:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:19:00 INFO - 'tsvgr_opacity', 07:19:00 INFO - 'tart', 07:19:00 INFO - 'tscrollx', 07:19:00 INFO - 'cart']}, 07:19:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:00 INFO - 'talos_options': ['--disable-e10s'], 07:19:00 INFO - 'tests': ['tp5o']}, 07:19:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:00 INFO - 'tests': ['tp5o']}, 07:19:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:00 INFO - 'talos_options': ['--disable-e10s', 07:19:00 INFO - '--xperf_path', 07:19:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:19:00 INFO - 'tests': ['tp5n']}, 07:19:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:19:00 INFO - 'talos_options': ['--xperf_path', 07:19:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:19:00 INFO - 'tests': ['tp5n']}}, 07:19:00 INFO - 'talos.zip': {'path': '', 07:19:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:19:00 INFO - Running post-action listener: _resource_record_post_action 07:19:00 INFO - [mozharness: 2016-11-14 15:19:00.459046Z] Finished populate-webroot step (success) 07:19:00 INFO - [mozharness: 2016-11-14 15:19:00.459135Z] Running create-virtualenv step. 07:19:00 INFO - Running pre-action listener: _resource_record_pre_action 07:19:00 INFO - Running main action method: create_virtualenv 07:19:00 INFO - Creating virtualenv /builds/slave/test/build/venv 07:19:00 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 07:19:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:19:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:19:00 INFO - Using real prefix '/usr' 07:19:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:19:01 INFO - Installing distribute.............................................................................................................................................................................................done. 07:19:03 INFO - Installing pip.................done. 07:19:03 INFO - Return code: 0 07:19:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb516234f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1000ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, '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-1479136723.576059-1881575041', '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 07:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:19:03 INFO - Using env: {'DISPLAY': ':0', 07:19:03 INFO - 'HOME': '/home/cltbld', 07:19:03 INFO - 'LANG': 'en_US.UTF-8', 07:19:03 INFO - 'LANGUAGE': 'en_US:en', 07:19:03 INFO - 'LOGNAME': 'cltbld', 07:19:03 INFO - 'MAIL': '/var/mail/cltbld', 07:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:03 INFO - 'MOZ_NO_REMOTE': '1', 07:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:03 INFO - 'NO_EM_RESTART': '1', 07:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:03 INFO - 'PWD': '/builds/slave/test', 07:19:03 INFO - 'SHELL': '/bin/bash', 07:19:03 INFO - 'SHLVL': '1', 07:19:03 INFO - 'TERM': 'linux', 07:19:03 INFO - 'TMOUT': '86400', 07:19:03 INFO - 'USER': 'cltbld', 07:19:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:03 INFO - '_': '/tools/buildbot/bin/python'} 07:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:03 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 07:19:03 INFO - Cleaning up... 07:19:03 INFO - Return code: 0 07:19:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb516234f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1000ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, '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-1479136723.576059-1881575041', '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 07:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:19:03 INFO - Using env: {'DISPLAY': ':0', 07:19:03 INFO - 'HOME': '/home/cltbld', 07:19:03 INFO - 'LANG': 'en_US.UTF-8', 07:19:03 INFO - 'LANGUAGE': 'en_US:en', 07:19:03 INFO - 'LOGNAME': 'cltbld', 07:19:03 INFO - 'MAIL': '/var/mail/cltbld', 07:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:03 INFO - 'MOZ_NO_REMOTE': '1', 07:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:03 INFO - 'NO_EM_RESTART': '1', 07:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:03 INFO - 'PWD': '/builds/slave/test', 07:19:03 INFO - 'SHELL': '/bin/bash', 07:19:03 INFO - 'SHLVL': '1', 07:19:03 INFO - 'TERM': 'linux', 07:19:03 INFO - 'TMOUT': '86400', 07:19:03 INFO - 'USER': 'cltbld', 07:19:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:03 INFO - '_': '/tools/buildbot/bin/python'} 07:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:03 INFO - Downloading/unpacking psutil>=3.1.1 07:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:19:05 INFO - Installing collected packages: psutil 07:19:05 INFO - Running setup.py install for psutil 07:19:05 INFO - building 'psutil._psutil_linux' extension 07:19:05 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 07:19:05 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 07:19:05 INFO - building 'psutil._psutil_posix' extension 07:19:05 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 07:19:05 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 07:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:19:06 INFO - Successfully installed psutil 07:19:06 INFO - Cleaning up... 07:19:06 INFO - Return code: 0 07:19:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:06 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 0x7fb516234f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1000ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, '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-1479136723.576059-1881575041', '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 07:19:06 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 07:19:06 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 07:19:06 INFO - Using env: {'DISPLAY': ':0', 07:19:06 INFO - 'HOME': '/home/cltbld', 07:19:06 INFO - 'LANG': 'en_US.UTF-8', 07:19:06 INFO - 'LANGUAGE': 'en_US:en', 07:19:06 INFO - 'LOGNAME': 'cltbld', 07:19:06 INFO - 'MAIL': '/var/mail/cltbld', 07:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:06 INFO - 'MOZ_NO_REMOTE': '1', 07:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:06 INFO - 'NO_EM_RESTART': '1', 07:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:06 INFO - 'PWD': '/builds/slave/test', 07:19:06 INFO - 'SHELL': '/bin/bash', 07:19:06 INFO - 'SHLVL': '1', 07:19:06 INFO - 'TERM': 'linux', 07:19:06 INFO - 'TMOUT': '86400', 07:19:06 INFO - 'USER': 'cltbld', 07:19:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:06 INFO - '_': '/tools/buildbot/bin/python'} 07:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:19:06 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 07:19:06 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 07:19:06 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 07:19:06 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 07:19:06 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 07:19:06 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 07:19:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:19:08 INFO - Installing collected packages: mozsystemmonitor 07:19:08 INFO - Running setup.py install for mozsystemmonitor 07:19:08 INFO - Successfully installed mozsystemmonitor 07:19:08 INFO - Cleaning up... 07:19:08 INFO - Return code: 0 07:19:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb516234f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1000ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, '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-1479136723.576059-1881575041', '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 07:19:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:19:08 INFO - Using env: {'DISPLAY': ':0', 07:19:08 INFO - 'HOME': '/home/cltbld', 07:19:08 INFO - 'LANG': 'en_US.UTF-8', 07:19:08 INFO - 'LANGUAGE': 'en_US:en', 07:19:08 INFO - 'LOGNAME': 'cltbld', 07:19:08 INFO - 'MAIL': '/var/mail/cltbld', 07:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:08 INFO - 'MOZ_NO_REMOTE': '1', 07:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:08 INFO - 'NO_EM_RESTART': '1', 07:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:08 INFO - 'PWD': '/builds/slave/test', 07:19:08 INFO - 'SHELL': '/bin/bash', 07:19:08 INFO - 'SHLVL': '1', 07:19:08 INFO - 'TERM': 'linux', 07:19:08 INFO - 'TMOUT': '86400', 07:19:08 INFO - 'USER': 'cltbld', 07:19:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:08 INFO - '_': '/tools/buildbot/bin/python'} 07:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:08 INFO - Downloading/unpacking jsonschema==2.5.1 07:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:19:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:10 INFO - Downloading functools32-3.2.3-2.tar.gz 07:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:19:10 INFO - warning: no files found matching '*.txt' 07:19:10 INFO - no previously-included directories found matching 'build' 07:19:10 INFO - no previously-included directories found matching 'dist' 07:19:10 INFO - no previously-included directories found matching '.git*' 07:19:10 INFO - Installing collected packages: jsonschema, functools32 07:19:10 INFO - Running setup.py install for functools32 07:19:10 INFO - warning: no files found matching '*.txt' 07:19:10 INFO - no previously-included directories found matching 'build' 07:19:10 INFO - no previously-included directories found matching 'dist' 07:19:10 INFO - no previously-included directories found matching '.git*' 07:19:10 INFO - Successfully installed jsonschema functools32 07:19:10 INFO - Cleaning up... 07:19:11 INFO - Return code: 0 07:19:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:11 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 0x7fb516234f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1000ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, '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-1479136723.576059-1881575041', '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 07:19:11 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 07:19:11 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 07:19:11 INFO - Using env: {'DISPLAY': ':0', 07:19:11 INFO - 'HOME': '/home/cltbld', 07:19:11 INFO - 'LANG': 'en_US.UTF-8', 07:19:11 INFO - 'LANGUAGE': 'en_US:en', 07:19:11 INFO - 'LOGNAME': 'cltbld', 07:19:11 INFO - 'MAIL': '/var/mail/cltbld', 07:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:11 INFO - 'MOZ_NO_REMOTE': '1', 07:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:11 INFO - 'NO_EM_RESTART': '1', 07:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:11 INFO - 'PWD': '/builds/slave/test', 07:19:11 INFO - 'SHELL': '/bin/bash', 07:19:11 INFO - 'SHLVL': '1', 07:19:11 INFO - 'TERM': 'linux', 07:19:11 INFO - 'TMOUT': '86400', 07:19:11 INFO - 'USER': 'cltbld', 07:19:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:11 INFO - '_': '/tools/buildbot/bin/python'} 07:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:19:11 INFO - Cleaning up... 07:19:11 INFO - Return code: 0 07:19:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:11 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 0x7fb516234f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1000ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, '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-1479136723.576059-1881575041', '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 07:19:11 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 07:19:11 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 07:19:11 INFO - Using env: {'DISPLAY': ':0', 07:19:11 INFO - 'HOME': '/home/cltbld', 07:19:11 INFO - 'LANG': 'en_US.UTF-8', 07:19:11 INFO - 'LANGUAGE': 'en_US:en', 07:19:11 INFO - 'LOGNAME': 'cltbld', 07:19:11 INFO - 'MAIL': '/var/mail/cltbld', 07:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:11 INFO - 'MOZ_NO_REMOTE': '1', 07:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:11 INFO - 'NO_EM_RESTART': '1', 07:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:11 INFO - 'PWD': '/builds/slave/test', 07:19:11 INFO - 'SHELL': '/bin/bash', 07:19:11 INFO - 'SHLVL': '1', 07:19:11 INFO - 'TERM': 'linux', 07:19:11 INFO - 'TMOUT': '86400', 07:19:11 INFO - 'USER': 'cltbld', 07:19:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:11 INFO - '_': '/tools/buildbot/bin/python'} 07:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:11 INFO - Downloading/unpacking blobuploader==1.2.4 07:19:11 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 07:19:11 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 07:19:11 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 07:19:11 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 07:19:11 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 07:19:11 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 07:19:13 INFO - Downloading blobuploader-1.2.4.tar.gz 07:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:19:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:19:13 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 07:19:13 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 07:19:13 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 07:19:13 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 07:19:13 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 07:19:13 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 07:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:19:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:19:13 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 07:19:13 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 07:19:13 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 07:19:13 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 07:19:13 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 07:19:13 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 07:19:14 INFO - Downloading docopt-0.6.1.tar.gz 07:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:19:14 INFO - Installing collected packages: blobuploader, requests, docopt 07:19:14 INFO - Running setup.py install for blobuploader 07:19:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:19:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:19:14 INFO - Running setup.py install for requests 07:19:14 INFO - Running setup.py install for docopt 07:19:14 INFO - Successfully installed blobuploader requests docopt 07:19:14 INFO - Cleaning up... 07:19:14 INFO - Return code: 0 07:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:14 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')]} 07:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:14 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')]} 07:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:14 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 0x7fb516234f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1000ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, '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-1479136723.576059-1881575041', '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 07:19:14 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 07:19:14 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 07:19:14 INFO - Using env: {'DISPLAY': ':0', 07:19:14 INFO - 'HOME': '/home/cltbld', 07:19:14 INFO - 'LANG': 'en_US.UTF-8', 07:19:14 INFO - 'LANGUAGE': 'en_US:en', 07:19:14 INFO - 'LOGNAME': 'cltbld', 07:19:14 INFO - 'MAIL': '/var/mail/cltbld', 07:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:14 INFO - 'MOZ_NO_REMOTE': '1', 07:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:14 INFO - 'NO_EM_RESTART': '1', 07:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:14 INFO - 'PWD': '/builds/slave/test', 07:19:14 INFO - 'SHELL': '/bin/bash', 07:19:14 INFO - 'SHLVL': '1', 07:19:14 INFO - 'TERM': 'linux', 07:19:14 INFO - 'TMOUT': '86400', 07:19:14 INFO - 'USER': 'cltbld', 07:19:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:14 INFO - '_': '/tools/buildbot/bin/python'} 07:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:14 INFO - Running setup.py (path:/tmp/pip-nI4xtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:15 INFO - Running setup.py (path:/tmp/pip-lfQ0jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:15 INFO - Running setup.py (path:/tmp/pip-xYvBqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:15 INFO - Running setup.py (path:/tmp/pip-GwGnct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:15 INFO - Running setup.py (path:/tmp/pip-ebvD7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:15 INFO - Running setup.py (path:/tmp/pip-7AOQOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:15 INFO - Running setup.py (path:/tmp/pip-bo0ZIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:15 INFO - Running setup.py (path:/tmp/pip-KEKBZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:15 INFO - Running setup.py (path:/tmp/pip-PuvBT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:15 INFO - Running setup.py (path:/tmp/pip-oIdsgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:15 INFO - Running setup.py (path:/tmp/pip-0w0PVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:15 INFO - Running setup.py (path:/tmp/pip-P3uAMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:15 INFO - Running setup.py (path:/tmp/pip-MAwliu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:15 INFO - Running setup.py (path:/tmp/pip-s4VHvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:15 INFO - Running setup.py (path:/tmp/pip-WDIsG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:16 INFO - Running setup.py (path:/tmp/pip-e5QIDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:16 INFO - Running setup.py (path:/tmp/pip-bJpTEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:19:16 INFO - Running setup.py install for manifestparser 07:19:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:19:16 INFO - Running setup.py install for mozcrash 07:19:16 INFO - Running setup.py install for mozdebug 07:19:16 INFO - Running setup.py install for mozdevice 07:19:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:19:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:19:16 INFO - Running setup.py install for mozfile 07:19:16 INFO - Running setup.py install for mozhttpd 07:19:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:19:16 INFO - Running setup.py install for mozinfo 07:19:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:19:16 INFO - Running setup.py install for mozInstall 07:19:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Running setup.py install for mozleak 07:19:17 INFO - Running setup.py install for mozlog 07:19:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Running setup.py install for moznetwork 07:19:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Running setup.py install for mozprocess 07:19:17 INFO - Running setup.py install for mozprofile 07:19:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Running setup.py install for mozrunner 07:19:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:19:17 INFO - Running setup.py install for mozscreenshot 07:19:17 INFO - Running setup.py install for moztest 07:19:17 INFO - Running setup.py install for mozversion 07:19:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:19:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:19:18 INFO - Cleaning up... 07:19:18 INFO - Return code: 0 07:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07: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')]} 07:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:18 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 0x7fb516234f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1000ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, '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-1479136723.576059-1881575041', '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 07:19:18 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 07:19:18 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 07:19:18 INFO - Using env: {'DISPLAY': ':0', 07:19:18 INFO - 'HOME': '/home/cltbld', 07:19:18 INFO - 'LANG': 'en_US.UTF-8', 07:19:18 INFO - 'LANGUAGE': 'en_US:en', 07:19:18 INFO - 'LOGNAME': 'cltbld', 07:19:18 INFO - 'MAIL': '/var/mail/cltbld', 07:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:18 INFO - 'MOZ_NO_REMOTE': '1', 07:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:18 INFO - 'NO_EM_RESTART': '1', 07:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:18 INFO - 'PWD': '/builds/slave/test', 07:19:18 INFO - 'SHELL': '/bin/bash', 07:19:18 INFO - 'SHLVL': '1', 07:19:18 INFO - 'TERM': 'linux', 07:19:18 INFO - 'TMOUT': '86400', 07:19:18 INFO - 'USER': 'cltbld', 07:19:18 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:18 INFO - '_': '/tools/buildbot/bin/python'} 07:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:18 INFO - Running setup.py (path:/tmp/pip-xZRnmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:18 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)) 07:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:18 INFO - Running setup.py (path:/tmp/pip-GnFoXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:18 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)) 07:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:18 INFO - Running setup.py (path:/tmp/pip-OXp9lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:18 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)) 07:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:18 INFO - Running setup.py (path:/tmp/pip-HaNgQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:18 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)) 07:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:18 INFO - Running setup.py (path:/tmp/pip-EjAMff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:18 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)) 07:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:18 INFO - Running setup.py (path:/tmp/pip-7dRJQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:18 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)) 07:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:18 INFO - Running setup.py (path:/tmp/pip-8s3ja6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:18 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)) 07:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:18 INFO - Running setup.py (path:/tmp/pip-rVQAC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:18 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)) 07:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:18 INFO - Running setup.py (path:/tmp/pip-uAKKgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:18 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)) 07:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:18 INFO - Running setup.py (path:/tmp/pip-mxBB8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:19 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)) 07:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:19 INFO - Running setup.py (path:/tmp/pip-YsYY2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:19 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)) 07:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:19 INFO - Running setup.py (path:/tmp/pip-yI5L2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:19 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)) 07:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:19 INFO - Running setup.py (path:/tmp/pip-qGcOS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:19 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)) 07:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:19 INFO - Running setup.py (path:/tmp/pip-XPCQZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:19 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)) 07:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:19 INFO - Running setup.py (path:/tmp/pip-ttYFTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:19 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)) 07:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:19 INFO - Running setup.py (path:/tmp/pip-rM89Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:19 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)) 07:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:19 INFO - Running setup.py (path:/tmp/pip-UtbHUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:19 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)) 07:19:19 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)) 07:19:19 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)) 07:19:19 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)) 07:19:19 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)) 07:19:19 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)) 07:19:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:19 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 07:19:19 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 07:19:19 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 07:19:19 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 07:19:19 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 07:19:19 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 07:19:21 INFO - Downloading blessings-1.6.tar.gz 07:19:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:19:21 INFO - Installing collected packages: blessings 07:19:21 INFO - Running setup.py install for blessings 07:19:21 INFO - Successfully installed blessings 07:19:21 INFO - Cleaning up... 07:19:21 INFO - Return code: 0 07:19:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:19:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:21 INFO - Reading from file tmpfile_stdout 07:19:21 INFO - Current package versions: 07:19:21 INFO - argparse == 1.2.1 07:19:21 INFO - blessings == 1.6 07:19:21 INFO - blobuploader == 1.2.4 07:19:21 INFO - docopt == 0.6.1 07:19:21 INFO - functools32 == 3.2.3-2 07:19:21 INFO - jsonschema == 2.5.1 07:19:21 INFO - manifestparser == 1.1 07:19:21 INFO - mozInstall == 1.12 07:19:21 INFO - mozcrash == 0.17 07:19:21 INFO - mozdebug == 0.1 07:19:21 INFO - mozdevice == 0.48 07:19:21 INFO - mozfile == 1.2 07:19:21 INFO - mozhttpd == 0.7 07:19:21 INFO - mozinfo == 0.9 07:19:21 INFO - mozleak == 0.1 07:19:21 INFO - mozlog == 3.4 07:19:21 INFO - moznetwork == 0.27 07:19:21 INFO - mozprocess == 0.23 07:19:21 INFO - mozprofile == 0.28 07:19:21 INFO - mozrunner == 6.12 07:19:21 INFO - mozscreenshot == 0.1 07:19:21 INFO - mozsystemmonitor == 0.3 07:19:21 INFO - moztest == 0.7 07:19:21 INFO - mozversion == 1.4 07:19:21 INFO - psutil == 3.1.1 07:19:21 INFO - requests == 1.2.3 07:19:21 INFO - wsgiref == 0.1.2 07:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07: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')]} 07:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:21 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 0x7fb516234f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1000ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, '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-1479136723.576059-1881575041', '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 07:19:21 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 07:19:21 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 07:19:21 INFO - Using env: {'DISPLAY': ':0', 07:19:21 INFO - 'HOME': '/home/cltbld', 07:19:21 INFO - 'LANG': 'en_US.UTF-8', 07:19:21 INFO - 'LANGUAGE': 'en_US:en', 07:19:21 INFO - 'LOGNAME': 'cltbld', 07:19:21 INFO - 'MAIL': '/var/mail/cltbld', 07:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:21 INFO - 'MOZ_NO_REMOTE': '1', 07:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:21 INFO - 'NO_EM_RESTART': '1', 07:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:21 INFO - 'PWD': '/builds/slave/test', 07:19:21 INFO - 'SHELL': '/bin/bash', 07:19:21 INFO - 'SHLVL': '1', 07:19:21 INFO - 'TERM': 'linux', 07:19:21 INFO - 'TMOUT': '86400', 07:19:21 INFO - 'USER': 'cltbld', 07:19:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:21 INFO - '_': '/tools/buildbot/bin/python'} 07:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:22 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)) 07:19:22 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)) 07:19:22 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)) 07:19:22 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)) 07:19:22 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)) 07:19:22 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)) 07:19:22 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)) 07:19:22 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)) 07:19:22 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)) 07:19:22 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)) 07:19:22 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)) 07:19:22 INFO - Cleaning up... 07:19:22 INFO - Return code: 0 07:19:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19:22 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')]} 07:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:22 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')]} 07:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:22 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 0x7fb516234f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1000ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, '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-1479136723.576059-1881575041', '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 07:19:22 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 07:19:22 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 07:19:22 INFO - Using env: {'DISPLAY': ':0', 07:19:22 INFO - 'HOME': '/home/cltbld', 07:19:22 INFO - 'LANG': 'en_US.UTF-8', 07:19:22 INFO - 'LANGUAGE': 'en_US:en', 07:19:22 INFO - 'LOGNAME': 'cltbld', 07:19:22 INFO - 'MAIL': '/var/mail/cltbld', 07:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:22 INFO - 'MOZ_NO_REMOTE': '1', 07:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:22 INFO - 'NO_EM_RESTART': '1', 07:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:22 INFO - 'PWD': '/builds/slave/test', 07:19:22 INFO - 'SHELL': '/bin/bash', 07:19:22 INFO - 'SHLVL': '1', 07:19:22 INFO - 'TERM': 'linux', 07:19:22 INFO - 'TMOUT': '86400', 07:19:22 INFO - 'USER': 'cltbld', 07:19:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:22 INFO - '_': '/tools/buildbot/bin/python'} 07:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:19:22 INFO - Cleaning up... 07:19:22 INFO - Return code: 0 07:19:22 INFO - Running post-action listener: _resource_record_post_action 07:19:22 INFO - Running post-action listener: _start_resource_monitoring 07:19:22 INFO - Starting resource monitoring. 07:19:22 INFO - [mozharness: 2016-11-14 15:19:22.403345Z] Finished create-virtualenv step (success) 07:19:22 INFO - [mozharness: 2016-11-14 15:19:22.403890Z] Running install step. 07:19:22 INFO - Running pre-action listener: _resource_record_pre_action 07:19:22 INFO - Running main action method: install 07:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:22 INFO - Reading from file tmpfile_stdout 07:19:22 INFO - Detecting whether we're running mozinstall >=1.0... 07:19:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:19:22 INFO - Reading from file tmpfile_stdout 07:19:22 INFO - Output received: 07:19:22 INFO - Usage: mozinstall [options] installer 07:19:22 INFO - Options: 07:19:22 INFO - -h, --help show this help message and exit 07:19:22 INFO - -d DEST, --destination=DEST 07:19:22 INFO - Directory to install application into. [default: 07:19:22 INFO - "/builds/slave/test"] 07:19:22 INFO - --app=APP Application being installed. [default: firefox] 07:19:22 INFO - mkdir: /builds/slave/test/build/application 07:19:22 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'] 07:19:22 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 07:19:38 INFO - Reading from file tmpfile_stdout 07:19:38 INFO - Output received: 07:19:38 INFO - /builds/slave/test/build/application/firefox/firefox 07:19:38 INFO - Running post-action listener: _resource_record_post_action 07:19:38 INFO - [mozharness: 2016-11-14 15:19:38.668620Z] Finished install step (success) 07:19:38 INFO - [mozharness: 2016-11-14 15:19:38.668862Z] Running run-tests step. 07:19:38 INFO - Running pre-action listener: _resource_record_pre_action 07:19:38 INFO - Running main action method: run_tests 07:19:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:38 INFO - Python 2.7.3 07:19:38 INFO - Return code: 0 07:19:38 INFO - grabbing minidump binary from tooltool 07:19:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:38 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 0xffdf60>, '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 0xffed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfff1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:38 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 07:19:38 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 07:19:38 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 07:19:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:38 INFO - Return code: 0 07:19:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:19:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:19:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:38 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/eflXNszJSt6vq_ouj2mDKA/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 07:19:38 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/eflXNszJSt6vq_ouj2mDKA/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 07:19:38 INFO - Using env: {'DISPLAY': ':0', 07:19:38 INFO - 'HOME': '/home/cltbld', 07:19:38 INFO - 'LANG': 'en_US.UTF-8', 07:19:38 INFO - 'LANGUAGE': 'en_US:en', 07:19:38 INFO - 'LOGNAME': 'cltbld', 07:19:38 INFO - 'MAIL': '/var/mail/cltbld', 07:19:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:19:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:38 INFO - 'MOZ_NO_REMOTE': '1', 07:19:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:38 INFO - 'NO_EM_RESTART': '1', 07:19:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:38 INFO - 'PWD': '/builds/slave/test', 07:19:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:38 INFO - 'SHELL': '/bin/bash', 07:19:38 INFO - 'SHLVL': '1', 07:19:38 INFO - 'TERM': 'linux', 07:19:38 INFO - 'TMOUT': '86400', 07:19:38 INFO - 'USER': 'cltbld', 07:19:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1479136723.576059-1881575041', 07:19:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:38 INFO - '_': '/tools/buildbot/bin/python'} 07:19:38 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/eflXNszJSt6vq_ouj2mDKA/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 07:19:38 INFO - mozversion application_buildid: 20161114015620 07:19:38 INFO - mozversion application_changeset: 0f867a8846778f927cfb3871e58cc61f6193ad5d 07:19:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:19:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:38 INFO - mozversion application_name: Firefox 07:19:38 INFO - mozversion application_remotingname: firefox-dev 07:19:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:19:38 INFO - mozversion application_vendor: Mozilla 07:19:38 INFO - mozversion application_version: 51.0a2 07:19:38 INFO - mozversion platform_buildid: 20161114015620 07:19:38 INFO - mozversion platform_changeset: 0f867a8846778f927cfb3871e58cc61f6193ad5d 07:19:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:19:38 INFO - mozversion platform_version: 51.0a2 07:19:38 INFO - using testdate: 1479136778 07:19:38 INFO - actual date: 1479136778 07:19:38 INFO - starting webserver on 'localhost:40715' 07:19:38 INFO - SUITE-START | Running 2 tests 07:19:38 INFO - TEST-START | dromaeo_css 07:19:38 INFO - operating with platform_type : linux_ 07:19:38 INFO - Initialising browser for dromaeo_css test... 07:19:38 INFO - TEST-INFO | started process 6871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuKYBtm/profile http://localhost:40715/getInfo.html) 07:19:42 INFO - PROCESS | 6871 | __metrics Screen width/height:1600/1200 07:19:42 INFO - PROCESS | 6871 | colorDepth:24 07:19:42 INFO - PROCESS | 6871 | Browser inner width/height: 1024/697 07:19:42 INFO - PROCESS | 6871 | __metrics 07:19:43 INFO - PROCESS | 6871 | 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" 07:19:43 INFO - PROCESS | 6871 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:43 INFO - PROCESS | 6871 | console.error: PushService: 07:19:43 INFO - PROCESS | 6871 | stateChangeProcessEnqueue: Error transitioning state 07:19:43 INFO - PROCESS | 6871 | UnknownError 07:19:44 INFO - TEST-INFO | 6871: exit 0 07:19:44 INFO - Browser initialized. 07:19:44 INFO - Running cycle 1/1 for dromaeo_css test... 07:19:44 INFO - TEST-INFO | started process 6962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuKYBtm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:56 INFO - PROCESS | 6962 | RSS: Main: 145309696 07:19:56 INFO - PROCESS | 6962 | 07:20:47 INFO - PROCESS | 6962 | 1479136847564 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] 07:22:56 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:40715/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40715/tests/dromaeo/cssquery-ext.html) 07:22:57 INFO - PROCESS | 6962 | RSS: Main: 239357952 07:22:57 INFO - PROCESS | 6962 | 07:25:59 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:40715/tests/dromaeo/cssquery-ext.html (next: http://localhost:40715/tests/dromaeo/cssquery-jquery.html) 07:26:00 INFO - PROCESS | 6962 | RSS: Main: 238489600 07:26:00 INFO - PROCESS | 6962 | 07:29:02 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:40715/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40715/tests/dromaeo/cssquery-mootools.html) 07:29:02 INFO - PROCESS | 6962 | RSS: Main: 174817280 07:29:02 INFO - PROCESS | 6962 | 07:32:04 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:40715/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40715/tests/dromaeo/cssquery-prototype.html) 07:32:05 INFO - PROCESS | 6962 | RSS: Main: 217612288 07:32:05 INFO - PROCESS | 6962 | 07:35:08 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:40715/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40715/tests/dromaeo/cssquery-yui.html) 07:35:08 INFO - PROCESS | 6962 | RSS: Main: 175968256 07:35:08 INFO - PROCESS | 6962 | 07:38:11 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:40715/tests/dromaeo/cssquery-yui.html (next: http://localhost:40715/tests/dromaeo/cssquery-dojo.html) 07:38:11 INFO - PROCESS | 6962 | RSS: Main: 268722176 07:38:11 INFO - PROCESS | 6962 | 07:38:11 INFO - PROCESS | 6962 | __start_tp_report 07:38:11 INFO - PROCESS | 6962 | _x_x_mozilla_page_load 07:38:11 INFO - PROCESS | 6962 | _x_x_mozilla_page_load_details 07:38:11 INFO - PROCESS | 6962 | |i|pagename|runs| 07:38:11 INFO - PROCESS | 6962 | |0;dojo.html;3138.7175154236115;3171.9365612687748;3188.968110318896;3210.662880397557;3220.1466611347983;5509.421510741375;5632.957902787977;5639.718014099289;5641.464060914212;5658.09470484722;5485.561155107592;5533.861653458665;5534.75093620787;5541.639793413426;5560.2493663355435;5013.047520971013;5021.723805190713;5058.924116138261;5094.133997220481;5101.821436249732;4979.228219625946;5054.241863720435;5103.821366252182;5112.207607820794;5116.948830511703;4959.752012399384;5001.874953126165;5012.172991456406;5054.949450505503;5060.291559181717;5018.84943451697;5055.646104772667;5056.469070747556;5100.464451232604;5125.3080834087295;4963.801447942078;5043.117454445457;5075.822346217865;5098.286239926413;5102.6173037022;5400.216968539579;5424.430434804328;5427.592930530226;5437.8368648940595;5458.181272809071;5853.180554722342;5860.677662728548;5953.404659534055;5981.401859814027;5983.132445795379;6025.186599809013;6037.879242415127;6045.33501314855;6052.485538729214;6056.454919057262;5395.865103372408;5461.672299662033;5508.3114610673665;5510.504054635062;5514.062609356419;6122.724477398528;6132.049532322497;6134.723937422827;6138.938610613926;6145.96927015371;5855.648661080349;5865.589408741347;5866.823995280149;5869.618474799125;5888.823335299948;5657.915131273035;5686.60193786431;5829.59192856496;5903.291605007426;5907.940920590739;5946.108083787466;5946.524278057745;5947.910781338283;5950.434708702666;5976.073708575178;5917.408259174048;5972.671503067373;5973.671448070398;5976;5999.580029397987;4462.843800467033;4488.147252022105;4494.033782736662;4528;4592.2193227151465;4053.7162398632404;4076.9592304077173;4105.958940410557;4111.444954931106;4118.011677197451;5608.495235428831;5618.213450116987;5619.100943849046;5619.494245517842;5624.493795558419;5681.659100453903;5720.48515633595;5908.881822363614;5972.970135149297;5975.073863551156;5601.411851755507;5648.293963254593;5682.346530149003;5690.146478028246;5691.089425691869;5201.557867581222;5203.089459344599;5205.2192171173865;5207.661502002434;5211.4527974562125;5964.731587078679;6174.166487524217;6220.844478887973;6241.063840423973;6246.875062498724;5806.274215723035;5900.468957793819;5953.196318496947;5959.314678811992;6063.060225664853;6161.70348863356;6192.102145189013;6195.96902015487;6209;6237.064440333805;5889.587728858939;5890.528757699288;5891.410858914074;5893.528517718658;5933.080372542263;5636.2954630671165;5752.6836024019085;5827.24245848037;5863.736131874161;5886.587938844411;5808.244928159313;5842.094475356326;5844.26946631671;5852.531797456279;5874.441928016831;5805.883882322245;5834.241548598655;5837.474627283565;5840.328362238397;5843.357230704534;5609.326880774333;5635.295588051494;5663.150527420755;5696.060150075191;5773.53811695055;5897.764089436375;5901.7639294427745;5905.173275741486;5939.10913362999;5941.22764040672;5742.540596752333;5756.251687280626;5760.135979603093;5760.337561180518;5761.164631128547 07:38:11 INFO - PROCESS | 6962 | |1;ext.html;598.7844376024631;615.4122812713858;621.3848290192709;643.4016364780751;645.4545908707141;33760;36988.630113698855;44602.77698611507;45549.31676024854;45582.31626525605;47479.287810682865;47743;47782.52217477833;47804.76097619516;47841.76079119599;8366.37252206084;9315.161635452809;9469.621215151386;9481.099295566944;9481.288903332243;8598.441101328393;10882.72793180169;11113.333200008025;11136.665900022972;11564.653060408202;11463.541458341699;11515.481803318871;11532.423378831067;11542.65372038836;11544.53821847125;11200.159988000933;11231.887681123166;11302.265352752045;11309.547618095266;11327.830082548768;11204.887951120467;11258;11278.436078196139;11280.717982050432;11294.040006599449;46268.53731462676;46602;46635.30047049297;46657.53342466566;46680.299795503095;3427.8286085695618;3458.2737625098757;3492.109512074405;3575.5888072871694;4293.570642935712;35017.299654006776;35329.470057949155;35379.29241415183;36040.63959360399;37495;4642.303654451825;4747.192977193886;4766.547178018082;4768.47546769855;4836.081144582553;380175.09912450536;381498;381757;383491;383574;39047.80476097601;40109.598904010585;65848;66343;66452;41515.377269340985;41570.37644435336;41572;41616.58383416187;41781;16562.50312490627;16596.419125330554;16602.418915337905;16639.33442662304;16647.583810404838;13319.467221311039;13514.797278040838;13577.59267221985;14081.929590352187;14126.223057731924;9324.95337523308;9449.574769135406;9454.763630909283;9510.619575217052;9517.666881659108;3578.6600272974024;3620.818959052037;3630.43728222126;3635.709143268532;3653.415453527423;1039.6984874386344;1046.1212581431635;1058.88352281249;1072.6460268111505;1170.3563040327786;33718.49422258668;35351.823240883634;35570.64429355725;35575;35650.10874728153;1117.793208256475;1146.1060372909144;1164.9941750291193;1174.3130268792852;1239.4794186441716;17959.281628734705;18131.72802407965;18302.176402061938;18313.542161445803;18357;547079;547860;548430;549078;549087;63251.68374158192;64023.359766402675;64109;64162.358376416574;64188.679056604415;1236.758832027764;1308.0320562783472;1338.1302153600043;1346.9797953030713;1406.4866323791741;33789.32421351608;36006.099847504025;36199.63800361963;36227.63772362243;36449.45325820168;47946.280805788636;48113.5188648109;48243.03513929772;48289.27566086441;48309.51690483191;407454;409043;411162;412452;485758;44278.335824963295;46874.296885546064;47214.291785622554;47682;48260.75869620629;52339;52645.47354526559;53294;53553;53929.191062133315;43657.781711091244;44302.778486108655;44590;45157.77421113005;46052.539474604826;44354;44697.075696096836;44781;46211.76894115642;46359.768201158775;44107.779461103775;44561;45104.77447612741;45756.31365529453;47708.284375735086;36935;38342;38865.41701874418;39665.80167099146;40328.1934361317;24960.750392495844;25320.240392788244;25550.616740748534;25907.3315061978;25976.22071337863 07:38:11 INFO - PROCESS | 6962 | |2;jquery.html;393.34704390711426;415.58233974855284;427.54466493184754;430.6877513802494;448.1149729284661;15665;19879.90660513671;20259.59480810383;20829.47926301843;20955.37133885982;19419.12613932373;19734.21063157472;20027.799722002776;20238.190472381088;20244.29144979926;5945.881082378361;6062.090686397031;6209.503239740832;6212.751489940397;6221.813345599639;5907;6100.847478813021;6107.114468402079;6109.327973922865;6117.296510901237;6011.128386383972;6029.427204415595;6071.63570185788;6076.149339092531;6082.452579267865;5856.707164641773;5996.910046349309;6002.729877155539;6003.219581454427;6004.669743164124;5279.762410691528;5384.0847056000575;5394.541463975567;5499.422560631157;5555;14221.715565688628;14460.92769536156;14470.204138772364;18483.537911552183;22406.32781016572;2379.892904819287;2422.2975337152207;2438.061346381638;2466.203963613061;2502.4744803591266;10122.44326562046;10717.624883129052;10751.83872241917;11501.827472587918;11759.7060073498;1860.5627677495777;1886.9056547172586;1952.80471952805;1992.481954691776;2007.0466528398895;83367.5831620838;90443.2898794014;92413;94095.52952235332;95557.0444295555;10135.391876487434;11351.602693905674;11431.199816012799;11633;11651.475683594259;14920.70158596822;30864.69135308663;31749.20626984344;31880.521792173135;32288.031359059267;10061.295709300279;10139.898601014043;10172.677551918203;10446.112080473245;10623.628173013907;8617.396782225183;8739.781505462413;8810.691625793066;8843;9738.415695058318;8843.91156088431;9063.36556441056;9064.274858011344;9279.72160835176;9354.071290058191;3434.759566830298;3481.9477707834403;3486.953913825842;3490.214701692099;3645.65366290202;483.33300045937085;486.8661118192525;492.0306995219412;819.647551552838;910.3445519226146;11761.235519691192;12440.253584784941;12577.622671319876;12896.935515322364;13256.73486530264;502.7511381866;508.5423119192756;514.6166106250867;517.1828510952686;533.3626316551683;6807.217170025411;6826.761063362758;6869.725210991504;6971.825704357431;7007.859842803217;485398.5730071327;501907;535926;538142;547344;96874.51562742141;99939.50030249948;100445;101687;102293.48853255835;1019.9439030853226;1044.7127040063892;1064.1061508332882;1071.7856428714288;1071.9142468602492;18033.188506516977;18284.634307314045;18402.631947361246;18565.204013776285;18810.811891880905;30175.698243018167;34685.30629387347;40795.36818527226;45274.54725452703;45462.772686136355;62924.05613915703;63916.68041659762;64320.356796431435;64614.676926615066;64689;7124.25195354501;7528.661210245443;8810.911890881009;8996.730098097067;9101.362904596615;12680.429380677708;13230.603081907559;13423.530176444168;13607.387667555182;13647.11293765902;10753.24727269115;11295.548178073113;11306.378149201873;12008.63974080779;12075.51697932108;11795;11799.823002654795;11990.460429280529;12211;12370.690732731393;11644.2431241969;11829.408529573659;12054.216475929037;12276.570320038756;12359.443825028075;7705.345045670956;7705.88441173394;8442.197991190827;8884.644614215358;8918.24194943437;11514.596989105341;11720.355380454157;11740.354280514654;12043.518259269882;12341.876581234432 07:38:11 INFO - PROCESS | 6962 | |3;mootools.html;1199.892009719125;1490.5304828978872;1551.154620731701;1703.7699910512076;1843.5391152211955;7788.883166752496;8954.91045089549;9374.531273436334;9387.483688397135;9391.15479606836;9202.677906273282;9257.39826911252;9276.304277179222;9279.396839205463;9286.767830804216;2468.543319485892;2493.139866745979;2495.5508008558454;2503.1864643990684;2504.649349091129;2392.0670938334065;2451.240115564181;2455.45979884426;2458.5943319352286;2460.6801115855005;2438.8414753041084;2461.249318957717;2473.6165894286414;2475.88858501367;2478.863662498562;2359.5988681924114;2376.1802178248477;2382.309130352196;2417.8791060446906;2426.1387207541247;2335.100986120356;2356.7761062699014;2356.8939397727145;2360.3037104054347;2360.3037104054347;8996.8650470243;9086.81826363469;9154.084591540859;9256.95371523138;9390.671326503609;5460.26286451328;5594.468525490072;5604.607677462538;5605.299337582802;5611.579131565149;3326.151831283007;3408.113890388492;3424.7260219182403;3485.5817301923676;3489.6335884732243;1265.7911444611627;1298.7272672738736;1298.9740205195844;1307.6011816395996;1331.3010669398545;12513.249205047727;12546.1844980076;12598.37008149598;12621.43203555833;12623.495060197582;4549.27211646135;4636.327732478771;4740.928886066712;4761.547652972962;4835.468098509161;10006.949965250127;10058.497075146213;10058.949705251427;10064.043915827984;10073.194144468425;5341.572674186055;5345.091334473149;5345.54562862161;5353.304070470814;5356.65181763192;4450.6884518083425;4615.699979501322;4942.9011419771405;5075.3402057732255;5167.974160129175;4156.147989662112;4167.423769932299;4236.2374772540625;4238.957610423918;4355.891102722394;1296.3453456004845;1312.2979206124678;1324.1194605587177;1330.7272009238084;1338.5382043195082;958.2812890332251;978.1929907826072;985.5614251658087;993.9751506212402;1002.3935519011039;5981.790637327673;6000.579959402888;6030.939690603125;6152.661603611755;6156.384361563808;986.9077555582069;1007.9143272821746;1013.6452241715341;1027.4708525109575;1037.159900480613;3879.1465877507467;3975.8012099394914;3981.661558767479;3997.84008639657;4181.728187667792;11013.229073964905;11212;11294.040006599367;11347.659570212907;11539;11141.777164456666;11266.267692599955;11291.54833806655;11303.660890173143;11319.886801132048;8526.701565445304;8568.52873091986;8581.528015959182;8656.13438656142;8703.129687031245;5806.303243610793;5877.147813566923;5955.791547295824;6083.1483592298;6106.45041946227;10462.94768526183;10503.42231177262;10567.89432105669;10590.152787777113;10592.947035264775;10241.846372304273;10387.220958427997;10493.842592360968;10601.469926503798;10708.785824283626;7072.929270707227;7304.853902922018;7683.116441609286;7815.765527034198;8018.238267364591;8688.739337819876;8723.738287851374;8739.43193692408;8744.12558744146;8752.78118047054;7443.590602516913;7455.776326710207;7564.697412103675;7736.845263094594;7776.144624091232;7362.5214361066355;7480.1397839247;7530.28462296081;7604.923950760422;7703.730369437043;6599.8020059398295;6727.730890764315;6727.831804204934;6730.125083739083;6730.899036514554;5194.662346947436;5262.473752624707;5306.442823503477;5367.677939323653;5471.124620060771;5253.632245742761;5333.626646134733;5342.679439233503;5365.839024829262;5654.321481422256 07:38:11 INFO - PROCESS | 6962 | |4;prototype.html;327.86885245901635;349.90552550811276;354.0882228262225;357.57091490211735;360.2632616299667;5494.313210848644;5528.9771392292405;5532.944670553298;5540.423702978114;5562;5132.4867513248655;5234.528892399683;5282.947170528294;5334.466553344673;5396.487333703292;4292.7424354538825;4312.63342615878;4329.307310830268;4329.5021072576665;4329.696921215516;4323.481182258133;4323.718958267718;4324.8375812093955;4326.415933848922;4366.694331396803;4126.587341265865;4229.471316085489;4246.341817018367;4248.766317852517;4250.659947204232;4241.618254357123;4241.681873859442;4253.21315556623;4254.765987870666;4257.467816522934;3717.6096509866616;3721.4603882437164;3733.197362567061;3733.197362567061;3736.4208547675153;5222.056395432432;5228.888811157355;5278.181881808326;5291.576673866081;5311.867203319909;4836.250381190921;4836.645739192996;4848.927266091011;4853.757312134379;4857.927131093036;5654.067078931971;5672.432756724335;5681.119426488859;5683.204351390808;5689.345725241609;3928.7249892507252;4088.8160032798596;4119.423280740669;4161.750294982311;4163.97918010411;5907.366969313884;5942.970285148546;5943.138244954501;5944.82165535039;5953.7320820562745;4221.409002739619;4246.10831725335;4253.149370125987;4262.23279809631;4263.978680106579;4206.8527601534415;4285.721428107226;4287.228298906164;4295.634871035934;4309.482862056573;4838.056578967138;4861.440934292602;4866.635002374836;4875.293082503088;4876.853694389174;5696;5702.7433765480655;5763.538916886723;5779.537636989031;5811.186433899257;1376.4494202318951;1396.3158052554174;1411.5553600615774;1443.6751730860472;1470.4926800253895;983.7491439682835;1002.5630914826412;1010.8584798128268;1013.1236480444362;1021.9948900255451;5449.3460784706085;5473.425290344536;5477.616566840363;5486.725663716798;5493.478119578634;5785.392533783976;5803.245578074823;5812.39631428517;5816.621919575214;5824.301083869963;5274.3670759509105;5428.375736790241;5462.453754624586;5468.535174510212;5543.7782488700805;3111.4554952883154;3128.8122712637314;3129.2020534763487;3138.4978403455793;3140.3876244132175;6036.275646922398;6041.852048110933;6059.939400606026;6088.238970128734;6103.542234332443;5741.712914354265;6004.849878753066;6020.518358531307;6065.5450841187085;6076.574639775174;6013.248343957005;6097.024476083805;6106.168149555116;6129.662868542273;6167.784127555514;5628.240187574625;5898;5928.644281343133;5948.2862056553495;6007.90988135187;5838.803045375773;5846.503047241032;5862.794802181903;5870.677112758839;5873.706314684334;5831.7375718091935;6081.543884208613;6156.26124865019;6177.81466556004;6182.258129024546;4303.93544096845;4316.2878125110265;4351.216780979454;4360.563943605614;4369.38828563995;5867.706614669335;5871.119332100219;5881.647101173943;5884.176215329771;5887.41125887425;5539.335279766454;5613.40018094841;5708.543316534584;5760.539156867524;5777.711114444345;5752.309722833287;5761.041245976388;5771.336296325809;5772.336181339032;5773.451522105393;5579.972100139474;5637;5652.152177173457;5726.885462290814;5740.971295143665;5685.829425117253;5701.885962280814;5718.885622287447;5777.24895763548;5798.695293559084;5590.832275031756;5611.270534830446;5630.831075067755;5638.774449021993;5652.7738890443925 07:38:11 INFO - PROCESS | 6962 | |5;yui.html;705.7917914215305;727.6252729844128;731.7731503233998;743.137959966439;766.229938911394;14837.629059273524;15720.135392553406;15770.605734856634;15777;15781.605459863495;14663.92668036661;14763.557093287192;14773.778393324108;14795.556133316019;14909.77635335468;713.1834050012733;728.5592216708894;839.7774589733725;840.5545061117617;866.3242670716819;870.3428911172056;871.1419252036738;877.2280393253927;877.8419884420802;878.6046279174365;911.3711539038043;913.1872633356318;913.9223166030895;914.07221670005;914.076782449724;741.8479211761576;904.2720609909021;904.3262769236895;904.3714618340223;908.504864848659;567.324883388766;651.46905272203;662.9801105966828;665;667.6361383046251;13651.590452286448;13744;13811.585652430444;13818.170909745348;13829.239391833446;13109.60671179866;13399;13498.122622029636;13655.317234138352;13659.658508537266;11974.221675591145;11985;12003.93998030013;12236.81644775329;12924.289164095972;3868.6711629511524;4475.619572336355;4476.8880777980485;4546.977265113654;4570;75848;76490.61754691247;76579.70260892183;76901.23098769052;76918.61540692317;9769.267304952014;9954.552045157985;9980.500974951368;9996.850047249298;10041.497925103715;17453.47639570815;17479.300827966737;17511.38710145139;17553.21010554528;17564.648707026045;7760.573168475788;8201.425900187049;8430.32557395407;8445.155484451505;8735.563221838882;4983.127952608279;5017.7491125443585;5044.596432285409;5321.973390133102;5352.277442545284;3701.5373078365205;3830.4637350770913;3833.1375440526217;3837.865674701372;3843.461915331856;620.4478014567039;629.0595559638278;632.4971647540217;644.9645269510222;645.5481163185789;579.190031152648;736.2784471218237;741.1328745367932;743.6096049574016;786.9488483248571;9302.627894884265;9423.528823558932;9480;10097.293189476666;10126.946488012274;665.2482694555122;705.0587465733201;721.6932803558467;790.0598288037218;806.2058872011064;4549.45406551216;4732.195526760459;4812.157872372391;4863.610911127102;4873.147199240118;129063;135398;139283.30358348347;139401;140724.88912666318;111790;117350;117631;118408;118667;98284.99999999857;99299.50350248202;100412;101045.48431773529;105998;9181.265498760216;9201.953990230006;9230.907690923004;9247.39891907024;9253.86119208199;40987.59012409838;57914.4208557909;59160.70419647874;60248.69875650594;61417.385826141166;78757.21242787498;80890.59554702189;88405;89277.55361223152;91597.08402915885;11565;11624.360660163435;11810.704732381759;12570.43433045497;12837.59666864991;12086.879131208576;12176.634700958986;12290.078244131904;13167.2757998311;13252.536161234311;11547.826782598437;11618.593349232737;12174.57388991381;12343.753124937271;12373.93813030929;11610.477528511406;11998.160128790902;12101.152919295564;12339.197952133083;12556.686082848002;11138.498767555642;11350.318980860844;11569.942150289195;11596.130290228099;12015.639530814089;9962.601495940371;10004.449755263238;10185;10290.948545257226;10457.68626941193;10045.648402305884;10203.38779673222;10658.73353166177;10706.625268115578;10822.404767737535 07:38:11 INFO - PROCESS | 6962 | __end_tp_report 07:38:11 INFO - PROCESS | 6962 | __start_cc_report 07:38:11 INFO - PROCESS | 6962 | _x_x_mozilla_cycle_collect,882 07:38:11 INFO - PROCESS | 6962 | __end_cc_report 07:38:11 INFO - PROCESS | 6962 | __startTimestamp1479137891387__endTimestamp 07:38:11 INFO - PROCESS | 6962 | 07:38:11 INFO - PROCESS | 6962 | ------- Summary: start ------- 07:38:11 INFO - PROCESS | 6962 | Number of tests: 6 07:38:11 INFO - PROCESS | 6962 | 07:38:11 INFO - PROCESS | 6962 | [#0] dojo.html Cycles:165 Average:5520.56 Median:5696.06 stddev:630.51 (11.1%) stddev-sans-first:604.12 07:38:11 INFO - PROCESS | 6962 | Values: 3138.7 3171.9 3189.0 3210.7 3220.1 5509.4 5633.0 5639.7 5641.5 5658.1 5485.6 5533.9 5534.8 5541.6 5560.2 5013.0 5021.7 5058.9 5094.1 5101.8 4979.2 5054.2 5103.8 5112.2 5116.9 4959.8 5001.9 5012.2 5054.9 5060.3 5018.8 5055.6 5056.5 5100.5 5125.3 4963.8 5043.1 5075.8 5098.3 5102.6 5400.2 5424.4 5427.6 5437.8 5458.2 5853.2 5860.7 5953.4 5981.4 5983.1 6025.2 6037.9 6045.3 6052.5 6056.5 5395.9 5461.7 5508.3 5510.5 5514.1 6122.7 6132.0 6134.7 6138.9 6146.0 5855.6 5865.6 5866.8 5869.6 5888.8 5657.9 5686.6 5829.6 5903.3 5907.9 5946.1 5946.5 5947.9 5950.4 5976.1 5917.4 5972.7 5973.7 5976.0 5999.6 4462.8 4488.1 4494.0 4528.0 4592.2 4053.7 4077.0 4106.0 4111.4 4118.0 5608.5 5618.2 5619.1 5619.5 5624.5 5681.7 5720.5 5908.9 5973.0 5975.1 5601.4 5648.3 5682.3 5690.1 5691.1 5201.6 5203.1 5205.2 5207.7 5211.5 5964.7 6174.2 6220.8 6241.1 6246.9 5806.3 5900.5 5953.2 5959.3 6063.1 6161.7 6192.1 6196.0 6209.0 6237.1 5889.6 5890.5 5891.4 5893.5 5933.1 5636.3 5752.7 5827.2 5863.7 5886.6 5808.2 5842.1 5844.3 5852.5 5874.4 5805.9 5834.2 5837.5 5840.3 5843.4 5609.3 5635.3 5663.2 5696.1 5773.5 5897.8 5901.8 5905.2 5939.1 5941.2 5742.5 5756.3 5760.1 5760.3 5761.2 07:38:11 INFO - PROCESS | 6962 | 07:38:11 INFO - PROCESS | 6962 | [#1] ext.html Cycles:180 Average:62090.54 Median:40218.90 stddev:121185.67 (301.3%) stddev-sans-first:121437.68 07:38:11 INFO - PROCESS | 6962 | Values: 598.8 615.4 621.4 643.4 645.5 33760.0 36988.6 44602.8 45549.3 45582.3 47479.3 47743.0 47782.5 47804.8 47841.8 8366.4 9315.2 9469.6 9481.1 9481.3 8598.4 10882.7 11113.3 11136.7 11564.7 11463.5 11515.5 11532.4 11542.7 11544.5 11200.2 11231.9 11302.3 11309.5 11327.8 11204.9 11258.0 11278.4 11280.7 11294.0 46268.5 46602.0 46635.3 46657.5 46680.3 3427.8 3458.3 3492.1 3575.6 4293.6 35017.3 35329.5 35379.3 36040.6 37495.0 4642.3 4747.2 4766.5 4768.5 4836.1 380175.1 381498.0 381757.0 383491.0 383574.0 39047.8 40109.6 65848.0 66343.0 66452.0 41515.4 41570.4 41572.0 41616.6 41781.0 16562.5 16596.4 16602.4 16639.3 16647.6 13319.5 13514.8 13577.6 14081.9 14126.2 9325.0 9449.6 9454.8 9510.6 9517.7 3578.7 3620.8 3630.4 3635.7 3653.4 1039.7 1046.1 1058.9 1072.6 1170.4 33718.5 35351.8 35570.6 35575.0 35650.1 1117.8 1146.1 1165.0 1174.3 1239.5 17959.3 18131.7 18302.2 18313.5 18357.0 547079.0 547860.0 548430.0 549078.0 549087.0 63251.7 64023.4 64109.0 64162.4 64188.7 1236.8 1308.0 1338.1 1347.0 1406.5 33789.3 36006.1 36199.6 36227.6 36449.5 47946.3 48113.5 48243.0 48289.3 48309.5 407454.0 409043.0 411162.0 412452.0 485758.0 44278.3 46874.3 47214.3 47682.0 48260.8 52339.0 52645.5 53294.0 53553.0 53929.2 43657.8 44302.8 44590.0 45157.8 46052.5 44354.0 44697.1 44781.0 46211.8 46359.8 44107.8 44561.0 45104.8 45756.3 47708.3 36935.0 38342.0 38865.4 39665.8 40328.2 24960.8 25320.2 25550.6 25907.3 25976.2 07:38:11 INFO - PROCESS | 6962 | 07:38:11 INFO - PROCESS | 6962 | [#2] jquery.html Cycles:180 Average:30754.68 Median:19083.63 stddev:86339.46 (452.4%) stddev-sans-first:86551.57 07:38:11 INFO - PROCESS | 6962 | Values: 393.3 415.6 427.5 430.7 448.1 15665.0 19879.9 20259.6 20829.5 20955.4 19419.1 19734.2 20027.8 20238.2 20244.3 5945.9 6062.1 6209.5 6212.8 6221.8 5907.0 6100.8 6107.1 6109.3 6117.3 6011.1 6029.4 6071.6 6076.1 6082.5 5856.7 5996.9 6002.7 6003.2 6004.7 5279.8 5384.1 5394.5 5499.4 5555.0 14221.7 14460.9 14470.2 18483.5 22406.3 2379.9 2422.3 2438.1 2466.2 2502.5 10122.4 10717.6 10751.8 11501.8 11759.7 1860.6 1886.9 1952.8 1992.5 2007.0 83367.6 90443.3 92413.0 94095.5 95557.0 10135.4 11351.6 11431.2 11633.0 11651.5 14920.7 30864.7 31749.2 31880.5 32288.0 10061.3 10139.9 10172.7 10446.1 10623.6 8617.4 8739.8 8810.7 8843.0 9738.4 8843.9 9063.4 9064.3 9279.7 9354.1 3434.8 3481.9 3487.0 3490.2 3645.7 483.3 486.9 492.0 819.6 910.3 11761.2 12440.3 12577.6 12896.9 13256.7 502.8 508.5 514.6 517.2 533.4 6807.2 6826.8 6869.7 6971.8 7007.9 485398.6 501907.0 535926.0 538142.0 547344.0 96874.5 99939.5 100445.0 101687.0 102293.5 1019.9 1044.7 1064.1 1071.8 1071.9 18033.2 18284.6 18402.6 18565.2 18810.8 30175.7 34685.3 40795.4 45274.5 45462.8 62924.1 63916.7 64320.4 64614.7 64689.0 7124.3 7528.7 8810.9 8996.7 9101.4 12680.4 13230.6 13423.5 13607.4 13647.1 10753.2 11295.5 11306.4 12008.6 12075.5 11795.0 11799.8 11990.5 12211.0 12370.7 11644.2 11829.4 12054.2 12276.6 12359.4 7705.3 7705.9 8442.2 8884.6 8918.2 11514.6 11720.4 11740.4 12043.5 12341.9 07:38:11 INFO - PROCESS | 6962 | 07:38:11 INFO - PROCESS | 6962 | [#3] mootools.html Cycles:180 Average:5932.86 Median:4499.98 stddev:3360.04 (74.7%) stddev-sans-first:3350.64 07:38:11 INFO - PROCESS | 6962 | Values: 1199.9 1490.5 1551.2 1703.8 1843.5 7788.9 8954.9 9374.5 9387.5 9391.2 9202.7 9257.4 9276.3 9279.4 9286.8 2468.5 2493.1 2495.6 2503.2 2504.6 2392.1 2451.2 2455.5 2458.6 2460.7 2438.8 2461.2 2473.6 2475.9 2478.9 2359.6 2376.2 2382.3 2417.9 2426.1 2335.1 2356.8 2356.9 2360.3 2360.3 8996.9 9086.8 9154.1 9257.0 9390.7 5460.3 5594.5 5604.6 5605.3 5611.6 3326.2 3408.1 3424.7 3485.6 3489.6 1265.8 1298.7 1299.0 1307.6 1331.3 12513.2 12546.2 12598.4 12621.4 12623.5 4549.3 4636.3 4740.9 4761.5 4835.5 10006.9 10058.5 10058.9 10064.0 10073.2 5341.6 5345.1 5345.5 5353.3 5356.7 4450.7 4615.7 4942.9 5075.3 5168.0 4156.1 4167.4 4236.2 4239.0 4355.9 1296.3 1312.3 1324.1 1330.7 1338.5 958.3 978.2 985.6 994.0 1002.4 5981.8 6000.6 6030.9 6152.7 6156.4 986.9 1007.9 1013.6 1027.5 1037.2 3879.1 3975.8 3981.7 3997.8 4181.7 11013.2 11212.0 11294.0 11347.7 11539.0 11141.8 11266.3 11291.5 11303.7 11319.9 8526.7 8568.5 8581.5 8656.1 8703.1 5806.3 5877.1 5955.8 6083.1 6106.5 10462.9 10503.4 10567.9 10590.2 10592.9 10241.8 10387.2 10493.8 10601.5 10708.8 7072.9 7304.9 7683.1 7815.8 8018.2 8688.7 8723.7 8739.4 8744.1 8752.8 7443.6 7455.8 7564.7 7736.8 7776.1 7362.5 7480.1 7530.3 7604.9 7703.7 6599.8 6727.7 6727.8 6730.1 6730.9 5194.7 5262.5 5306.4 5367.7 5471.1 5253.6 5333.6 5342.7 5365.8 5654.3 07:38:11 INFO - PROCESS | 6962 | 07:38:11 INFO - PROCESS | 6962 | [#4] prototype.html Cycles:180 Average:4830.99 Median:5482.17 stddev:1414.78 (25.8%) stddev-sans-first:1377.78 07:38:11 INFO - PROCESS | 6962 | Values: 327.9 349.9 354.1 357.6 360.3 5494.3 5529.0 5532.9 5540.4 5562.0 5132.5 5234.5 5282.9 5334.5 5396.5 4292.7 4312.6 4329.3 4329.5 4329.7 4323.5 4323.7 4324.8 4326.4 4366.7 4126.6 4229.5 4246.3 4248.8 4250.7 4241.6 4241.7 4253.2 4254.8 4257.5 3717.6 3721.5 3733.2 3733.2 3736.4 5222.1 5228.9 5278.2 5291.6 5311.9 4836.3 4836.6 4848.9 4853.8 4857.9 5654.1 5672.4 5681.1 5683.2 5689.3 3928.7 4088.8 4119.4 4161.8 4164.0 5907.4 5943.0 5943.1 5944.8 5953.7 4221.4 4246.1 4253.1 4262.2 4264.0 4206.9 4285.7 4287.2 4295.6 4309.5 4838.1 4861.4 4866.6 4875.3 4876.9 5696.0 5702.7 5763.5 5779.5 5811.2 1376.4 1396.3 1411.6 1443.7 1470.5 983.7 1002.6 1010.9 1013.1 1022.0 5449.3 5473.4 5477.6 5486.7 5493.5 5785.4 5803.2 5812.4 5816.6 5824.3 5274.4 5428.4 5462.5 5468.5 5543.8 3111.5 3128.8 3129.2 3138.5 3140.4 6036.3 6041.9 6059.9 6088.2 6103.5 5741.7 6004.8 6020.5 6065.5 6076.6 6013.2 6097.0 6106.2 6129.7 6167.8 5628.2 5898.0 5928.6 5948.3 6007.9 5838.8 5846.5 5862.8 5870.7 5873.7 5831.7 6081.5 6156.3 6177.8 6182.3 4303.9 4316.3 4351.2 4360.6 4369.4 5867.7 5871.1 5881.6 5884.2 5887.4 5539.3 5613.4 5708.5 5760.5 5777.7 5752.3 5761.0 5771.3 5772.3 5773.5 5580.0 5637.0 5652.2 5726.9 5741.0 5685.8 5701.9 5718.9 5777.2 5798.7 5590.8 5611.3 5630.8 5638.8 5652.8 07:38:11 INFO - PROCESS | 6962 | 07:38:11 INFO - PROCESS | 6962 | [#5] yui.html Cycles:180 Average:22316.04 Median:4559.73 stddev:34956.93 (766.6%) stddev-sans-first:35017.33 07:38:11 INFO - PROCESS | 6962 | Values: 705.8 727.6 731.8 743.1 766.2 14837.6 15720.1 15770.6 15777.0 15781.6 14663.9 14763.6 14773.8 14795.6 14909.8 713.2 728.6 839.8 840.6 866.3 870.3 871.1 877.2 877.8 878.6 911.4 913.2 913.9 914.1 914.1 741.8 904.3 904.3 904.4 908.5 567.3 651.5 663.0 665.0 667.6 13651.6 13744.0 13811.6 13818.2 13829.2 13109.6 13399.0 13498.1 13655.3 13659.7 11974.2 11985.0 12003.9 12236.8 12924.3 3868.7 4475.6 4476.9 4547.0 4570.0 75848.0 76490.6 76579.7 76901.2 76918.6 9769.3 9954.6 9980.5 9996.9 10041.5 17453.5 17479.3 17511.4 17553.2 17564.6 7760.6 8201.4 8430.3 8445.2 8735.6 4983.1 5017.7 5044.6 5322.0 5352.3 3701.5 3830.5 3833.1 3837.9 3843.5 620.4 629.1 632.5 645.0 645.5 579.2 736.3 741.1 743.6 786.9 9302.6 9423.5 9480.0 10097.3 10126.9 665.2 705.1 721.7 790.1 806.2 4549.5 4732.2 4812.2 4863.6 4873.1 129063.0 135398.0 139283.3 139401.0 140724.9 111790.0 117350.0 117631.0 118408.0 118667.0 98285.0 99299.5 100412.0 101045.5 105998.0 9181.3 9202.0 9230.9 9247.4 9253.9 40987.6 57914.4 59160.7 60248.7 61417.4 78757.2 80890.6 88405.0 89277.6 91597.1 11565.0 11624.4 11810.7 12570.4 12837.6 12086.9 12176.6 12290.1 13167.3 13252.5 11547.8 11618.6 12174.6 12343.8 12373.9 11610.5 11998.2 12101.2 12339.2 12556.7 11138.5 11350.3 11569.9 11596.1 12015.6 9962.6 10004.4 10185.0 10290.9 10457.7 10045.6 10203.4 10658.7 10706.6 10822.4 07:38:11 INFO - PROCESS | 6962 | -------- Summary: end -------- 07:38:11 INFO - PROCESS | 6962 | 07:38:12 INFO - TEST-INFO | 6962: exit 0 07:38:12 INFO - TEST-OK | dromaeo_css | took 1113240ms 07:38:12 INFO - TEST-START | kraken 07:38:12 INFO - operating with platform_type : linux_ 07:38:12 INFO - Initialising browser for kraken test... 07:38:12 INFO - TEST-INFO | started process 7282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx53vJi/profile http://localhost:40715/getInfo.html) 07:38:16 INFO - PROCESS | 7282 | __metrics Screen width/height:1600/1200 07:38:16 INFO - PROCESS | 7282 | colorDepth:24 07:38:16 INFO - PROCESS | 7282 | Browser inner width/height: 1024/697 07:38:16 INFO - PROCESS | 7282 | __metrics 07:38:16 INFO - PROCESS | 7282 | 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" 07:38:16 INFO - PROCESS | 7282 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:17 INFO - PROCESS | 7282 | console.error: PushService: 07:38:17 INFO - PROCESS | 7282 | stateChangeProcessEnqueue: Error transitioning state 07:38:17 INFO - PROCESS | 7282 | UnknownError 07:38:17 INFO - TEST-INFO | 7282: exit 0 07:38:17 INFO - Browser initialized. 07:38:17 INFO - Running cycle 1/1 for kraken test... 07:38:17 INFO - TEST-INFO | started process 7374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx53vJi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:29 INFO - PROCESS | 7374 | RSS: Main: 144969728 07:38:29 INFO - PROCESS | 7374 | 07:38:31 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40715/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:32 INFO - PROCESS | 7374 | RSS: Main: 186220544 07:38:32 INFO - PROCESS | 7374 | 07:38:35 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40715/tests/kraken/driver.html?testName=audio-dft) 07:38:35 INFO - PROCESS | 7374 | RSS: Main: 175984640 07:38:35 INFO - PROCESS | 7374 | 07:38:38 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40715/tests/kraken/driver.html?testName=audio-fft) 07:38:39 INFO - PROCESS | 7374 | RSS: Main: 267255808 07:38:39 INFO - PROCESS | 7374 | 07:38:41 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40715/tests/kraken/driver.html?testName=audio-oscillator) 07:38:41 INFO - PROCESS | 7374 | RSS: Main: 173412352 07:38:41 INFO - PROCESS | 7374 | 07:38:44 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40715/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:38:44 INFO - PROCESS | 7374 | RSS: Main: 174710784 07:38:44 INFO - PROCESS | 7374 | 07:38:47 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40715/tests/kraken/driver.html?testName=imaging-darkroom) 07:38:48 INFO - PROCESS | 7374 | RSS: Main: 210923520 07:38:48 INFO - PROCESS | 7374 | 07:38:51 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40715/tests/kraken/driver.html?testName=imaging-desaturate) 07:38:52 INFO - PROCESS | 7374 | RSS: Main: 209960960 07:38:52 INFO - PROCESS | 7374 | 07:38:54 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40715/tests/kraken/driver.html?testName=json-parse-financial) 07:38:55 INFO - PROCESS | 7374 | RSS: Main: 209670144 07:38:55 INFO - PROCESS | 7374 | 07:38:57 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40715/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:38:57 INFO - PROCESS | 7374 | RSS: Main: 171339776 07:38:57 INFO - PROCESS | 7374 | 07:38:59 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40715/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:38:59 INFO - PROCESS | 7374 | RSS: Main: 178884608 07:38:59 INFO - PROCESS | 7374 | 07:39:01 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40715/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:39:02 INFO - PROCESS | 7374 | RSS: Main: 188674048 07:39:02 INFO - PROCESS | 7374 | 07:39:05 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:39:05 INFO - PROCESS | 7374 | RSS: Main: 197189632 07:39:05 INFO - PROCESS | 7374 | 07:39:08 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:39:08 INFO - PROCESS | 7374 | RSS: Main: 193011712 07:39:08 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:40715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40715/tests/kraken/driver.html?testName=ai-astar) 07:39:10 INFO - PROCESS | 7374 | RSS: Main: 244543488 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | __start_tp_report 07:39:10 INFO - PROCESS | 7374 | _x_x_mozilla_page_load 07:39:10 INFO - PROCESS | 7374 | _x_x_mozilla_page_load_details 07:39:10 INFO - PROCESS | 7374 | |i|pagename|runs| 07:39:10 INFO - PROCESS | 7374 | |0;ai-astar;109;110;111;111;111;110;110;111;111;111 07:39:10 INFO - PROCESS | 7374 | |1;audio-beat-detection;150;120;122;155;118;119;122;120;151;121 07:39:10 INFO - PROCESS | 7374 | |2;audio-dft;162;163;162;163;161;161;161;162;162;160 07:39:10 INFO - PROCESS | 7374 | |3;audio-fft;74;75;76;108;75;76;76;75;96;75 07:39:10 INFO - PROCESS | 7374 | |4;audio-oscillator;82;82;120;82;82;81;104;82;82;105 07:39:10 INFO - PROCESS | 7374 | |5;imaging-gaussian-blur;118;118;117;116;117;117;116;116;117;116 07:39:10 INFO - PROCESS | 7374 | |6;imaging-darkroom;145;146;146;146;146;147;146;146;145;147 07:39:10 INFO - PROCESS | 7374 | |7;imaging-desaturate;95;96;96;95;95;96;96;96;95;95 07:39:10 INFO - PROCESS | 7374 | |8;json-parse-financial;51;50;52;49;49;50;50;50;50;50 07:39:10 INFO - PROCESS | 7374 | |9;json-stringify-tinderbox;58;59;59;58;59;59;60;59;59;58 07:39:10 INFO - PROCESS | 7374 | |10;stanford-crypto-aes;82;77;74;75;74;74;73;74;74;74 07:39:10 INFO - PROCESS | 7374 | |11;stanford-crypto-ccm;132;122;120;124;129;122;140;121;153;127 07:39:10 INFO - PROCESS | 7374 | |12;stanford-crypto-pbkdf2;154;157;154;160;157;151;154;153;150;157 07:39:10 INFO - PROCESS | 7374 | |13;stanford-crypto-sha256-iterative;63;61;63;62;61;62;62;69;62;61 07:39:10 INFO - PROCESS | 7374 | __end_tp_report 07:39:10 INFO - PROCESS | 7374 | __start_cc_report 07:39:10 INFO - PROCESS | 7374 | _x_x_mozilla_cycle_collect,1636 07:39:10 INFO - PROCESS | 7374 | __end_cc_report 07:39:10 INFO - PROCESS | 7374 | __startTimestamp1479137950860__endTimestamp 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | ------- Summary: start ------- 07:39:10 INFO - PROCESS | 7374 | Number of tests: 14 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:0.71 (0.6%) stddev-sans-first:0.50 07:39:10 INFO - PROCESS | 7374 | Values: 109.0 110.0 111.0 111.0 111.0 110.0 110.0 111.0 111.0 111.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:122.00 stddev:15.42 (12.6%) stddev-sans-first:14.52 07:39:10 INFO - PROCESS | 7374 | Values: 150.0 120.0 122.0 155.0 118.0 119.0 122.0 120.0 151.0 121.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 07:39:10 INFO - PROCESS | 7374 | Values: 162.0 163.0 162.0 163.0 161.0 161.0 161.0 162.0 162.0 160.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.50 stddev:11.64 (15.4%) stddev-sans-first:12.10 07:39:10 INFO - PROCESS | 7374 | Values: 74.0 75.0 76.0 108.0 75.0 76.0 76.0 75.0 96.0 75.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:82.00 stddev:14.09 (17.2%) stddev-sans-first:14.62 07:39:10 INFO - PROCESS | 7374 | Values: 82.0 82.0 120.0 82.0 82.0 81.0 104.0 82.0 82.0 105.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 07:39:10 INFO - PROCESS | 7374 | Values: 118.0 118.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 116.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 07:39:10 INFO - PROCESS | 7374 | Values: 145.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 147.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:39:10 INFO - PROCESS | 7374 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:0.88 (1.8%) stddev-sans-first:0.87 07:39:10 INFO - PROCESS | 7374 | Values: 51.0 50.0 52.0 49.0 49.0 50.0 50.0 50.0 50.0 50.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 07:39:10 INFO - PROCESS | 7374 | Values: 58.0 59.0 59.0 58.0 59.0 59.0 60.0 59.0 59.0 58.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.00 stddev:2.64 (3.6%) stddev-sans-first:1.12 07:39:10 INFO - PROCESS | 7374 | Values: 82.0 77.0 74.0 75.0 74.0 74.0 73.0 74.0 74.0 74.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:128.00 stddev:10.42 (8.1%) stddev-sans-first:11.00 07:39:10 INFO - PROCESS | 7374 | Values: 132.0 122.0 120.0 124.0 129.0 122.0 140.0 121.0 153.0 127.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.50 stddev:3.06 (2.0%) stddev-sans-first:3.23 07:39:10 INFO - PROCESS | 7374 | Values: 154.0 157.0 154.0 160.0 157.0 151.0 154.0 153.0 150.0 157.0 07:39:10 INFO - PROCESS | 7374 | 07:39:10 INFO - PROCESS | 7374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.00 stddev:2.37 (3.8%) stddev-sans-first:2.51 07:39:10 INFO - PROCESS | 7374 | Values: 63.0 61.0 63.0 62.0 61.0 62.0 62.0 69.0 62.0 61.0 07:39:10 INFO - PROCESS | 7374 | -------- Summary: end -------- 07:39:10 INFO - PROCESS | 7374 | 07:39:12 INFO - TEST-INFO | 7374: exit 0 07:39:12 INFO - TEST-OK | kraken | took 59900ms 07:39:12 INFO - SUITE-END | took 1173s 07:39:12 INFO - Completed test suite (00:19:33) 07:39:12 INFO - javascript benchmark 07:39:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.7175154236115, 3171.9365612687748, 3188.968110318896, 3210.662880397557, 3220.1466611347983, 5509.421510741375, 5632.957902787977, 5639.718014099289, 5641.464060914212, 5658.09470484722, 5485.561155107592, 5533.861653458665, 5534.75093620787, 5541.639793413426, 5560.2493663355435, 5013.047520971013, 5021.723805190713, 5058.924116138261, 5094.133997220481, 5101.821436249732, 4979.228219625946, 5054.241863720435, 5103.821366252182, 5112.207607820794, 5116.948830511703, 4959.752012399384, 5001.874953126165, 5012.172991456406, 5054.949450505503, 5060.291559181717, 5018.84943451697, 5055.646104772667, 5056.469070747556, 5100.464451232604, 5125.3080834087295, 4963.801447942078, 5043.117454445457, 5075.822346217865, 5098.286239926413, 5102.6173037022, 5400.216968539579, 5424.430434804328, 5427.592930530226, 5437.8368648940595, 5458.181272809071, 5853.180554722342, 5860.677662728548, 5953.404659534055, 5981.401859814027, 5983.132445795379, 6025.186599809013, 6037.879242415127, 6045.33501314855, 6052.485538729214, 6056.454919057262, 5395.865103372408, 5461.672299662033, 5508.3114610673665, 5510.504054635062, 5514.062609356419, 6122.724477398528, 6132.049532322497, 6134.723937422827, 6138.938610613926, 6145.96927015371, 5855.648661080349, 5865.589408741347, 5866.823995280149, 5869.618474799125, 5888.823335299948, 5657.915131273035, 5686.60193786431, 5829.59192856496, 5903.291605007426, 5907.940920590739, 5946.108083787466, 5946.524278057745, 5947.910781338283, 5950.434708702666, 5976.073708575178, 5917.408259174048, 5972.671503067373, 5973.671448070398, 5976.0, 5999.580029397987, 4462.843800467033, 4488.147252022105, 4494.033782736662, 4528.0, 4592.2193227151465, 4053.7162398632404, 4076.9592304077173, 4105.958940410557, 4111.444954931106, 4118.011677197451, 5608.495235428831, 5618.213450116987, 5619.100943849046, 5619.494245517842, 5624.493795558419, 5681.659100453903, 5720.48515633595, 5908.881822363614, 5972.970135149297, 5975.073863551156, 5601.411851755507, 5648.293963254593, 5682.346530149003, 5690.146478028246, 5691.089425691869, 5201.557867581222, 5203.089459344599, 5205.2192171173865, 5207.661502002434, 5211.4527974562125, 5964.731587078679, 6174.166487524217, 6220.844478887973, 6241.063840423973, 6246.875062498724, 5806.274215723035, 5900.468957793819, 5953.196318496947, 5959.314678811992, 6063.060225664853, 6161.70348863356, 6192.102145189013, 6195.96902015487, 6209.0, 6237.064440333805, 5889.587728858939, 5890.528757699288, 5891.410858914074, 5893.528517718658, 5933.080372542263, 5636.2954630671165, 5752.6836024019085, 5827.24245848037, 5863.736131874161, 5886.587938844411, 5808.244928159313, 5842.094475356326, 5844.26946631671, 5852.531797456279, 5874.441928016831, 5805.883882322245, 5834.241548598655, 5837.474627283565, 5840.328362238397, 5843.357230704534, 5609.326880774333, 5635.295588051494, 5663.150527420755, 5696.060150075191, 5773.53811695055, 5897.764089436375, 5901.7639294427745, 5905.173275741486, 5939.10913362999, 5941.22764040672, 5742.540596752333, 5756.251687280626, 5760.135979603093, 5760.337561180518, 5761.164631128547], "value": 5477.632211666893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.7844376024631, 615.4122812713858, 621.3848290192709, 643.4016364780751, 645.4545908707141, 33760.0, 36988.630113698855, 44602.77698611507, 45549.31676024854, 45582.31626525605, 47479.287810682865, 47743.0, 47782.52217477833, 47804.76097619516, 47841.76079119599, 8366.37252206084, 9315.161635452809, 9469.621215151386, 9481.099295566944, 9481.288903332243, 8598.441101328393, 10882.72793180169, 11113.333200008025, 11136.665900022972, 11564.653060408202, 11463.541458341699, 11515.481803318871, 11532.423378831067, 11542.65372038836, 11544.53821847125, 11200.159988000933, 11231.887681123166, 11302.265352752045, 11309.547618095266, 11327.830082548768, 11204.887951120467, 11258.0, 11278.436078196139, 11280.717982050432, 11294.040006599449, 46268.53731462676, 46602.0, 46635.30047049297, 46657.53342466566, 46680.299795503095, 3427.8286085695618, 3458.2737625098757, 3492.109512074405, 3575.5888072871694, 4293.570642935712, 35017.299654006776, 35329.470057949155, 35379.29241415183, 36040.63959360399, 37495.0, 4642.303654451825, 4747.192977193886, 4766.547178018082, 4768.47546769855, 4836.081144582553, 380175.09912450536, 381498.0, 381757.0, 383491.0, 383574.0, 39047.80476097601, 40109.598904010585, 65848.0, 66343.0, 66452.0, 41515.377269340985, 41570.37644435336, 41572.0, 41616.58383416187, 41781.0, 16562.50312490627, 16596.419125330554, 16602.418915337905, 16639.33442662304, 16647.583810404838, 13319.467221311039, 13514.797278040838, 13577.59267221985, 14081.929590352187, 14126.223057731924, 9324.95337523308, 9449.574769135406, 9454.763630909283, 9510.619575217052, 9517.666881659108, 3578.6600272974024, 3620.818959052037, 3630.43728222126, 3635.709143268532, 3653.415453527423, 1039.6984874386344, 1046.1212581431635, 1058.88352281249, 1072.6460268111505, 1170.3563040327786, 33718.49422258668, 35351.823240883634, 35570.64429355725, 35575.0, 35650.10874728153, 1117.793208256475, 1146.1060372909144, 1164.9941750291193, 1174.3130268792852, 1239.4794186441716, 17959.281628734705, 18131.72802407965, 18302.176402061938, 18313.542161445803, 18357.0, 547079.0, 547860.0, 548430.0, 549078.0, 549087.0, 63251.68374158192, 64023.359766402675, 64109.0, 64162.358376416574, 64188.679056604415, 1236.758832027764, 1308.0320562783472, 1338.1302153600043, 1346.9797953030713, 1406.4866323791741, 33789.32421351608, 36006.099847504025, 36199.63800361963, 36227.63772362243, 36449.45325820168, 47946.280805788636, 48113.5188648109, 48243.03513929772, 48289.27566086441, 48309.51690483191, 407454.0, 409043.0, 411162.0, 412452.0, 485758.0, 44278.335824963295, 46874.296885546064, 47214.291785622554, 47682.0, 48260.75869620629, 52339.0, 52645.47354526559, 53294.0, 53553.0, 53929.191062133315, 43657.781711091244, 44302.778486108655, 44590.0, 45157.77421113005, 46052.539474604826, 44354.0, 44697.075696096836, 44781.0, 46211.76894115642, 46359.768201158775, 44107.779461103775, 44561.0, 45104.77447612741, 45756.31365529453, 47708.284375735086, 36935.0, 38342.0, 38865.41701874418, 39665.80167099146, 40328.1934361317, 24960.750392495844, 25320.240392788244, 25550.616740748534, 25907.3315061978, 25976.22071337863], "value": 20662.431129924702, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.34704390711426, 415.58233974855284, 427.54466493184754, 430.6877513802494, 448.1149729284661, 15665.0, 19879.90660513671, 20259.59480810383, 20829.47926301843, 20955.37133885982, 19419.12613932373, 19734.21063157472, 20027.799722002776, 20238.190472381088, 20244.29144979926, 5945.881082378361, 6062.090686397031, 6209.503239740832, 6212.751489940397, 6221.813345599639, 5907.0, 6100.847478813021, 6107.114468402079, 6109.327973922865, 6117.296510901237, 6011.128386383972, 6029.427204415595, 6071.63570185788, 6076.149339092531, 6082.452579267865, 5856.707164641773, 5996.910046349309, 6002.729877155539, 6003.219581454427, 6004.669743164124, 5279.762410691528, 5384.0847056000575, 5394.541463975567, 5499.422560631157, 5555.0, 14221.715565688628, 14460.92769536156, 14470.204138772364, 18483.537911552183, 22406.32781016572, 2379.892904819287, 2422.2975337152207, 2438.061346381638, 2466.203963613061, 2502.4744803591266, 10122.44326562046, 10717.624883129052, 10751.83872241917, 11501.827472587918, 11759.7060073498, 1860.5627677495777, 1886.9056547172586, 1952.80471952805, 1992.481954691776, 2007.0466528398895, 83367.5831620838, 90443.2898794014, 92413.0, 94095.52952235332, 95557.0444295555, 10135.391876487434, 11351.602693905674, 11431.199816012799, 11633.0, 11651.475683594259, 14920.70158596822, 30864.69135308663, 31749.20626984344, 31880.521792173135, 32288.031359059267, 10061.295709300279, 10139.898601014043, 10172.677551918203, 10446.112080473245, 10623.628173013907, 8617.396782225183, 8739.781505462413, 8810.691625793066, 8843.0, 9738.415695058318, 8843.91156088431, 9063.36556441056, 9064.274858011344, 9279.72160835176, 9354.071290058191, 3434.759566830298, 3481.9477707834403, 3486.953913825842, 3490.214701692099, 3645.65366290202, 483.33300045937085, 486.8661118192525, 492.0306995219412, 819.647551552838, 910.3445519226146, 11761.235519691192, 12440.253584784941, 12577.622671319876, 12896.935515322364, 13256.73486530264, 502.7511381866, 508.5423119192756, 514.6166106250867, 517.1828510952686, 533.3626316551683, 6807.217170025411, 6826.761063362758, 6869.725210991504, 6971.825704357431, 7007.859842803217, 485398.5730071327, 501907.0, 535926.0, 538142.0, 547344.0, 96874.51562742141, 99939.50030249948, 100445.0, 101687.0, 102293.48853255835, 1019.9439030853226, 1044.7127040063892, 1064.1061508332882, 1071.7856428714288, 1071.9142468602492, 18033.188506516977, 18284.634307314045, 18402.631947361246, 18565.204013776285, 18810.811891880905, 30175.698243018167, 34685.30629387347, 40795.36818527226, 45274.54725452703, 45462.772686136355, 62924.05613915703, 63916.68041659762, 64320.356796431435, 64614.676926615066, 64689.0, 7124.25195354501, 7528.661210245443, 8810.911890881009, 8996.730098097067, 9101.362904596615, 12680.429380677708, 13230.603081907559, 13423.530176444168, 13607.387667555182, 13647.11293765902, 10753.24727269115, 11295.548178073113, 11306.378149201873, 12008.63974080779, 12075.51697932108, 11795.0, 11799.823002654795, 11990.460429280529, 12211.0, 12370.690732731393, 11644.2431241969, 11829.408529573659, 12054.216475929037, 12276.570320038756, 12359.443825028075, 7705.345045670956, 7705.88441173394, 8442.197991190827, 8884.644614215358, 8918.24194943437, 11514.596989105341, 11720.355380454157, 11740.354280514654, 12043.518259269882, 12341.876581234432], "value": 9428.456021853106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1199.892009719125, 1490.5304828978872, 1551.154620731701, 1703.7699910512076, 1843.5391152211955, 7788.883166752496, 8954.91045089549, 9374.531273436334, 9387.483688397135, 9391.15479606836, 9202.677906273282, 9257.39826911252, 9276.304277179222, 9279.396839205463, 9286.767830804216, 2468.543319485892, 2493.139866745979, 2495.5508008558454, 2503.1864643990684, 2504.649349091129, 2392.0670938334065, 2451.240115564181, 2455.45979884426, 2458.5943319352286, 2460.6801115855005, 2438.8414753041084, 2461.249318957717, 2473.6165894286414, 2475.88858501367, 2478.863662498562, 2359.5988681924114, 2376.1802178248477, 2382.309130352196, 2417.8791060446906, 2426.1387207541247, 2335.100986120356, 2356.7761062699014, 2356.8939397727145, 2360.3037104054347, 2360.3037104054347, 8996.8650470243, 9086.81826363469, 9154.084591540859, 9256.95371523138, 9390.671326503609, 5460.26286451328, 5594.468525490072, 5604.607677462538, 5605.299337582802, 5611.579131565149, 3326.151831283007, 3408.113890388492, 3424.7260219182403, 3485.5817301923676, 3489.6335884732243, 1265.7911444611627, 1298.7272672738736, 1298.9740205195844, 1307.6011816395996, 1331.3010669398545, 12513.249205047727, 12546.1844980076, 12598.37008149598, 12621.43203555833, 12623.495060197582, 4549.27211646135, 4636.327732478771, 4740.928886066712, 4761.547652972962, 4835.468098509161, 10006.949965250127, 10058.497075146213, 10058.949705251427, 10064.043915827984, 10073.194144468425, 5341.572674186055, 5345.091334473149, 5345.54562862161, 5353.304070470814, 5356.65181763192, 4450.6884518083425, 4615.699979501322, 4942.9011419771405, 5075.3402057732255, 5167.974160129175, 4156.147989662112, 4167.423769932299, 4236.2374772540625, 4238.957610423918, 4355.891102722394, 1296.3453456004845, 1312.2979206124678, 1324.1194605587177, 1330.7272009238084, 1338.5382043195082, 958.2812890332251, 978.1929907826072, 985.5614251658087, 993.9751506212402, 1002.3935519011039, 5981.790637327673, 6000.579959402888, 6030.939690603125, 6152.661603611755, 6156.384361563808, 986.9077555582069, 1007.9143272821746, 1013.6452241715341, 1027.4708525109575, 1037.159900480613, 3879.1465877507467, 3975.8012099394914, 3981.661558767479, 3997.84008639657, 4181.728187667792, 11013.229073964905, 11212.0, 11294.040006599367, 11347.659570212907, 11539.0, 11141.777164456666, 11266.267692599955, 11291.54833806655, 11303.660890173143, 11319.886801132048, 8526.701565445304, 8568.52873091986, 8581.528015959182, 8656.13438656142, 8703.129687031245, 5806.303243610793, 5877.147813566923, 5955.791547295824, 6083.1483592298, 6106.45041946227, 10462.94768526183, 10503.42231177262, 10567.89432105669, 10590.152787777113, 10592.947035264775, 10241.846372304273, 10387.220958427997, 10493.842592360968, 10601.469926503798, 10708.785824283626, 7072.929270707227, 7304.853902922018, 7683.116441609286, 7815.765527034198, 8018.238267364591, 8688.739337819876, 8723.738287851374, 8739.43193692408, 8744.12558744146, 8752.78118047054, 7443.590602516913, 7455.776326710207, 7564.697412103675, 7736.845263094594, 7776.144624091232, 7362.5214361066355, 7480.1397839247, 7530.28462296081, 7604.923950760422, 7703.730369437043, 6599.8020059398295, 6727.730890764315, 6727.831804204934, 6730.125083739083, 6730.899036514554, 5194.662346947436, 5262.473752624707, 5306.442823503477, 5367.677939323653, 5471.124620060771, 5253.632245742761, 5333.626646134733, 5342.679439233503, 5365.839024829262, 5654.321481422256], "value": 4773.824322235804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.86885245901635, 349.90552550811276, 354.0882228262225, 357.57091490211735, 360.2632616299667, 5494.313210848644, 5528.9771392292405, 5532.944670553298, 5540.423702978114, 5562.0, 5132.4867513248655, 5234.528892399683, 5282.947170528294, 5334.466553344673, 5396.487333703292, 4292.7424354538825, 4312.63342615878, 4329.307310830268, 4329.5021072576665, 4329.696921215516, 4323.481182258133, 4323.718958267718, 4324.8375812093955, 4326.415933848922, 4366.694331396803, 4126.587341265865, 4229.471316085489, 4246.341817018367, 4248.766317852517, 4250.659947204232, 4241.618254357123, 4241.681873859442, 4253.21315556623, 4254.765987870666, 4257.467816522934, 3717.6096509866616, 3721.4603882437164, 3733.197362567061, 3733.197362567061, 3736.4208547675153, 5222.056395432432, 5228.888811157355, 5278.181881808326, 5291.576673866081, 5311.867203319909, 4836.250381190921, 4836.645739192996, 4848.927266091011, 4853.757312134379, 4857.927131093036, 5654.067078931971, 5672.432756724335, 5681.119426488859, 5683.204351390808, 5689.345725241609, 3928.7249892507252, 4088.8160032798596, 4119.423280740669, 4161.750294982311, 4163.97918010411, 5907.366969313884, 5942.970285148546, 5943.138244954501, 5944.82165535039, 5953.7320820562745, 4221.409002739619, 4246.10831725335, 4253.149370125987, 4262.23279809631, 4263.978680106579, 4206.8527601534415, 4285.721428107226, 4287.228298906164, 4295.634871035934, 4309.482862056573, 4838.056578967138, 4861.440934292602, 4866.635002374836, 4875.293082503088, 4876.853694389174, 5696.0, 5702.7433765480655, 5763.538916886723, 5779.537636989031, 5811.186433899257, 1376.4494202318951, 1396.3158052554174, 1411.5553600615774, 1443.6751730860472, 1470.4926800253895, 983.7491439682835, 1002.5630914826412, 1010.8584798128268, 1013.1236480444362, 1021.9948900255451, 5449.3460784706085, 5473.425290344536, 5477.616566840363, 5486.725663716798, 5493.478119578634, 5785.392533783976, 5803.245578074823, 5812.39631428517, 5816.621919575214, 5824.301083869963, 5274.3670759509105, 5428.375736790241, 5462.453754624586, 5468.535174510212, 5543.7782488700805, 3111.4554952883154, 3128.8122712637314, 3129.2020534763487, 3138.4978403455793, 3140.3876244132175, 6036.275646922398, 6041.852048110933, 6059.939400606026, 6088.238970128734, 6103.542234332443, 5741.712914354265, 6004.849878753066, 6020.518358531307, 6065.5450841187085, 6076.574639775174, 6013.248343957005, 6097.024476083805, 6106.168149555116, 6129.662868542273, 6167.784127555514, 5628.240187574625, 5898.0, 5928.644281343133, 5948.2862056553495, 6007.90988135187, 5838.803045375773, 5846.503047241032, 5862.794802181903, 5870.677112758839, 5873.706314684334, 5831.7375718091935, 6081.543884208613, 6156.26124865019, 6177.81466556004, 6182.258129024546, 4303.93544096845, 4316.2878125110265, 4351.216780979454, 4360.563943605614, 4369.38828563995, 5867.706614669335, 5871.119332100219, 5881.647101173943, 5884.176215329771, 5887.41125887425, 5539.335279766454, 5613.40018094841, 5708.543316534584, 5760.539156867524, 5777.711114444345, 5752.309722833287, 5761.041245976388, 5771.336296325809, 5772.336181339032, 5773.451522105393, 5579.972100139474, 5637.0, 5652.152177173457, 5726.885462290814, 5740.971295143665, 5685.829425117253, 5701.885962280814, 5718.885622287447, 5777.24895763548, 5798.695293559084, 5590.832275031756, 5611.270534830446, 5630.831075067755, 5638.774449021993, 5652.7738890443925], "value": 4381.927647860357, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.7917914215305, 727.6252729844128, 731.7731503233998, 743.137959966439, 766.229938911394, 14837.629059273524, 15720.135392553406, 15770.605734856634, 15777.0, 15781.605459863495, 14663.92668036661, 14763.557093287192, 14773.778393324108, 14795.556133316019, 14909.77635335468, 713.1834050012733, 728.5592216708894, 839.7774589733725, 840.5545061117617, 866.3242670716819, 870.3428911172056, 871.1419252036738, 877.2280393253927, 877.8419884420802, 878.6046279174365, 911.3711539038043, 913.1872633356318, 913.9223166030895, 914.07221670005, 914.076782449724, 741.8479211761576, 904.2720609909021, 904.3262769236895, 904.3714618340223, 908.504864848659, 567.324883388766, 651.46905272203, 662.9801105966828, 665.0, 667.6361383046251, 13651.590452286448, 13744.0, 13811.585652430444, 13818.170909745348, 13829.239391833446, 13109.60671179866, 13399.0, 13498.122622029636, 13655.317234138352, 13659.658508537266, 11974.221675591145, 11985.0, 12003.93998030013, 12236.81644775329, 12924.289164095972, 3868.6711629511524, 4475.619572336355, 4476.8880777980485, 4546.977265113654, 4570.0, 75848.0, 76490.61754691247, 76579.70260892183, 76901.23098769052, 76918.61540692317, 9769.267304952014, 9954.552045157985, 9980.500974951368, 9996.850047249298, 10041.497925103715, 17453.47639570815, 17479.300827966737, 17511.38710145139, 17553.21010554528, 17564.648707026045, 7760.573168475788, 8201.425900187049, 8430.32557395407, 8445.155484451505, 8735.563221838882, 4983.127952608279, 5017.7491125443585, 5044.596432285409, 5321.973390133102, 5352.277442545284, 3701.5373078365205, 3830.4637350770913, 3833.1375440526217, 3837.865674701372, 3843.461915331856, 620.4478014567039, 629.0595559638278, 632.4971647540217, 644.9645269510222, 645.5481163185789, 579.190031152648, 736.2784471218237, 741.1328745367932, 743.6096049574016, 786.9488483248571, 9302.627894884265, 9423.528823558932, 9480.0, 10097.293189476666, 10126.946488012274, 665.2482694555122, 705.0587465733201, 721.6932803558467, 790.0598288037218, 806.2058872011064, 4549.45406551216, 4732.195526760459, 4812.157872372391, 4863.610911127102, 4873.147199240118, 129063.0, 135398.0, 139283.30358348347, 139401.0, 140724.88912666318, 111790.0, 117350.0, 117631.0, 118408.0, 118667.0, 98284.99999999857, 99299.50350248202, 100412.0, 101045.48431773529, 105998.0, 9181.265498760216, 9201.953990230006, 9230.907690923004, 9247.39891907024, 9253.86119208199, 40987.59012409838, 57914.4208557909, 59160.70419647874, 60248.69875650594, 61417.385826141166, 78757.21242787498, 80890.59554702189, 88405.0, 89277.55361223152, 91597.08402915885, 11565.0, 11624.360660163435, 11810.704732381759, 12570.43433045497, 12837.59666864991, 12086.879131208576, 12176.634700958986, 12290.078244131904, 13167.2757998311, 13252.536161234311, 11547.826782598437, 11618.593349232737, 12174.57388991381, 12343.753124937271, 12373.93813030929, 11610.477528511406, 11998.160128790902, 12101.152919295564, 12339.197952133083, 12556.686082848002, 11138.498767555642, 11350.318980860844, 11569.942150289195, 11596.130290228099, 12015.639530814089, 9962.601495940371, 10004.449755263238, 10185.0, 10290.948545257226, 10457.68626941193, 10045.648402305884, 10203.38779673222, 10658.73353166177, 10706.625268115578, 10822.404767737535], "value": 7547.380866853322, "unit": "score"}], "name": "dromaeo_css", "value": 7431.862881482549, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 111.0, 111.0, 111.0, 110.0, 110.0, 111.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 122.0, 155.0, 118.0, 119.0, 122.0, 120.0, 151.0, 121.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 161.0, 161.0, 161.0, 162.0, 162.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 108.0, 75.0, 76.0, 76.0, 75.0, 96.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 120.0, 82.0, 82.0, 81.0, 104.0, 82.0, 82.0, 105.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 52.0, 49.0, 49.0, 50.0, 50.0, 50.0, 50.0, 50.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 58.0, 59.0, 59.0, 60.0, 59.0, 59.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 74.0, 75.0, 74.0, 74.0, 73.0, 74.0, 74.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 122.0, 120.0, 124.0, 129.0, 122.0, 140.0, 121.0, 153.0, 127.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 154.0, 160.0, 157.0, 151.0, 154.0, 153.0, 150.0, 157.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 62.0, 61.0, 62.0, 62.0, 69.0, 62.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1461.3999999999999, "alertThreshold": 2.0}]} 07:39:12 INFO - Return code: 0 07:39:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:39:12 INFO - # TBPL SUCCESS # 07:39:12 INFO - Running post-action listener: _resource_record_post_action 07:39:12 INFO - [mozharness: 2016-11-14 15:39:12.661938Z] Finished run-tests step (success) 07:39:12 INFO - Running post-run listener: _resource_record_post_run 07:39:12 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 358699008; Read time: 0; Write time: 257864 07:39:12 INFO - TinderboxPrint: CPU usage
12.9% 07:39:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:39:12 INFO - TinderboxPrint: I/O write bytes / time
358,699,008 / 257,864 07:39:12 INFO - TinderboxPrint: CPU idle
8,271.4 (87.1%) 07:39:12 INFO - TinderboxPrint: CPU user
1,182.6 (12.5%) 07:39:12 INFO - TinderboxPrint: Swap in / out
0 / 0 07:39:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108060672; Read time: 0; Write time: 98460 07:39:12 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 250638336; Read time: 0; Write time: 159404 07:39:13 INFO - Running post-run listener: _upload_blobber_files 07:39:13 INFO - Blob upload gear active. 07:39:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:13 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 07:39:13 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'] 07:39:13 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 07:39:13 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:39:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:14 INFO - (blobuploader) - INFO - Done attempting. 07:39:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:39:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:39:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:15 INFO - (blobuploader) - INFO - Done attempting. 07:39:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:39:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:39:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:19 INFO - (blobuploader) - INFO - Done attempting. 07:39:19 INFO - (blobuploader) - INFO - Iteration through files over. 07:39:19 INFO - Return code: 0 07:39:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:39:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:39:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29761aab3e31373fbdbb381281bd366d126f92397bf9a43795fa8bf65858cb1a3c1d9a289512889d4031e069c2bab3905efe8e6620f924f70a349ef8f3de9a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d224dc3f1de26a6a12988489f38668c8359357655de7c1497c2c8880eaa1ed6ed899428d79581b9db0b627b4ece9b78404b69ec5bd0bfd6f018fe53711e5943e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/789aaad475f5a22a95536fda1e959c74820c8273d9d7da3a11cb1a8897bdfc26cf8ef39993da3c46201b22b4d63a7ffeb843510bf009098a3515141362a62467"} 07:39:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:39:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:39:19 INFO - Contents: 07:39:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29761aab3e31373fbdbb381281bd366d126f92397bf9a43795fa8bf65858cb1a3c1d9a289512889d4031e069c2bab3905efe8e6620f924f70a349ef8f3de9a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d224dc3f1de26a6a12988489f38668c8359357655de7c1497c2c8880eaa1ed6ed899428d79581b9db0b627b4ece9b78404b69ec5bd0bfd6f018fe53711e5943e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/789aaad475f5a22a95536fda1e959c74820c8273d9d7da3a11cb1a8897bdfc26cf8ef39993da3c46201b22b4d63a7ffeb843510bf009098a3515141362a62467"} 07:39:19 INFO - Running post-run listener: copy_logs_to_upload_dir 07:39:19 INFO - Copying logs to upload dir... 07:39:19 INFO - mkdir: /builds/slave/test/build/upload/logs 07:39:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.221251 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-14 07:39:19.265528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:39:19.269106) ========= 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-1479136723.576059-1881575041 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/29761aab3e31373fbdbb381281bd366d126f92397bf9a43795fa8bf65858cb1a3c1d9a289512889d4031e069c2bab3905efe8e6620f924f70a349ef8f3de9a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d224dc3f1de26a6a12988489f38668c8359357655de7c1497c2c8880eaa1ed6ed899428d79581b9db0b627b4ece9b78404b69ec5bd0bfd6f018fe53711e5943e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/789aaad475f5a22a95536fda1e959c74820c8273d9d7da3a11cb1a8897bdfc26cf8ef39993da3c46201b22b4d63a7ffeb843510bf009098a3515141362a62467"} build_url:https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011694 build_url: 'https://queue.taskcluster.net/v1/task/eflXNszJSt6vq_ouj2mDKA/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/29761aab3e31373fbdbb381281bd366d126f92397bf9a43795fa8bf65858cb1a3c1d9a289512889d4031e069c2bab3905efe8e6620f924f70a349ef8f3de9a8a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d224dc3f1de26a6a12988489f38668c8359357655de7c1497c2c8880eaa1ed6ed899428d79581b9db0b627b4ece9b78404b69ec5bd0bfd6f018fe53711e5943e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/789aaad475f5a22a95536fda1e959c74820c8273d9d7da3a11cb1a8897bdfc26cf8ef39993da3c46201b22b4d63a7ffeb843510bf009098a3515141362a62467"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:39:19.295683) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:39:19.296084) ========= 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-1479136723.576059-1881575041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:39:19.382679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:39:19.383513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:39:19.384173) ========= ========= Total master_lag: 0.18 =========