builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1474608429.52 results: success (0) buildid: 20160922193455 builduid: 31aa310a994946c8a3c98cfefd9536c3 revision: fa9844b0dee3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:09.518860) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:09.519292) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:09.519626) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:09.543990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:09.544350) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 22:27:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-09-22 22:27:10 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096923 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:09.683502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:09.683839) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023531 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:09.748183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 22:27:09.748529) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fa9844b0dee3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fa9844b0dee3 --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=e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 22:27:10,544 Setting DEBUG logging. 2016-09-22 22:27:10,544 attempt 1/10 2016-09-22 22:27:10,544 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fa9844b0dee3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 22:27:11,851 unpacking tar archive at: mozilla-inbound-fa9844b0dee3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.644734 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 22:27:11.412040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:11.412741) ========= script_repo_revision: fa9844b0dee3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:11.413182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:11.413501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 22:27:11.425141) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-22 22:27:11.425510) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:27:12 INFO - MultiFileLogger online at 20160922 22:27:12 in /builds/slave/test 22:27:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:27:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:27:12 INFO - {'append_to_log': False, 22:27:12 INFO - 'base_work_dir': '/builds/slave/test', 22:27:12 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:27:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:27:12 INFO - 'branch': 'Mozilla-Inbound', 22:27:12 INFO - 'buildbot_json_path': 'buildprops.json', 22:27:12 INFO - 'config_files': ('talos/linux_config.py',), 22:27:12 INFO - 'default_actions': ('clobber', 22:27:12 INFO - 'read-buildbot-config', 22:27:12 INFO - 'download-and-extract', 22:27:12 INFO - 'populate-webroot', 22:27:12 INFO - 'create-virtualenv', 22:27:12 INFO - 'install', 22:27:12 INFO - 'run-tests'), 22:27:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:27:12 INFO - 'download_minidump_stackwalk': True, 22:27:12 INFO - 'download_symbols': 'ondemand', 22:27:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:27:12 INFO - 'tooltool.py': '/tools/tooltool.py', 22:27:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:27:12 INFO - '/tools/misc-python/virtualenv.py')}, 22:27:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:27:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:27:12 INFO - 'installer_path': 'installer.exe', 22:27:12 INFO - 'log_level': 'info', 22:27:12 INFO - 'log_name': 'talos', 22:27:12 INFO - 'log_to_console': True, 22:27:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:27:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:27:12 INFO - 'opt_config_files': (), 22:27:12 INFO - 'pip_index': False, 22:27:12 INFO - 'sps_profile': False, 22:27:12 INFO - 'sps_profile_interval': 0, 22:27:12 INFO - 'suite': 'dromaeojs-e10s', 22:27:12 INFO - 'system_bits': '32', 22:27:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:27:12 INFO - 'title': 'talos-linux64-ix-067', 22:27:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:27:12 INFO - 'use_talos_json': True, 22:27:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:27:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:27:12 INFO - 'work_dir': 'build'} 22:27:12 INFO - [mozharness: 2016-09-23 05:27:12.312790Z] Running clobber step. 22:27:12 INFO - Running pre-action listener: _resource_record_pre_action 22:27:12 INFO - Running main action method: clobber 22:27:12 INFO - rmtree: /builds/slave/test/build 22:27:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:27:12 INFO - Running post-action listener: _resource_record_post_action 22:27:12 INFO - [mozharness: 2016-09-23 05:27:12.773397Z] Finished clobber step (success) 22:27:12 INFO - [mozharness: 2016-09-23 05:27:12.773498Z] Running read-buildbot-config step. 22:27:12 INFO - Running pre-action listener: _resource_record_pre_action 22:27:12 INFO - Running main action method: read_buildbot_config 22:27:12 INFO - Using buildbot properties: 22:27:12 INFO - { 22:27:12 INFO - "project": "", 22:27:12 INFO - "product": "firefox", 22:27:12 INFO - "script_repo_revision": "production", 22:27:12 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:27:12 INFO - "repository": "", 22:27:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:27:12 INFO - "buildid": "20160922193455", 22:27:12 INFO - "pgo_build": "True", 22:27:12 INFO - "basedir": "/builds/slave/test", 22:27:12 INFO - "buildnumber": 1677, 22:27:12 INFO - "slavename": "talos-linux64-ix-067", 22:27:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:27:12 INFO - "platform": "ubuntu64_hw", 22:27:12 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:27:12 INFO - "branch": "mozilla-inbound", 22:27:12 INFO - "repo_path": "integration/mozilla-inbound", 22:27:12 INFO - "revision": "fa9844b0dee3", 22:27:12 INFO - "stage_platform": "linux64-pgo", 22:27:12 INFO - "builduid": "31aa310a994946c8a3c98cfefd9536c3", 22:27:12 INFO - "slavebuilddir": "test" 22:27:12 INFO - } 22:27:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:27:12 INFO - Running post-action listener: _resource_record_post_action 22:27:12 INFO - [mozharness: 2016-09-23 05:27:12.775943Z] Finished read-buildbot-config step (success) 22:27:12 INFO - [mozharness: 2016-09-23 05:27:12.776032Z] Running download-and-extract step. 22:27:12 INFO - Running pre-action listener: _resource_record_pre_action 22:27:12 INFO - Running main action method: download_and_extract 22:27:12 INFO - mkdir: /builds/slave/test/build/tests 22:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:12 INFO - trying https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:27:12 INFO - Downloading https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:27:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:27:13 INFO - Downloaded 1361 bytes. 22:27:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:27:13 INFO - Using the following test package requirements: 22:27:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:27:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:27:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:27:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:13 INFO - u'jsshell-linux-x86_64.zip'], 22:27:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:27:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:27:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:27:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:27:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:27:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:27:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:27:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:27:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:27:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:27:13 INFO - Fetch https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:27:13 INFO - Expected file size: 21950401 22:27:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:27:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:27:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:27:18 INFO - Fetch https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:27:18 INFO - Expected file size: 21950401 22:27:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:27:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:27:23 INFO - Fetch https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:27:24 INFO - Expected file size: 14414059 22:27:24 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')]} 22:27:24 INFO - trying https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:27:24 INFO - Downloading https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:27:26 INFO - Downloaded 63331295 bytes. 22:27:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:27:26 INFO - mkdir: /builds/slave/test/properties 22:27:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:27:26 INFO - Writing to file /builds/slave/test/properties/build_url 22:27:26 INFO - Contents: 22:27:26 INFO - build_url:https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:27:26 INFO - Running post-action listener: _resource_record_post_action 22:27:26 INFO - Running post-action listener: set_extra_try_arguments 22:27:26 INFO - [mozharness: 2016-09-23 05:27:26.686908Z] Finished download-and-extract step (success) 22:27:26 INFO - [mozharness: 2016-09-23 05:27:26.687135Z] Running populate-webroot step. 22:27:26 INFO - Running pre-action listener: _resource_record_pre_action 22:27:26 INFO - Running main action method: populate_webroot 22:27:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:27:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:27:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:27:26 INFO - '--tppagecycles', 22:27:26 INFO - '7'], 22:27:26 INFO - 'tests': ['tsvgm']}}, 22:27:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:27:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:27:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:27:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:27:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:26 INFO - 'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:26 INFO - 'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['damp', 'tps']}, 22:27:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:26 INFO - 'tests': ['damp', 'tps']}, 22:27:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['dromaeo_dom']}, 22:27:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:27:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['basic_compositor_video']}, 22:27:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:27:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['a11yr', 22:27:26 INFO - 'ts_paint', 22:27:26 INFO - 'tpaint', 22:27:26 INFO - 'sessionrestore', 22:27:26 INFO - 'sessionrestore_no_auto_restore', 22:27:26 INFO - 'tabpaint']}, 22:27:26 INFO - 'other-e10s': {'tests': ['a11yr', 22:27:26 INFO - 'ts_paint', 22:27:26 INFO - 'tpaint', 22:27:26 INFO - 'sessionrestore', 22:27:26 INFO - 'sessionrestore_no_auto_restore', 22:27:26 INFO - 'tabpaint']}, 22:27:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:27:26 INFO - 'ts_paint', 22:27:26 INFO - 'tpaint', 22:27:26 INFO - 'sessionrestore', 22:27:26 INFO - 'sessionrestore_no_auto_restore', 22:27:26 INFO - 'tabpaint']}, 22:27:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:27:26 INFO - 'ts_paint', 22:27:26 INFO - 'tpaint', 22:27:26 INFO - 'sessionrestore', 22:27:26 INFO - 'sessionrestore_no_auto_restore', 22:27:26 INFO - 'tabpaint']}, 22:27:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['a11yr', 22:27:26 INFO - 'ts_paint', 22:27:26 INFO - 'tpaint', 22:27:26 INFO - 'sessionrestore', 22:27:26 INFO - 'sessionrestore_no_auto_restore', 22:27:26 INFO - 'tabpaint']}, 22:27:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['a11yr', 22:27:26 INFO - 'ts_paint', 22:27:26 INFO - 'tpaint', 22:27:26 INFO - 'sessionrestore', 22:27:26 INFO - 'sessionrestore_no_auto_restore', 22:27:26 INFO - 'tabpaint']}, 22:27:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['tsvgx', 22:27:26 INFO - 'tsvgr_opacity', 22:27:26 INFO - 'tart', 22:27:26 INFO - 'tscrollx', 22:27:26 INFO - 'cart']}, 22:27:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:27:26 INFO - 'tsvgr_opacity', 22:27:26 INFO - 'tart', 22:27:26 INFO - 'tscrollx', 22:27:26 INFO - 'cart']}, 22:27:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:26 INFO - 'talos_options': ['--disable-e10s'], 22:27:26 INFO - 'tests': ['tp5o']}, 22:27:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:26 INFO - 'tests': ['tp5o']}, 22:27:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:26 INFO - 'talos_options': ['--disable-e10s', 22:27:26 INFO - '--xperf_path', 22:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:26 INFO - 'tests': ['tp5n']}, 22:27:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:26 INFO - 'talos_options': ['--xperf_path', 22:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:26 INFO - 'tests': ['tp5n']}}, 22:27:26 INFO - 'talos.zip': {'path': '', 22:27:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:27:26 INFO - Running post-action listener: _resource_record_post_action 22:27:26 INFO - [mozharness: 2016-09-23 05:27:26.707583Z] Finished populate-webroot step (success) 22:27:26 INFO - [mozharness: 2016-09-23 05:27:26.707671Z] Running create-virtualenv step. 22:27:26 INFO - Running pre-action listener: _resource_record_pre_action 22:27:26 INFO - Running main action method: create_virtualenv 22:27:26 INFO - Creating virtualenv /builds/slave/test/build/venv 22:27:26 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 22:27:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:27:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:27:26 INFO - Using real prefix '/usr' 22:27:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:27:27 INFO - Installing distribute.............................................................................................................................................................................................done. 22:27:29 INFO - Installing pip.................done. 22:27:29 INFO - Return code: 0 22:27:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:29 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 0x7fbba891bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', '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 22:27:29 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 22:27:29 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 22:27:29 INFO - Using env: {'DISPLAY': ':0', 22:27:29 INFO - 'HOME': '/home/cltbld', 22:27:29 INFO - 'LANG': 'en_US.UTF-8', 22:27:29 INFO - 'LANGUAGE': 'en_US:en', 22:27:29 INFO - 'LOGNAME': 'cltbld', 22:27:29 INFO - 'MAIL': '/var/mail/cltbld', 22:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:29 INFO - 'MOZ_NO_REMOTE': '1', 22:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:29 INFO - 'NO_EM_RESTART': '1', 22:27:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:29 INFO - 'PWD': '/builds/slave/test', 22:27:29 INFO - 'SHELL': '/bin/bash', 22:27:29 INFO - 'SHLVL': '1', 22:27:29 INFO - 'TERM': 'linux', 22:27:29 INFO - 'TMOUT': '86400', 22:27:29 INFO - 'USER': 'cltbld', 22:27:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:29 INFO - '_': '/tools/buildbot/bin/python'} 22:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:29 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 22:27:29 INFO - Cleaning up... 22:27:29 INFO - Return code: 0 22:27:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:29 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 0x7fbba891bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', '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 22:27:29 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 22:27:29 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 22:27:29 INFO - Using env: {'DISPLAY': ':0', 22:27:29 INFO - 'HOME': '/home/cltbld', 22:27:29 INFO - 'LANG': 'en_US.UTF-8', 22:27:29 INFO - 'LANGUAGE': 'en_US:en', 22:27:29 INFO - 'LOGNAME': 'cltbld', 22:27:29 INFO - 'MAIL': '/var/mail/cltbld', 22:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:29 INFO - 'MOZ_NO_REMOTE': '1', 22:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:29 INFO - 'NO_EM_RESTART': '1', 22:27:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:29 INFO - 'PWD': '/builds/slave/test', 22:27:29 INFO - 'SHELL': '/bin/bash', 22:27:29 INFO - 'SHLVL': '1', 22:27:29 INFO - 'TERM': 'linux', 22:27:29 INFO - 'TMOUT': '86400', 22:27:29 INFO - 'USER': 'cltbld', 22:27:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:29 INFO - '_': '/tools/buildbot/bin/python'} 22:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:29 INFO - Downloading/unpacking psutil>=3.1.1 22:27:29 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 22:27:29 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 22:27:29 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 22:27:29 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 22:27:29 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 22:27:29 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 22:27:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:27:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:31 INFO - Installing collected packages: psutil 22:27:31 INFO - Running setup.py install for psutil 22:27:31 INFO - building 'psutil._psutil_linux' extension 22:27:31 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 22:27:31 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 22:27:32 INFO - building 'psutil._psutil_posix' extension 22:27:32 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 22:27:32 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 22:27:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:32 INFO - Successfully installed psutil 22:27:32 INFO - Cleaning up... 22:27:32 INFO - Return code: 0 22:27:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:32 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 0x7fbba891bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', '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 22:27:32 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 22:27:32 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 22:27:32 INFO - Using env: {'DISPLAY': ':0', 22:27:32 INFO - 'HOME': '/home/cltbld', 22:27:32 INFO - 'LANG': 'en_US.UTF-8', 22:27:32 INFO - 'LANGUAGE': 'en_US:en', 22:27:32 INFO - 'LOGNAME': 'cltbld', 22:27:32 INFO - 'MAIL': '/var/mail/cltbld', 22:27:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:32 INFO - 'MOZ_NO_REMOTE': '1', 22:27:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:32 INFO - 'NO_EM_RESTART': '1', 22:27:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:32 INFO - 'PWD': '/builds/slave/test', 22:27:32 INFO - 'SHELL': '/bin/bash', 22:27:32 INFO - 'SHLVL': '1', 22:27:32 INFO - 'TERM': 'linux', 22:27:32 INFO - 'TMOUT': '86400', 22:27:32 INFO - 'USER': 'cltbld', 22:27:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:27:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:32 INFO - '_': '/tools/buildbot/bin/python'} 22:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:27:32 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 22:27:32 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 22:27:32 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 22:27:32 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 22:27:32 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 22:27:32 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 22:27:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:27:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:27:34 INFO - Installing collected packages: mozsystemmonitor 22:27:34 INFO - Running setup.py install for mozsystemmonitor 22:27:34 INFO - Successfully installed mozsystemmonitor 22:27:34 INFO - Cleaning up... 22:27:34 INFO - Return code: 0 22:27:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:34 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 0x7fbba891bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', '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 22:27:34 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 22:27:34 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 22:27:34 INFO - Using env: {'DISPLAY': ':0', 22:27:34 INFO - 'HOME': '/home/cltbld', 22:27:34 INFO - 'LANG': 'en_US.UTF-8', 22:27:34 INFO - 'LANGUAGE': 'en_US:en', 22:27:34 INFO - 'LOGNAME': 'cltbld', 22:27:34 INFO - 'MAIL': '/var/mail/cltbld', 22:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:34 INFO - 'MOZ_NO_REMOTE': '1', 22:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:34 INFO - 'NO_EM_RESTART': '1', 22:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:34 INFO - 'PWD': '/builds/slave/test', 22:27:34 INFO - 'SHELL': '/bin/bash', 22:27:34 INFO - 'SHLVL': '1', 22:27:34 INFO - 'TERM': 'linux', 22:27:34 INFO - 'TMOUT': '86400', 22:27:34 INFO - 'USER': 'cltbld', 22:27:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:34 INFO - '_': '/tools/buildbot/bin/python'} 22:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:34 INFO - Downloading/unpacking jsonschema==2.5.1 22:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:27:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:36 INFO - Downloading functools32-3.2.3-2.tar.gz 22:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:27:37 INFO - warning: no files found matching '*.txt' 22:27:37 INFO - no previously-included directories found matching 'build' 22:27:37 INFO - no previously-included directories found matching 'dist' 22:27:37 INFO - no previously-included directories found matching '.git*' 22:27:37 INFO - Installing collected packages: jsonschema, functools32 22:27:37 INFO - Running setup.py install for functools32 22:27:37 INFO - warning: no files found matching '*.txt' 22:27:37 INFO - no previously-included directories found matching 'build' 22:27:37 INFO - no previously-included directories found matching 'dist' 22:27:37 INFO - no previously-included directories found matching '.git*' 22:27:37 INFO - Successfully installed jsonschema functools32 22:27:37 INFO - Cleaning up... 22:27:37 INFO - Return code: 0 22:27:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:27:37 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')]} 22:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:37 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')]} 22:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:37 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 0x7fbba891bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', '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 22:27:37 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 22:27:37 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 22:27:37 INFO - Using env: {'DISPLAY': ':0', 22:27:37 INFO - 'HOME': '/home/cltbld', 22:27:37 INFO - 'LANG': 'en_US.UTF-8', 22:27:37 INFO - 'LANGUAGE': 'en_US:en', 22:27:37 INFO - 'LOGNAME': 'cltbld', 22:27:37 INFO - 'MAIL': '/var/mail/cltbld', 22:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:37 INFO - 'MOZ_NO_REMOTE': '1', 22:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:37 INFO - 'NO_EM_RESTART': '1', 22:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:37 INFO - 'PWD': '/builds/slave/test', 22:27:37 INFO - 'SHELL': '/bin/bash', 22:27:37 INFO - 'SHLVL': '1', 22:27:37 INFO - 'TERM': 'linux', 22:27:37 INFO - 'TMOUT': '86400', 22:27:37 INFO - 'USER': 'cltbld', 22:27:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:37 INFO - '_': '/tools/buildbot/bin/python'} 22:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:27:37 INFO - Cleaning up... 22:27:37 INFO - Return code: 0 22:27:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:27:37 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')]} 22:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:37 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')]} 22:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:37 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 0x7fbba891bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', '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 22:27:37 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 22:27:37 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 22:27:37 INFO - Using env: {'DISPLAY': ':0', 22:27:37 INFO - 'HOME': '/home/cltbld', 22:27:37 INFO - 'LANG': 'en_US.UTF-8', 22:27:37 INFO - 'LANGUAGE': 'en_US:en', 22:27:37 INFO - 'LOGNAME': 'cltbld', 22:27:37 INFO - 'MAIL': '/var/mail/cltbld', 22:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:37 INFO - 'MOZ_NO_REMOTE': '1', 22:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:37 INFO - 'NO_EM_RESTART': '1', 22:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:37 INFO - 'PWD': '/builds/slave/test', 22:27:37 INFO - 'SHELL': '/bin/bash', 22:27:37 INFO - 'SHLVL': '1', 22:27:37 INFO - 'TERM': 'linux', 22:27:37 INFO - 'TMOUT': '86400', 22:27:37 INFO - 'USER': 'cltbld', 22:27:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:37 INFO - '_': '/tools/buildbot/bin/python'} 22:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:37 INFO - Downloading/unpacking blobuploader==1.2.4 22:27:37 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 22:27:37 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 22:27:37 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 22:27:37 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 22:27:37 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 22:27:37 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 22:27:40 INFO - Downloading blobuploader-1.2.4.tar.gz 22:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:27:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:27:40 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 22:27:40 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 22:27:40 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 22:27:40 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 22:27:40 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 22:27:40 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 22:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:27:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:41 INFO - Downloading docopt-0.6.1.tar.gz 22:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:27:41 INFO - Installing collected packages: blobuploader, requests, docopt 22:27:41 INFO - Running setup.py install for blobuploader 22:27:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:27:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:27:41 INFO - Running setup.py install for requests 22:27:41 INFO - Running setup.py install for docopt 22:27:41 INFO - Successfully installed blobuploader requests docopt 22:27:41 INFO - Cleaning up... 22:27:41 INFO - Return code: 0 22:27:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:41 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 0x7fbba891bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', '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 22:27:41 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 22:27:41 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 22:27:41 INFO - Using env: {'DISPLAY': ':0', 22:27:41 INFO - 'HOME': '/home/cltbld', 22:27:41 INFO - 'LANG': 'en_US.UTF-8', 22:27:41 INFO - 'LANGUAGE': 'en_US:en', 22:27:41 INFO - 'LOGNAME': 'cltbld', 22:27:41 INFO - 'MAIL': '/var/mail/cltbld', 22:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:41 INFO - 'MOZ_NO_REMOTE': '1', 22:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:41 INFO - 'NO_EM_RESTART': '1', 22:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:41 INFO - 'PWD': '/builds/slave/test', 22:27:41 INFO - 'SHELL': '/bin/bash', 22:27:41 INFO - 'SHLVL': '1', 22:27:41 INFO - 'TERM': 'linux', 22:27:41 INFO - 'TMOUT': '86400', 22:27:41 INFO - 'USER': 'cltbld', 22:27:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:41 INFO - '_': '/tools/buildbot/bin/python'} 22:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:27:42 INFO - Running setup.py (path:/tmp/pip-h6QEoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:27:42 INFO - Running setup.py (path:/tmp/pip-tZBLKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:27:42 INFO - Running setup.py (path:/tmp/pip-1dngCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:27:42 INFO - Running setup.py (path:/tmp/pip-WXI5os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:27:42 INFO - Running setup.py (path:/tmp/pip-lPndKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:27:42 INFO - Running setup.py (path:/tmp/pip-KTpPXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:27:42 INFO - Running setup.py (path:/tmp/pip-rKGRqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:27:42 INFO - Running setup.py (path:/tmp/pip-P7TrN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:27:42 INFO - Running setup.py (path:/tmp/pip-9ur4TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:27:42 INFO - Running setup.py (path:/tmp/pip-97p2gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:27:42 INFO - Running setup.py (path:/tmp/pip-qkzfl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:27:42 INFO - Running setup.py (path:/tmp/pip-aOM4ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:27:43 INFO - Running setup.py (path:/tmp/pip-qzfkOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:27:43 INFO - Running setup.py (path:/tmp/pip-ubB3AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:43 INFO - Running setup.py (path:/tmp/pip-I9oYP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:27:43 INFO - Running setup.py (path:/tmp/pip-Q0Av7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:27:43 INFO - Running setup.py (path:/tmp/pip-py4PYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:27:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:27:43 INFO - Running setup.py install for manifestparser 22:27:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:27:43 INFO - Running setup.py install for mozcrash 22:27:43 INFO - Running setup.py install for mozdebug 22:27:43 INFO - Running setup.py install for mozdevice 22:27:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:27:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:27:43 INFO - Running setup.py install for mozfile 22:27:43 INFO - Running setup.py install for mozhttpd 22:27:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:27:43 INFO - Running setup.py install for mozinfo 22:27:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Running setup.py install for mozInstall 22:27:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Running setup.py install for mozleak 22:27:44 INFO - Running setup.py install for mozlog 22:27:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Running setup.py install for moznetwork 22:27:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Running setup.py install for mozprocess 22:27:44 INFO - Running setup.py install for mozprofile 22:27:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Running setup.py install for mozrunner 22:27:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:27:44 INFO - Running setup.py install for mozscreenshot 22:27:44 INFO - Running setup.py install for moztest 22:27:45 INFO - Running setup.py install for mozversion 22:27:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:27:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:27:45 INFO - Cleaning up... 22:27:45 INFO - Return code: 0 22:27:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:27:45 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')]} 22:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:45 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')]} 22:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:45 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 0x7fbba891bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', '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 22:27:45 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 22:27:45 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 22:27:45 INFO - Using env: {'DISPLAY': ':0', 22:27:45 INFO - 'HOME': '/home/cltbld', 22:27:45 INFO - 'LANG': 'en_US.UTF-8', 22:27:45 INFO - 'LANGUAGE': 'en_US:en', 22:27:45 INFO - 'LOGNAME': 'cltbld', 22:27:45 INFO - 'MAIL': '/var/mail/cltbld', 22:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:45 INFO - 'MOZ_NO_REMOTE': '1', 22:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:45 INFO - 'NO_EM_RESTART': '1', 22:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:45 INFO - 'PWD': '/builds/slave/test', 22:27:45 INFO - 'SHELL': '/bin/bash', 22:27:45 INFO - 'SHLVL': '1', 22:27:45 INFO - 'TERM': 'linux', 22:27:45 INFO - 'TMOUT': '86400', 22:27:45 INFO - 'USER': 'cltbld', 22:27:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:45 INFO - '_': '/tools/buildbot/bin/python'} 22:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:27:45 INFO - Running setup.py (path:/tmp/pip-2xfldU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:27:45 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)) 22:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:27:45 INFO - Running setup.py (path:/tmp/pip-JYP59N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:27:45 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)) 22:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:27:45 INFO - Running setup.py (path:/tmp/pip-0W1C11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:27:45 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)) 22:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:27:45 INFO - Running setup.py (path:/tmp/pip-sE8IFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:27:45 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)) 22:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:27:45 INFO - Running setup.py (path:/tmp/pip-vByTUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:27:45 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)) 22:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:27:45 INFO - Running setup.py (path:/tmp/pip-YdPnJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:27:45 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)) 22:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:27:45 INFO - Running setup.py (path:/tmp/pip-u7hVoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:27:45 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)) 22:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:27:45 INFO - Running setup.py (path:/tmp/pip-HsFm_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:27:45 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)) 22:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:27:45 INFO - Running setup.py (path:/tmp/pip-2BfyRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:27:46 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)) 22:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:27:46 INFO - Running setup.py (path:/tmp/pip-Y5a9ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:27:46 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)) 22:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:27:46 INFO - Running setup.py (path:/tmp/pip-1u1IKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:27:46 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)) 22:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:27:46 INFO - Running setup.py (path:/tmp/pip-TsNZ51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:27:46 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)) 22:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:27:46 INFO - Running setup.py (path:/tmp/pip-ENos3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:27:46 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)) 22:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:27:46 INFO - Running setup.py (path:/tmp/pip-aLtwTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:27:46 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)) 22:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:46 INFO - Running setup.py (path:/tmp/pip-Algoq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:27:46 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)) 22:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:27:46 INFO - Running setup.py (path:/tmp/pip-qVEVGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:27:46 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)) 22:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:27:46 INFO - Running setup.py (path:/tmp/pip-Ux_3w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:27:46 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)) 22:27:46 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)) 22:27:46 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)) 22:27:46 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)) 22:27:46 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)) 22:27:46 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)) 22:27:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:48 INFO - Downloading blessings-1.6.tar.gz 22:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:27:48 INFO - Installing collected packages: blessings 22:27:48 INFO - Running setup.py install for blessings 22:27:48 INFO - Successfully installed blessings 22:27:48 INFO - Cleaning up... 22:27:48 INFO - Return code: 0 22:27:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:27:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:27:48 INFO - Reading from file tmpfile_stdout 22:27:48 INFO - Current package versions: 22:27:48 INFO - argparse == 1.2.1 22:27:48 INFO - blessings == 1.6 22:27:48 INFO - blobuploader == 1.2.4 22:27:48 INFO - docopt == 0.6.1 22:27:48 INFO - functools32 == 3.2.3-2 22:27:48 INFO - jsonschema == 2.5.1 22:27:48 INFO - manifestparser == 1.1 22:27:48 INFO - mozInstall == 1.12 22:27:48 INFO - mozcrash == 0.17 22:27:48 INFO - mozdebug == 0.1 22:27:48 INFO - mozdevice == 0.48 22:27:48 INFO - mozfile == 1.2 22:27:48 INFO - mozhttpd == 0.7 22:27:48 INFO - mozinfo == 0.9 22:27:48 INFO - mozleak == 0.1 22:27:48 INFO - mozlog == 3.4 22:27:48 INFO - moznetwork == 0.27 22:27:48 INFO - mozprocess == 0.23 22:27:48 INFO - mozprofile == 0.28 22:27:48 INFO - mozrunner == 6.12 22:27:48 INFO - mozscreenshot == 0.1 22:27:48 INFO - mozsystemmonitor == 0.3 22:27:48 INFO - moztest == 0.7 22:27:48 INFO - mozversion == 1.4 22:27:48 INFO - psutil == 3.1.1 22:27:48 INFO - requests == 1.2.3 22:27:48 INFO - wsgiref == 0.1.2 22:27:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:27:48 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')]} 22:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:48 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')]} 22:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:48 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 0x7fbba891bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', '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 22:27:48 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 22:27:48 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 22:27:48 INFO - Using env: {'DISPLAY': ':0', 22:27:48 INFO - 'HOME': '/home/cltbld', 22:27:48 INFO - 'LANG': 'en_US.UTF-8', 22:27:48 INFO - 'LANGUAGE': 'en_US:en', 22:27:48 INFO - 'LOGNAME': 'cltbld', 22:27:48 INFO - 'MAIL': '/var/mail/cltbld', 22:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:48 INFO - 'MOZ_NO_REMOTE': '1', 22:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:48 INFO - 'NO_EM_RESTART': '1', 22:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:48 INFO - 'PWD': '/builds/slave/test', 22:27:48 INFO - 'SHELL': '/bin/bash', 22:27:48 INFO - 'SHLVL': '1', 22:27:48 INFO - 'TERM': 'linux', 22:27:48 INFO - 'TMOUT': '86400', 22:27:48 INFO - 'USER': 'cltbld', 22:27:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:48 INFO - '_': '/tools/buildbot/bin/python'} 22:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:49 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)) 22:27:49 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)) 22:27:49 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)) 22:27:49 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)) 22:27:49 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)) 22:27:49 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)) 22:27:49 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)) 22:27:49 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)) 22:27:49 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)) 22:27:49 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)) 22:27:49 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)) 22:27:49 INFO - Cleaning up... 22:27:49 INFO - Return code: 0 22:27:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:27:49 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')]} 22:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 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')]} 22:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 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 0x7fbba891bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', '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 22:27:49 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 22:27:49 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 22:27:49 INFO - Using env: {'DISPLAY': ':0', 22:27:49 INFO - 'HOME': '/home/cltbld', 22:27:49 INFO - 'LANG': 'en_US.UTF-8', 22:27:49 INFO - 'LANGUAGE': 'en_US:en', 22:27:49 INFO - 'LOGNAME': 'cltbld', 22:27:49 INFO - 'MAIL': '/var/mail/cltbld', 22:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:49 INFO - 'MOZ_NO_REMOTE': '1', 22:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:27:49 INFO - 'NO_EM_RESTART': '1', 22:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:49 INFO - 'PWD': '/builds/slave/test', 22:27:49 INFO - 'SHELL': '/bin/bash', 22:27:49 INFO - 'SHLVL': '1', 22:27:49 INFO - 'TERM': 'linux', 22:27:49 INFO - 'TMOUT': '86400', 22:27:49 INFO - 'USER': 'cltbld', 22:27:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:49 INFO - '_': '/tools/buildbot/bin/python'} 22:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:27:49 INFO - Cleaning up... 22:27:49 INFO - Return code: 0 22:27:49 INFO - Running post-action listener: _resource_record_post_action 22:27:49 INFO - Running post-action listener: _start_resource_monitoring 22:27:49 INFO - Starting resource monitoring. 22:27:49 INFO - [mozharness: 2016-09-23 05:27:49.466930Z] Finished create-virtualenv step (success) 22:27:49 INFO - [mozharness: 2016-09-23 05:27:49.467392Z] Running install step. 22:27:49 INFO - Running pre-action listener: _resource_record_pre_action 22:27:49 INFO - Running main action method: install 22:27:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:27:49 INFO - Reading from file tmpfile_stdout 22:27:49 INFO - Detecting whether we're running mozinstall >=1.0... 22:27:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:27:49 INFO - Reading from file tmpfile_stdout 22:27:49 INFO - Output received: 22:27:49 INFO - Usage: mozinstall [options] installer 22:27:49 INFO - Options: 22:27:49 INFO - -h, --help show this help message and exit 22:27:49 INFO - -d DEST, --destination=DEST 22:27:49 INFO - Directory to install application into. [default: 22:27:49 INFO - "/builds/slave/test"] 22:27:49 INFO - --app=APP Application being installed. [default: firefox] 22:27:49 INFO - mkdir: /builds/slave/test/build/application 22:27:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:28:07 INFO - Reading from file tmpfile_stdout 22:28:07 INFO - Output received: 22:28:07 INFO - /builds/slave/test/build/application/firefox/firefox 22:28:07 INFO - Running post-action listener: _resource_record_post_action 22:28:07 INFO - [mozharness: 2016-09-23 05:28:07.088732Z] Finished install step (success) 22:28:07 INFO - [mozharness: 2016-09-23 05:28:07.088976Z] Running run-tests step. 22:28:07 INFO - Running pre-action listener: _resource_record_pre_action 22:28:07 INFO - Running main action method: run_tests 22:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:28:07 INFO - Python 2.7.3 22:28:07 INFO - Return code: 0 22:28:07 INFO - grabbing minidump binary from tooltool 22:28:07 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')]} 22:28:07 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 0x12bdf60>, '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 0x12bed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12bf1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:28:07 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 22:28:07 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 22:28:07 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 22:28:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:28:07 INFO - Return code: 0 22:28:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:28:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:28:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:28:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:28:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:28:07 INFO - Using env: {'DISPLAY': ':0', 22:28:07 INFO - 'HOME': '/home/cltbld', 22:28:07 INFO - 'LANG': 'en_US.UTF-8', 22:28:07 INFO - 'LANGUAGE': 'en_US:en', 22:28:07 INFO - 'LOGNAME': 'cltbld', 22:28:07 INFO - 'MAIL': '/var/mail/cltbld', 22:28:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:28:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:07 INFO - 'MOZ_NO_REMOTE': '1', 22:28:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:28:07 INFO - 'NO_EM_RESTART': '1', 22:28:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:07 INFO - 'PWD': '/builds/slave/test', 22:28:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:28:07 INFO - 'SHELL': '/bin/bash', 22:28:07 INFO - 'SHLVL': '1', 22:28:07 INFO - 'TERM': 'linux', 22:28:07 INFO - 'TMOUT': '86400', 22:28:07 INFO - 'USER': 'cltbld', 22:28:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018', 22:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:07 INFO - '_': '/tools/buildbot/bin/python'} 22:28:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:28:07 INFO - mozversion application_buildid: 20160922193455 22:28:07 INFO - mozversion application_changeset: fa9844b0dee37aeb4c94d027f7c68a94721db320 22:28:07 INFO - mozversion application_display_name: Nightly 22:28:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:28:07 INFO - mozversion application_name: Firefox 22:28:07 INFO - mozversion application_remotingname: firefox 22:28:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:28:07 INFO - mozversion application_vendor: Mozilla 22:28:07 INFO - mozversion application_version: 52.0a1 22:28:07 INFO - mozversion platform_buildid: 20160922193455 22:28:07 INFO - mozversion platform_changeset: fa9844b0dee37aeb4c94d027f7c68a94721db320 22:28:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:28:07 INFO - mozversion platform_version: 52.0a1 22:28:07 INFO - using testdate: 1474608487 22:28:07 INFO - actual date: 1474608487 22:28:07 INFO - starting webserver on 'localhost:41867' 22:28:07 INFO - SUITE-START | Running 2 tests 22:28:07 INFO - TEST-START | dromaeo_css 22:28:07 INFO - operating with platform_type : linux_ 22:28:07 INFO - Initialising browser for dromaeo_css test... 22:28:07 INFO - TEST-INFO | started process 16012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpczxC6V/profile http://localhost:41867/getInfo.html) 22:28:11 INFO - PROCESS | 16012 | __metrics Screen width/height:1600/1200 22:28:11 INFO - PROCESS | 16012 | colorDepth:24 22:28:11 INFO - PROCESS | 16012 | Browser inner width/height: 1024/697 22:28:11 INFO - PROCESS | 16012 | __metrics 22:28:12 ERROR - PROCESS | 16012 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 22:28:13 INFO - TEST-INFO | 16012: exit 0 22:28:13 INFO - Browser initialized. 22:28:13 INFO - Running cycle 1/1 for dromaeo_css test... 22:28:13 INFO - TEST-INFO | started process 16134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpczxC6V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:28:25 INFO - PROCESS | 16134 | RSS: Main: 181211136 22:28:25 INFO - PROCESS | 16134 | 22:29:14 INFO - PROCESS | 16134 | 1474608554966 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] 22:31:25 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:41867/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41867/tests/dromaeo/cssquery-ext.html) 22:31:26 INFO - PROCESS | 16134 | RSS: Main: 195489792 22:31:26 INFO - PROCESS | 16134 | 22:34:28 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:41867/tests/dromaeo/cssquery-ext.html (next: http://localhost:41867/tests/dromaeo/cssquery-jquery.html) 22:34:29 INFO - PROCESS | 16134 | RSS: Main: 193658880 22:34:29 INFO - PROCESS | 16134 | 22:37:31 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:41867/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41867/tests/dromaeo/cssquery-mootools.html) 22:37:32 INFO - PROCESS | 16134 | RSS: Main: 193929216 22:37:32 INFO - PROCESS | 16134 | 22:40:34 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:41867/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41867/tests/dromaeo/cssquery-prototype.html) 22:40:34 INFO - PROCESS | 16134 | RSS: Main: 190726144 22:40:34 INFO - PROCESS | 16134 | 22:43:37 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:41867/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41867/tests/dromaeo/cssquery-yui.html) 22:43:37 INFO - PROCESS | 16134 | RSS: Main: 194334720 22:43:37 INFO - PROCESS | 16134 | 22:46:40 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:41867/tests/dromaeo/cssquery-yui.html (next: http://localhost:41867/tests/dromaeo/cssquery-dojo.html) 22:46:40 INFO - PROCESS | 16134 | RSS: Main: 194920448 22:46:40 INFO - PROCESS | 16134 | 22:46:40 INFO - PROCESS | 16134 | __start_tp_report 22:46:40 INFO - PROCESS | 16134 | _x_x_mozilla_page_load 22:46:40 INFO - PROCESS | 16134 | _x_x_mozilla_page_load_details 22:46:40 INFO - PROCESS | 16134 | |i|pagename|runs| 22:46:40 INFO - PROCESS | 16134 | |0;dojo.html;3074.2007078159677;3086.1975886269593;3105.9844700776507;3115.0343393548;3119.563261143439;5411.377691565471;5547.223388725577;5618.185363122345;5650.660960342378;5663.008973429643;5467.20725494803;5498.0653288940875;5502.58730595205;5568.443155684429;5612.354579223391;4945.505449455061;4983.252512123175;5023.14606516893;5050.671706339094;5111.667741596803;4993.325901003373;5052.040112378636;5113.769880355374;5132.820351287705;5148;4829.396325459317;5090.363704536933;5121.871953201181;5132.897342053138;5137.152369858969;4845.370101886732;4937.21004639256;4946.183879659852;4991.07665081961;5080.847574572732;4957.3059771632;4963.60291176705;4964.6276529260085;4984.850454486371;4997.725125118117;5511.669299842022;5538.861528461781;5543.8891222175735;5557.666540007613;5558.722063896789;5703.458171473703;5780.468175933381;5828.41715828418;5928.733207005652;5929.851753706149;6018.067199584071;6022.96988515059;6023.156758053876;6030.969845150747;6075.483583895374;5604.131359639263;5606.018946684314;5611.691356975365;5612.466815652507;5619.803306884281;5847.619904706181;5899.351071382144;5920.881582368328;5970.611910225822;6074.058520929263;5767.36558978512;5825.650460972355;5828.708564571754;5885.676287804126;5905.40945905406;5859;5903.586748927534;5909.497692696169;5913.142594323799;5924.526037916957;5639.351474580394;5702.800401985911;5889.734961926723;5917.52659787216;5919.940800591939;5822.737976791054;5825.126231065289;5844.240248767718;5921.14143449206;5924.881502369928;4497.145542346943;4538.818447262072;4539.546045395434;4546.340780586796;4582;3998.260321840469;4001.7398869073418;4012.0972781124597;4035.0921042765144;4035.8183881725395;5669.121286200563;5684.857878553069;5685.744141513642;5690.459406356389;5696.772129114789;5980.521558275327;5989.970050149721;6019.578629495981;6024.0662697282;6043.576949613484;5498.670079795225;5535.861603459865;5586.301712285965;5633.324001119892;5656.434356564393;5178.689278643294;5184.300119483897;5184.870378240575;5188.299579556787;5224.660397074178;6175.073738939105;6178.351273116438;6181.505479561624;6182.072689096672;6188.319284878659;5774.971125144348;5828.329742079545;5907.822765317047;5934;5954.851128721816;6254.155688981929;6255.186825712628;6260.248770147611;6288.088227207121;6291.1192433058495;5829.387914268941;5829.737661805144;5844.26946631671;5874.722750316782;5960.374160713236;5790;5867.735951882261;5917.201177840936;6004.639721616542;6016.87966240664;5798.304203495608;5811;5832.766689332379;5874.471297583238;5890.087036509348;5792.594518383673;5794.072948328248;5795.1017592273265;5812.82561523155;5825.737841797045;5506.091494903296;5518.227448157181;5588.916166257428;5589.413111623384;5631.2960879890015;5751.223584815996;5844.094165404369;5847.532197424111;5865.9441300566305;5925.348211696623;5614.775408983758;5691.459311365414;5701.629394089371;5702.401247868914;5703.258576385043 22:46:40 INFO - PROCESS | 16134 | |1;ext.html;547.9045663349265;571.8627529392945;574.1387918122816;592.0615823919088;605.5276884030455;41890.79054604727;43930;43994.56005439949;45884.77057614707;46477;44727;45010.54989450105;45161.774191129;45177.32234016492;45186;8813.647454101845;8956.149165829236;8956.552172391355;8971.506567138806;8987.191152796247;8684.261837743768;8754;8771.166739159802;8797.648094076229;8801.295896328278;8777.341699372573;8785.868211976793;8813.42712723671;8833.73498795034;8881.111888811132;8739.95630021849;8769.56152192391;8802.64789408423;8858.601362938683;8902.821943561157;8852.955735221347;8922.955385223097;8934.910650893473;8964.50695211763;8970.461772293684;42632.57367426348;42780.57219427797;42988.140237195395;43065;43085.78457107726;3045.771567132474;3055.8624861881267;3108.922276943072;3232.2404235004756;3339.3154403347257;31147.844260778777;31631.367372652418;31712.36575268482;31829.681703182905;31888.840555797306;4320.956790432118;4435.911281774379;4446.42196514451;4462.821487140511;4545.954540454619;359292;361231;363121.9999999974;363264;364753;34719;54963.72518137463;55223.723881380334;55495;55508.16737748937;31657.05028849138;33214.501782473286;33281.83359083189;33304.16739581482;33334.83332583321;13538.255395953318;13591.592252232449;13609;13685.178889266675;13729.382177802023;11866.762664746657;11896.16726829131;11947.342896140623;11986;12009.159358844972;8452;8500.404971651926;8547.572621368907;8630.540296015606;8640.30877529796;3323.6177839548277;3384.4584866421255;3387.1193489692364;3395.2021275000357;3424.74314426419;930.9534523273944;976.7069879036403;991.9900800991898;1003.5534187286587;1053.2469284461495;32557.67442325594;32572.511412328833;32669.836650816593;32867.53208071711;32913.83543082317;1022.5500779657076;1065.6643157405547;1078.9136869050458;1160.6808127764764;1173.5892437646755;15942.20288985546;16665.583360415843;16957.067361295;17144.657106857794;17175.31298748061;565945;566452;569073;570316;570998;56948;57103.71448142733;57189.71405143031;57368.71315643395;57373.426265737646;1271.5168236070233;1319.3864852843283;1323.4970711129708;1336.2850874782139;1341.53716967646;29901.700982990762;31415.528767068055;31767.205819854687;31810.522842156923;32272.677273226967;49567;49602.503974959785;49690;49799.253011204135;49846.25230621471;471518;472728;473162;473504;475682;27298.727012729618;27604.861975689993;27879.860600696866;28049.859750701115;28126.43747125005;46007.30989035234;46435.303470447296;47212.7639361801;47533.28700069571;47588.28617570808;38954;39149.148898942;39730.80807575777;40091;41199.794001029804;35051;35773;35894.461583075754;36016.63983360133;36185.63814361823;34120;39034.804825976826;40779;41353;44065.339019915365;33031.33937321192;36032.63967360293;36129.27741445104;36264;36550.4517432244;27967.44065118727;28355.14934551967;28443.573346400233;28466.288342791595;28553.28616784597 22:46:40 INFO - PROCESS | 16134 | |2;jquery.html;396.4034128636402;398.6213097557321;403.80415498483234;405.9330210515264;422.45081394187565;16095.275712592933;16170.353185872551;18056.638867222664;19575.314863979762;19714.90142549287;18413.447596572125;18729.625407491843;18772.906135469337;18843.340483083095;19005.334813281537;5146.691198528081;5198.740062996844;5264.315638966929;5305.946940530584;5416.647917885344;5237.973810130963;5296.3379577552805;5322.148456247001;5326.520613144816;5332.413434522199;5591.9720401397935;5890.352061273256;5918.644881307136;5989.88020239595;5990.790322338719;5832.912506312408;5937.970310148422;5974.5220382369525;5979.372165922559;6004.279486461631;5761.423857614247;5769.163471296639;5774.538036957033;5784.566157538202;5787.855303617401;13527.188368697909;13909.58271251864;13973.580792576238;14031.929840350835;14047.22740249286;2083.874967501955;2229.3980625231097;2311.433698743802;2397.1490121006964;2687.0058078511074;9945.086346129954;10167.135793457492;10666.306690065121;10720.463976801208;11523.250988685708;1891.4703882912806;1986.5629561496448;2049.6515592349188;2064.3910046536157;2098.223657246813;79170;82162;83315.16684833134;83645.58177209136;86094;10728.463576821128;11104.61133860311;11119.888801112047;11318.26431281964;11516.1362897783;15699.136547489998;15702.293396797171;15718.449854255046;15734.370625175094;15738.606534836721;7610.657520411595;7861.803454913673;7872.763817085496;7993.280604745484;8137;7354.926450735424;7365.668544915492;7613.6573854176695;7622.9237707622215;7671.923280767232;4597.551771192064;4726;4860.975695121572;4891.290762839369;4976.875578110504;2007.789182135884;2008.7890771468785;2051.0975170924744;2054.41449186981;2088.2691058129535;920.8388532006873;930.9767255818658;993.821112199811;1032.2722480651123;1043.4052590023766;18490.59622249126;19545.511362216057;19695.704564431544;19878.148131487982;19886.801131988494;952.8094381123803;980.926430517714;985.9950700246453;1014.5333146752429;1018.5823812237095;10274.126699230648;10841.620543280947;10882.075023622923;10984.890151098387;11004.779904401867;483240;484062;490174;491028;495311;71125;92009;92161;93602.53198733962;93882;936.6862101196176;969.9806003880024;985.7289245457556;989.0307498651362;992.2855544008303;16623.25195366187;16886.324547018474;17361.045142517283;17525.86081904672;17838.28646854111;41829.79085104555;41859.37210941899;42585;42724;42922;57197.42802571921;58493.70753146207;58960.115598266915;59438.70280648742;60255.39744602498;8127.187281272062;8199.42604017713;8271.710490132817;8391.832163356577;8557.144285571392;11747.29516229029;12576.182548134342;12586.307753073303;12593;12780.744385112432;10807.189460790314;11049.39228342449;11057.11543076568;11267.436628168723;11514.53941842317;10985.395803230898;11029.503672334604;11225.15811314171;11363.943180284376;11766.88233117658;10289.228307876789;10330.896691033295;11216.102711782874;11310;11999;7381.224971377928;7529.322360987538;7803;7824.569648669378;9068.954655226946;10999.560017599206;11458.484368203617;11686.415679216176;11772.058235341323;11801.819818018474 22:46:40 INFO - PROCESS | 16134 | |3;mootools.html;1502.053706165116;1502.97745533817;1669.9248533815978;1743.0413272700011;1797.3195062616446;8136.715214967478;8406.495610263388;8771.956140219298;9438.480883551394;9465.763355916106;8773.868391974125;9101.59042843072;9117.133872282138;9370.48462334573;9394.154526092667;2420.624803155505;2441.9877900610472;2444.9511009779794;2447.21689059501;2449.8162637802147;2376.809855211579;2382.1424287256573;2428.405040765015;2445.7187423446353;2451.5832308507597;2383.0467812874817;2383.6901202843605;2388.856668599881;2416.1301931304715;2420.8910599022997;2340.8478448900937;2390.9043638254448;2399.904003839853;2400.735919048912;2407.5666380051584;2326.2090889097617;2331.25399872041;2336.9649455258186;2345.5895218336723;2356.7171939367213;9146.131117543822;9329.860052099224;9384.5307734613;9400.670976515858;9471.337006409554;5549.778008879681;5662.292213473316;5689.260396148516;5693.316801983747;5700.458456446631;3683.907902302437;3691.6123807000417;3779.0174554615724;3779.981100094482;3816.2939856126704;1190.9940450297693;1201.7716633839543;1204.2232759869835;1208.1844754790482;1223.816427535868;12892.613221603367;13008.479660813557;13062.804057939044;13083.149595276276;13084.280364579945;4646.210144275481;4673.890564204692;4727.361806156125;4780.569748722632;4891.902161956741;9961.900380996241;10034.698959031095;10034.849477257847;10036.849447258297;10046.799064018678;5247.239150323258;5271.604629652791;5297.602679799031;5310.123829568078;5316.6544174628525;4942;4989.3264409305;5167.354080739908;5190.6366554341585;5261.76322065508;3525.3735966704967;3688.22547265072;3713.962860371362;3767;3780.432935059708;1081.4106312059946;1087.4127970895786;1096.5394534295456;1099.9560017599367;1132.6885106595753;908.7637214324324;914.9634014639473;930.5533343994784;946.6260826973445;962.4562122400961;5747.4252574742195;5788.3343415506915;5979.133025711248;6096.268447786205;6463.159789227464;875.2035647560816;917.2570218123342;1040.0743338428804;1072.9678109656722;1093.3112139352315;3930.155016671429;4151.27352713274;4160.979195104005;4180.581941805795;4253.893987563256;11370;11606.30362178272;11696.766064678659;11713;11744.29534227949;11563.88436115628;11564.248323858923;11600.6519804406;11601.07191424684;11654.417279136009;8117.634706438224;8519.892413986267;8564.559100656283;8699.913000870038;8707.608157632922;6340;6400.263969643551;6418.261899881387;6461.6123032616315;6470.22357317125;9972.351797133164;10632.574697012033;10660;10705.678829635124;10711.357318560911;10587.788244235226;10622.256442048982;10675.786484270426;10782.514786834769;10790.136789057013;6795.830104247433;7600.239976002355;7660.157382688011;7821.178776228414;7828.530288182727;8720.520371379635;8837.690680826141;8857.114288571349;8860.202581767671;8878;7530.28462296081;7638.274363935418;7837.843243135219;7943.205679432011;8246.505209687199;7719;7901.17037711032;7956.880646790419;7994.40041996841;8009.3192078673965;7108.218096009331;7108.46686498525;7183.640817959185;7208.207097219197;7216.819579510344;5208.583313335;5255.579553635624;5319.3084898964435;5343.332083489564;5462.20797984298;5169.948300517097;5308.814191503279;5350.277712508917;5375.784968601369;5447.618666693294 22:46:40 INFO - PROCESS | 16134 | |4;prototype.html;328.07810053748955;333.8798032708225;338.71886334342497;344.55896452540725;345.3369530501437;5421.159720243369;5569.415211402805;5594.74823632937;5636.267285252917;5654.830355089349;5251.737413129338;5410.513053825155;5420.83737487875;5439.3200849893765;5501.642393244436;4259.659227261827;4278.65770738341;4282.571742825724;4294.141171765644;4340.7395556266565;4199.601037901394;4274.807633656493;4312.525622181557;4347.500037495697;4354.433923589945;4238.660907127422;4256.340267258564;4264;4269.359596060584;4282.8715138545895;4256.2764330063965;4258.957410425887;4261.318189089746;4303.978480107611;4337.306031035019;3694.242680250542;3826.1199924017355;3829.310724069694;3829.5978922213044;3845.8461661533506;5312.840614781563;5334.972710370073;5353.330833645794;5360.785568577252;5375.247465354853;4924.261360795874;4930.630202734774;4930.926036109461;4939.456659767423;4965;5514.862128446781;5721.599488035839;5727.770889164429;5770.163326317703;5778.27771528559;4160.979195104005;4168.458100446953;4172.70791044627;4177.310743727281;4188.643965262956;6018.729157187893;6019.398060193946;6034.6982650867285;6037.245344331958;6053.273607167124;3979.621935916083;4222.662187025031;4272.46594175728;4272.871813845528;4278.0374415756205;4212.768297743653;4229.175310814362;4258.723182993095;4261.893452663709;4288.270993931039;4882.876938304139;4905.656604037755;4945.774401519331;4949.65352425334;4951.430585482715;5635.408282130317;5782.739776710058;5892.292924849045;5895.906953031697;5901.232839730894;1437.5040610989192;1459.2849503743303;1479.748442764711;1490.6944076464515;1491.209658880795;902.7156445719577;927.3276874266238;946.6970569417721;957.8419560772534;961.4711908450324;4845.854624361275;4879.951200488021;4964.90070198594;4966.448988972829;4983.327250821093;5207.739613019334;5222.294990176353;5234.659747116425;5252.868678282997;5255.290535777697;4709.846087708464;4887.167312257903;4889.828855990023;4976.776045077981;5002.023795841468;2755.781595815348;2755.9448811023667;2758.3379988802944;2760.5997130415976;2778.583212518098;5429.809956651498;5431.782728690808;5434;5464.316960379952;5535.308086489189;5350.946490535122;5371.811986580451;5747.453991870766;6153.538484613672;6197.287311959092;6223.782167624202;6272.529560282997;6292.2134733158355;6301.52738544611;6307.653079080603;5910.852228694317;6020.969895150672;6063.363346848518;6084.3797940225495;6124.908126378197;5914.3439836845755;5954;5960.331107289966;5976.372480889444;6007.309159446545;6285.2457705075685;6308.959021761358;6315.715792789428;6315.757905943324;6317.494600431863;4267.893302667459;4331.870043898688;4348.391225228534;4353.3687615294975;4354.346847972829;5805.187273781589;5966.880662386641;5974.998375544242;5978;6023.216981792339;5876.706164691834;5932.13983972313;5936.940630593812;5937.168796368598;5938.524918006636;5800.390958949419;5832.854178645398;5862.267216597926;5887.882242355215;5944.197533332945;5581.6371935824045;5764.884702306014;5788.494991302376;5788.9131663024245;5802.912956305574;5877.970610146922;5954.166416701752;5967.552433567413;5978.923793717173;5981.910271346021;5610.410906854885;5739.827805165852;5754.338251101177;5781.364049954417;5786.826395208151 22:46:40 INFO - PROCESS | 16134 | |5;yui.html;552.9198266251396;554.5480433446743;614.8697486063942;687.1180264222697;719.3274288540215;15346.386144554219;16755.1622418879;16814.32742690291;16932.153392330365;16973.57566060849;14882.85117148831;15411.845881541181;15549.378024879019;15576.766348504752;15624.2969066392;805.5368163306093;808.6644042722263;809.0776514773163;809.7611204694629;810.9026916769966;800.4756884240832;811.0227176252602;828.4201059258513;830.1076342931343;838.3795990966671;842.086336325088;845.6363763581658;846.5090247656344;848.4145939301893;849.7068511363569;837.5184269045324;844.2401838345477;845.4082142500213;845.7970087179064;845.9323254139654;617.3456136495329;618.7834258009706;618.9783357582463;619.3249358199585;620.8385819686869;15582.688346233124;15583.610409739735;15712.29294681742;15727.921360393239;15742.68514629701;13157.144785588906;13463.798043029363;13514.662133446742;13568.728625427535;13909.30453477322;11285.379304138269;11436.37099959502;11522.827157592643;11529.135314851419;11606.94196529012;3799.5820459749407;3809.6190380961957;3815.04623844039;3867.0719027433493;3994.6404823565726;78357;79167.6041619794;79743.6012819938;80862.99999999942;82314;10024.298299118991;10283.280170388001;10427.217958653131;10484.370937743759;10652.84020739674;21661.891690541448;21772;21778.237761678265;21830;21882.12471501154;7672.616369181518;7760.883586746203;7811.68753249875;7939.722109726247;8036.116027236999;4367.737935723867;4368.22264164026;4394.362817391524;4420.624246939046;4536.886577835515;3463.0822831949554;3529;3562.786232825987;3573.3210689968823;3574.821258937043;610.0513701194596;610.1457958857635;612.1093808508609;622.8380621038563;636.5448704176536;515.409855715204;550.7026205848877;597.7519329478305;631.905214217871;649.912261844645;9373.250139988784;9510.33427660071;9538.284628652878;9556;9587.616495340108;581.4360070731384;612.552836429409;624.4910398025595;627.7300760672863;668.7124536449373;4342.1532801103485;4411.360352748898;4432.091421258634;4473.977630111894;4536.115457485758;113117.43441282741;128989;133488;134232.32883835517;137530;109159.45420272848;110030;112063.43968280106;114080.42959785149;114834;66330;99566;100027.49986250022;100667.49666251622;101305.99999999853;8156.225158609923;8479.872801907853;8535.95732021336;8575.828483430172;8794.29645628361;52879.73560132175;53580.46419535755;54086.72956635192;54146;54769.72615136899;47149.05701886012;47231;66288;82414.17585824305;83156;10757.569697212337;10858.185636077167;11021.779564408507;11028.22802403856;11437.714057148638;12030.15788894769;12378.690532736393;12499.93750031244;12510.499580016698;12612.936935315265;11655.417229138679;11661.300321980709;11758.941205293919;11777;12389.442475088463;10550.788984220118;10711.143108551452;10714.839277410689;10751.086157676686;10953.452327383759;11013.2841365311;11139.164562657996;11542.538298468304;11555.88444115548;12038.699032524257;8947.373683842068;9616.423014619146;9865.112139907444;9897.455639939872;10050.69847904564;8673.869891951752;9786.363886347364;10212.693619191436;10234.385936843813;10300.124489418184 22:46:40 INFO - PROCESS | 16134 | __end_tp_report 22:46:40 INFO - PROCESS | 16134 | __start_cc_report 22:46:40 INFO - PROCESS | 16134 | _x_x_mozilla_cycle_collect,282 22:46:40 INFO - PROCESS | 16134 | __end_cc_report 22:46:40 INFO - PROCESS | 16134 | __startTimestamp1474609600624__endTimestamp 22:46:40 INFO - PROCESS | 16134 | 22:46:40 INFO - PROCESS | 16134 | ------- Summary: start ------- 22:46:40 INFO - PROCESS | 16134 | Number of tests: 6 22:46:40 INFO - PROCESS | 16134 | 22:46:40 INFO - PROCESS | 16134 | [#0] dojo.html Cycles:165 Average:5502.81 Median:5696.77 stddev:642.48 (11.3%) stddev-sans-first:615.55 22:46:40 INFO - PROCESS | 16134 | Values: 3074.2 3086.2 3106.0 3115.0 3119.6 5411.4 5547.2 5618.2 5650.7 5663.0 5467.2 5498.1 5502.6 5568.4 5612.4 4945.5 4983.3 5023.1 5050.7 5111.7 4993.3 5052.0 5113.8 5132.8 5148.0 4829.4 5090.4 5121.9 5132.9 5137.2 4845.4 4937.2 4946.2 4991.1 5080.8 4957.3 4963.6 4964.6 4984.9 4997.7 5511.7 5538.9 5543.9 5557.7 5558.7 5703.5 5780.5 5828.4 5928.7 5929.9 6018.1 6023.0 6023.2 6031.0 6075.5 5604.1 5606.0 5611.7 5612.5 5619.8 5847.6 5899.4 5920.9 5970.6 6074.1 5767.4 5825.7 5828.7 5885.7 5905.4 5859.0 5903.6 5909.5 5913.1 5924.5 5639.4 5702.8 5889.7 5917.5 5919.9 5822.7 5825.1 5844.2 5921.1 5924.9 4497.1 4538.8 4539.5 4546.3 4582.0 3998.3 4001.7 4012.1 4035.1 4035.8 5669.1 5684.9 5685.7 5690.5 5696.8 5980.5 5990.0 6019.6 6024.1 6043.6 5498.7 5535.9 5586.3 5633.3 5656.4 5178.7 5184.3 5184.9 5188.3 5224.7 6175.1 6178.4 6181.5 6182.1 6188.3 5775.0 5828.3 5907.8 5934.0 5954.9 6254.2 6255.2 6260.2 6288.1 6291.1 5829.4 5829.7 5844.3 5874.7 5960.4 5790.0 5867.7 5917.2 6004.6 6016.9 5798.3 5811.0 5832.8 5874.5 5890.1 5792.6 5794.1 5795.1 5812.8 5825.7 5506.1 5518.2 5588.9 5589.4 5631.3 5751.2 5844.1 5847.5 5865.9 5925.3 5614.8 5691.5 5701.6 5702.4 5703.3 22:46:40 INFO - PROCESS | 16134 | 22:46:40 INFO - PROCESS | 16134 | [#1] ext.html Cycles:180 Average:60770.99 Median:41276.40 stddev:126700.00 (307.0%) stddev-sans-first:126974.75 22:46:40 INFO - PROCESS | 16134 | Values: 547.9 571.9 574.1 592.1 605.5 41890.8 43930.0 43994.6 45884.8 46477.0 44727.0 45010.5 45161.8 45177.3 45186.0 8813.6 8956.1 8956.6 8971.5 8987.2 8684.3 8754.0 8771.2 8797.6 8801.3 8777.3 8785.9 8813.4 8833.7 8881.1 8740.0 8769.6 8802.6 8858.6 8902.8 8853.0 8923.0 8934.9 8964.5 8970.5 42632.6 42780.6 42988.1 43065.0 43085.8 3045.8 3055.9 3108.9 3232.2 3339.3 31147.8 31631.4 31712.4 31829.7 31888.8 4321.0 4435.9 4446.4 4462.8 4546.0 359292.0 361231.0 363122.0 363264.0 364753.0 34719.0 54963.7 55223.7 55495.0 55508.2 31657.1 33214.5 33281.8 33304.2 33334.8 13538.3 13591.6 13609.0 13685.2 13729.4 11866.8 11896.2 11947.3 11986.0 12009.2 8452.0 8500.4 8547.6 8630.5 8640.3 3323.6 3384.5 3387.1 3395.2 3424.7 931.0 976.7 992.0 1003.6 1053.2 32557.7 32572.5 32669.8 32867.5 32913.8 1022.6 1065.7 1078.9 1160.7 1173.6 15942.2 16665.6 16957.1 17144.7 17175.3 565945.0 566452.0 569073.0 570316.0 570998.0 56948.0 57103.7 57189.7 57368.7 57373.4 1271.5 1319.4 1323.5 1336.3 1341.5 29901.7 31415.5 31767.2 31810.5 32272.7 49567.0 49602.5 49690.0 49799.3 49846.3 471518.0 472728.0 473162.0 473504.0 475682.0 27298.7 27604.9 27879.9 28049.9 28126.4 46007.3 46435.3 47212.8 47533.3 47588.3 38954.0 39149.1 39730.8 40091.0 41199.8 35051.0 35773.0 35894.5 36016.6 36185.6 34120.0 39034.8 40779.0 41353.0 44065.3 33031.3 36032.6 36129.3 36264.0 36550.5 27967.4 28355.1 28443.6 28466.3 28553.3 22:46:40 INFO - PROCESS | 16134 | 22:46:40 INFO - PROCESS | 16134 | [#2] jquery.html Cycles:180 Average:28579.89 Median:404.87 stddev:80643.43 (19918.4%) stddev-sans-first:80841.89 22:46:40 INFO - PROCESS | 16134 | Values: 396.4 398.6 403.8 405.9 422.5 16095.3 16170.4 18056.6 19575.3 19714.9 18413.4 18729.6 18772.9 18843.3 19005.3 5146.7 5198.7 5264.3 5305.9 5416.6 5238.0 5296.3 5322.1 5326.5 5332.4 5592.0 5890.4 5918.6 5989.9 5990.8 5832.9 5938.0 5974.5 5979.4 6004.3 5761.4 5769.2 5774.5 5784.6 5787.9 13527.2 13909.6 13973.6 14031.9 14047.2 2083.9 2229.4 2311.4 2397.1 2687.0 9945.1 10167.1 10666.3 10720.5 11523.3 1891.5 1986.6 2049.7 2064.4 2098.2 79170.0 82162.0 83315.2 83645.6 86094.0 10728.5 11104.6 11119.9 11318.3 11516.1 15699.1 15702.3 15718.4 15734.4 15738.6 7610.7 7861.8 7872.8 7993.3 8137.0 7354.9 7365.7 7613.7 7622.9 7671.9 4597.6 4726.0 4861.0 4891.3 4976.9 2007.8 2008.8 2051.1 2054.4 2088.3 920.8 931.0 993.8 1032.3 1043.4 18490.6 19545.5 19695.7 19878.1 19886.8 952.8 980.9 986.0 1014.5 1018.6 10274.1 10841.6 10882.1 10984.9 11004.8 483240.0 484062.0 490174.0 491028.0 495311.0 71125.0 92009.0 92161.0 93602.5 93882.0 936.7 970.0 985.7 989.0 992.3 16623.3 16886.3 17361.0 17525.9 17838.3 41829.8 41859.4 42585.0 42724.0 42922.0 57197.4 58493.7 58960.1 59438.7 60255.4 8127.2 8199.4 8271.7 8391.8 8557.1 11747.3 12576.2 12586.3 12593.0 12780.7 10807.2 11049.4 11057.1 11267.4 11514.5 10985.4 11029.5 11225.2 11363.9 11766.9 10289.2 10330.9 11216.1 11310.0 11999.0 7381.2 7529.3 7803.0 7824.6 9069.0 10999.6 11458.5 11686.4 11772.1 11801.8 22:46:40 INFO - PROCESS | 16134 | 22:46:40 INFO - PROCESS | 16134 | [#3] mootools.html Cycles:180 Average:5999.57 Median:4916.95 stddev:3449.19 (70.1%) stddev-sans-first:3442.31 22:46:40 INFO - PROCESS | 16134 | Values: 1502.1 1503.0 1669.9 1743.0 1797.3 8136.7 8406.5 8772.0 9438.5 9465.8 8773.9 9101.6 9117.1 9370.5 9394.2 2420.6 2442.0 2445.0 2447.2 2449.8 2376.8 2382.1 2428.4 2445.7 2451.6 2383.0 2383.7 2388.9 2416.1 2420.9 2340.8 2390.9 2399.9 2400.7 2407.6 2326.2 2331.3 2337.0 2345.6 2356.7 9146.1 9329.9 9384.5 9400.7 9471.3 5549.8 5662.3 5689.3 5693.3 5700.5 3683.9 3691.6 3779.0 3780.0 3816.3 1191.0 1201.8 1204.2 1208.2 1223.8 12892.6 13008.5 13062.8 13083.1 13084.3 4646.2 4673.9 4727.4 4780.6 4891.9 9961.9 10034.7 10034.8 10036.8 10046.8 5247.2 5271.6 5297.6 5310.1 5316.7 4942.0 4989.3 5167.4 5190.6 5261.8 3525.4 3688.2 3714.0 3767.0 3780.4 1081.4 1087.4 1096.5 1100.0 1132.7 908.8 915.0 930.6 946.6 962.5 5747.4 5788.3 5979.1 6096.3 6463.2 875.2 917.3 1040.1 1073.0 1093.3 3930.2 4151.3 4161.0 4180.6 4253.9 11370.0 11606.3 11696.8 11713.0 11744.3 11563.9 11564.2 11600.7 11601.1 11654.4 8117.6 8519.9 8564.6 8699.9 8707.6 6340.0 6400.3 6418.3 6461.6 6470.2 9972.4 10632.6 10660.0 10705.7 10711.4 10587.8 10622.3 10675.8 10782.5 10790.1 6795.8 7600.2 7660.2 7821.2 7828.5 8720.5 8837.7 8857.1 8860.2 8878.0 7530.3 7638.3 7837.8 7943.2 8246.5 7719.0 7901.2 7956.9 7994.4 8009.3 7108.2 7108.5 7183.6 7208.2 7216.8 5208.6 5255.6 5319.3 5343.3 5462.2 5169.9 5308.8 5350.3 5375.8 5447.6 22:46:40 INFO - PROCESS | 16134 | 22:46:40 INFO - PROCESS | 16134 | [#4] prototype.html Cycles:180 Average:4811.17 Median:5366.30 stddev:1438.03 (26.8%) stddev-sans-first:1402.14 22:46:40 INFO - PROCESS | 16134 | Values: 328.1 333.9 338.7 344.6 345.3 5421.2 5569.4 5594.7 5636.3 5654.8 5251.7 5410.5 5420.8 5439.3 5501.6 4259.7 4278.7 4282.6 4294.1 4340.7 4199.6 4274.8 4312.5 4347.5 4354.4 4238.7 4256.3 4264.0 4269.4 4282.9 4256.3 4259.0 4261.3 4304.0 4337.3 3694.2 3826.1 3829.3 3829.6 3845.8 5312.8 5335.0 5353.3 5360.8 5375.2 4924.3 4930.6 4930.9 4939.5 4965.0 5514.9 5721.6 5727.8 5770.2 5778.3 4161.0 4168.5 4172.7 4177.3 4188.6 6018.7 6019.4 6034.7 6037.2 6053.3 3979.6 4222.7 4272.5 4272.9 4278.0 4212.8 4229.2 4258.7 4261.9 4288.3 4882.9 4905.7 4945.8 4949.7 4951.4 5635.4 5782.7 5892.3 5895.9 5901.2 1437.5 1459.3 1479.7 1490.7 1491.2 902.7 927.3 946.7 957.8 961.5 4845.9 4880.0 4964.9 4966.4 4983.3 5207.7 5222.3 5234.7 5252.9 5255.3 4709.8 4887.2 4889.8 4976.8 5002.0 2755.8 2755.9 2758.3 2760.6 2778.6 5429.8 5431.8 5434.0 5464.3 5535.3 5350.9 5371.8 5747.5 6153.5 6197.3 6223.8 6272.5 6292.2 6301.5 6307.7 5910.9 6021.0 6063.4 6084.4 6124.9 5914.3 5954.0 5960.3 5976.4 6007.3 6285.2 6309.0 6315.7 6315.8 6317.5 4267.9 4331.9 4348.4 4353.4 4354.3 5805.2 5966.9 5975.0 5978.0 6023.2 5876.7 5932.1 5936.9 5937.2 5938.5 5800.4 5832.9 5862.3 5887.9 5944.2 5581.6 5764.9 5788.5 5788.9 5802.9 5878.0 5954.2 5967.6 5978.9 5981.9 5610.4 5739.8 5754.3 5781.4 5786.8 22:46:40 INFO - PROCESS | 16134 | 22:46:40 INFO - PROCESS | 16134 | [#5] yui.html Cycles:180 Average:21239.38 Median:4402.86 stddev:32892.51 (747.1%) stddev-sans-first:32948.11 22:46:40 INFO - PROCESS | 16134 | Values: 552.9 554.5 614.9 687.1 719.3 15346.4 16755.2 16814.3 16932.2 16973.6 14882.9 15411.8 15549.4 15576.8 15624.3 805.5 808.7 809.1 809.8 810.9 800.5 811.0 828.4 830.1 838.4 842.1 845.6 846.5 848.4 849.7 837.5 844.2 845.4 845.8 845.9 617.3 618.8 619.0 619.3 620.8 15582.7 15583.6 15712.3 15727.9 15742.7 13157.1 13463.8 13514.7 13568.7 13909.3 11285.4 11436.4 11522.8 11529.1 11606.9 3799.6 3809.6 3815.0 3867.1 3994.6 78357.0 79167.6 79743.6 80863.0 82314.0 10024.3 10283.3 10427.2 10484.4 10652.8 21661.9 21772.0 21778.2 21830.0 21882.1 7672.6 7760.9 7811.7 7939.7 8036.1 4367.7 4368.2 4394.4 4420.6 4536.9 3463.1 3529.0 3562.8 3573.3 3574.8 610.1 610.1 612.1 622.8 636.5 515.4 550.7 597.8 631.9 649.9 9373.3 9510.3 9538.3 9556.0 9587.6 581.4 612.6 624.5 627.7 668.7 4342.2 4411.4 4432.1 4474.0 4536.1 113117.4 128989.0 133488.0 134232.3 137530.0 109159.5 110030.0 112063.4 114080.4 114834.0 66330.0 99566.0 100027.5 100667.5 101306.0 8156.2 8479.9 8536.0 8575.8 8794.3 52879.7 53580.5 54086.7 54146.0 54769.7 47149.1 47231.0 66288.0 82414.2 83156.0 10757.6 10858.2 11021.8 11028.2 11437.7 12030.2 12378.7 12499.9 12510.5 12612.9 11655.4 11661.3 11758.9 11777.0 12389.4 10550.8 10711.1 10714.8 10751.1 10953.5 11013.3 11139.2 11542.5 11555.9 12038.7 8947.4 9616.4 9865.1 9897.5 10050.7 8673.9 9786.4 10212.7 10234.4 10300.1 22:46:40 INFO - PROCESS | 16134 | -------- Summary: end -------- 22:46:40 INFO - PROCESS | 16134 | 22:46:41 INFO - TEST-INFO | 16134: exit 0 22:46:41 INFO - TEST-OK | dromaeo_css | took 1114278ms 22:46:41 INFO - TEST-START | kraken 22:46:41 INFO - operating with platform_type : linux_ 22:46:41 INFO - Initialising browser for kraken test... 22:46:41 INFO - TEST-INFO | started process 16493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpryshnZ/profile http://localhost:41867/getInfo.html) 22:46:45 INFO - PROCESS | 16493 | __metrics Screen width/height:1600/1200 22:46:45 INFO - PROCESS | 16493 | colorDepth:24 22:46:45 INFO - PROCESS | 16493 | Browser inner width/height: 1024/697 22:46:45 INFO - PROCESS | 16493 | __metrics 22:46:46 ERROR - PROCESS | 16493 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 22:46:47 INFO - TEST-INFO | 16493: exit 0 22:46:47 INFO - Browser initialized. 22:46:47 INFO - Running cycle 1/1 for kraken test... 22:46:47 INFO - TEST-INFO | started process 16613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpryshnZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:46:59 INFO - PROCESS | 16613 | RSS: Main: 180998144 22:46:59 INFO - PROCESS | 16613 | 22:47:02 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41867/tests/kraken/driver.html?testName=audio-beat-detection) 22:47:03 INFO - PROCESS | 16613 | RSS: Main: 194580480 22:47:03 INFO - PROCESS | 16613 | 22:47:05 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41867/tests/kraken/driver.html?testName=audio-dft) 22:47:06 INFO - PROCESS | 16613 | RSS: Main: 192552960 22:47:06 INFO - PROCESS | 16613 | 22:47:09 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41867/tests/kraken/driver.html?testName=audio-fft) 22:47:10 INFO - PROCESS | 16613 | RSS: Main: 187633664 22:47:10 INFO - PROCESS | 16613 | 22:47:12 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41867/tests/kraken/driver.html?testName=audio-oscillator) 22:47:12 INFO - PROCESS | 16613 | RSS: Main: 188493824 22:47:12 INFO - PROCESS | 16613 | 22:47:14 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41867/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:47:15 INFO - PROCESS | 16613 | RSS: Main: 188485632 22:47:15 INFO - PROCESS | 16613 | 22:47:18 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41867/tests/kraken/driver.html?testName=imaging-darkroom) 22:47:19 INFO - PROCESS | 16613 | RSS: Main: 188829696 22:47:19 INFO - PROCESS | 16613 | 22:47:22 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41867/tests/kraken/driver.html?testName=imaging-desaturate) 22:47:23 INFO - PROCESS | 16613 | RSS: Main: 186777600 22:47:23 INFO - PROCESS | 16613 | 22:47:26 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41867/tests/kraken/driver.html?testName=json-parse-financial) 22:47:26 INFO - PROCESS | 16613 | RSS: Main: 187817984 22:47:26 INFO - PROCESS | 16613 | 22:47:28 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41867/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:47:29 INFO - PROCESS | 16613 | RSS: Main: 188129280 22:47:29 INFO - PROCESS | 16613 | 22:47:30 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41867/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:47:31 INFO - PROCESS | 16613 | RSS: Main: 188145664 22:47:31 INFO - PROCESS | 16613 | 22:47:33 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41867/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:47:34 INFO - PROCESS | 16613 | RSS: Main: 188592128 22:47:34 INFO - PROCESS | 16613 | 22:47:36 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:47:37 INFO - PROCESS | 16613 | RSS: Main: 188628992 22:47:37 INFO - PROCESS | 16613 | 22:47:40 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:47:40 INFO - PROCESS | 16613 | RSS: Main: 188551168 22:47:40 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | Cycle 1(1): loaded http://localhost:41867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41867/tests/kraken/driver.html?testName=ai-astar) 22:47:42 INFO - PROCESS | 16613 | RSS: Main: 190107648 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | __start_tp_report 22:47:42 INFO - PROCESS | 16613 | _x_x_mozilla_page_load 22:47:42 INFO - PROCESS | 16613 | _x_x_mozilla_page_load_details 22:47:42 INFO - PROCESS | 16613 | |i|pagename|runs| 22:47:42 INFO - PROCESS | 16613 | |0;ai-astar;103;111;111;111;112;112;111;110;112;110 22:47:42 INFO - PROCESS | 16613 | |1;audio-beat-detection;158;126;127;173;126;121;121;121;153;120 22:47:42 INFO - PROCESS | 16613 | |2;audio-dft;165;163;166;172;162;163;163;164;163;163 22:47:42 INFO - PROCESS | 16613 | |3;audio-fft;75;76;77;117;77;76;76;76;100;76 22:47:42 INFO - PROCESS | 16613 | |4;audio-oscillator;84;84;105;83;84;84;105;82;82;111 22:47:42 INFO - PROCESS | 16613 | |5;imaging-gaussian-blur;119;119;119;118;118;117;118;118;117;119 22:47:42 INFO - PROCESS | 16613 | |6;imaging-darkroom;147;149;147;147;146;147;147;148;146;148 22:47:42 INFO - PROCESS | 16613 | |7;imaging-desaturate;96;97;97;96;96;96;96;96;97;96 22:47:42 INFO - PROCESS | 16613 | |8;json-parse-financial;53;53;54;55;54;55;54;54;54;55 22:47:42 INFO - PROCESS | 16613 | |9;json-stringify-tinderbox;58;60;59;60;60;59;60;60;65;60 22:47:42 INFO - PROCESS | 16613 | |10;stanford-crypto-aes;80;80;80;79;80;80;80;85;80;78 22:47:42 INFO - PROCESS | 16613 | |11;stanford-crypto-ccm;145;143;129;137;136;139;140;128;167;126 22:47:42 INFO - PROCESS | 16613 | |12;stanford-crypto-pbkdf2;171;170;169;168;178;169;171;171;167;166 22:47:42 INFO - PROCESS | 16613 | |13;stanford-crypto-sha256-iterative;69;67;66;68;67;67;67;65;66;65 22:47:42 INFO - PROCESS | 16613 | __end_tp_report 22:47:42 INFO - PROCESS | 16613 | __start_cc_report 22:47:42 INFO - PROCESS | 16613 | _x_x_mozilla_cycle_collect,702 22:47:42 INFO - PROCESS | 16613 | __end_cc_report 22:47:42 INFO - PROCESS | 16613 | __startTimestamp1474609662933__endTimestamp 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | ------- Summary: start ------- 22:47:42 INFO - PROCESS | 16613 | Number of tests: 14 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:0.78 22:47:42 INFO - PROCESS | 16613 | Values: 103.0 111.0 111.0 111.0 112.0 112.0 111.0 110.0 112.0 110.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:126.50 stddev:19.25 (15.2%) stddev-sans-first:18.46 22:47:42 INFO - PROCESS | 16613 | Values: 158.0 126.0 127.0 173.0 126.0 121.0 121.0 121.0 153.0 120.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:2.91 (1.8%) stddev-sans-first:3.08 22:47:42 INFO - PROCESS | 16613 | Values: 165.0 163.0 166.0 172.0 162.0 163.0 163.0 164.0 163.0 163.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:14.24 (18.7%) stddev-sans-first:14.83 22:47:42 INFO - PROCESS | 16613 | Values: 75.0 76.0 77.0 117.0 77.0 76.0 76.0 76.0 100.0 76.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.50 stddev:11.60 (13.9%) stddev-sans-first:12.07 22:47:42 INFO - PROCESS | 16613 | Values: 84.0 84.0 105.0 83.0 84.0 84.0 105.0 82.0 82.0 111.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 22:47:42 INFO - PROCESS | 16613 | Values: 119.0 119.0 119.0 118.0 118.0 117.0 118.0 118.0 117.0 119.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 22:47:42 INFO - PROCESS | 16613 | Values: 147.0 149.0 147.0 147.0 146.0 147.0 147.0 148.0 146.0 148.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:47:42 INFO - PROCESS | 16613 | Values: 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 22:47:42 INFO - PROCESS | 16613 | Values: 53.0 53.0 54.0 55.0 54.0 55.0 54.0 54.0 54.0 55.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.85 (3.1%) stddev-sans-first:1.80 22:47:42 INFO - PROCESS | 16613 | Values: 58.0 60.0 59.0 60.0 60.0 59.0 60.0 60.0 65.0 60.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:1.81 (2.3%) stddev-sans-first:1.92 22:47:42 INFO - PROCESS | 16613 | Values: 80.0 80.0 80.0 79.0 80.0 80.0 80.0 85.0 80.0 78.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:139.50 stddev:11.74 (8.4%) stddev-sans-first:12.25 22:47:42 INFO - PROCESS | 16613 | Values: 145.0 143.0 129.0 137.0 136.0 139.0 140.0 128.0 167.0 126.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:170.50 stddev:3.30 (1.9%) stddev-sans-first:3.48 22:47:42 INFO - PROCESS | 16613 | Values: 171.0 170.0 169.0 168.0 178.0 169.0 171.0 171.0 167.0 166.0 22:47:42 INFO - PROCESS | 16613 | 22:47:42 INFO - PROCESS | 16613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.01 22:47:42 INFO - PROCESS | 16613 | Values: 69.0 67.0 66.0 68.0 67.0 67.0 67.0 65.0 66.0 65.0 22:47:42 INFO - PROCESS | 16613 | -------- Summary: end -------- 22:47:42 INFO - PROCESS | 16613 | 22:47:43 INFO - PROCESS | 16613 | 22:47:43 INFO - PROCESS | 16613 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 22:47:43 INFO - PROCESS | 16613 | 22:47:43 INFO - PROCESS | 16613 | 22:47:43 INFO - PROCESS | 16613 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 22:47:43 INFO - PROCESS | 16613 | 22:47:43 INFO - PROCESS | 16613 | 22:47:43 INFO - PROCESS | 16613 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 22:47:43 INFO - PROCESS | 16613 | 22:47:43 INFO - PROCESS | 16613 | 22:47:43 INFO - PROCESS | 16613 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 22:47:43 INFO - PROCESS | 16613 | 22:47:43 INFO - PROCESS | 16613 | 22:47:43 INFO - PROCESS | 16613 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 22:47:43 INFO - PROCESS | 16613 | 22:47:44 INFO - TEST-INFO | 16613: exit 0 22:47:44 INFO - TEST-OK | kraken | took 62458ms 22:47:44 INFO - SUITE-END | took 1176s 22:47:44 INFO - Completed test suite (00:19:37) 22:47:44 INFO - javascript benchmark 22:47:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7175.600172803865, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.2007078159677, 3086.1975886269593, 3105.9844700776507, 3115.0343393548, 3119.563261143439, 5411.377691565471, 5547.223388725577, 5618.185363122345, 5650.660960342378, 5663.008973429643, 5467.20725494803, 5498.0653288940875, 5502.58730595205, 5568.443155684429, 5612.354579223391, 4945.505449455061, 4983.252512123175, 5023.14606516893, 5050.671706339094, 5111.667741596803, 4993.325901003373, 5052.040112378636, 5113.769880355374, 5132.820351287705, 5148.0, 4829.396325459317, 5090.363704536933, 5121.871953201181, 5132.897342053138, 5137.152369858969, 4845.370101886732, 4937.21004639256, 4946.183879659852, 4991.07665081961, 5080.847574572732, 4957.3059771632, 4963.60291176705, 4964.6276529260085, 4984.850454486371, 4997.725125118117, 5511.669299842022, 5538.861528461781, 5543.8891222175735, 5557.666540007613, 5558.722063896789, 5703.458171473703, 5780.468175933381, 5828.41715828418, 5928.733207005652, 5929.851753706149, 6018.067199584071, 6022.96988515059, 6023.156758053876, 6030.969845150747, 6075.483583895374, 5604.131359639263, 5606.018946684314, 5611.691356975365, 5612.466815652507, 5619.803306884281, 5847.619904706181, 5899.351071382144, 5920.881582368328, 5970.611910225822, 6074.058520929263, 5767.36558978512, 5825.650460972355, 5828.708564571754, 5885.676287804126, 5905.40945905406, 5859.0, 5903.586748927534, 5909.497692696169, 5913.142594323799, 5924.526037916957, 5639.351474580394, 5702.800401985911, 5889.734961926723, 5917.52659787216, 5919.940800591939, 5822.737976791054, 5825.126231065289, 5844.240248767718, 5921.14143449206, 5924.881502369928, 4497.145542346943, 4538.818447262072, 4539.546045395434, 4546.340780586796, 4582.0, 3998.260321840469, 4001.7398869073418, 4012.0972781124597, 4035.0921042765144, 4035.8183881725395, 5669.121286200563, 5684.857878553069, 5685.744141513642, 5690.459406356389, 5696.772129114789, 5980.521558275327, 5989.970050149721, 6019.578629495981, 6024.0662697282, 6043.576949613484, 5498.670079795225, 5535.861603459865, 5586.301712285965, 5633.324001119892, 5656.434356564393, 5178.689278643294, 5184.300119483897, 5184.870378240575, 5188.299579556787, 5224.660397074178, 6175.073738939105, 6178.351273116438, 6181.505479561624, 6182.072689096672, 6188.319284878659, 5774.971125144348, 5828.329742079545, 5907.822765317047, 5934.0, 5954.851128721816, 6254.155688981929, 6255.186825712628, 6260.248770147611, 6288.088227207121, 6291.1192433058495, 5829.387914268941, 5829.737661805144, 5844.26946631671, 5874.722750316782, 5960.374160713236, 5790.0, 5867.735951882261, 5917.201177840936, 6004.639721616542, 6016.87966240664, 5798.304203495608, 5811.0, 5832.766689332379, 5874.471297583238, 5890.087036509348, 5792.594518383673, 5794.072948328248, 5795.1017592273265, 5812.82561523155, 5825.737841797045, 5506.091494903296, 5518.227448157181, 5588.916166257428, 5589.413111623384, 5631.2960879890015, 5751.223584815996, 5844.094165404369, 5847.532197424111, 5865.9441300566305, 5925.348211696623, 5614.775408983758, 5691.459311365414, 5701.629394089371, 5702.401247868914, 5703.258576385043], "value": 5457.598246979563, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.9045663349265, 571.8627529392945, 574.1387918122816, 592.0615823919088, 605.5276884030455, 41890.79054604727, 43930.0, 43994.56005439949, 45884.77057614707, 46477.0, 44727.0, 45010.54989450105, 45161.774191129, 45177.32234016492, 45186.0, 8813.647454101845, 8956.149165829236, 8956.552172391355, 8971.506567138806, 8987.191152796247, 8684.261837743768, 8754.0, 8771.166739159802, 8797.648094076229, 8801.295896328278, 8777.341699372573, 8785.868211976793, 8813.42712723671, 8833.73498795034, 8881.111888811132, 8739.95630021849, 8769.56152192391, 8802.64789408423, 8858.601362938683, 8902.821943561157, 8852.955735221347, 8922.955385223097, 8934.910650893473, 8964.50695211763, 8970.461772293684, 42632.57367426348, 42780.57219427797, 42988.140237195395, 43065.0, 43085.78457107726, 3045.771567132474, 3055.8624861881267, 3108.922276943072, 3232.2404235004756, 3339.3154403347257, 31147.844260778777, 31631.367372652418, 31712.36575268482, 31829.681703182905, 31888.840555797306, 4320.956790432118, 4435.911281774379, 4446.42196514451, 4462.821487140511, 4545.954540454619, 359292.0, 361231.0, 363121.9999999974, 363264.0, 364753.0, 34719.0, 54963.72518137463, 55223.723881380334, 55495.0, 55508.16737748937, 31657.05028849138, 33214.501782473286, 33281.83359083189, 33304.16739581482, 33334.83332583321, 13538.255395953318, 13591.592252232449, 13609.0, 13685.178889266675, 13729.382177802023, 11866.762664746657, 11896.16726829131, 11947.342896140623, 11986.0, 12009.159358844972, 8452.0, 8500.404971651926, 8547.572621368907, 8630.540296015606, 8640.30877529796, 3323.6177839548277, 3384.4584866421255, 3387.1193489692364, 3395.2021275000357, 3424.74314426419, 930.9534523273944, 976.7069879036403, 991.9900800991898, 1003.5534187286587, 1053.2469284461495, 32557.67442325594, 32572.511412328833, 32669.836650816593, 32867.53208071711, 32913.83543082317, 1022.5500779657076, 1065.6643157405547, 1078.9136869050458, 1160.6808127764764, 1173.5892437646755, 15942.20288985546, 16665.583360415843, 16957.067361295, 17144.657106857794, 17175.31298748061, 565945.0, 566452.0, 569073.0, 570316.0, 570998.0, 56948.0, 57103.71448142733, 57189.71405143031, 57368.71315643395, 57373.426265737646, 1271.5168236070233, 1319.3864852843283, 1323.4970711129708, 1336.2850874782139, 1341.53716967646, 29901.700982990762, 31415.528767068055, 31767.205819854687, 31810.522842156923, 32272.677273226967, 49567.0, 49602.503974959785, 49690.0, 49799.253011204135, 49846.25230621471, 471518.0, 472728.0, 473162.0, 473504.0, 475682.0, 27298.727012729618, 27604.861975689993, 27879.860600696866, 28049.859750701115, 28126.43747125005, 46007.30989035234, 46435.303470447296, 47212.7639361801, 47533.28700069571, 47588.28617570808, 38954.0, 39149.148898942, 39730.80807575777, 40091.0, 41199.794001029804, 35051.0, 35773.0, 35894.461583075754, 36016.63983360133, 36185.63814361823, 34120.0, 39034.804825976826, 40779.0, 41353.0, 44065.339019915365, 33031.33937321192, 36032.63967360293, 36129.27741445104, 36264.0, 36550.4517432244, 27967.44065118727, 28355.14934551967, 28443.573346400233, 28466.288342791595, 28553.28616784597], "value": 18587.80928023152, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.4034128636402, 398.6213097557321, 403.80415498483234, 405.9330210515264, 422.45081394187565, 16095.275712592933, 16170.353185872551, 18056.638867222664, 19575.314863979762, 19714.90142549287, 18413.447596572125, 18729.625407491843, 18772.906135469337, 18843.340483083095, 19005.334813281537, 5146.691198528081, 5198.740062996844, 5264.315638966929, 5305.946940530584, 5416.647917885344, 5237.973810130963, 5296.3379577552805, 5322.148456247001, 5326.520613144816, 5332.413434522199, 5591.9720401397935, 5890.352061273256, 5918.644881307136, 5989.88020239595, 5990.790322338719, 5832.912506312408, 5937.970310148422, 5974.5220382369525, 5979.372165922559, 6004.279486461631, 5761.423857614247, 5769.163471296639, 5774.538036957033, 5784.566157538202, 5787.855303617401, 13527.188368697909, 13909.58271251864, 13973.580792576238, 14031.929840350835, 14047.22740249286, 2083.874967501955, 2229.3980625231097, 2311.433698743802, 2397.1490121006964, 2687.0058078511074, 9945.086346129954, 10167.135793457492, 10666.306690065121, 10720.463976801208, 11523.250988685708, 1891.4703882912806, 1986.5629561496448, 2049.6515592349188, 2064.3910046536157, 2098.223657246813, 79170.0, 82162.0, 83315.16684833134, 83645.58177209136, 86094.0, 10728.463576821128, 11104.61133860311, 11119.888801112047, 11318.26431281964, 11516.1362897783, 15699.136547489998, 15702.293396797171, 15718.449854255046, 15734.370625175094, 15738.606534836721, 7610.657520411595, 7861.803454913673, 7872.763817085496, 7993.280604745484, 8137.0, 7354.926450735424, 7365.668544915492, 7613.6573854176695, 7622.9237707622215, 7671.923280767232, 4597.551771192064, 4726.0, 4860.975695121572, 4891.290762839369, 4976.875578110504, 2007.789182135884, 2008.7890771468785, 2051.0975170924744, 2054.41449186981, 2088.2691058129535, 920.8388532006873, 930.9767255818658, 993.821112199811, 1032.2722480651123, 1043.4052590023766, 18490.59622249126, 19545.511362216057, 19695.704564431544, 19878.148131487982, 19886.801131988494, 952.8094381123803, 980.926430517714, 985.9950700246453, 1014.5333146752429, 1018.5823812237095, 10274.126699230648, 10841.620543280947, 10882.075023622923, 10984.890151098387, 11004.779904401867, 483240.0, 484062.0, 490174.0, 491028.0, 495311.0, 71125.0, 92009.0, 92161.0, 93602.53198733962, 93882.0, 936.6862101196176, 969.9806003880024, 985.7289245457556, 989.0307498651362, 992.2855544008303, 16623.25195366187, 16886.324547018474, 17361.045142517283, 17525.86081904672, 17838.28646854111, 41829.79085104555, 41859.37210941899, 42585.0, 42724.0, 42922.0, 57197.42802571921, 58493.70753146207, 58960.115598266915, 59438.70280648742, 60255.39744602498, 8127.187281272062, 8199.42604017713, 8271.710490132817, 8391.832163356577, 8557.144285571392, 11747.29516229029, 12576.182548134342, 12586.307753073303, 12593.0, 12780.744385112432, 10807.189460790314, 11049.39228342449, 11057.11543076568, 11267.436628168723, 11514.53941842317, 10985.395803230898, 11029.503672334604, 11225.15811314171, 11363.943180284376, 11766.88233117658, 10289.228307876789, 10330.896691033295, 11216.102711782874, 11310.0, 11999.0, 7381.224971377928, 7529.322360987538, 7803.0, 7824.569648669378, 9068.954655226946, 10999.560017599206, 11458.484368203617, 11686.415679216176, 11772.058235341323, 11801.819818018474], "value": 8997.42764832094, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.053706165116, 1502.97745533817, 1669.9248533815978, 1743.0413272700011, 1797.3195062616446, 8136.715214967478, 8406.495610263388, 8771.956140219298, 9438.480883551394, 9465.763355916106, 8773.868391974125, 9101.59042843072, 9117.133872282138, 9370.48462334573, 9394.154526092667, 2420.624803155505, 2441.9877900610472, 2444.9511009779794, 2447.21689059501, 2449.8162637802147, 2376.809855211579, 2382.1424287256573, 2428.405040765015, 2445.7187423446353, 2451.5832308507597, 2383.0467812874817, 2383.6901202843605, 2388.856668599881, 2416.1301931304715, 2420.8910599022997, 2340.8478448900937, 2390.9043638254448, 2399.904003839853, 2400.735919048912, 2407.5666380051584, 2326.2090889097617, 2331.25399872041, 2336.9649455258186, 2345.5895218336723, 2356.7171939367213, 9146.131117543822, 9329.860052099224, 9384.5307734613, 9400.670976515858, 9471.337006409554, 5549.778008879681, 5662.292213473316, 5689.260396148516, 5693.316801983747, 5700.458456446631, 3683.907902302437, 3691.6123807000417, 3779.0174554615724, 3779.981100094482, 3816.2939856126704, 1190.9940450297693, 1201.7716633839543, 1204.2232759869835, 1208.1844754790482, 1223.816427535868, 12892.613221603367, 13008.479660813557, 13062.804057939044, 13083.149595276276, 13084.280364579945, 4646.210144275481, 4673.890564204692, 4727.361806156125, 4780.569748722632, 4891.902161956741, 9961.900380996241, 10034.698959031095, 10034.849477257847, 10036.849447258297, 10046.799064018678, 5247.239150323258, 5271.604629652791, 5297.602679799031, 5310.123829568078, 5316.6544174628525, 4942.0, 4989.3264409305, 5167.354080739908, 5190.6366554341585, 5261.76322065508, 3525.3735966704967, 3688.22547265072, 3713.962860371362, 3767.0, 3780.432935059708, 1081.4106312059946, 1087.4127970895786, 1096.5394534295456, 1099.9560017599367, 1132.6885106595753, 908.7637214324324, 914.9634014639473, 930.5533343994784, 946.6260826973445, 962.4562122400961, 5747.4252574742195, 5788.3343415506915, 5979.133025711248, 6096.268447786205, 6463.159789227464, 875.2035647560816, 917.2570218123342, 1040.0743338428804, 1072.9678109656722, 1093.3112139352315, 3930.155016671429, 4151.27352713274, 4160.979195104005, 4180.581941805795, 4253.893987563256, 11370.0, 11606.30362178272, 11696.766064678659, 11713.0, 11744.29534227949, 11563.88436115628, 11564.248323858923, 11600.6519804406, 11601.07191424684, 11654.417279136009, 8117.634706438224, 8519.892413986267, 8564.559100656283, 8699.913000870038, 8707.608157632922, 6340.0, 6400.263969643551, 6418.261899881387, 6461.6123032616315, 6470.22357317125, 9972.351797133164, 10632.574697012033, 10660.0, 10705.678829635124, 10711.357318560911, 10587.788244235226, 10622.256442048982, 10675.786484270426, 10782.514786834769, 10790.136789057013, 6795.830104247433, 7600.239976002355, 7660.157382688011, 7821.178776228414, 7828.530288182727, 8720.520371379635, 8837.690680826141, 8857.114288571349, 8860.202581767671, 8878.0, 7530.28462296081, 7638.274363935418, 7837.843243135219, 7943.205679432011, 8246.505209687199, 7719.0, 7901.17037711032, 7956.880646790419, 7994.40041996841, 8009.3192078673965, 7108.218096009331, 7108.46686498525, 7183.640817959185, 7208.207097219197, 7216.819579510344, 5208.583313335, 5255.579553635624, 5319.3084898964435, 5343.332083489564, 5462.20797984298, 5169.948300517097, 5308.814191503279, 5350.277712508917, 5375.784968601369, 5447.618666693294], "value": 4774.9818422975695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.07810053748955, 333.8798032708225, 338.71886334342497, 344.55896452540725, 345.3369530501437, 5421.159720243369, 5569.415211402805, 5594.74823632937, 5636.267285252917, 5654.830355089349, 5251.737413129338, 5410.513053825155, 5420.83737487875, 5439.3200849893765, 5501.642393244436, 4259.659227261827, 4278.65770738341, 4282.571742825724, 4294.141171765644, 4340.7395556266565, 4199.601037901394, 4274.807633656493, 4312.525622181557, 4347.500037495697, 4354.433923589945, 4238.660907127422, 4256.340267258564, 4264.0, 4269.359596060584, 4282.8715138545895, 4256.2764330063965, 4258.957410425887, 4261.318189089746, 4303.978480107611, 4337.306031035019, 3694.242680250542, 3826.1199924017355, 3829.310724069694, 3829.5978922213044, 3845.8461661533506, 5312.840614781563, 5334.972710370073, 5353.330833645794, 5360.785568577252, 5375.247465354853, 4924.261360795874, 4930.630202734774, 4930.926036109461, 4939.456659767423, 4965.0, 5514.862128446781, 5721.599488035839, 5727.770889164429, 5770.163326317703, 5778.27771528559, 4160.979195104005, 4168.458100446953, 4172.70791044627, 4177.310743727281, 4188.643965262956, 6018.729157187893, 6019.398060193946, 6034.6982650867285, 6037.245344331958, 6053.273607167124, 3979.621935916083, 4222.662187025031, 4272.46594175728, 4272.871813845528, 4278.0374415756205, 4212.768297743653, 4229.175310814362, 4258.723182993095, 4261.893452663709, 4288.270993931039, 4882.876938304139, 4905.656604037755, 4945.774401519331, 4949.65352425334, 4951.430585482715, 5635.408282130317, 5782.739776710058, 5892.292924849045, 5895.906953031697, 5901.232839730894, 1437.5040610989192, 1459.2849503743303, 1479.748442764711, 1490.6944076464515, 1491.209658880795, 902.7156445719577, 927.3276874266238, 946.6970569417721, 957.8419560772534, 961.4711908450324, 4845.854624361275, 4879.951200488021, 4964.90070198594, 4966.448988972829, 4983.327250821093, 5207.739613019334, 5222.294990176353, 5234.659747116425, 5252.868678282997, 5255.290535777697, 4709.846087708464, 4887.167312257903, 4889.828855990023, 4976.776045077981, 5002.023795841468, 2755.781595815348, 2755.9448811023667, 2758.3379988802944, 2760.5997130415976, 2778.583212518098, 5429.809956651498, 5431.782728690808, 5434.0, 5464.316960379952, 5535.308086489189, 5350.946490535122, 5371.811986580451, 5747.453991870766, 6153.538484613672, 6197.287311959092, 6223.782167624202, 6272.529560282997, 6292.2134733158355, 6301.52738544611, 6307.653079080603, 5910.852228694317, 6020.969895150672, 6063.363346848518, 6084.3797940225495, 6124.908126378197, 5914.3439836845755, 5954.0, 5960.331107289966, 5976.372480889444, 6007.309159446545, 6285.2457705075685, 6308.959021761358, 6315.715792789428, 6315.757905943324, 6317.494600431863, 4267.893302667459, 4331.870043898688, 4348.391225228534, 4353.3687615294975, 4354.346847972829, 5805.187273781589, 5966.880662386641, 5974.998375544242, 5978.0, 6023.216981792339, 5876.706164691834, 5932.13983972313, 5936.940630593812, 5937.168796368598, 5938.524918006636, 5800.390958949419, 5832.854178645398, 5862.267216597926, 5887.882242355215, 5944.197533332945, 5581.6371935824045, 5764.884702306014, 5788.494991302376, 5788.9131663024245, 5802.912956305574, 5877.970610146922, 5954.166416701752, 5967.552433567413, 5978.923793717173, 5981.910271346021, 5610.410906854885, 5739.827805165852, 5754.338251101177, 5781.364049954417, 5786.826395208151], "value": 4349.926096677352, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9198266251396, 554.5480433446743, 614.8697486063942, 687.1180264222697, 719.3274288540215, 15346.386144554219, 16755.1622418879, 16814.32742690291, 16932.153392330365, 16973.57566060849, 14882.85117148831, 15411.845881541181, 15549.378024879019, 15576.766348504752, 15624.2969066392, 805.5368163306093, 808.6644042722263, 809.0776514773163, 809.7611204694629, 810.9026916769966, 800.4756884240832, 811.0227176252602, 828.4201059258513, 830.1076342931343, 838.3795990966671, 842.086336325088, 845.6363763581658, 846.5090247656344, 848.4145939301893, 849.7068511363569, 837.5184269045324, 844.2401838345477, 845.4082142500213, 845.7970087179064, 845.9323254139654, 617.3456136495329, 618.7834258009706, 618.9783357582463, 619.3249358199585, 620.8385819686869, 15582.688346233124, 15583.610409739735, 15712.29294681742, 15727.921360393239, 15742.68514629701, 13157.144785588906, 13463.798043029363, 13514.662133446742, 13568.728625427535, 13909.30453477322, 11285.379304138269, 11436.37099959502, 11522.827157592643, 11529.135314851419, 11606.94196529012, 3799.5820459749407, 3809.6190380961957, 3815.04623844039, 3867.0719027433493, 3994.6404823565726, 78357.0, 79167.6041619794, 79743.6012819938, 80862.99999999942, 82314.0, 10024.298299118991, 10283.280170388001, 10427.217958653131, 10484.370937743759, 10652.84020739674, 21661.891690541448, 21772.0, 21778.237761678265, 21830.0, 21882.12471501154, 7672.616369181518, 7760.883586746203, 7811.68753249875, 7939.722109726247, 8036.116027236999, 4367.737935723867, 4368.22264164026, 4394.362817391524, 4420.624246939046, 4536.886577835515, 3463.0822831949554, 3529.0, 3562.786232825987, 3573.3210689968823, 3574.821258937043, 610.0513701194596, 610.1457958857635, 612.1093808508609, 622.8380621038563, 636.5448704176536, 515.409855715204, 550.7026205848877, 597.7519329478305, 631.905214217871, 649.912261844645, 9373.250139988784, 9510.33427660071, 9538.284628652878, 9556.0, 9587.616495340108, 581.4360070731384, 612.552836429409, 624.4910398025595, 627.7300760672863, 668.7124536449373, 4342.1532801103485, 4411.360352748898, 4432.091421258634, 4473.977630111894, 4536.115457485758, 113117.43441282741, 128989.0, 133488.0, 134232.32883835517, 137530.0, 109159.45420272848, 110030.0, 112063.43968280106, 114080.42959785149, 114834.0, 66330.0, 99566.0, 100027.49986250022, 100667.49666251622, 101305.99999999853, 8156.225158609923, 8479.872801907853, 8535.95732021336, 8575.828483430172, 8794.29645628361, 52879.73560132175, 53580.46419535755, 54086.72956635192, 54146.0, 54769.72615136899, 47149.05701886012, 47231.0, 66288.0, 82414.17585824305, 83156.0, 10757.569697212337, 10858.185636077167, 11021.779564408507, 11028.22802403856, 11437.714057148638, 12030.15788894769, 12378.690532736393, 12499.93750031244, 12510.499580016698, 12612.936935315265, 11655.417229138679, 11661.300321980709, 11758.941205293919, 11777.0, 12389.442475088463, 10550.788984220118, 10711.143108551452, 10714.839277410689, 10751.086157676686, 10953.452327383759, 11013.2841365311, 11139.164562657996, 11542.538298468304, 11555.88444115548, 12038.699032524257, 8947.373683842068, 9616.423014619146, 9865.112139907444, 9897.455639939872, 10050.69847904564, 8673.869891951752, 9786.363886347364, 10212.693619191436, 10234.385936843813, 10300.124489418184], "value": 7199.601916012986, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 111.0, 112.0, 112.0, 111.0, 110.0, 112.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 127.0, 173.0, 126.0, 121.0, 121.0, 121.0, 153.0, 120.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 166.0, 172.0, 162.0, 163.0, 163.0, 164.0, 163.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 117.0, 77.0, 76.0, 76.0, 76.0, 100.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 105.0, 83.0, 84.0, 84.0, 105.0, 82.0, 82.0, 111.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 65.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 79.0, 80.0, 80.0, 80.0, 85.0, 80.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 143.0, 129.0, 137.0, 136.0, 139.0, 140.0, 128.0, 167.0, 126.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 169.0, 168.0, 178.0, 169.0, 171.0, 171.0, 167.0, 166.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 66.0, 68.0, 67.0, 67.0, 67.0, 65.0, 66.0, 65.0], "value": 66.7, "unit": "score"}]}]} 22:47:44 INFO - Return code: 0 22:47:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:47:44 ERROR - # TBPL SUCCESS # 22:47:44 INFO - Running post-action listener: _resource_record_post_action 22:47:44 INFO - [mozharness: 2016-09-23 05:47:44.739090Z] Finished run-tests step (success) 22:47:44 INFO - Running post-run listener: _resource_record_post_run 22:47:44 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 402399232; Read time: 0; Write time: 239420 22:47:44 INFO - TinderboxPrint: CPU usage
13.4% 22:47:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:47:44 INFO - TinderboxPrint: I/O write bytes / time
402,399,232 / 239,420 22:47:44 INFO - TinderboxPrint: CPU idle
8,250.8 (86.6%) 22:47:44 INFO - TinderboxPrint: CPU user
1,219.7 (12.8%) 22:47:44 INFO - TinderboxPrint: Swap in / out
0 / 0 22:47:44 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107577344; Read time: 0; Write time: 68440 22:47:44 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 283426816; Read time: 0; Write time: 169432 22:47:45 INFO - Running post-run listener: _upload_blobber_files 22:47:45 INFO - Blob upload gear active. 22:47:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:47:45 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 22:47:45 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:47:45 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:47:45 INFO - (blobuploader) - INFO - Open directory for files ... 22:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:46 INFO - (blobuploader) - INFO - Done attempting. 22:47:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:47:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:47:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:50 INFO - (blobuploader) - INFO - Done attempting. 22:47:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:47:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:47:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:47:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:47:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:47:51 INFO - (blobuploader) - INFO - Done attempting. 22:47:51 INFO - (blobuploader) - INFO - Iteration through files over. 22:47:51 INFO - Return code: 0 22:47:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:47:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:47:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cf3bfcd1a9b81b0855b451777e16e4d5aa9fd299b31415eaec66b93295ed2a629f7a5a3638f8b9147ff5732c27b3434418760e1b8c9260a4d40ac54b6b8db7f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e3263be7ff90bce8b26116fcae402d574870ec3315e7fe1f6a0725593cc1b1b7c123af9f3e6f8b599b56aa6e94caa16483936a47df082a98e504c620dae637d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb7998495d2344f818a0db8428929116cc38226778afbd7a4f73e19fde65fdb0c39abbf975efcb86563dc3861d7e39417e68c69840d9e5e50c14ef392712bae2"} 22:47:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:47:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:47:51 INFO - Contents: 22:47:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cf3bfcd1a9b81b0855b451777e16e4d5aa9fd299b31415eaec66b93295ed2a629f7a5a3638f8b9147ff5732c27b3434418760e1b8c9260a4d40ac54b6b8db7f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e3263be7ff90bce8b26116fcae402d574870ec3315e7fe1f6a0725593cc1b1b7c123af9f3e6f8b599b56aa6e94caa16483936a47df082a98e504c620dae637d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb7998495d2344f818a0db8428929116cc38226778afbd7a4f73e19fde65fdb0c39abbf975efcb86563dc3861d7e39417e68c69840d9e5e50c14ef392712bae2"} 22:47:51 INFO - Running post-run listener: copy_logs_to_upload_dir 22:47:51 INFO - Copying logs to upload dir... 22:47:51 INFO - mkdir: /builds/slave/test/build/upload/logs 22:47:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.193581 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-22 22:47:50.617536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 22:47:50.621157) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cf3bfcd1a9b81b0855b451777e16e4d5aa9fd299b31415eaec66b93295ed2a629f7a5a3638f8b9147ff5732c27b3434418760e1b8c9260a4d40ac54b6b8db7f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e3263be7ff90bce8b26116fcae402d574870ec3315e7fe1f6a0725593cc1b1b7c123af9f3e6f8b599b56aa6e94caa16483936a47df082a98e504c620dae637d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb7998495d2344f818a0db8428929116cc38226778afbd7a4f73e19fde65fdb0c39abbf975efcb86563dc3861d7e39417e68c69840d9e5e50c14ef392712bae2"} build_url:https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/EAFO84e6RoWEcrYgcV2Xgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cf3bfcd1a9b81b0855b451777e16e4d5aa9fd299b31415eaec66b93295ed2a629f7a5a3638f8b9147ff5732c27b3434418760e1b8c9260a4d40ac54b6b8db7f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9e3263be7ff90bce8b26116fcae402d574870ec3315e7fe1f6a0725593cc1b1b7c123af9f3e6f8b599b56aa6e94caa16483936a47df082a98e504c620dae637d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bb7998495d2344f818a0db8428929116cc38226778afbd7a4f73e19fde65fdb0c39abbf975efcb86563dc3861d7e39417e68c69840d9e5e50c14ef392712bae2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 22:47:50.646188) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:47:50.646481) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474606497.79250-358216018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 22:47:50.730244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 22:47:50.730538) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 22:47:50.730850) ========= ========= Total master_lag: 0.19 =========