builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1471442844.34 results: success (0) buildid: 20160817043003 builduid: 06e9b86617fc4b61b1aa5902523e0539 revision: e232e2267d5f5fb009cb5d3d1a446e5b28ae8915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:24.339551) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:24.340134) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:24.340452) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:24.365241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:24.365607) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-17 07:07:24-- 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% 31.3M=0s 2016-08-17 07:07:24 (31.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103696 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:24.488404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:24.488737) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019973 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:24.539079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:24.539424) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e232e2267d5f5fb009cb5d3d1a446e5b28ae8915 --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 e232e2267d5f5fb009cb5d3d1a446e5b28ae8915 --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=56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-17 07:07:24,869 truncating revision to first 12 chars 2016-08-17 07:07:24,869 Setting DEBUG logging. 2016-08-17 07:07:24,869 attempt 1/10 2016-08-17 07:07:24,869 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e232e2267d5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 07:07:25,250 unpacking tar archive at: mozilla-inbound-e232e2267d5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.734163 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:25.287801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:25.288133) ========= script_repo_revision: e232e2267d5f5fb009cb5d3d1a446e5b28ae8915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:25.288530) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:25.288797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 07:07:25.299968) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-17 07:07:25.300278) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:07:25 INFO - MultiFileLogger online at 20160817 07:07:25 in /builds/slave/test 07:07:25 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 07:07:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:07:25 INFO - {'append_to_log': False, 07:07:25 INFO - 'base_work_dir': '/builds/slave/test', 07:07:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:07:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:07:25 INFO - 'branch': 'Mozilla-Inbound', 07:07:25 INFO - 'buildbot_json_path': 'buildprops.json', 07:07:25 INFO - 'config_files': ('talos/linux_config.py',), 07:07:25 INFO - 'default_actions': ('clobber', 07:07:25 INFO - 'read-buildbot-config', 07:07:25 INFO - 'download-and-extract', 07:07:25 INFO - 'populate-webroot', 07:07:25 INFO - 'create-virtualenv', 07:07:25 INFO - 'install', 07:07:25 INFO - 'run-tests'), 07:07:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:07:25 INFO - 'download_minidump_stackwalk': True, 07:07:25 INFO - 'download_symbols': 'ondemand', 07:07:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:07:25 INFO - 'tooltool.py': '/tools/tooltool.py', 07:07:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:07:25 INFO - '/tools/misc-python/virtualenv.py')}, 07:07:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:07:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:07:25 INFO - 'installer_path': 'installer.exe', 07:07:25 INFO - 'log_level': 'info', 07:07:25 INFO - 'log_name': 'talos', 07:07:25 INFO - 'log_to_console': True, 07:07:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:07:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:07:25 INFO - 'opt_config_files': (), 07:07:25 INFO - 'pip_index': False, 07:07:25 INFO - 'sps_profile': False, 07:07:25 INFO - 'sps_profile_interval': 0, 07:07:25 INFO - 'suite': 'dromaeojs-e10s', 07:07:25 INFO - 'system_bits': '32', 07:07:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:07:25 INFO - 'title': 'talos-linux64-ix-037', 07:07:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:07:25 INFO - 'use_talos_json': True, 07:07:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:07:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:07:25 INFO - 'work_dir': 'build'} 07:07:25 INFO - [mozharness: 2016-08-17 14:07:25.727388Z] Running clobber step. 07:07:25 INFO - Running pre-action listener: _resource_record_pre_action 07:07:25 INFO - Running main action method: clobber 07:07:25 INFO - rmtree: /builds/slave/test/build 07:07:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:07:26 INFO - Running post-action listener: _resource_record_post_action 07:07:26 INFO - [mozharness: 2016-08-17 14:07:26.707467Z] Finished clobber step (success) 07:07:26 INFO - [mozharness: 2016-08-17 14:07:26.707567Z] Running read-buildbot-config step. 07:07:26 INFO - Running pre-action listener: _resource_record_pre_action 07:07:26 INFO - Running main action method: read_buildbot_config 07:07:26 INFO - Using buildbot properties: 07:07:26 INFO - { 07:07:26 INFO - "project": "", 07:07:26 INFO - "product": "firefox", 07:07:26 INFO - "script_repo_revision": "production", 07:07:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:07:26 INFO - "repository": "", 07:07:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:07:26 INFO - "buildid": "20160817043003", 07:07:26 INFO - "pgo_build": "True", 07:07:26 INFO - "basedir": "/builds/slave/test", 07:07:26 INFO - "buildnumber": 1023, 07:07:26 INFO - "slavename": "talos-linux64-ix-037", 07:07:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:07:26 INFO - "platform": "ubuntu64_hw", 07:07:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:07:26 INFO - "branch": "mozilla-inbound", 07:07:26 INFO - "repo_path": "integration/mozilla-inbound", 07:07:26 INFO - "revision": "e232e2267d5f5fb009cb5d3d1a446e5b28ae8915", 07:07:26 INFO - "stage_platform": "linux64-pgo", 07:07:26 INFO - "builduid": "06e9b86617fc4b61b1aa5902523e0539", 07:07:26 INFO - "slavebuilddir": "test" 07:07:26 INFO - } 07:07:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:07:26 INFO - Running post-action listener: _resource_record_post_action 07:07:26 INFO - [mozharness: 2016-08-17 14:07:26.710002Z] Finished read-buildbot-config step (success) 07:07:26 INFO - [mozharness: 2016-08-17 14:07:26.710091Z] Running download-and-extract step. 07:07:26 INFO - Running pre-action listener: _resource_record_pre_action 07:07:26 INFO - Running main action method: download_and_extract 07:07:26 INFO - mkdir: /builds/slave/test/build/tests 07:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:26 INFO - trying https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:07:26 INFO - Downloading https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:07:27 INFO - Downloaded 1361 bytes. 07:07:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:07:27 INFO - Using the following test package requirements: 07:07:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:07:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:07:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:07:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:27 INFO - u'jsshell-linux-x86_64.zip'], 07:07:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:07:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:07:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:07:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:07:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:07:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:07:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:07:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:27 INFO - trying https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:07:27 INFO - Downloading https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:07:28 INFO - Downloaded 21903960 bytes. 07:07:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:07:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:07: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')]} 07:07:32 INFO - trying https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:07:32 INFO - Downloading https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:07:33 INFO - Downloaded 21903960 bytes. 07:07:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:38 INFO - trying https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:38 INFO - Downloading https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:07:39 INFO - Downloaded 14413719 bytes. 07:07:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 07:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:39 INFO - trying https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:07:39 INFO - Downloading https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:07:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:07:40 INFO - Downloaded 59592339 bytes. 07:07:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:07:40 INFO - mkdir: /builds/slave/test/properties 07:07:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:07:40 INFO - Writing to file /builds/slave/test/properties/build_url 07:07:40 INFO - Contents: 07:07:40 INFO - build_url:https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:07:41 INFO - Running post-action listener: _resource_record_post_action 07:07:41 INFO - Running post-action listener: set_extra_try_arguments 07:07:41 INFO - [mozharness: 2016-08-17 14:07:41.568198Z] Finished download-and-extract step (success) 07:07:41 INFO - [mozharness: 2016-08-17 14:07:41.568423Z] Running populate-webroot step. 07:07:41 INFO - Running pre-action listener: _resource_record_pre_action 07:07:41 INFO - Running main action method: populate_webroot 07:07:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:07:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:07:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:07:41 INFO - '--tppagecycles', 07:07:41 INFO - '7'], 07:07:41 INFO - 'tests': ['tsvgm']}}, 07:07:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:07:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:07:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:07:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:07:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:41 INFO - 'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:41 INFO - 'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['damp', 'tps']}, 07:07:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:41 INFO - 'tests': ['damp', 'tps']}, 07:07:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['dromaeo_dom']}, 07:07:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:07:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['basic_compositor_video']}, 07:07:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:07:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['a11yr', 07:07:41 INFO - 'ts_paint', 07:07:41 INFO - 'tpaint', 07:07:41 INFO - 'sessionrestore', 07:07:41 INFO - 'sessionrestore_no_auto_restore', 07:07:41 INFO - 'tabpaint']}, 07:07:41 INFO - 'other-e10s': {'tests': ['a11yr', 07:07:41 INFO - 'ts_paint', 07:07:41 INFO - 'tpaint', 07:07:41 INFO - 'sessionrestore', 07:07:41 INFO - 'sessionrestore_no_auto_restore', 07:07:41 INFO - 'tabpaint']}, 07:07:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:07:41 INFO - 'ts_paint', 07:07:41 INFO - 'tpaint', 07:07:41 INFO - 'sessionrestore', 07:07:41 INFO - 'sessionrestore_no_auto_restore', 07:07:41 INFO - 'tabpaint']}, 07:07:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:07:41 INFO - 'ts_paint', 07:07:41 INFO - 'tpaint', 07:07:41 INFO - 'sessionrestore', 07:07:41 INFO - 'sessionrestore_no_auto_restore', 07:07:41 INFO - 'tabpaint']}, 07:07:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['a11yr', 07:07:41 INFO - 'ts_paint', 07:07:41 INFO - 'tpaint', 07:07:41 INFO - 'sessionrestore', 07:07:41 INFO - 'sessionrestore_no_auto_restore', 07:07:41 INFO - 'tabpaint']}, 07:07:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['a11yr', 07:07:41 INFO - 'ts_paint', 07:07:41 INFO - 'tpaint', 07:07:41 INFO - 'sessionrestore', 07:07:41 INFO - 'sessionrestore_no_auto_restore', 07:07:41 INFO - 'tabpaint']}, 07:07:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['tsvgx', 07:07:41 INFO - 'tsvgr_opacity', 07:07:41 INFO - 'tart', 07:07:41 INFO - 'tscrollx', 07:07:41 INFO - 'cart']}, 07:07:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:07:41 INFO - 'tsvgr_opacity', 07:07:41 INFO - 'tart', 07:07:41 INFO - 'tscrollx', 07:07:41 INFO - 'cart']}, 07:07:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:41 INFO - 'talos_options': ['--disable-e10s'], 07:07:41 INFO - 'tests': ['tp5o']}, 07:07:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:41 INFO - 'tests': ['tp5o']}, 07:07:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:41 INFO - 'talos_options': ['--disable-e10s', 07:07:41 INFO - '--xperf_path', 07:07:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:41 INFO - 'tests': ['tp5n']}, 07:07:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:41 INFO - 'talos_options': ['--xperf_path', 07:07:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:41 INFO - 'tests': ['tp5n']}}, 07:07:41 INFO - 'talos.zip': {'path': '', 07:07:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:07:41 INFO - Running post-action listener: _resource_record_post_action 07:07:41 INFO - [mozharness: 2016-08-17 14:07:41.585093Z] Finished populate-webroot step (success) 07:07:41 INFO - [mozharness: 2016-08-17 14:07:41.585181Z] Running create-virtualenv step. 07:07:41 INFO - Running pre-action listener: _resource_record_pre_action 07:07:41 INFO - Running main action method: create_virtualenv 07:07:41 INFO - Creating virtualenv /builds/slave/test/build/venv 07:07:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:07:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:07:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:07:41 INFO - Using real prefix '/usr' 07:07:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:07:42 INFO - Installing distribute.............................................................................................................................................................................................done. 07:07:44 INFO - Installing pip.................done. 07:07:44 INFO - Return code: 0 07:07:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd301adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:07:44 INFO - Using env: {'DISPLAY': ':0', 07:07:44 INFO - 'HOME': '/home/cltbld', 07:07:44 INFO - 'LANG': 'en_US.UTF-8', 07:07:44 INFO - 'LANGUAGE': 'en_US:en', 07:07:44 INFO - 'LOGNAME': 'cltbld', 07:07:44 INFO - 'MAIL': '/var/mail/cltbld', 07:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:44 INFO - 'MOZ_NO_REMOTE': '1', 07:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:44 INFO - 'NO_EM_RESTART': '1', 07:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:44 INFO - 'PWD': '/builds/slave/test', 07:07:44 INFO - 'SHELL': '/bin/bash', 07:07:44 INFO - 'SHLVL': '1', 07:07:44 INFO - 'TERM': 'linux', 07:07:44 INFO - 'TMOUT': '86400', 07:07:44 INFO - 'USER': 'cltbld', 07:07:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:44 INFO - '_': '/tools/buildbot/bin/python'} 07:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:07:44 INFO - Cleaning up... 07:07:44 INFO - Return code: 0 07:07:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffd301adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:07:44 INFO - Using env: {'DISPLAY': ':0', 07:07:44 INFO - 'HOME': '/home/cltbld', 07:07:44 INFO - 'LANG': 'en_US.UTF-8', 07:07:44 INFO - 'LANGUAGE': 'en_US:en', 07:07:44 INFO - 'LOGNAME': 'cltbld', 07:07:44 INFO - 'MAIL': '/var/mail/cltbld', 07:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:44 INFO - 'MOZ_NO_REMOTE': '1', 07:07:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:44 INFO - 'NO_EM_RESTART': '1', 07:07:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:44 INFO - 'PWD': '/builds/slave/test', 07:07:44 INFO - 'SHELL': '/bin/bash', 07:07:44 INFO - 'SHLVL': '1', 07:07:44 INFO - 'TERM': 'linux', 07:07:44 INFO - 'TMOUT': '86400', 07:07:44 INFO - 'USER': 'cltbld', 07:07:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:44 INFO - '_': '/tools/buildbot/bin/python'} 07:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:44 INFO - Downloading/unpacking psutil>=3.1.1 07:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:07:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:46 INFO - Installing collected packages: psutil 07:07:46 INFO - Running setup.py install for psutil 07:07:46 INFO - building 'psutil._psutil_linux' extension 07:07:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:07:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:07:46 INFO - building 'psutil._psutil_posix' extension 07:07:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:07:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:07:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:47 INFO - Successfully installed psutil 07:07:47 INFO - Cleaning up... 07:07:47 INFO - Return code: 0 07:07:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:47 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 0x7ffd301adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:07:47 INFO - Using env: {'DISPLAY': ':0', 07:07:47 INFO - 'HOME': '/home/cltbld', 07:07:47 INFO - 'LANG': 'en_US.UTF-8', 07:07:47 INFO - 'LANGUAGE': 'en_US:en', 07:07:47 INFO - 'LOGNAME': 'cltbld', 07:07:47 INFO - 'MAIL': '/var/mail/cltbld', 07:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:47 INFO - 'MOZ_NO_REMOTE': '1', 07:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:47 INFO - 'NO_EM_RESTART': '1', 07:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:47 INFO - 'PWD': '/builds/slave/test', 07:07:47 INFO - 'SHELL': '/bin/bash', 07:07:47 INFO - 'SHLVL': '1', 07:07:47 INFO - 'TERM': 'linux', 07:07:47 INFO - 'TMOUT': '86400', 07:07:47 INFO - 'USER': 'cltbld', 07:07:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:47 INFO - '_': '/tools/buildbot/bin/python'} 07:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:07:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:07:49 INFO - Installing collected packages: mozsystemmonitor 07:07:49 INFO - Running setup.py install for mozsystemmonitor 07:07:49 INFO - Successfully installed mozsystemmonitor 07:07:49 INFO - Cleaning up... 07:07:49 INFO - Return code: 0 07:07:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:07: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')]} 07:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd301adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07: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==2.5.1'] in /builds/slave/test/build 07:07: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==2.5.1 07:07:49 INFO - Using env: {'DISPLAY': ':0', 07:07:49 INFO - 'HOME': '/home/cltbld', 07:07:49 INFO - 'LANG': 'en_US.UTF-8', 07:07:49 INFO - 'LANGUAGE': 'en_US:en', 07:07:49 INFO - 'LOGNAME': 'cltbld', 07:07:49 INFO - 'MAIL': '/var/mail/cltbld', 07:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:49 INFO - 'MOZ_NO_REMOTE': '1', 07:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:49 INFO - 'NO_EM_RESTART': '1', 07:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:49 INFO - 'PWD': '/builds/slave/test', 07:07:49 INFO - 'SHELL': '/bin/bash', 07:07:49 INFO - 'SHLVL': '1', 07:07:49 INFO - 'TERM': 'linux', 07:07:49 INFO - 'TMOUT': '86400', 07:07:49 INFO - 'USER': 'cltbld', 07:07:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:49 INFO - '_': '/tools/buildbot/bin/python'} 07:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:49 INFO - Downloading/unpacking jsonschema==2.5.1 07:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:07:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:52 INFO - Downloading functools32-3.2.3-2.tar.gz 07:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:07:52 INFO - warning: no files found matching '*.txt' 07:07:52 INFO - no previously-included directories found matching 'build' 07:07:52 INFO - no previously-included directories found matching 'dist' 07:07:52 INFO - no previously-included directories found matching '.git*' 07:07:52 INFO - Installing collected packages: jsonschema, functools32 07:07:52 INFO - Running setup.py install for functools32 07:07:52 INFO - warning: no files found matching '*.txt' 07:07:52 INFO - no previously-included directories found matching 'build' 07:07:52 INFO - no previously-included directories found matching 'dist' 07:07:52 INFO - no previously-included directories found matching '.git*' 07:07:52 INFO - Successfully installed jsonschema functools32 07:07:52 INFO - Cleaning up... 07:07:52 INFO - Return code: 0 07:07:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:52 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 0x7ffd301adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:07:52 INFO - Using env: {'DISPLAY': ':0', 07:07:52 INFO - 'HOME': '/home/cltbld', 07:07:52 INFO - 'LANG': 'en_US.UTF-8', 07:07:52 INFO - 'LANGUAGE': 'en_US:en', 07:07:52 INFO - 'LOGNAME': 'cltbld', 07:07:52 INFO - 'MAIL': '/var/mail/cltbld', 07:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:52 INFO - 'MOZ_NO_REMOTE': '1', 07:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:52 INFO - 'NO_EM_RESTART': '1', 07:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:52 INFO - 'PWD': '/builds/slave/test', 07:07:52 INFO - 'SHELL': '/bin/bash', 07:07:52 INFO - 'SHLVL': '1', 07:07:52 INFO - 'TERM': 'linux', 07:07:52 INFO - 'TMOUT': '86400', 07:07:52 INFO - 'USER': 'cltbld', 07:07:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:52 INFO - '_': '/tools/buildbot/bin/python'} 07:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:07:53 INFO - Cleaning up... 07:07:53 INFO - Return code: 0 07:07:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:53 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 0x7ffd301adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:07:53 INFO - Using env: {'DISPLAY': ':0', 07:07:53 INFO - 'HOME': '/home/cltbld', 07:07:53 INFO - 'LANG': 'en_US.UTF-8', 07:07:53 INFO - 'LANGUAGE': 'en_US:en', 07:07:53 INFO - 'LOGNAME': 'cltbld', 07:07:53 INFO - 'MAIL': '/var/mail/cltbld', 07:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:53 INFO - 'MOZ_NO_REMOTE': '1', 07:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:53 INFO - 'NO_EM_RESTART': '1', 07:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:53 INFO - 'PWD': '/builds/slave/test', 07:07:53 INFO - 'SHELL': '/bin/bash', 07:07:53 INFO - 'SHLVL': '1', 07:07:53 INFO - 'TERM': 'linux', 07:07:53 INFO - 'TMOUT': '86400', 07:07:53 INFO - 'USER': 'cltbld', 07:07:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:53 INFO - '_': '/tools/buildbot/bin/python'} 07:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:55 INFO - Downloading blobuploader-1.2.4.tar.gz 07:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:07:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:07:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:55 INFO - Downloading docopt-0.6.1.tar.gz 07:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:07:56 INFO - Installing collected packages: blobuploader, requests, docopt 07:07:56 INFO - Running setup.py install for blobuploader 07:07:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:07:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:07:56 INFO - Running setup.py install for requests 07:07:56 INFO - Running setup.py install for docopt 07:07:56 INFO - Successfully installed blobuploader requests docopt 07:07:56 INFO - Cleaning up... 07:07:56 INFO - Return code: 0 07:07:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:56 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 0x7ffd301adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:07:56 INFO - Using env: {'DISPLAY': ':0', 07:07:56 INFO - 'HOME': '/home/cltbld', 07:07:56 INFO - 'LANG': 'en_US.UTF-8', 07:07:56 INFO - 'LANGUAGE': 'en_US:en', 07:07:56 INFO - 'LOGNAME': 'cltbld', 07:07:56 INFO - 'MAIL': '/var/mail/cltbld', 07:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:56 INFO - 'MOZ_NO_REMOTE': '1', 07:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:56 INFO - 'NO_EM_RESTART': '1', 07:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:56 INFO - 'PWD': '/builds/slave/test', 07:07:56 INFO - 'SHELL': '/bin/bash', 07:07:56 INFO - 'SHLVL': '1', 07:07:56 INFO - 'TERM': 'linux', 07:07:56 INFO - 'TMOUT': '86400', 07:07:56 INFO - 'USER': 'cltbld', 07:07:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:56 INFO - '_': '/tools/buildbot/bin/python'} 07:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:07:56 INFO - Running setup.py (path:/tmp/pip-6RgPxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:07:56 INFO - Running setup.py (path:/tmp/pip-xG_Y9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:07:57 INFO - Running setup.py (path:/tmp/pip-LQfswX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:07:57 INFO - Running setup.py (path:/tmp/pip-uh_n2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:07:57 INFO - Running setup.py (path:/tmp/pip-fewCH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:07:57 INFO - Running setup.py (path:/tmp/pip-jShEJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:07:57 INFO - Running setup.py (path:/tmp/pip-UAWOfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:07:57 INFO - Running setup.py (path:/tmp/pip-P4wrRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:07:57 INFO - Running setup.py (path:/tmp/pip-Myu7Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:07:57 INFO - Running setup.py (path:/tmp/pip-ICBOmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:07:57 INFO - Running setup.py (path:/tmp/pip-Bq8nOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:07:57 INFO - Running setup.py (path:/tmp/pip-_7EmA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:07:57 INFO - Running setup.py (path:/tmp/pip-dC9wJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:07:57 INFO - Running setup.py (path:/tmp/pip-rKsTdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:57 INFO - Running setup.py (path:/tmp/pip-AcM4qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:07:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:07:58 INFO - Running setup.py (path:/tmp/pip-NJTcuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:07:58 INFO - Running setup.py (path:/tmp/pip-VYK3E7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:07:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:07:58 INFO - Running setup.py install for manifestparser 07:07:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:07:58 INFO - Running setup.py install for mozcrash 07:07:58 INFO - Running setup.py install for mozdebug 07:07:58 INFO - Running setup.py install for mozdevice 07:07:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:07:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:07:58 INFO - Running setup.py install for mozfile 07:07:58 INFO - Running setup.py install for mozhttpd 07:07:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:07:58 INFO - Running setup.py install for mozinfo 07:07:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:07:58 INFO - Running setup.py install for mozInstall 07:07:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:07:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:07:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:07:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:07:58 INFO - Running setup.py install for mozleak 07:07:59 INFO - Running setup.py install for mozlog 07:07:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:07:59 INFO - Running setup.py install for moznetwork 07:07:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:07:59 INFO - Running setup.py install for mozprocess 07:07:59 INFO - Running setup.py install for mozprofile 07:07:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:07:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:07:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:07:59 INFO - Running setup.py install for mozrunner 07:07:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:07:59 INFO - Running setup.py install for mozscreenshot 07:07:59 INFO - Running setup.py install for moztest 07:07:59 INFO - Running setup.py install for mozversion 07:07:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:07:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:07:59 INFO - Cleaning up... 07:07:59 INFO - Return code: 0 07:07:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:59 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 0x7ffd301adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:07:59 INFO - Using env: {'DISPLAY': ':0', 07:07:59 INFO - 'HOME': '/home/cltbld', 07:07:59 INFO - 'LANG': 'en_US.UTF-8', 07:07:59 INFO - 'LANGUAGE': 'en_US:en', 07:07:59 INFO - 'LOGNAME': 'cltbld', 07:07:59 INFO - 'MAIL': '/var/mail/cltbld', 07:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:59 INFO - 'MOZ_NO_REMOTE': '1', 07:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:59 INFO - 'NO_EM_RESTART': '1', 07:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:59 INFO - 'PWD': '/builds/slave/test', 07:07:59 INFO - 'SHELL': '/bin/bash', 07:07:59 INFO - 'SHLVL': '1', 07:07:59 INFO - 'TERM': 'linux', 07:07:59 INFO - 'TMOUT': '86400', 07:07:59 INFO - 'USER': 'cltbld', 07:07:59 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:59 INFO - '_': '/tools/buildbot/bin/python'} 07:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:00 INFO - Running setup.py (path:/tmp/pip-UfBFtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:00 INFO - Running setup.py (path:/tmp/pip-0AeSaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:00 INFO - Running setup.py (path:/tmp/pip-wN83CC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:00 INFO - Running setup.py (path:/tmp/pip-Z8mrni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:00 INFO - Running setup.py (path:/tmp/pip-BMDsOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:00 INFO - Running setup.py (path:/tmp/pip-eZW1n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:00 INFO - Running setup.py (path:/tmp/pip-BNcLWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:00 INFO - Running setup.py (path:/tmp/pip-o0siCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:00 INFO - Running setup.py (path:/tmp/pip-7rqWvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:00 INFO - Running setup.py (path:/tmp/pip-JAv4kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:00 INFO - Running setup.py (path:/tmp/pip-b0kIGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:00 INFO - Running setup.py (path:/tmp/pip-1oODGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:01 INFO - Running setup.py (path:/tmp/pip-FAQipk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:01 INFO - Running setup.py (path:/tmp/pip-YnDZKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:01 INFO - Running setup.py (path:/tmp/pip-pe9dzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:01 INFO - Running setup.py (path:/tmp/pip-PHuJdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:01 INFO - Running setup.py (path:/tmp/pip-bbUNgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:08:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:03 INFO - Downloading blessings-1.6.tar.gz 07:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:08:03 INFO - Installing collected packages: blessings 07:08:03 INFO - Running setup.py install for blessings 07:08:03 INFO - Successfully installed blessings 07:08:03 INFO - Cleaning up... 07:08:03 INFO - Return code: 0 07:08:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:08:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:03 INFO - Reading from file tmpfile_stdout 07:08:03 INFO - Current package versions: 07:08:03 INFO - argparse == 1.2.1 07:08:03 INFO - blessings == 1.6 07:08:03 INFO - blobuploader == 1.2.4 07:08:03 INFO - docopt == 0.6.1 07:08:03 INFO - functools32 == 3.2.3-2 07:08:03 INFO - jsonschema == 2.5.1 07:08:03 INFO - manifestparser == 1.1 07:08:03 INFO - mozInstall == 1.12 07:08:03 INFO - mozcrash == 0.17 07:08:03 INFO - mozdebug == 0.1 07:08:03 INFO - mozdevice == 0.48 07:08:03 INFO - mozfile == 1.2 07:08:03 INFO - mozhttpd == 0.7 07:08:03 INFO - mozinfo == 0.9 07:08:03 INFO - mozleak == 0.1 07:08:03 INFO - mozlog == 3.3 07:08:03 INFO - moznetwork == 0.27 07:08:03 INFO - mozprocess == 0.23 07:08:03 INFO - mozprofile == 0.28 07:08:03 INFO - mozrunner == 6.12 07:08:03 INFO - mozscreenshot == 0.1 07:08:03 INFO - mozsystemmonitor == 0.3 07:08:03 INFO - moztest == 0.7 07:08:03 INFO - mozversion == 1.4 07:08:03 INFO - psutil == 3.1.1 07:08:03 INFO - requests == 1.2.3 07:08:03 INFO - wsgiref == 0.1.2 07:08:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:03 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 0x7ffd301adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:08:03 INFO - Using env: {'DISPLAY': ':0', 07:08:03 INFO - 'HOME': '/home/cltbld', 07:08:03 INFO - 'LANG': 'en_US.UTF-8', 07:08:03 INFO - 'LANGUAGE': 'en_US:en', 07:08:03 INFO - 'LOGNAME': 'cltbld', 07:08:03 INFO - 'MAIL': '/var/mail/cltbld', 07:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:03 INFO - 'MOZ_NO_REMOTE': '1', 07:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:03 INFO - 'NO_EM_RESTART': '1', 07:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:03 INFO - 'PWD': '/builds/slave/test', 07:08:03 INFO - 'SHELL': '/bin/bash', 07:08:03 INFO - 'SHLVL': '1', 07:08:03 INFO - 'TERM': 'linux', 07:08:03 INFO - 'TMOUT': '86400', 07:08:03 INFO - 'USER': 'cltbld', 07:08:03 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:03 INFO - '_': '/tools/buildbot/bin/python'} 07:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:08:03 INFO - Cleaning up... 07:08:03 INFO - Return code: 0 07:08:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd301adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c00230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:08:03 INFO - Using env: {'DISPLAY': ':0', 07:08:03 INFO - 'HOME': '/home/cltbld', 07:08:03 INFO - 'LANG': 'en_US.UTF-8', 07:08:03 INFO - 'LANGUAGE': 'en_US:en', 07:08:03 INFO - 'LOGNAME': 'cltbld', 07:08:03 INFO - 'MAIL': '/var/mail/cltbld', 07:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:03 INFO - 'MOZ_NO_REMOTE': '1', 07:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:03 INFO - 'NO_EM_RESTART': '1', 07:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:04 INFO - 'PWD': '/builds/slave/test', 07:08:04 INFO - 'SHELL': '/bin/bash', 07:08:04 INFO - 'SHLVL': '1', 07:08:04 INFO - 'TERM': 'linux', 07:08:04 INFO - 'TMOUT': '86400', 07:08:04 INFO - 'USER': 'cltbld', 07:08:04 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:04 INFO - '_': '/tools/buildbot/bin/python'} 07:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:08:04 INFO - Cleaning up... 07:08:04 INFO - Return code: 0 07:08:04 INFO - Running post-action listener: _resource_record_post_action 07:08:04 INFO - Running post-action listener: _start_resource_monitoring 07:08:04 INFO - Starting resource monitoring. 07:08:04 INFO - [mozharness: 2016-08-17 14:08:04.246353Z] Finished create-virtualenv step (success) 07:08:04 INFO - [mozharness: 2016-08-17 14:08:04.246810Z] Running install step. 07:08:04 INFO - Running pre-action listener: _resource_record_pre_action 07:08:04 INFO - Running main action method: install 07:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:04 INFO - Reading from file tmpfile_stdout 07:08:04 INFO - Detecting whether we're running mozinstall >=1.0... 07:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:08:04 INFO - Reading from file tmpfile_stdout 07:08:04 INFO - Output received: 07:08:04 INFO - Usage: mozinstall [options] installer 07:08:04 INFO - Options: 07:08:04 INFO - -h, --help show this help message and exit 07:08:04 INFO - -d DEST, --destination=DEST 07:08:04 INFO - Directory to install application into. [default: 07:08:04 INFO - "/builds/slave/test"] 07:08:04 INFO - --app=APP Application being installed. [default: firefox] 07:08:04 INFO - mkdir: /builds/slave/test/build/application 07:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:08:21 INFO - Reading from file tmpfile_stdout 07:08:21 INFO - Output received: 07:08:21 INFO - /builds/slave/test/build/application/firefox/firefox 07:08:21 INFO - Running post-action listener: _resource_record_post_action 07:08:21 INFO - [mozharness: 2016-08-17 14:08:21.498313Z] Finished install step (success) 07:08:21 INFO - [mozharness: 2016-08-17 14:08:21.498561Z] Running run-tests step. 07:08:21 INFO - Running pre-action listener: _resource_record_pre_action 07:08:21 INFO - Running main action method: run_tests 07:08:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:08:21 INFO - Python 2.7.3 07:08:21 INFO - Return code: 0 07:08:21 INFO - grabbing minidump binary from tooltool 07:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:08:21 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 0x2bfa090>, '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 0x2bfd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bfde40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:08:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:08:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:08:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:08:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:08:21 INFO - Return code: 0 07:08:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:08:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:08:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:08:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:08:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:08:21 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/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 07:08:21 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/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 07:08:21 INFO - Using env: {'DISPLAY': ':0', 07:08:21 INFO - 'HOME': '/home/cltbld', 07:08:21 INFO - 'LANG': 'en_US.UTF-8', 07:08:21 INFO - 'LANGUAGE': 'en_US:en', 07:08:21 INFO - 'LOGNAME': 'cltbld', 07:08:21 INFO - 'MAIL': '/var/mail/cltbld', 07:08:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:08:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:21 INFO - 'MOZ_NO_REMOTE': '1', 07:08:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:21 INFO - 'NO_EM_RESTART': '1', 07:08:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:21 INFO - 'PWD': '/builds/slave/test', 07:08:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:08:21 INFO - 'SHELL': '/bin/bash', 07:08:21 INFO - 'SHLVL': '1', 07:08:21 INFO - 'TERM': 'linux', 07:08:21 INFO - 'TMOUT': '86400', 07:08:21 INFO - 'USER': 'cltbld', 07:08:21 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541', 07:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:21 INFO - '_': '/tools/buildbot/bin/python'} 07:08:21 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/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 07:08:21 INFO - mozversion application_buildid: 20160817043003 07:08:21 INFO - mozversion application_changeset: e232e2267d5f5fb009cb5d3d1a446e5b28ae8915 07:08:21 INFO - mozversion application_display_name: Nightly 07:08:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:08:21 INFO - mozversion application_name: Firefox 07:08:21 INFO - mozversion application_remotingname: firefox 07:08:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:08:21 INFO - mozversion application_vendor: Mozilla 07:08:21 INFO - mozversion application_version: 51.0a1 07:08:21 INFO - mozversion platform_buildid: 20160817043003 07:08:21 INFO - mozversion platform_changeset: e232e2267d5f5fb009cb5d3d1a446e5b28ae8915 07:08:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:08:21 INFO - mozversion platform_version: 51.0a1 07:08:21 INFO - using testdate: 1471442901 07:08:21 INFO - actual date: 1471442901 07:08:21 INFO - starting webserver on 'localhost:50767' 07:08:21 INFO - SUITE-START | Running 2 tests 07:08:21 INFO - TEST-START | dromaeo_css 07:08:21 INFO - operating with platform_type : linux_ 07:08:21 INFO - Initialising browser for dromaeo_css test... 07:08:21 INFO - TEST-INFO | started process 13034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvoQhhb/profile http://localhost:50767/getInfo.html) 07:08:25 INFO - PROCESS | 13034 | __metrics Screen width/height:1600/1200 07:08:25 INFO - PROCESS | 13034 | colorDepth:24 07:08:25 INFO - PROCESS | 13034 | Browser inner width/height: 1024/697 07:08:25 INFO - PROCESS | 13034 | __metrics 07:08:26 ERROR - PROCESS | 13034 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 07:08:27 INFO - TEST-INFO | 13034: exit 0 07:08:27 INFO - Browser initialized. 07:08:27 INFO - Running cycle 1/1 for dromaeo_css test... 07:08:27 INFO - TEST-INFO | started process 13154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvoQhhb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:38 INFO - PROCESS | 13154 | RSS: Main: 162963456 07:08:38 INFO - PROCESS | 13154 | 07:09:28 INFO - PROCESS | 13154 | 1471442968483 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:11:38 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:50767/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50767/tests/dromaeo/cssquery-ext.html) 07:11:39 INFO - PROCESS | 13154 | RSS: Main: 164392960 07:11:39 INFO - PROCESS | 13154 | 07:14:41 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:50767/tests/dromaeo/cssquery-ext.html (next: http://localhost:50767/tests/dromaeo/cssquery-jquery.html) 07:14:42 INFO - PROCESS | 13154 | RSS: Main: 165384192 07:14:42 INFO - PROCESS | 13154 | 07:17:44 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:50767/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50767/tests/dromaeo/cssquery-mootools.html) 07:17:45 INFO - PROCESS | 13154 | RSS: Main: 166461440 07:17:45 INFO - PROCESS | 13154 | 07:20:47 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:50767/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50767/tests/dromaeo/cssquery-prototype.html) 07:20:47 INFO - PROCESS | 13154 | RSS: Main: 163291136 07:20:47 INFO - PROCESS | 13154 | 07:23:50 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:50767/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50767/tests/dromaeo/cssquery-yui.html) 07:23:50 INFO - PROCESS | 13154 | RSS: Main: 166785024 07:23:50 INFO - PROCESS | 13154 | 07:26:53 INFO - PROCESS | 13154 | Cycle 1(1): loaded http://localhost:50767/tests/dromaeo/cssquery-yui.html (next: http://localhost:50767/tests/dromaeo/cssquery-dojo.html) 07:26:53 INFO - PROCESS | 13154 | RSS: Main: 166690816 07:26:53 INFO - PROCESS | 13154 | 07:26:53 INFO - PROCESS | 13154 | __start_tp_report 07:26:53 INFO - PROCESS | 13154 | _x_x_mozilla_page_load 07:26:53 INFO - PROCESS | 13154 | _x_x_mozilla_page_load_details 07:26:53 INFO - PROCESS | 13154 | |i|pagename|runs| 07:26:53 INFO - PROCESS | 13154 | |0;dojo.html;3089.752819774418;3121.5005599104147;3135.999999999999;3138.6861313868603;3144.6855314468557;5340.519353258206;5402.972985135074;5491.148871924853;5500.917486237709;5535.25274087998;5389.083855744523;5458.754356053977;5478.643888147278;5488.1493368527845;5488.4785945335125;4895.583875370588;4957.702537847741;4985.476524964881;5037.874053148682;5131.4098878629065;5076.974615126937;5113;5113.744312784346;5155.097857874857;5157.819476318329;4837.758112094381;4874.2444921037295;5003.124453220708;5070.771815268304;5073.239014147871;4892.926606100911;4907.9263811042865;4929.482404347527;4930.852074437773;4933.555979961785;4884.658073934826;4889.413270407538;4909.239067944474;4989.65072444929;4996.2755400467095;5438.293021907127;5446;5458.918116228259;5478.123500239983;5481.451854814526;5806.1000544915605;5877.975452209192;5882.499987501067;5891.705414729289;5915.053591425394;5880.059190529495;5943.821685349403;5951.553633477506;5953.13679516472;5999.040153575451;5477.452254774531;5528.44715528448;5531;5533.6956467393875;5537;5832.737526811304;5853.707314634251;5882.117682347682;6044.486218671374;6050.213472248667;5655.321361436654;5655.858603534944;5663.546916246691;5664.631798933056;5673.489385955284;5681.829545113571;5741.224934633855;5746.02317606008;5746.454086861741;5759.827205183851;5660.490555849993;5714.000049991235;5767.769289228468;5784;5873.970630146822;5842.357340692605;5851.707414629252;5853.560982926298;5853.88292234153;5864.912026319608;4467.061916997467;4467.285234362552;4470.2177119004045;4478.977605111953;4505.909881802346;3915.295246855593;3943.8028098594955;3970.563238043813;4016.2971479990883;4035.1122752994293;5577.860553486195;5612.989661860823;5616.803411880564;5624.437556244425;5685.60200785941;5835.270591176103;5878.3239927408895;5926.525877929756;5928.7332070056955;5950.851228719317;5451.727413629382;5500.7524661390335;5547;5576.498115169654;5624.943750562442;5087.618428617869;5096.439391666913;5097.898042039213;5113.386393632788;5129.153689641242;6065.696715164224;6076.118962750465;6078.483328917092;6084.361142080106;6089.086637004485;5776.960147173381;5800;5832.096025116114;5892.823215303548;5897.026990546683;6010.879782404415;6012.488938440281;6036.63780173191;6076.058210977306;6090.330063693079;5752;5756.453136951983;5758.2514273144225;5767.653940763567;5772.278465191851;5725.971370143123;5758.712064396847;5794.159846822272;5840.94159058404;5848.590598658223;5708.5147762439;5715.199872018004;5743.1385292206505;5757.395473475225;5758.309002919509;5665.886682266414;5701.572382071444;5704.515116215168;5720.599558030898;5723.971380143073;5553.361363443094;5618.2134501170685;5653.378128405954;5660.433956604306;5665.405132461032;5840.269966254218;5844.064949608042;5846.707664616667;5868.149118377897;5877.089051197071;5704.629199102045;5705.087186050212;5725.055365864752;5728.140778883034;5729.140628905698 07:26:53 INFO - PROCESS | 13154 | |1;ext.html;550.2751375687845;577.630316597378;584.6346033728919;599.4574909706715;633.5660072850095;38424.61575384245;42999.355009674844;43090.7845460773;43142.352864707056;43186.568134318644;41743.58256417435;42384.57615423845;42490;42902.141957160915;42925.141497170036;8794.252488538483;8895.066018068106;8921.197092261695;8925.152110549487;8929.330300227477;8855.424397414148;8867.290616750677;8877;8896.599653015597;8923.598438070303;8900.73297801067;8953.194212520872;8978.955105224464;9024.14270644291;9026.142516460926;8894.42186257891;8916.643334266622;8922.241609463203;8948.463092214488;8997.685081022166;8648.481091134552;8761.08008659088;8780.868286975701;8799.384043116985;8842.292616590657;41160;41594;41598.1680366394;41607;41614.1677166455;3065.6167979002626;3307.074019274583;3332.0836769888233;3412.7269818414466;3554.626764189749;32517.67482325194;32875;33268.03917649415;33631.3273734524;33772.32455350879;4308.870733877989;4435.334699795024;4487.573680500347;4698.718076915396;4708.10545996263;363324;363348;365951;366292;366664.16667916754;56220.43779562234;56649.43350566524;56899;57056.42943570511;57093.714531427075;35923;36661.45007824885;36661.63338366582;59440;59685.104723429184;14836.18400987956;15319.387224511118;15419.151946643042;15419.768703469457;15427.614309642124;11858.703532411759;12141.514339426501;12195.573154939535;12238.388080595934;12241.938790306169;18558.721619175452;18737.596664783763;18787.812121878607;18889.7166542502;18959.43121706351;7187.676554555058;7203.567785932861;7266.92733072673;7385.03994480714;7489.138749043821;951.2247518272586;1009.9343542669703;1050.4905121016302;1055.7518983038979;1100.4387762241315;32583.51124733131;32838.179045523575;33139.66860331414;33163.50254746181;33745.83127084349;1019.6533178719271;1063.3301020357126;1063.4982662504983;1129.9830502542468;1155.364549497773;15624.921875390777;16580.668386632442;16675.83324166767;16686.332546697995;16887.240074196692;575674;580563;582134;583565;584717;56957.715211423674;57558.7122064387;57745.42254577485;57841.71079144662;57849.42150578524;1310.4627102887962;1345.381124682657;1355.728854229158;1403.0739711789965;1404.6067101211677;29491;30611.065153040767;30974.69025309808;31437.842810785798;31520.36959260756;48867;49545;49632.255516166566;49739.50260497349;49746.75126624344;446655;448299;448949;449300;449419;28038;28385.858070709513;28985.565216521347;29189.85405072961;30096.24759381033;47452.288215676104;47898.76050619724;48050.27924581204;48307.5169248303;49303.260451092545;40694;41283.587164127974;41450;42055.15889682128;43471.78264108659;40956.18087638171;41227.79386103051;41770;42016.579834201264;42034.579654203066;40622;40800.79599601983;40924.79537602293;41676.79161604172;44463.55536444724;34237;36933;37360;37946.620533795416;38262;28329;28684.13947581576;28790;28896.566551501324;29041.128766137048 07:26:53 INFO - PROCESS | 13154 | |2;jquery.html;399.6143721308936;403.36067333276776;413.51825123730856;414.44878311845247;419.4002576315869;18319;19928.003599819986;19965.600687986233;20085.698714519276;20108.296209632666;16835.242414091364;18761.624767504643;19122.33071842486;19782.40652780419;19795.307164249218;5863.941360586404;5889;6021.187139736124;6035.788747393842;6044.214252147215;5928.614640048405;5948;5979.312379076418;5993.250843644544;6021.9698901505435;5854.268216472941;5952.88094238115;5966.46301832835;5967.343592204854;6003.549733769963;5725.685087320196;5897;5941.970290148543;5985.5810093293485;6002.609830361034;5316.494932981361;5318.7074710891275;5320.388155362144;5332.2801421808335;5336.679799212021;23366.182183623492;23751.524969500515;23885.522289554287;24014.519709605884;24294.87852560726;2442.05980697431;2467.161165203839;2489.427431690703;2588.637590737298;2604.67971151515;14499.176523431672;15237.390504379811;15425.922870385688;15463.768043479356;15626.218689065501;1911.671388385073;1956.7651881774277;1988.9104990275473;2009.8744702966385;2028.4725971247435;83828.16171838326;84033.99999999939;84300;86430;87004.12995870023;9548.856767148498;10035.448050357154;10093.444860532742;10198.541065652063;10250.948745256375;13800.654983625489;13825.308734563232;13853.030287879752;13860.722785544434;13874.791878121836;7389.889151662729;7467.775966721007;7852.489588176751;8063.395245356504;8119.47223430487;7627.351675107678;7636.885446718304;7756.844863102707;7893.723719669784;8016.31861291785;3998.8400463981698;4081.142959978438;4224.831006759757;4232.6190642841675;4376.868693939187;1963.2049020146862;1967.3114409956402;2000.909959051817;2033.7152798608206;2046.6827641715558;932.1563984593953;988.5749127874939;1031.582209205273;1042.1298215989734;1084.1651928015383;18641.44075677732;20075;21050.894745526482;21147.78852211458;21308.467288317916;995.7709726762885;1031.8400647899587;1034.3121823986965;1043.8121138195197;1054.7257712994676;10545.367277963347;11466.31202127875;11578.710532236593;11603.303801771921;11633;491690;502299;502654;510038;531124;88734;89075.55462222647;95940.52029739946;96171;100442;1004.2819384140374;1052.3317693264833;1053.6206965492418;1056.857324261215;1059.4755595979884;17717;18580.628387432447;19303.710444343626;19515.804841951398;19545.21819127219;44049.119017618825;44079.559204408826;44246.557534425534;44587.55412445964;44852.77573612111;61005.38994609997;62747.37252627415;63810.36189638044;63965.68017159885;65310.02034969574;8143.267105960492;8475.364347674073;8529.635258358632;8581.528015959182;9049.457032578066;9878.221240574057;12904.16122952005;13822.86177138256;13858.445662173803;13955.790663140264;11656;11668.008219301455;11682.649520514398;11942.522299107939;12140.575079872162;10720.463976800973;10860.619878304222;11135.33188008722;11269;11408.201425900439;11160.888391115985;11366.772664546828;11565.421728913689;11818.054555635701;12159.452824622736;8522.190391912758;8633.525156116222;8739.606717697592;8782.419164550187;8926.107389261022;9867.851982220416;11407.315561066363;11576.363300018244;11807.940960295144;11911.642650720492 07:26:53 INFO - PROCESS | 13154 | |3;mootools.html;1491.433255362962;1513.931873065712;1675.2880025988952;1804.6029873427842;1817.7364282179092;8144.91855081449;8794.252488538474;8979.865302020458;9463.858042129365;9474.715758527247;8989.865152022725;9217;9267;9275.30435217358;9306.906930930689;2364.6453032045247;2366.7278262999716;2393.7366889642212;2399.3761621978238;2400.699912510936;2275.1354485295565;2327.5810354136247;2331.19573747057;2334.871582062986;2345.6012477878717;2392.6650268962358;2406.3502854229346;2406.6750988616486;2434.4157402223427;2438.219769673696;2328.441174118216;2342.273895092518;2343.121329501437;2350.2126787526286;2357.2574638988663;2309.572729045132;2323.512062466867;2332.148765700524;2332.3935776698013;2333.8599684019014;9343.345965782399;9538.856917146248;9540.713778586654;9548.045195480467;9552.474613896233;5249.317588713443;5417.702026388547;5438.320209973754;5439.129739241703;5455.1544510600925;3484.0593039879345;3521.049316684481;3525.383057964846;3547.6452354764574;3580.4987301777774;1237.665830225834;1240.820081088246;1252.956146534876;1278.284160869916;1292.4248709324354;13021;13085.084044116915;13117.540886068942;13140.474381024747;13182.67043323915;4348.673849461303;4658.976705116453;4721.527847215251;4841.467438581753;4852.053849499313;11030.44847757625;11050.56342675447;11060.944695276634;11061.059809916087;11103.111751059896;5297.073012222922;5316.494932981361;5326.97336513315;5346.732663366816;5359.758810853521;4202;4750.216214324598;4855.465898751135;4870.634702397334;4930.334404855299;4078.69643934822;4091.0181556426837;4179.665626749853;4190.916181676349;4196.51740049892;1295.1581472043247;1301.5184381778802;1304.804279358104;1321.2468892731051;1330.5210124355224;912.4342907397323;928.331601247101;928.5078908178676;930.5021813329836;940.4122423485321;5760.423957604206;5768.567357448208;5886.80372343075;5916.970415147983;6053.424924632153;466;468.42617793203055;471.9805220723221;476.04077783266746;477.257864021443;3760.981195094007;3805.5052843130215;3810.1427178885083;3833.8274777635074;3911.530616326002;11266.66200014001;11608.24546404481;11619.825702614467;11723.472443740053;11748.29510229389;10768.3538987661;11032.117430605533;11208.495617697223;11346.48940797666;11626.186166968231;8437.114103019218;8466.365022623328;8518.722191671175;8641.956790216009;8691.826163476822;6057.333693293822;6111.205543279345;6115.877682446415;6241.812745617639;6363.61818290904;10567.101796347397;10635.627753028606;10660.200484963814;10708.411037393018;10748.140148788234;10542.472876356305;10547.103496202908;10643.414612196404;10788.244822862323;10870.130389568658;7226.205117437183;7404.074490688664;7553.282438168365;8189.631466583899;8319.168083191633;8852.336074794544;8874.822503550022;8878.644854205759;8925.062868398725;8926.955365223132;7903.881441778263;7975.72084977023;7985.321247694011;8099.878501822595;8238.09380968105;7873.803154920944;7877.724279650414;7921.366290696616;8022.237887400687;8056.355491560778;7020.473464490286;7054.153501579844;7128.251533588898;7134.32223938725;7177.425805935408;4838.491958344323;4885.1206782779445;4943.925841112458;4975.402951645681;5078.796848126033;4988.600911926965;5000.999800040079;5034.395872495324;5058.747062646927;5168.198929165986 07:26:53 INFO - PROCESS | 13154 | |4;prototype.html;327.49864356905084;341.1947803184485;346.7347479178428;348.0654442821026;349.22297887200995;5389.78440862365;5435.510804027636;5527.640703354279;5593.356763972144;5594.188842617818;5434.864128396792;5514.36584792749;5541.695206763627;5569.331680198372;5579.386267510581;4364.014373460068;4371.475422949251;4373.737575745449;4378.16814805186;4379.956200438002;4094.303968325392;4281.550437204095;4306.590873866978;4374.147041326943;4375.868723938271;4253;4260.1266740318315;4271.893202669927;4274.893127671818;4293.313069908815;4264.936025959613;4288.914221715549;4289.506706728719;4292.184484947881;4296.613304802583;3651.835667394974;3739.4951681522916;3741.9625803741887;3749.3438648236724;3751.587325394232;5351.759170837322;5386.272853164812;5409.890142844254;5411.972940135313;5435.10320797068;4917.4344950330815;4921.655484116113;4933.161362568336;4946.431160416562;4969.701817890938;5571.275734154575;5701.344345400291;5731.478149614157;5733.713314334308;5816.302043754777;4116.485439320085;4132.359484279941;4140.855070072533;4151.730137541081;4153.356229784388;5878.61788983719;6042.214512113441;6044.516438684895;6045.425684559959;6048.455638992512;4162.167566486714;4176.206520761107;4196.223698615766;4197.727147735449;4232.343986682069;4233.407322974725;4254.510921177563;4270.402143699885;4272.722273052242;4275.40144379787;4849.369581954324;4866.904946387105;4904.803807847647;4907.2393778964315;4952.653314267966;5686.57350698691;5739.454751798572;5850.648961062265;5871.677057761779;5879.882402352015;1452.157748505864;1474.4470823441209;1476.3799204334205;1478.4825311141014;1485.3390241342715;918.8024574716468;937.4937533731709;942.3356533643764;953.3183773601908;959.1942768074712;4900.803967841318;4914.20631469511;4939;4970.652054356233;4989.401271847329;5185.351831021122;5210.452902445264;5212.035773381936;5256.894862102813;5341.706206158621;4765.26138448541;4944.777485013183;4957.900841983213;4961.603071754251;4973.403191617029;2797.5244208484605;2808.2838876086876;2813.9437211256068;2821.224163355053;2826.901058462944;5363.329583802025;5431.21247419122;5433.9675461662155;5441.782328706887;5445.829146733471;5368;5477.561795056386;5673.390240489339;6146.969265153735;6162.691865406712;6132.78535251264;6171.13604095427;6186.556310257423;6203.2245969253845;6231.4391704746795;5734.569907257056;5994.880102398015;5997.190379298739;6004.669743164168;6039.184710064085;5821.417858214145;5892.94107058924;5895.056790913433;5911.349751527415;5915.497182739516;6153.2616086068165;6174.506039516738;6215.409536094245;6228.719707613078;6244.219472565929;4109.3357190337965;4180.832766689298;4220.261454245556;4233.322668373045;4238.491381034172;5723.542116630576;5773.682447465262;5982.670953097621;6011.27864656244;6014.548908831943;5766;5778.8266352009505;5799.057315799255;5834.620749651259;5866.7066646668345;5832.96685723413;5856.94143058564;5862.355140934579;5872.001759700946;5944.197533332945;5548.805791797267;5689.894738946617;5709.942900570941;5733;5757.165211044291;5871.794487192928;5876.147958546072;5888.526818736055;5895.882082358243;5927.673977931255;5619.466150715675;5654.745536450787;5713.228714123707;5785.9132113017495;5786.450287222707 07:26:53 INFO - PROCESS | 13154 | |5;yui.html;687.2371667449131;701.0710808179164;706.1737766812829;750.4259241680112;772.7758949904528;15601.297941592627;16886;16951.91524042378;17032.659346813056;17081.487555373344;15579.065256084643;15694.843051569482;15708.136052517108;15717.764233536505;15734.055956642609;776.6815605601704;781.812365032391;799.0491315334733;804.8470790549777;805.2551389964289;809.9392545559077;813.1989989860012;813.3168138763438;814.5316443045243;814.9592520373988;841.6254766628853;846.5640195299426;848.8387206430789;849.0617867256685;849.9277561407257;835.6197929941892;843.1357858195338;846.1538461538462;846.932245420368;848.2620120495178;608.2579253310954;611.1596554737237;612.1185492890223;612.6936531734133;612.7732738886596;16633.002019878844;16653.33386664532;16691.582710432216;16701.164941752984;16707.582310442216;14706.779398309034;14756.852431475656;14927.477538286217;15151.772723409158;15160.31778569967;12204;12379.938100309531;12383.318917459535;12397.194182378116;13176.802347964789;3848.8460461581503;3881;3983.6215559521797;4043;4043.1307268937026;87574;88604.5569772147;91525;91728;92802;10573.101286390589;10617.522211500502;10998.450077496253;11209.103271738242;11462.828057579143;21578.136874525157;21739.67390489144;22022.33932981981;22049.559008819735;22237.22169724052;8215.260626543639;8426.789330266793;8461.111583283666;8470.49177049379;8480.787980300418;4507.301368287921;4527.320901864747;4582.656300777388;4586.747728874877;4683.672142949961;3593.82030898454;3948.4274780156716;4086.959130408658;4090.4886889138857;4118.588141185917;687.4878215729314;694.3265032918061;695.4158506854166;698.8462538241579;716.9283071692894;591.8106206014035;594.3462191589217;614.1034090228228;629.9653519056496;637.0985056145595;9347.859782103274;9419.293552983554;9445.535941928874;9479.573419196153;9679.903200968041;602.599271484458;611.4344231585766;626.6083697688945;633.6926590603554;678.2302087131043;4236.745795252295;4507.8196872124745;4526.23054080807;4560.293154561048;4602.217623004098;127571;128837;129651.35174324257;135152;139228;112834;117242.41378793222;117721;118376;119073;98980;101311;103111.4844425773;104104.47947760364;104807;8534.06125326226;8672.436291641023;8725.127487251479;8792.912070879465;8892;40383;41855.7907210462;48527.51472485371;50053;51886.481135188165;75171.62414187894;78028;81171.18828811872;81422.59288703519;82423.58788206261;12251.448684809384;12441.440135193758;12454.937725311316;12735.681607959505;12974.870251297367;15706;15716.449924252596;15759.763603546186;15829.445969391476;15904.681906361577;14266;14290.57128286153;14343.067700599428;14404.207768572829;14627.707445851236;14286.571402857931;14299.57101286963;14321.427142914166;14396.640083997565;14484.420623174956;12351.19717218378;13596.252206128758;13597.456101755819;14125.43498260058;14426.350814213176;10821.458927053773;10902.087252530859;10928.180386470887;11029.944850275697;11330.546778128783;9355.53222338894;10638.41488718128;11061.612843550438;11316.434178291218;11320.150988676047 07:26:53 INFO - PROCESS | 13154 | __end_tp_report 07:26:53 INFO - PROCESS | 13154 | __start_cc_report 07:26:53 INFO - PROCESS | 13154 | _x_x_mozilla_cycle_collect,328 07:26:53 INFO - PROCESS | 13154 | __end_cc_report 07:26:53 INFO - PROCESS | 13154 | __startTimestamp1471444013923__endTimestamp 07:26:53 INFO - PROCESS | 13154 | 07:26:53 INFO - PROCESS | 13154 | ------- Summary: start ------- 07:26:53 INFO - PROCESS | 13154 | Number of tests: 6 07:26:53 INFO - PROCESS | 13154 | 07:26:53 INFO - PROCESS | 13154 | [#0] dojo.html Cycles:165 Average:5440.17 Median:5664.63 stddev:619.95 (10.9%) stddev-sans-first:593.80 07:26:53 INFO - PROCESS | 13154 | Values: 3089.8 3121.5 3136.0 3138.7 3144.7 5340.5 5403.0 5491.1 5500.9 5535.3 5389.1 5458.8 5478.6 5488.1 5488.5 4895.6 4957.7 4985.5 5037.9 5131.4 5077.0 5113.0 5113.7 5155.1 5157.8 4837.8 4874.2 5003.1 5070.8 5073.2 4892.9 4907.9 4929.5 4930.9 4933.6 4884.7 4889.4 4909.2 4989.7 4996.3 5438.3 5446.0 5458.9 5478.1 5481.5 5806.1 5878.0 5882.5 5891.7 5915.1 5880.1 5943.8 5951.6 5953.1 5999.0 5477.5 5528.4 5531.0 5533.7 5537.0 5832.7 5853.7 5882.1 6044.5 6050.2 5655.3 5655.9 5663.5 5664.6 5673.5 5681.8 5741.2 5746.0 5746.5 5759.8 5660.5 5714.0 5767.8 5784.0 5874.0 5842.4 5851.7 5853.6 5853.9 5864.9 4467.1 4467.3 4470.2 4479.0 4505.9 3915.3 3943.8 3970.6 4016.3 4035.1 5577.9 5613.0 5616.8 5624.4 5685.6 5835.3 5878.3 5926.5 5928.7 5950.9 5451.7 5500.8 5547.0 5576.5 5624.9 5087.6 5096.4 5097.9 5113.4 5129.2 6065.7 6076.1 6078.5 6084.4 6089.1 5777.0 5800.0 5832.1 5892.8 5897.0 6010.9 6012.5 6036.6 6076.1 6090.3 5752.0 5756.5 5758.3 5767.7 5772.3 5726.0 5758.7 5794.2 5840.9 5848.6 5708.5 5715.2 5743.1 5757.4 5758.3 5665.9 5701.6 5704.5 5720.6 5724.0 5553.4 5618.2 5653.4 5660.4 5665.4 5840.3 5844.1 5846.7 5868.1 5877.1 5704.6 5705.1 5725.1 5728.1 5729.1 07:26:53 INFO - PROCESS | 13154 | 07:26:53 INFO - PROCESS | 13154 | [#1] ext.html Cycles:180 Average:61725.94 Median:41645.48 stddev:125850.21 (302.2%) stddev-sans-first:126119.43 07:26:53 INFO - PROCESS | 13154 | Values: 550.3 577.6 584.6 599.5 633.6 38424.6 42999.4 43090.8 43142.4 43186.6 41743.6 42384.6 42490.0 42902.1 42925.1 8794.3 8895.1 8921.2 8925.2 8929.3 8855.4 8867.3 8877.0 8896.6 8923.6 8900.7 8953.2 8979.0 9024.1 9026.1 8894.4 8916.6 8922.2 8948.5 8997.7 8648.5 8761.1 8780.9 8799.4 8842.3 41160.0 41594.0 41598.2 41607.0 41614.2 3065.6 3307.1 3332.1 3412.7 3554.6 32517.7 32875.0 33268.0 33631.3 33772.3 4308.9 4435.3 4487.6 4698.7 4708.1 363324.0 363348.0 365951.0 366292.0 366664.2 56220.4 56649.4 56899.0 57056.4 57093.7 35923.0 36661.5 36661.6 59440.0 59685.1 14836.2 15319.4 15419.2 15419.8 15427.6 11858.7 12141.5 12195.6 12238.4 12241.9 18558.7 18737.6 18787.8 18889.7 18959.4 7187.7 7203.6 7266.9 7385.0 7489.1 951.2 1009.9 1050.5 1055.8 1100.4 32583.5 32838.2 33139.7 33163.5 33745.8 1019.7 1063.3 1063.5 1130.0 1155.4 15624.9 16580.7 16675.8 16686.3 16887.2 575674.0 580563.0 582134.0 583565.0 584717.0 56957.7 57558.7 57745.4 57841.7 57849.4 1310.5 1345.4 1355.7 1403.1 1404.6 29491.0 30611.1 30974.7 31437.8 31520.4 48867.0 49545.0 49632.3 49739.5 49746.8 446655.0 448299.0 448949.0 449300.0 449419.0 28038.0 28385.9 28985.6 29189.9 30096.2 47452.3 47898.8 48050.3 48307.5 49303.3 40694.0 41283.6 41450.0 42055.2 43471.8 40956.2 41227.8 41770.0 42016.6 42034.6 40622.0 40800.8 40924.8 41676.8 44463.6 34237.0 36933.0 37360.0 37946.6 38262.0 28329.0 28684.1 28790.0 28896.6 29041.1 07:26:53 INFO - PROCESS | 13154 | 07:26:53 INFO - PROCESS | 13154 | [#2] jquery.html Cycles:180 Average:30044.84 Median:2454.61 stddev:83785.06 (3413.4%) stddev-sans-first:83990.53 07:26:53 INFO - PROCESS | 13154 | Values: 399.6 403.4 413.5 414.4 419.4 18319.0 19928.0 19965.6 20085.7 20108.3 16835.2 18761.6 19122.3 19782.4 19795.3 5863.9 5889.0 6021.2 6035.8 6044.2 5928.6 5948.0 5979.3 5993.3 6022.0 5854.3 5952.9 5966.5 5967.3 6003.5 5725.7 5897.0 5942.0 5985.6 6002.6 5316.5 5318.7 5320.4 5332.3 5336.7 23366.2 23751.5 23885.5 24014.5 24294.9 2442.1 2467.2 2489.4 2588.6 2604.7 14499.2 15237.4 15425.9 15463.8 15626.2 1911.7 1956.8 1988.9 2009.9 2028.5 83828.2 84034.0 84300.0 86430.0 87004.1 9548.9 10035.4 10093.4 10198.5 10250.9 13800.7 13825.3 13853.0 13860.7 13874.8 7389.9 7467.8 7852.5 8063.4 8119.5 7627.4 7636.9 7756.8 7893.7 8016.3 3998.8 4081.1 4224.8 4232.6 4376.9 1963.2 1967.3 2000.9 2033.7 2046.7 932.2 988.6 1031.6 1042.1 1084.2 18641.4 20075.0 21050.9 21147.8 21308.5 995.8 1031.8 1034.3 1043.8 1054.7 10545.4 11466.3 11578.7 11603.3 11633.0 491690.0 502299.0 502654.0 510038.0 531124.0 88734.0 89075.6 95940.5 96171.0 100442.0 1004.3 1052.3 1053.6 1056.9 1059.5 17717.0 18580.6 19303.7 19515.8 19545.2 44049.1 44079.6 44246.6 44587.6 44852.8 61005.4 62747.4 63810.4 63965.7 65310.0 8143.3 8475.4 8529.6 8581.5 9049.5 9878.2 12904.2 13822.9 13858.4 13955.8 11656.0 11668.0 11682.6 11942.5 12140.6 10720.5 10860.6 11135.3 11269.0 11408.2 11160.9 11366.8 11565.4 11818.1 12159.5 8522.2 8633.5 8739.6 8782.4 8926.1 9867.9 11407.3 11576.4 11807.9 11911.6 07:26:53 INFO - PROCESS | 13154 | 07:26:53 INFO - PROCESS | 13154 | [#3] mootools.html Cycles:180 Average:5982.76 Median:2596.75 stddev:3520.61 (135.6%) stddev-sans-first:3514.31 07:26:53 INFO - PROCESS | 13154 | Values: 1491.4 1513.9 1675.3 1804.6 1817.7 8144.9 8794.3 8979.9 9463.9 9474.7 8989.9 9217.0 9267.0 9275.3 9306.9 2364.6 2366.7 2393.7 2399.4 2400.7 2275.1 2327.6 2331.2 2334.9 2345.6 2392.7 2406.4 2406.7 2434.4 2438.2 2328.4 2342.3 2343.1 2350.2 2357.3 2309.6 2323.5 2332.1 2332.4 2333.9 9343.3 9538.9 9540.7 9548.0 9552.5 5249.3 5417.7 5438.3 5439.1 5455.2 3484.1 3521.0 3525.4 3547.6 3580.5 1237.7 1240.8 1253.0 1278.3 1292.4 13021.0 13085.1 13117.5 13140.5 13182.7 4348.7 4659.0 4721.5 4841.5 4852.1 11030.4 11050.6 11060.9 11061.1 11103.1 5297.1 5316.5 5327.0 5346.7 5359.8 4202.0 4750.2 4855.5 4870.6 4930.3 4078.7 4091.0 4179.7 4190.9 4196.5 1295.2 1301.5 1304.8 1321.2 1330.5 912.4 928.3 928.5 930.5 940.4 5760.4 5768.6 5886.8 5917.0 6053.4 466.0 468.4 472.0 476.0 477.3 3761.0 3805.5 3810.1 3833.8 3911.5 11266.7 11608.2 11619.8 11723.5 11748.3 10768.4 11032.1 11208.5 11346.5 11626.2 8437.1 8466.4 8518.7 8642.0 8691.8 6057.3 6111.2 6115.9 6241.8 6363.6 10567.1 10635.6 10660.2 10708.4 10748.1 10542.5 10547.1 10643.4 10788.2 10870.1 7226.2 7404.1 7553.3 8189.6 8319.2 8852.3 8874.8 8878.6 8925.1 8927.0 7903.9 7975.7 7985.3 8099.9 8238.1 7873.8 7877.7 7921.4 8022.2 8056.4 7020.5 7054.2 7128.3 7134.3 7177.4 4838.5 4885.1 4943.9 4975.4 5078.8 4988.6 5001.0 5034.4 5058.7 5168.2 07:26:53 INFO - PROCESS | 13154 | 07:26:53 INFO - PROCESS | 13154 | [#4] prototype.html Cycles:180 Average:4791.70 Median:5410.93 stddev:1422.58 (26.3%) stddev-sans-first:1386.55 07:26:53 INFO - PROCESS | 13154 | Values: 327.5 341.2 346.7 348.1 349.2 5389.8 5435.5 5527.6 5593.4 5594.2 5434.9 5514.4 5541.7 5569.3 5579.4 4364.0 4371.5 4373.7 4378.2 4380.0 4094.3 4281.6 4306.6 4374.1 4375.9 4253.0 4260.1 4271.9 4274.9 4293.3 4264.9 4288.9 4289.5 4292.2 4296.6 3651.8 3739.5 3742.0 3749.3 3751.6 5351.8 5386.3 5409.9 5412.0 5435.1 4917.4 4921.7 4933.2 4946.4 4969.7 5571.3 5701.3 5731.5 5733.7 5816.3 4116.5 4132.4 4140.9 4151.7 4153.4 5878.6 6042.2 6044.5 6045.4 6048.5 4162.2 4176.2 4196.2 4197.7 4232.3 4233.4 4254.5 4270.4 4272.7 4275.4 4849.4 4866.9 4904.8 4907.2 4952.7 5686.6 5739.5 5850.6 5871.7 5879.9 1452.2 1474.4 1476.4 1478.5 1485.3 918.8 937.5 942.3 953.3 959.2 4900.8 4914.2 4939.0 4970.7 4989.4 5185.4 5210.5 5212.0 5256.9 5341.7 4765.3 4944.8 4957.9 4961.6 4973.4 2797.5 2808.3 2813.9 2821.2 2826.9 5363.3 5431.2 5434.0 5441.8 5445.8 5368.0 5477.6 5673.4 6147.0 6162.7 6132.8 6171.1 6186.6 6203.2 6231.4 5734.6 5994.9 5997.2 6004.7 6039.2 5821.4 5892.9 5895.1 5911.3 5915.5 6153.3 6174.5 6215.4 6228.7 6244.2 4109.3 4180.8 4220.3 4233.3 4238.5 5723.5 5773.7 5982.7 6011.3 6014.5 5766.0 5778.8 5799.1 5834.6 5866.7 5833.0 5856.9 5862.4 5872.0 5944.2 5548.8 5689.9 5709.9 5733.0 5757.2 5871.8 5876.1 5888.5 5895.9 5927.7 5619.5 5654.7 5713.2 5785.9 5786.5 07:26:53 INFO - PROCESS | 13154 | 07:26:53 INFO - PROCESS | 13154 | [#5] yui.html Cycles:180 Average:22785.76 Median:4065.04 stddev:34676.61 (853.0%) stddev-sans-first:34734.19 07:26:53 INFO - PROCESS | 13154 | Values: 687.2 701.1 706.2 750.4 772.8 15601.3 16886.0 16951.9 17032.7 17081.5 15579.1 15694.8 15708.1 15717.8 15734.1 776.7 781.8 799.0 804.8 805.3 809.9 813.2 813.3 814.5 815.0 841.6 846.6 848.8 849.1 849.9 835.6 843.1 846.2 846.9 848.3 608.3 611.2 612.1 612.7 612.8 16633.0 16653.3 16691.6 16701.2 16707.6 14706.8 14756.9 14927.5 15151.8 15160.3 12204.0 12379.9 12383.3 12397.2 13176.8 3848.8 3881.0 3983.6 4043.0 4043.1 87574.0 88604.6 91525.0 91728.0 92802.0 10573.1 10617.5 10998.5 11209.1 11462.8 21578.1 21739.7 22022.3 22049.6 22237.2 8215.3 8426.8 8461.1 8470.5 8480.8 4507.3 4527.3 4582.7 4586.7 4683.7 3593.8 3948.4 4087.0 4090.5 4118.6 687.5 694.3 695.4 698.8 716.9 591.8 594.3 614.1 630.0 637.1 9347.9 9419.3 9445.5 9479.6 9679.9 602.6 611.4 626.6 633.7 678.2 4236.7 4507.8 4526.2 4560.3 4602.2 127571.0 128837.0 129651.4 135152.0 139228.0 112834.0 117242.4 117721.0 118376.0 119073.0 98980.0 101311.0 103111.5 104104.5 104807.0 8534.1 8672.4 8725.1 8792.9 8892.0 40383.0 41855.8 48527.5 50053.0 51886.5 75171.6 78028.0 81171.2 81422.6 82423.6 12251.4 12441.4 12454.9 12735.7 12974.9 15706.0 15716.4 15759.8 15829.4 15904.7 14266.0 14290.6 14343.1 14404.2 14627.7 14286.6 14299.6 14321.4 14396.6 14484.4 12351.2 13596.3 13597.5 14125.4 14426.4 10821.5 10902.1 10928.2 11029.9 11330.5 9355.5 10638.4 11061.6 11316.4 11320.2 07:26:53 INFO - PROCESS | 13154 | -------- Summary: end -------- 07:26:53 INFO - PROCESS | 13154 | 07:26:54 INFO - TEST-INFO | 13154: exit 0 07:26:54 INFO - TEST-OK | dromaeo_css | took 1112919ms 07:26:54 INFO - TEST-START | kraken 07:26:54 INFO - operating with platform_type : linux_ 07:26:54 INFO - Initialising browser for kraken test... 07:26:54 INFO - TEST-INFO | started process 13513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgqxJYX/profile http://localhost:50767/getInfo.html) 07:26:59 INFO - PROCESS | 13513 | __metrics Screen width/height:1600/1200 07:26:59 INFO - PROCESS | 13513 | colorDepth:24 07:26:59 INFO - PROCESS | 13513 | Browser inner width/height: 1024/697 07:26:59 INFO - PROCESS | 13513 | __metrics 07:26:59 ERROR - PROCESS | 13513 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 07:27:00 INFO - TEST-INFO | 13513: exit 0 07:27:00 INFO - Browser initialized. 07:27:00 INFO - Running cycle 1/1 for kraken test... 07:27:00 INFO - TEST-INFO | started process 13636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgqxJYX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:11 INFO - PROCESS | 13636 | RSS: Main: 163127296 07:27:11 INFO - PROCESS | 13636 | 07:27:14 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50767/tests/kraken/driver.html?testName=audio-beat-detection) 07:27:15 INFO - PROCESS | 13636 | RSS: Main: 168239104 07:27:15 INFO - PROCESS | 13636 | 07:27:18 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50767/tests/kraken/driver.html?testName=audio-dft) 07:27:18 INFO - PROCESS | 13636 | RSS: Main: 167616512 07:27:18 INFO - PROCESS | 13636 | 07:27:21 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50767/tests/kraken/driver.html?testName=audio-fft) 07:27:22 INFO - PROCESS | 13636 | RSS: Main: 163241984 07:27:22 INFO - PROCESS | 13636 | 07:27:24 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50767/tests/kraken/driver.html?testName=audio-oscillator) 07:27:25 INFO - PROCESS | 13636 | RSS: Main: 164728832 07:27:25 INFO - PROCESS | 13636 | 07:27:27 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50767/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:27:27 INFO - PROCESS | 13636 | RSS: Main: 164601856 07:27:27 INFO - PROCESS | 13636 | 07:27:31 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50767/tests/kraken/driver.html?testName=imaging-darkroom) 07:27:31 INFO - PROCESS | 13636 | RSS: Main: 165150720 07:27:31 INFO - PROCESS | 13636 | 07:27:35 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50767/tests/kraken/driver.html?testName=imaging-desaturate) 07:27:35 INFO - PROCESS | 13636 | RSS: Main: 162205696 07:27:35 INFO - PROCESS | 13636 | 07:27:38 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50767/tests/kraken/driver.html?testName=json-parse-financial) 07:27:39 INFO - PROCESS | 13636 | RSS: Main: 163643392 07:27:39 INFO - PROCESS | 13636 | 07:27:40 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50767/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:27:41 INFO - PROCESS | 13636 | RSS: Main: 164098048 07:27:41 INFO - PROCESS | 13636 | 07:27:43 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50767/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:27:43 INFO - PROCESS | 13636 | RSS: Main: 164143104 07:27:43 INFO - PROCESS | 13636 | 07:27:45 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50767/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:27:46 INFO - PROCESS | 13636 | RSS: Main: 164696064 07:27:46 INFO - PROCESS | 13636 | 07:27:49 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:27:49 INFO - PROCESS | 13636 | RSS: Main: 164462592 07:27:49 INFO - PROCESS | 13636 | 07:27:52 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:27:53 INFO - PROCESS | 13636 | RSS: Main: 164835328 07:27:53 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | Cycle 1(1): loaded http://localhost:50767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50767/tests/kraken/driver.html?testName=ai-astar) 07:27:55 INFO - PROCESS | 13636 | RSS: Main: 165871616 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | __start_tp_report 07:27:55 INFO - PROCESS | 13636 | _x_x_mozilla_page_load 07:27:55 INFO - PROCESS | 13636 | _x_x_mozilla_page_load_details 07:27:55 INFO - PROCESS | 13636 | |i|pagename|runs| 07:27:55 INFO - PROCESS | 13636 | |0;ai-astar;105;111;115;113;112;111;123;112;112;113 07:27:55 INFO - PROCESS | 13636 | |1;audio-beat-detection;151;123;153;178;120;151;156;124;186;121 07:27:55 INFO - PROCESS | 13636 | |2;audio-dft;162;164;163;162;163;184;163;162;163;164 07:27:55 INFO - PROCESS | 13636 | |3;audio-fft;75;75;75;186;76;75;76;76;182;76 07:27:55 INFO - PROCESS | 13636 | |4;audio-oscillator;88;85;155;84;85;86;140;84;84;161 07:27:55 INFO - PROCESS | 13636 | |5;imaging-gaussian-blur;117;122;117;117;118;117;117;117;117;117 07:27:55 INFO - PROCESS | 13636 | |6;imaging-darkroom;146;148;147;147;146;148;147;146;147;148 07:27:55 INFO - PROCESS | 13636 | |7;imaging-desaturate;96;95;96;96;95;95;96;97;95;95 07:27:55 INFO - PROCESS | 13636 | |8;json-parse-financial;51;50;56;52;53;55;51;51;51;58 07:27:55 INFO - PROCESS | 13636 | |9;json-stringify-tinderbox;64;62;61;62;62;62;62;62;62;63 07:27:55 INFO - PROCESS | 13636 | |10;stanford-crypto-aes;87;84;83;81;79;79;82;80;79;80 07:27:55 INFO - PROCESS | 13636 | |11;stanford-crypto-ccm;132;123;141;141;145;128;124;126;152;123 07:27:55 INFO - PROCESS | 13636 | |12;stanford-crypto-pbkdf2;169;165;163;164;165;162;164;160;168;161 07:27:55 INFO - PROCESS | 13636 | |13;stanford-crypto-sha256-iterative;68;66;66;64;67;66;65;65;68;64 07:27:55 INFO - PROCESS | 13636 | __end_tp_report 07:27:55 INFO - PROCESS | 13636 | __start_cc_report 07:27:55 INFO - PROCESS | 13636 | _x_x_mozilla_cycle_collect,864 07:27:55 INFO - PROCESS | 13636 | __end_cc_report 07:27:55 INFO - PROCESS | 13636 | __startTimestamp1471444075282__endTimestamp 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | ------- Summary: start ------- 07:27:55 INFO - PROCESS | 13636 | Number of tests: 14 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.50 stddev:4.45 (4.0%) stddev-sans-first:3.75 07:27:55 INFO - PROCESS | 13636 | Values: 105.0 111.0 115.0 113.0 112.0 111.0 123.0 112.0 112.0 113.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:152.00 stddev:23.89 (15.7%) stddev-sans-first:25.28 07:27:55 INFO - PROCESS | 13636 | Values: 151.0 123.0 153.0 178.0 120.0 151.0 156.0 124.0 186.0 121.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#2] audio-dft Cycles:10 Average:165.00 Median:163.00 stddev:6.72 (4.1%) stddev-sans-first:7.04 07:27:55 INFO - PROCESS | 13636 | Values: 162.0 164.0 163.0 162.0 163.0 184.0 163.0 162.0 163.0 164.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#3] audio-fft Cycles:10 Average:97.20 Median:75.50 stddev:45.76 (60.6%) stddev-sans-first:47.83 07:27:55 INFO - PROCESS | 13636 | Values: 75.0 75.0 75.0 186.0 76.0 75.0 76.0 76.0 182.0 76.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:84.50 stddev:32.72 (38.7%) stddev-sans-first:34.10 07:27:55 INFO - PROCESS | 13636 | Values: 88.0 85.0 155.0 84.0 85.0 86.0 140.0 84.0 84.0 161.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.58 (1.3%) stddev-sans-first:1.66 07:27:55 INFO - PROCESS | 13636 | Values: 117.0 122.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 07:27:55 INFO - PROCESS | 13636 | Values: 146.0 148.0 147.0 147.0 146.0 148.0 147.0 146.0 147.0 148.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 07:27:55 INFO - PROCESS | 13636 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 96.0 97.0 95.0 95.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:52.50 stddev:2.66 (5.1%) stddev-sans-first:2.74 07:27:55 INFO - PROCESS | 13636 | Values: 51.0 50.0 56.0 52.0 53.0 55.0 51.0 51.0 51.0 58.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.79 (1.3%) stddev-sans-first:0.50 07:27:55 INFO - PROCESS | 13636 | Values: 64.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.50 stddev:2.63 (3.2%) stddev-sans-first:1.86 07:27:55 INFO - PROCESS | 13636 | Values: 87.0 84.0 83.0 81.0 79.0 79.0 82.0 80.0 79.0 80.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:136.50 stddev:10.47 (7.7%) stddev-sans-first:11.09 07:27:55 INFO - PROCESS | 13636 | Values: 132.0 123.0 141.0 141.0 145.0 128.0 124.0 126.0 152.0 123.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.50 stddev:2.85 (1.7%) stddev-sans-first:2.40 07:27:55 INFO - PROCESS | 13636 | Values: 169.0 165.0 163.0 164.0 165.0 162.0 164.0 160.0 168.0 161.0 07:27:55 INFO - PROCESS | 13636 | 07:27:55 INFO - PROCESS | 13636 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.45 (2.2%) stddev-sans-first:1.32 07:27:55 INFO - PROCESS | 13636 | Values: 68.0 66.0 66.0 64.0 67.0 66.0 65.0 65.0 68.0 64.0 07:27:55 INFO - PROCESS | 13636 | -------- Summary: end -------- 07:27:55 INFO - PROCESS | 13636 | 07:27:56 INFO - TEST-INFO | 13636: exit 0 07:27:56 INFO - TEST-OK | kraken | took 61558ms 07:27:56 INFO - SUITE-END | took 1174s 07:27:56 INFO - Completed test suite (00:19:34) 07:27:56 INFO - javascript benchmark 07:27:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7356.589165117784, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.752819774418, 3121.5005599104147, 3135.999999999999, 3138.6861313868603, 3144.6855314468557, 5340.519353258206, 5402.972985135074, 5491.148871924853, 5500.917486237709, 5535.25274087998, 5389.083855744523, 5458.754356053977, 5478.643888147278, 5488.1493368527845, 5488.4785945335125, 4895.583875370588, 4957.702537847741, 4985.476524964881, 5037.874053148682, 5131.4098878629065, 5076.974615126937, 5113.0, 5113.744312784346, 5155.097857874857, 5157.819476318329, 4837.758112094381, 4874.2444921037295, 5003.124453220708, 5070.771815268304, 5073.239014147871, 4892.926606100911, 4907.9263811042865, 4929.482404347527, 4930.852074437773, 4933.555979961785, 4884.658073934826, 4889.413270407538, 4909.239067944474, 4989.65072444929, 4996.2755400467095, 5438.293021907127, 5446.0, 5458.918116228259, 5478.123500239983, 5481.451854814526, 5806.1000544915605, 5877.975452209192, 5882.499987501067, 5891.705414729289, 5915.053591425394, 5880.059190529495, 5943.821685349403, 5951.553633477506, 5953.13679516472, 5999.040153575451, 5477.452254774531, 5528.44715528448, 5531.0, 5533.6956467393875, 5537.0, 5832.737526811304, 5853.707314634251, 5882.117682347682, 6044.486218671374, 6050.213472248667, 5655.321361436654, 5655.858603534944, 5663.546916246691, 5664.631798933056, 5673.489385955284, 5681.829545113571, 5741.224934633855, 5746.02317606008, 5746.454086861741, 5759.827205183851, 5660.490555849993, 5714.000049991235, 5767.769289228468, 5784.0, 5873.970630146822, 5842.357340692605, 5851.707414629252, 5853.560982926298, 5853.88292234153, 5864.912026319608, 4467.061916997467, 4467.285234362552, 4470.2177119004045, 4478.977605111953, 4505.909881802346, 3915.295246855593, 3943.8028098594955, 3970.563238043813, 4016.2971479990883, 4035.1122752994293, 5577.860553486195, 5612.989661860823, 5616.803411880564, 5624.437556244425, 5685.60200785941, 5835.270591176103, 5878.3239927408895, 5926.525877929756, 5928.7332070056955, 5950.851228719317, 5451.727413629382, 5500.7524661390335, 5547.0, 5576.498115169654, 5624.943750562442, 5087.618428617869, 5096.439391666913, 5097.898042039213, 5113.386393632788, 5129.153689641242, 6065.696715164224, 6076.118962750465, 6078.483328917092, 6084.361142080106, 6089.086637004485, 5776.960147173381, 5800.0, 5832.096025116114, 5892.823215303548, 5897.026990546683, 6010.879782404415, 6012.488938440281, 6036.63780173191, 6076.058210977306, 6090.330063693079, 5752.0, 5756.453136951983, 5758.2514273144225, 5767.653940763567, 5772.278465191851, 5725.971370143123, 5758.712064396847, 5794.159846822272, 5840.94159058404, 5848.590598658223, 5708.5147762439, 5715.199872018004, 5743.1385292206505, 5757.395473475225, 5758.309002919509, 5665.886682266414, 5701.572382071444, 5704.515116215168, 5720.599558030898, 5723.971380143073, 5553.361363443094, 5618.2134501170685, 5653.378128405954, 5660.433956604306, 5665.405132461032, 5840.269966254218, 5844.064949608042, 5846.707664616667, 5868.149118377897, 5877.089051197071, 5704.629199102045, 5705.087186050212, 5725.055365864752, 5728.140778883034, 5729.140628905698], "value": 5397.651978641582, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.2751375687845, 577.630316597378, 584.6346033728919, 599.4574909706715, 633.5660072850095, 38424.61575384245, 42999.355009674844, 43090.7845460773, 43142.352864707056, 43186.568134318644, 41743.58256417435, 42384.57615423845, 42490.0, 42902.141957160915, 42925.141497170036, 8794.252488538483, 8895.066018068106, 8921.197092261695, 8925.152110549487, 8929.330300227477, 8855.424397414148, 8867.290616750677, 8877.0, 8896.599653015597, 8923.598438070303, 8900.73297801067, 8953.194212520872, 8978.955105224464, 9024.14270644291, 9026.142516460926, 8894.42186257891, 8916.643334266622, 8922.241609463203, 8948.463092214488, 8997.685081022166, 8648.481091134552, 8761.08008659088, 8780.868286975701, 8799.384043116985, 8842.292616590657, 41160.0, 41594.0, 41598.1680366394, 41607.0, 41614.1677166455, 3065.6167979002626, 3307.074019274583, 3332.0836769888233, 3412.7269818414466, 3554.626764189749, 32517.67482325194, 32875.0, 33268.03917649415, 33631.3273734524, 33772.32455350879, 4308.870733877989, 4435.334699795024, 4487.573680500347, 4698.718076915396, 4708.10545996263, 363324.0, 363348.0, 365951.0, 366292.0, 366664.16667916754, 56220.43779562234, 56649.43350566524, 56899.0, 57056.42943570511, 57093.714531427075, 35923.0, 36661.45007824885, 36661.63338366582, 59440.0, 59685.104723429184, 14836.18400987956, 15319.387224511118, 15419.151946643042, 15419.768703469457, 15427.614309642124, 11858.703532411759, 12141.514339426501, 12195.573154939535, 12238.388080595934, 12241.938790306169, 18558.721619175452, 18737.596664783763, 18787.812121878607, 18889.7166542502, 18959.43121706351, 7187.676554555058, 7203.567785932861, 7266.92733072673, 7385.03994480714, 7489.138749043821, 951.2247518272586, 1009.9343542669703, 1050.4905121016302, 1055.7518983038979, 1100.4387762241315, 32583.51124733131, 32838.179045523575, 33139.66860331414, 33163.50254746181, 33745.83127084349, 1019.6533178719271, 1063.3301020357126, 1063.4982662504983, 1129.9830502542468, 1155.364549497773, 15624.921875390777, 16580.668386632442, 16675.83324166767, 16686.332546697995, 16887.240074196692, 575674.0, 580563.0, 582134.0, 583565.0, 584717.0, 56957.715211423674, 57558.7122064387, 57745.42254577485, 57841.71079144662, 57849.42150578524, 1310.4627102887962, 1345.381124682657, 1355.728854229158, 1403.0739711789965, 1404.6067101211677, 29491.0, 30611.065153040767, 30974.69025309808, 31437.842810785798, 31520.36959260756, 48867.0, 49545.0, 49632.255516166566, 49739.50260497349, 49746.75126624344, 446655.0, 448299.0, 448949.0, 449300.0, 449419.0, 28038.0, 28385.858070709513, 28985.565216521347, 29189.85405072961, 30096.24759381033, 47452.288215676104, 47898.76050619724, 48050.27924581204, 48307.5169248303, 49303.260451092545, 40694.0, 41283.587164127974, 41450.0, 42055.15889682128, 43471.78264108659, 40956.18087638171, 41227.79386103051, 41770.0, 42016.579834201264, 42034.579654203066, 40622.0, 40800.79599601983, 40924.79537602293, 41676.79161604172, 44463.55536444724, 34237.0, 36933.0, 37360.0, 37946.620533795416, 38262.0, 28329.0, 28684.13947581576, 28790.0, 28896.566551501324, 29041.128766137048], "value": 19931.839631765186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.6143721308936, 403.36067333276776, 413.51825123730856, 414.44878311845247, 419.4002576315869, 18319.0, 19928.003599819986, 19965.600687986233, 20085.698714519276, 20108.296209632666, 16835.242414091364, 18761.624767504643, 19122.33071842486, 19782.40652780419, 19795.307164249218, 5863.941360586404, 5889.0, 6021.187139736124, 6035.788747393842, 6044.214252147215, 5928.614640048405, 5948.0, 5979.312379076418, 5993.250843644544, 6021.9698901505435, 5854.268216472941, 5952.88094238115, 5966.46301832835, 5967.343592204854, 6003.549733769963, 5725.685087320196, 5897.0, 5941.970290148543, 5985.5810093293485, 6002.609830361034, 5316.494932981361, 5318.7074710891275, 5320.388155362144, 5332.2801421808335, 5336.679799212021, 23366.182183623492, 23751.524969500515, 23885.522289554287, 24014.519709605884, 24294.87852560726, 2442.05980697431, 2467.161165203839, 2489.427431690703, 2588.637590737298, 2604.67971151515, 14499.176523431672, 15237.390504379811, 15425.922870385688, 15463.768043479356, 15626.218689065501, 1911.671388385073, 1956.7651881774277, 1988.9104990275473, 2009.8744702966385, 2028.4725971247435, 83828.16171838326, 84033.99999999939, 84300.0, 86430.0, 87004.12995870023, 9548.856767148498, 10035.448050357154, 10093.444860532742, 10198.541065652063, 10250.948745256375, 13800.654983625489, 13825.308734563232, 13853.030287879752, 13860.722785544434, 13874.791878121836, 7389.889151662729, 7467.775966721007, 7852.489588176751, 8063.395245356504, 8119.47223430487, 7627.351675107678, 7636.885446718304, 7756.844863102707, 7893.723719669784, 8016.31861291785, 3998.8400463981698, 4081.142959978438, 4224.831006759757, 4232.6190642841675, 4376.868693939187, 1963.2049020146862, 1967.3114409956402, 2000.909959051817, 2033.7152798608206, 2046.6827641715558, 932.1563984593953, 988.5749127874939, 1031.582209205273, 1042.1298215989734, 1084.1651928015383, 18641.44075677732, 20075.0, 21050.894745526482, 21147.78852211458, 21308.467288317916, 995.7709726762885, 1031.8400647899587, 1034.3121823986965, 1043.8121138195197, 1054.7257712994676, 10545.367277963347, 11466.31202127875, 11578.710532236593, 11603.303801771921, 11633.0, 491690.0, 502299.0, 502654.0, 510038.0, 531124.0, 88734.0, 89075.55462222647, 95940.52029739946, 96171.0, 100442.0, 1004.2819384140374, 1052.3317693264833, 1053.6206965492418, 1056.857324261215, 1059.4755595979884, 17717.0, 18580.628387432447, 19303.710444343626, 19515.804841951398, 19545.21819127219, 44049.119017618825, 44079.559204408826, 44246.557534425534, 44587.55412445964, 44852.77573612111, 61005.38994609997, 62747.37252627415, 63810.36189638044, 63965.68017159885, 65310.02034969574, 8143.267105960492, 8475.364347674073, 8529.635258358632, 8581.528015959182, 9049.457032578066, 9878.221240574057, 12904.16122952005, 13822.86177138256, 13858.445662173803, 13955.790663140264, 11656.0, 11668.008219301455, 11682.649520514398, 11942.522299107939, 12140.575079872162, 10720.463976800973, 10860.619878304222, 11135.33188008722, 11269.0, 11408.201425900439, 11160.888391115985, 11366.772664546828, 11565.421728913689, 11818.054555635701, 12159.452824622736, 8522.190391912758, 8633.525156116222, 8739.606717697592, 8782.419164550187, 8926.107389261022, 9867.851982220416, 11407.315561066363, 11576.363300018244, 11807.940960295144, 11911.642650720492], "value": 9425.657353463032, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.433255362962, 1513.931873065712, 1675.2880025988952, 1804.6029873427842, 1817.7364282179092, 8144.91855081449, 8794.252488538474, 8979.865302020458, 9463.858042129365, 9474.715758527247, 8989.865152022725, 9217.0, 9267.0, 9275.30435217358, 9306.906930930689, 2364.6453032045247, 2366.7278262999716, 2393.7366889642212, 2399.3761621978238, 2400.699912510936, 2275.1354485295565, 2327.5810354136247, 2331.19573747057, 2334.871582062986, 2345.6012477878717, 2392.6650268962358, 2406.3502854229346, 2406.6750988616486, 2434.4157402223427, 2438.219769673696, 2328.441174118216, 2342.273895092518, 2343.121329501437, 2350.2126787526286, 2357.2574638988663, 2309.572729045132, 2323.512062466867, 2332.148765700524, 2332.3935776698013, 2333.8599684019014, 9343.345965782399, 9538.856917146248, 9540.713778586654, 9548.045195480467, 9552.474613896233, 5249.317588713443, 5417.702026388547, 5438.320209973754, 5439.129739241703, 5455.1544510600925, 3484.0593039879345, 3521.049316684481, 3525.383057964846, 3547.6452354764574, 3580.4987301777774, 1237.665830225834, 1240.820081088246, 1252.956146534876, 1278.284160869916, 1292.4248709324354, 13021.0, 13085.084044116915, 13117.540886068942, 13140.474381024747, 13182.67043323915, 4348.673849461303, 4658.976705116453, 4721.527847215251, 4841.467438581753, 4852.053849499313, 11030.44847757625, 11050.56342675447, 11060.944695276634, 11061.059809916087, 11103.111751059896, 5297.073012222922, 5316.494932981361, 5326.97336513315, 5346.732663366816, 5359.758810853521, 4202.0, 4750.216214324598, 4855.465898751135, 4870.634702397334, 4930.334404855299, 4078.69643934822, 4091.0181556426837, 4179.665626749853, 4190.916181676349, 4196.51740049892, 1295.1581472043247, 1301.5184381778802, 1304.804279358104, 1321.2468892731051, 1330.5210124355224, 912.4342907397323, 928.331601247101, 928.5078908178676, 930.5021813329836, 940.4122423485321, 5760.423957604206, 5768.567357448208, 5886.80372343075, 5916.970415147983, 6053.424924632153, 466.0, 468.42617793203055, 471.9805220723221, 476.04077783266746, 477.257864021443, 3760.981195094007, 3805.5052843130215, 3810.1427178885083, 3833.8274777635074, 3911.530616326002, 11266.66200014001, 11608.24546404481, 11619.825702614467, 11723.472443740053, 11748.29510229389, 10768.3538987661, 11032.117430605533, 11208.495617697223, 11346.48940797666, 11626.186166968231, 8437.114103019218, 8466.365022623328, 8518.722191671175, 8641.956790216009, 8691.826163476822, 6057.333693293822, 6111.205543279345, 6115.877682446415, 6241.812745617639, 6363.61818290904, 10567.101796347397, 10635.627753028606, 10660.200484963814, 10708.411037393018, 10748.140148788234, 10542.472876356305, 10547.103496202908, 10643.414612196404, 10788.244822862323, 10870.130389568658, 7226.205117437183, 7404.074490688664, 7553.282438168365, 8189.631466583899, 8319.168083191633, 8852.336074794544, 8874.822503550022, 8878.644854205759, 8925.062868398725, 8926.955365223132, 7903.881441778263, 7975.72084977023, 7985.321247694011, 8099.878501822595, 8238.09380968105, 7873.803154920944, 7877.724279650414, 7921.366290696616, 8022.237887400687, 8056.355491560778, 7020.473464490286, 7054.153501579844, 7128.251533588898, 7134.32223938725, 7177.425805935408, 4838.491958344323, 4885.1206782779445, 4943.925841112458, 4975.402951645681, 5078.796848126033, 4988.600911926965, 5000.999800040079, 5034.395872495324, 5058.747062646927, 5168.198929165986], "value": 4673.500000428772, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.49864356905084, 341.1947803184485, 346.7347479178428, 348.0654442821026, 349.22297887200995, 5389.78440862365, 5435.510804027636, 5527.640703354279, 5593.356763972144, 5594.188842617818, 5434.864128396792, 5514.36584792749, 5541.695206763627, 5569.331680198372, 5579.386267510581, 4364.014373460068, 4371.475422949251, 4373.737575745449, 4378.16814805186, 4379.956200438002, 4094.303968325392, 4281.550437204095, 4306.590873866978, 4374.147041326943, 4375.868723938271, 4253.0, 4260.1266740318315, 4271.893202669927, 4274.893127671818, 4293.313069908815, 4264.936025959613, 4288.914221715549, 4289.506706728719, 4292.184484947881, 4296.613304802583, 3651.835667394974, 3739.4951681522916, 3741.9625803741887, 3749.3438648236724, 3751.587325394232, 5351.759170837322, 5386.272853164812, 5409.890142844254, 5411.972940135313, 5435.10320797068, 4917.4344950330815, 4921.655484116113, 4933.161362568336, 4946.431160416562, 4969.701817890938, 5571.275734154575, 5701.344345400291, 5731.478149614157, 5733.713314334308, 5816.302043754777, 4116.485439320085, 4132.359484279941, 4140.855070072533, 4151.730137541081, 4153.356229784388, 5878.61788983719, 6042.214512113441, 6044.516438684895, 6045.425684559959, 6048.455638992512, 4162.167566486714, 4176.206520761107, 4196.223698615766, 4197.727147735449, 4232.343986682069, 4233.407322974725, 4254.510921177563, 4270.402143699885, 4272.722273052242, 4275.40144379787, 4849.369581954324, 4866.904946387105, 4904.803807847647, 4907.2393778964315, 4952.653314267966, 5686.57350698691, 5739.454751798572, 5850.648961062265, 5871.677057761779, 5879.882402352015, 1452.157748505864, 1474.4470823441209, 1476.3799204334205, 1478.4825311141014, 1485.3390241342715, 918.8024574716468, 937.4937533731709, 942.3356533643764, 953.3183773601908, 959.1942768074712, 4900.803967841318, 4914.20631469511, 4939.0, 4970.652054356233, 4989.401271847329, 5185.351831021122, 5210.452902445264, 5212.035773381936, 5256.894862102813, 5341.706206158621, 4765.26138448541, 4944.777485013183, 4957.900841983213, 4961.603071754251, 4973.403191617029, 2797.5244208484605, 2808.2838876086876, 2813.9437211256068, 2821.224163355053, 2826.901058462944, 5363.329583802025, 5431.21247419122, 5433.9675461662155, 5441.782328706887, 5445.829146733471, 5368.0, 5477.561795056386, 5673.390240489339, 6146.969265153735, 6162.691865406712, 6132.78535251264, 6171.13604095427, 6186.556310257423, 6203.2245969253845, 6231.4391704746795, 5734.569907257056, 5994.880102398015, 5997.190379298739, 6004.669743164168, 6039.184710064085, 5821.417858214145, 5892.94107058924, 5895.056790913433, 5911.349751527415, 5915.497182739516, 6153.2616086068165, 6174.506039516738, 6215.409536094245, 6228.719707613078, 6244.219472565929, 4109.3357190337965, 4180.832766689298, 4220.261454245556, 4233.322668373045, 4238.491381034172, 5723.542116630576, 5773.682447465262, 5982.670953097621, 6011.27864656244, 6014.548908831943, 5766.0, 5778.8266352009505, 5799.057315799255, 5834.620749651259, 5866.7066646668345, 5832.96685723413, 5856.94143058564, 5862.355140934579, 5872.001759700946, 5944.197533332945, 5548.805791797267, 5689.894738946617, 5709.942900570941, 5733.0, 5757.165211044291, 5871.794487192928, 5876.147958546072, 5888.526818736055, 5895.882082358243, 5927.673977931255, 5619.466150715675, 5654.745536450787, 5713.228714123707, 5785.9132113017495, 5786.450287222707], "value": 4337.44102940129, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.2371667449131, 701.0710808179164, 706.1737766812829, 750.4259241680112, 772.7758949904528, 15601.297941592627, 16886.0, 16951.91524042378, 17032.659346813056, 17081.487555373344, 15579.065256084643, 15694.843051569482, 15708.136052517108, 15717.764233536505, 15734.055956642609, 776.6815605601704, 781.812365032391, 799.0491315334733, 804.8470790549777, 805.2551389964289, 809.9392545559077, 813.1989989860012, 813.3168138763438, 814.5316443045243, 814.9592520373988, 841.6254766628853, 846.5640195299426, 848.8387206430789, 849.0617867256685, 849.9277561407257, 835.6197929941892, 843.1357858195338, 846.1538461538462, 846.932245420368, 848.2620120495178, 608.2579253310954, 611.1596554737237, 612.1185492890223, 612.6936531734133, 612.7732738886596, 16633.002019878844, 16653.33386664532, 16691.582710432216, 16701.164941752984, 16707.582310442216, 14706.779398309034, 14756.852431475656, 14927.477538286217, 15151.772723409158, 15160.31778569967, 12204.0, 12379.938100309531, 12383.318917459535, 12397.194182378116, 13176.802347964789, 3848.8460461581503, 3881.0, 3983.6215559521797, 4043.0, 4043.1307268937026, 87574.0, 88604.5569772147, 91525.0, 91728.0, 92802.0, 10573.101286390589, 10617.522211500502, 10998.450077496253, 11209.103271738242, 11462.828057579143, 21578.136874525157, 21739.67390489144, 22022.33932981981, 22049.559008819735, 22237.22169724052, 8215.260626543639, 8426.789330266793, 8461.111583283666, 8470.49177049379, 8480.787980300418, 4507.301368287921, 4527.320901864747, 4582.656300777388, 4586.747728874877, 4683.672142949961, 3593.82030898454, 3948.4274780156716, 4086.959130408658, 4090.4886889138857, 4118.588141185917, 687.4878215729314, 694.3265032918061, 695.4158506854166, 698.8462538241579, 716.9283071692894, 591.8106206014035, 594.3462191589217, 614.1034090228228, 629.9653519056496, 637.0985056145595, 9347.859782103274, 9419.293552983554, 9445.535941928874, 9479.573419196153, 9679.903200968041, 602.599271484458, 611.4344231585766, 626.6083697688945, 633.6926590603554, 678.2302087131043, 4236.745795252295, 4507.8196872124745, 4526.23054080807, 4560.293154561048, 4602.217623004098, 127571.0, 128837.0, 129651.35174324257, 135152.0, 139228.0, 112834.0, 117242.41378793222, 117721.0, 118376.0, 119073.0, 98980.0, 101311.0, 103111.4844425773, 104104.47947760364, 104807.0, 8534.06125326226, 8672.436291641023, 8725.127487251479, 8792.912070879465, 8892.0, 40383.0, 41855.7907210462, 48527.51472485371, 50053.0, 51886.481135188165, 75171.62414187894, 78028.0, 81171.18828811872, 81422.59288703519, 82423.58788206261, 12251.448684809384, 12441.440135193758, 12454.937725311316, 12735.681607959505, 12974.870251297367, 15706.0, 15716.449924252596, 15759.763603546186, 15829.445969391476, 15904.681906361577, 14266.0, 14290.57128286153, 14343.067700599428, 14404.207768572829, 14627.707445851236, 14286.571402857931, 14299.57101286963, 14321.427142914166, 14396.640083997565, 14484.420623174956, 12351.19717218378, 13596.252206128758, 13597.456101755819, 14125.43498260058, 14426.350814213176, 10821.458927053773, 10902.087252530859, 10928.180386470887, 11029.944850275697, 11330.546778128783, 9355.53222338894, 10638.41488718128, 11061.612843550438, 11316.434178291218, 11320.150988676047], "value": 7710.380181305299, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 115.0, 113.0, 112.0, 111.0, 123.0, 112.0, 112.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 123.0, 153.0, 178.0, 120.0, 151.0, 156.0, 124.0, 186.0, 121.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 162.0, 163.0, 184.0, 163.0, 162.0, 163.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 186.0, 76.0, 75.0, 76.0, 76.0, 182.0, 76.0], "value": 97.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 155.0, 84.0, 85.0, 86.0, 140.0, 84.0, 84.0, 161.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 122.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 97.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 56.0, 52.0, 53.0, 55.0, 51.0, 51.0, 51.0, 58.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 83.0, 81.0, 79.0, 79.0, 82.0, 80.0, 79.0, 80.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 141.0, 141.0, 145.0, 128.0, 124.0, 126.0, 152.0, 123.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 163.0, 164.0, 165.0, 162.0, 164.0, 160.0, 168.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 64.0, 67.0, 66.0, 65.0, 65.0, 68.0, 64.0], "value": 65.9, "unit": "score"}]}]} 07:27:56 INFO - Return code: 0 07:27:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:27:56 ERROR - # TBPL SUCCESS # 07:27:56 INFO - Running post-action listener: _resource_record_post_action 07:27:56 INFO - [mozharness: 2016-08-17 14:27:56.588240Z] Finished run-tests step (success) 07:27:56 INFO - Running post-run listener: _resource_record_post_run 07:27:56 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 409448448; Read time: 0; Write time: 307088 07:27:56 INFO - TinderboxPrint: CPU usage
13.4% 07:27:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:27:56 INFO - TinderboxPrint: I/O write bytes / time
409,448,448 / 307,088 07:27:56 INFO - TinderboxPrint: CPU idle
8,235.1 (86.6%) 07:27:56 INFO - TinderboxPrint: CPU user
1,218.4 (12.8%) 07:27:56 INFO - TinderboxPrint: Swap in / out
0 / 0 07:27:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118251520; Read time: 0; Write time: 106352 07:27:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290852864; Read time: 0; Write time: 200732 07:27:57 INFO - Running post-run listener: _upload_blobber_files 07:27:57 INFO - Blob upload gear active. 07:27:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:27:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:27:57 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'] 07:27:57 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 07:27:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:27:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:27:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:58 INFO - (blobuploader) - INFO - Done attempting. 07:27:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:27:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:28:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:02 INFO - (blobuploader) - INFO - Done attempting. 07:28:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:28:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:03 INFO - (blobuploader) - INFO - Done attempting. 07:28:03 INFO - (blobuploader) - INFO - Iteration through files over. 07:28:03 INFO - Return code: 0 07:28:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:28:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:28:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb04e01c70214348e685f0d8eca47835735b21d83d89b925a5394273a1852d57a568f6aff7ce2ffd6eccba006b6a6ab38f4c2b0a854e5a176bbaa2fa2db5e101", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/425c6fc850d2681d0f9f683037840dbd41e227758c3d409a3ab22d75905e68b8645dde9d2f5bc4fa114e615aa08defe99db7d58266d93b7d98d1163de73f171a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2df876d0619ff8c3e87ad21a1935a25e4cb85558186d951a0395fe64922d93b179d4c2bedd58c450ce12f5825a2f78ebb631a3bd69ed8282b538bcd1445872e1"} 07:28:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:28:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:28:03 INFO - Contents: 07:28:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fb04e01c70214348e685f0d8eca47835735b21d83d89b925a5394273a1852d57a568f6aff7ce2ffd6eccba006b6a6ab38f4c2b0a854e5a176bbaa2fa2db5e101", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/425c6fc850d2681d0f9f683037840dbd41e227758c3d409a3ab22d75905e68b8645dde9d2f5bc4fa114e615aa08defe99db7d58266d93b7d98d1163de73f171a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2df876d0619ff8c3e87ad21a1935a25e4cb85558186d951a0395fe64922d93b179d4c2bedd58c450ce12f5825a2f78ebb631a3bd69ed8282b538bcd1445872e1"} 07:28:03 INFO - Running post-run listener: copy_logs_to_upload_dir 07:28:03 INFO - Copying logs to upload dir... 07:28:03 INFO - mkdir: /builds/slave/test/build/upload/logs 07:28:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.800901 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-17 07:28:03.130051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 07:28:03.134068) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541 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/fb04e01c70214348e685f0d8eca47835735b21d83d89b925a5394273a1852d57a568f6aff7ce2ffd6eccba006b6a6ab38f4c2b0a854e5a176bbaa2fa2db5e101", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/425c6fc850d2681d0f9f683037840dbd41e227758c3d409a3ab22d75905e68b8645dde9d2f5bc4fa114e615aa08defe99db7d58266d93b7d98d1163de73f171a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2df876d0619ff8c3e87ad21a1935a25e4cb85558186d951a0395fe64922d93b179d4c2bedd58c450ce12f5825a2f78ebb631a3bd69ed8282b538bcd1445872e1"} build_url:https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/W4ujJXYfQ265ldJ7kg8Onw/artifacts/public/build/firefox-51.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/fb04e01c70214348e685f0d8eca47835735b21d83d89b925a5394273a1852d57a568f6aff7ce2ffd6eccba006b6a6ab38f4c2b0a854e5a176bbaa2fa2db5e101", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/425c6fc850d2681d0f9f683037840dbd41e227758c3d409a3ab22d75905e68b8645dde9d2f5bc4fa114e615aa08defe99db7d58266d93b7d98d1163de73f171a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2df876d0619ff8c3e87ad21a1935a25e4cb85558186d951a0395fe64922d93b179d4c2bedd58c450ce12f5825a2f78ebb631a3bd69ed8282b538bcd1445872e1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 07:28:03.168036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 07:28:03.168421) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1471437416.549043-1845828541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 07:28:03.249740) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 07:28:03.250115) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 07:28:03.250533) ========= ========= Total master_lag: 0.19 =========