builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1470695964.32 results: success (0) buildid: 20160808135726 builduid: 96d5b165200a41dbb2639bc91c6b7057 revision: d1274a312b6b21d58c94357c2cccf78fb13af9c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:24.318183) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:24.319654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:24.319952) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:24.337131) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:24.337483) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 15:39: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% 226M=0s 2016-08-08 15:39:24 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123962 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:24.475524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:24.475880) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019440 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:24.524855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 15:39:24.525227) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d1274a312b6b21d58c94357c2cccf78fb13af9c2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev d1274a312b6b21d58c94357c2cccf78fb13af9c2 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 15:39:25,030 truncating revision to first 12 chars 2016-08-08 15:39:25,030 Setting DEBUG logging. 2016-08-08 15:39:25,030 attempt 1/10 2016-08-08 15:39:25,030 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d1274a312b6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 15:39:26,358 unpacking tar archive at: autoland-d1274a312b6b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.651415 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 15:39:26.191799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:26.192122) ========= script_repo_revision: d1274a312b6b21d58c94357c2cccf78fb13af9c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:26.192623) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:26.192991) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 15:39:26.203075) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-08-08 15:39:26.203491) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:39:26 INFO - MultiFileLogger online at 20160808 15:39:26 in /builds/slave/test 15:39:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 15:39:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:26 INFO - {'append_to_log': False, 15:39:26 INFO - 'base_work_dir': '/builds/slave/test', 15:39:26 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:39:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:26 INFO - 'branch': 'Autoland-Non-PGO', 15:39:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:26 INFO - 'config_files': ('talos/linux_config.py',), 15:39:26 INFO - 'default_actions': ('clobber', 15:39:26 INFO - 'read-buildbot-config', 15:39:26 INFO - 'download-and-extract', 15:39:26 INFO - 'populate-webroot', 15:39:26 INFO - 'create-virtualenv', 15:39:26 INFO - 'install', 15:39:26 INFO - 'run-tests'), 15:39:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:26 INFO - 'download_minidump_stackwalk': True, 15:39:26 INFO - 'download_symbols': 'ondemand', 15:39:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:39:26 INFO - 'tooltool.py': '/tools/tooltool.py', 15:39:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:39:26 INFO - '/tools/misc-python/virtualenv.py')}, 15:39:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:26 INFO - 'installer_path': 'installer.exe', 15:39:26 INFO - 'log_level': 'info', 15:39:26 INFO - 'log_name': 'talos', 15:39:26 INFO - 'log_to_console': True, 15:39:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:39:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:39:26 INFO - 'opt_config_files': (), 15:39:26 INFO - 'pip_index': False, 15:39:26 INFO - 'sps_profile': False, 15:39:26 INFO - 'sps_profile_interval': 0, 15:39:26 INFO - 'suite': 'dromaeojs-e10s', 15:39:26 INFO - 'system_bits': '32', 15:39:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:26 INFO - 'title': 'talos-linux64-ix-041', 15:39:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:26 INFO - 'use_talos_json': True, 15:39:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:26 INFO - 'work_dir': 'build'} 15:39:26 INFO - [mozharness: 2016-08-08 22:39:26.808361Z] Running clobber step. 15:39:26 INFO - Running pre-action listener: _resource_record_pre_action 15:39:26 INFO - Running main action method: clobber 15:39:26 INFO - rmtree: /builds/slave/test/build 15:39:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:27 INFO - Running post-action listener: _resource_record_post_action 15:39:27 INFO - [mozharness: 2016-08-08 22:39:27.267781Z] Finished clobber step (success) 15:39:27 INFO - [mozharness: 2016-08-08 22:39:27.267881Z] Running read-buildbot-config step. 15:39:27 INFO - Running pre-action listener: _resource_record_pre_action 15:39:27 INFO - Running main action method: read_buildbot_config 15:39:27 INFO - Using buildbot properties: 15:39:27 INFO - { 15:39:27 INFO - "project": "", 15:39:27 INFO - "product": "firefox", 15:39:27 INFO - "script_repo_revision": "production", 15:39:27 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:39:27 INFO - "repository": "", 15:39:27 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 15:39:27 INFO - "buildid": "20160808135726", 15:39:27 INFO - "pgo_build": "False", 15:39:27 INFO - "basedir": "/builds/slave/test", 15:39:27 INFO - "buildnumber": 245, 15:39:27 INFO - "slavename": "talos-linux64-ix-041", 15:39:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:39:27 INFO - "platform": "ubuntu64_hw", 15:39:27 INFO - "scheduler": "tests-autoland-linux64-talos", 15:39:27 INFO - "branch": "autoland", 15:39:27 INFO - "repo_path": "integration/autoland", 15:39:27 INFO - "revision": "d1274a312b6b21d58c94357c2cccf78fb13af9c2", 15:39:27 INFO - "stage_platform": "linux64", 15:39:27 INFO - "builduid": "96d5b165200a41dbb2639bc91c6b7057", 15:39:27 INFO - "slavebuilddir": "test" 15:39:27 INFO - } 15:39:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:39:27 INFO - Running post-action listener: _resource_record_post_action 15:39:27 INFO - [mozharness: 2016-08-08 22:39:27.270310Z] Finished read-buildbot-config step (success) 15:39:27 INFO - [mozharness: 2016-08-08 22:39:27.270398Z] Running download-and-extract step. 15:39:27 INFO - Running pre-action listener: _resource_record_pre_action 15:39:27 INFO - Running main action method: download_and_extract 15:39:27 INFO - mkdir: /builds/slave/test/build/tests 15:39: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')]} 15:39:27 INFO - trying https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:39:27 INFO - Downloading https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 15:39:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 15:39:27 INFO - Downloaded 1361 bytes. 15:39:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:39:27 INFO - Using the following test package requirements: 15:39:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:39:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:39:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'jsshell-linux-x86_64.zip'], 15:39:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:39:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:39:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:39:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:39:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:39:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:39:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:39:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:39: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')]} 15:39:27 INFO - trying https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:39:27 INFO - Downloading https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 15:39:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 15:39:28 INFO - Downloaded 20258190 bytes. 15:39:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:39:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:39:29 INFO - Return code: 0 15:39:29 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 15:39:30 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')]} 15:39:30 INFO - trying https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:39:30 INFO - Downloading https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 15:39:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 15:39:31 INFO - Downloaded 20258190 bytes. 15:39:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:39:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:39:32 INFO - Return code: 0 15:39: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')]} 15:39:32 INFO - trying https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:39:32 INFO - Downloading https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 15:39:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 15:39:33 INFO - Downloaded 14413723 bytes. 15:39:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:39:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:39:33 INFO - Return code: 0 15:39:33 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')]} 15:39:33 INFO - trying https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:39:33 INFO - Downloading https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 15:39:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 15:39:51 WARNING - URL Error: https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:39:51 INFO - Running command: ['nslookup', 'queue.taskcluster.net'] 15:39:51 INFO - Copy/paste: nslookup queue.taskcluster.net 15:39:51 INFO - Server: 10.26.75.40 15:39:51 INFO - Address: 10.26.75.40#53 15:39:51 INFO - queue.taskcluster.net canonical name = toyama-73636.herokussl.com. 15:39:51 INFO - toyama-73636.herokussl.com canonical name = elb081832-1105536650.us-east-1.elb.amazonaws.com. 15:39:51 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 15:39:51 INFO - Address: 23.21.158.67 15:39:51 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 15:39:51 INFO - Address: 23.23.159.234 15:39:51 INFO - Name: elb081832-1105536650.us-east-1.elb.amazonaws.com 15:39:51 INFO - Address: 54.235.199.202 15:39:51 INFO - Return code: 0 15:39:51 INFO - retry: attempt #1 caught exception: 15:39:51 INFO - retry: Failed, sleeping 30 seconds before retrying 15:40:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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 #2 15:40:23 INFO - Downloaded 56138746 bytes. 15:40:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:40:23 INFO - mkdir: /builds/slave/test/properties 15:40:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:40:23 INFO - Writing to file /builds/slave/test/properties/build_url 15:40:23 INFO - Contents: 15:40:23 INFO - build_url:https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:40:23 INFO - Running post-action listener: _resource_record_post_action 15:40:23 INFO - Running post-action listener: set_extra_try_arguments 15:40:23 INFO - [mozharness: 2016-08-08 22:40:23.865882Z] Finished download-and-extract step (success) 15:40:23 INFO - [mozharness: 2016-08-08 22:40:23.866115Z] Running populate-webroot step. 15:40:23 INFO - Running pre-action listener: _resource_record_pre_action 15:40:23 INFO - Running main action method: populate_webroot 15:40:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:40:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:40:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:40:23 INFO - '--tppagecycles', 15:40:23 INFO - '7'], 15:40:23 INFO - 'tests': ['tsvgm']}}, 15:40:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:40:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:40:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:40:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:40:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:23 INFO - 'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:40:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:40:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:23 INFO - 'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['damp', 'tps']}, 15:40:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:23 INFO - 'tests': ['damp', 'tps']}, 15:40:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['dromaeo_dom']}, 15:40:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:40:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['basic_compositor_video']}, 15:40:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:40:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['a11yr', 15:40:23 INFO - 'ts_paint', 15:40:23 INFO - 'tpaint', 15:40:23 INFO - 'sessionrestore', 15:40:23 INFO - 'sessionrestore_no_auto_restore', 15:40:23 INFO - 'tabpaint']}, 15:40:23 INFO - 'other-e10s': {'tests': ['a11yr', 15:40:23 INFO - 'ts_paint', 15:40:23 INFO - 'tpaint', 15:40:23 INFO - 'sessionrestore', 15:40:23 INFO - 'sessionrestore_no_auto_restore', 15:40:23 INFO - 'tabpaint']}, 15:40:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:40:23 INFO - 'ts_paint', 15:40:23 INFO - 'tpaint', 15:40:23 INFO - 'sessionrestore', 15:40:23 INFO - 'sessionrestore_no_auto_restore', 15:40:23 INFO - 'tabpaint']}, 15:40:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:40:23 INFO - 'ts_paint', 15:40:23 INFO - 'tpaint', 15:40:23 INFO - 'sessionrestore', 15:40:23 INFO - 'sessionrestore_no_auto_restore', 15:40:23 INFO - 'tabpaint']}, 15:40:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['a11yr', 15:40:23 INFO - 'ts_paint', 15:40:23 INFO - 'tpaint', 15:40:23 INFO - 'sessionrestore', 15:40:23 INFO - 'sessionrestore_no_auto_restore', 15:40:23 INFO - 'tabpaint']}, 15:40:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['a11yr', 15:40:23 INFO - 'ts_paint', 15:40:23 INFO - 'tpaint', 15:40:23 INFO - 'sessionrestore', 15:40:23 INFO - 'sessionrestore_no_auto_restore', 15:40:23 INFO - 'tabpaint']}, 15:40:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['tsvgx', 15:40:23 INFO - 'tsvgr_opacity', 15:40:23 INFO - 'tart', 15:40:23 INFO - 'tscrollx', 15:40:23 INFO - 'cart']}, 15:40:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:40:23 INFO - 'tsvgr_opacity', 15:40:23 INFO - 'tart', 15:40:23 INFO - 'tscrollx', 15:40:23 INFO - 'cart']}, 15:40:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:23 INFO - 'talos_options': ['--disable-e10s'], 15:40:23 INFO - 'tests': ['tp5o']}, 15:40:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:23 INFO - 'tests': ['tp5o']}, 15:40:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:23 INFO - 'talos_options': ['--disable-e10s', 15:40:23 INFO - '--xperf_path', 15:40:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:40:23 INFO - 'tests': ['tp5n']}, 15:40:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:23 INFO - 'talos_options': ['--xperf_path', 15:40:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:40:23 INFO - 'tests': ['tp5n']}}, 15:40:23 INFO - 'talos.zip': {'path': '', 15:40:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:40:23 INFO - Running post-action listener: _resource_record_post_action 15:40:23 INFO - [mozharness: 2016-08-08 22:40:23.881267Z] Finished populate-webroot step (success) 15:40:23 INFO - [mozharness: 2016-08-08 22:40:23.881355Z] Running create-virtualenv step. 15:40:23 INFO - Running pre-action listener: _resource_record_pre_action 15:40:23 INFO - Running main action method: create_virtualenv 15:40:23 INFO - Creating virtualenv /builds/slave/test/build/venv 15:40:23 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 15:40:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:40:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:40:23 INFO - Using real prefix '/usr' 15:40:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:40:24 INFO - Installing distribute.............................................................................................................................................................................................done. 15:40:26 INFO - Installing pip.................done. 15:40:26 INFO - Return code: 0 15:40:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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')]} 15:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', '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 15:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:40:26 INFO - Using env: {'DISPLAY': ':0', 15:40:26 INFO - 'HOME': '/home/cltbld', 15:40:26 INFO - 'LANG': 'en_US.UTF-8', 15:40:26 INFO - 'LANGUAGE': 'en_US:en', 15:40:26 INFO - 'LOGNAME': 'cltbld', 15:40:26 INFO - 'MAIL': '/var/mail/cltbld', 15:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:26 INFO - 'MOZ_NO_REMOTE': '1', 15:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:26 INFO - 'NO_EM_RESTART': '1', 15:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:26 INFO - 'PWD': '/builds/slave/test', 15:40:26 INFO - 'SHELL': '/bin/bash', 15:40:26 INFO - 'SHLVL': '1', 15:40:26 INFO - 'TERM': 'linux', 15:40:26 INFO - 'TMOUT': '86400', 15:40:26 INFO - 'USER': 'cltbld', 15:40:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:26 INFO - '_': '/tools/buildbot/bin/python'} 15:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:26 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 15:40:26 INFO - Cleaning up... 15:40:26 INFO - Return code: 0 15:40:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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')]} 15:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', '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 15:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:40:26 INFO - Using env: {'DISPLAY': ':0', 15:40:26 INFO - 'HOME': '/home/cltbld', 15:40:26 INFO - 'LANG': 'en_US.UTF-8', 15:40:26 INFO - 'LANGUAGE': 'en_US:en', 15:40:26 INFO - 'LOGNAME': 'cltbld', 15:40:26 INFO - 'MAIL': '/var/mail/cltbld', 15:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:26 INFO - 'MOZ_NO_REMOTE': '1', 15:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:26 INFO - 'NO_EM_RESTART': '1', 15:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:26 INFO - 'PWD': '/builds/slave/test', 15:40:26 INFO - 'SHELL': '/bin/bash', 15:40:26 INFO - 'SHLVL': '1', 15:40:26 INFO - 'TERM': 'linux', 15:40:26 INFO - 'TMOUT': '86400', 15:40:26 INFO - 'USER': 'cltbld', 15:40:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:26 INFO - '_': '/tools/buildbot/bin/python'} 15:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:26 INFO - Downloading/unpacking psutil>=3.1.1 15:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:40:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:40:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:40:28 INFO - Installing collected packages: psutil 15:40:28 INFO - Running setup.py install for psutil 15:40:28 INFO - building 'psutil._psutil_linux' extension 15:40:28 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 15:40:29 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 15:40:29 INFO - building 'psutil._psutil_posix' extension 15:40:29 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 15:40:29 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 15:40:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:40:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:40:29 INFO - Successfully installed psutil 15:40:29 INFO - Cleaning up... 15:40:29 INFO - Return code: 0 15:40:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', '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 15:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:40:29 INFO - Using env: {'DISPLAY': ':0', 15:40:29 INFO - 'HOME': '/home/cltbld', 15:40:29 INFO - 'LANG': 'en_US.UTF-8', 15:40:29 INFO - 'LANGUAGE': 'en_US:en', 15:40:29 INFO - 'LOGNAME': 'cltbld', 15:40:29 INFO - 'MAIL': '/var/mail/cltbld', 15:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:29 INFO - 'MOZ_NO_REMOTE': '1', 15:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:29 INFO - 'NO_EM_RESTART': '1', 15:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:29 INFO - 'PWD': '/builds/slave/test', 15:40:29 INFO - 'SHELL': '/bin/bash', 15:40:29 INFO - 'SHLVL': '1', 15:40:29 INFO - 'TERM': 'linux', 15:40:29 INFO - 'TMOUT': '86400', 15:40:29 INFO - 'USER': 'cltbld', 15:40:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:29 INFO - '_': '/tools/buildbot/bin/python'} 15:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:40:31 INFO - Installing collected packages: mozsystemmonitor 15:40:31 INFO - Running setup.py install for mozsystemmonitor 15:40:31 INFO - Successfully installed mozsystemmonitor 15:40:31 INFO - Cleaning up... 15:40:31 INFO - Return code: 0 15:40:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:31 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', '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 15:40:31 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 15:40:31 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 15:40:31 INFO - Using env: {'DISPLAY': ':0', 15:40:31 INFO - 'HOME': '/home/cltbld', 15:40:31 INFO - 'LANG': 'en_US.UTF-8', 15:40:31 INFO - 'LANGUAGE': 'en_US:en', 15:40:31 INFO - 'LOGNAME': 'cltbld', 15:40:31 INFO - 'MAIL': '/var/mail/cltbld', 15:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:31 INFO - 'MOZ_NO_REMOTE': '1', 15:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:31 INFO - 'NO_EM_RESTART': '1', 15:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:31 INFO - 'PWD': '/builds/slave/test', 15:40:31 INFO - 'SHELL': '/bin/bash', 15:40:31 INFO - 'SHLVL': '1', 15:40:31 INFO - 'TERM': 'linux', 15:40:31 INFO - 'TMOUT': '86400', 15:40:31 INFO - 'USER': 'cltbld', 15:40:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:31 INFO - '_': '/tools/buildbot/bin/python'} 15:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:31 INFO - Downloading/unpacking jsonschema==2.5.1 15:40:31 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 15:40:31 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 15:40:31 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 15:40:31 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 15:40:31 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 15:40:31 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 15:40:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:40:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:40:33 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 15:40:33 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 15:40:33 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 15:40:33 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 15:40:33 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 15:40:33 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 15:40:33 INFO - Downloading functools32-3.2.3-2.tar.gz 15:40:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:40:34 INFO - warning: no files found matching '*.txt' 15:40:34 INFO - no previously-included directories found matching 'build' 15:40:34 INFO - no previously-included directories found matching 'dist' 15:40:34 INFO - no previously-included directories found matching '.git*' 15:40:34 INFO - Installing collected packages: jsonschema, functools32 15:40:34 INFO - Running setup.py install for functools32 15:40:34 INFO - warning: no files found matching '*.txt' 15:40:34 INFO - no previously-included directories found matching 'build' 15:40:34 INFO - no previously-included directories found matching 'dist' 15:40:34 INFO - no previously-included directories found matching '.git*' 15:40:34 INFO - Successfully installed jsonschema functools32 15:40:34 INFO - Cleaning up... 15:40:34 INFO - Return code: 0 15:40:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', '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 15:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:40:34 INFO - Using env: {'DISPLAY': ':0', 15:40:34 INFO - 'HOME': '/home/cltbld', 15:40:34 INFO - 'LANG': 'en_US.UTF-8', 15:40:34 INFO - 'LANGUAGE': 'en_US:en', 15:40:34 INFO - 'LOGNAME': 'cltbld', 15:40:34 INFO - 'MAIL': '/var/mail/cltbld', 15:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:34 INFO - 'MOZ_NO_REMOTE': '1', 15:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:34 INFO - 'NO_EM_RESTART': '1', 15:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:34 INFO - 'PWD': '/builds/slave/test', 15:40:34 INFO - 'SHELL': '/bin/bash', 15:40:34 INFO - 'SHLVL': '1', 15:40:34 INFO - 'TERM': 'linux', 15:40:34 INFO - 'TMOUT': '86400', 15:40:34 INFO - 'USER': 'cltbld', 15:40:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:34 INFO - '_': '/tools/buildbot/bin/python'} 15:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:40:34 INFO - Cleaning up... 15:40:34 INFO - Return code: 0 15:40:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', '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 15:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:40:34 INFO - Using env: {'DISPLAY': ':0', 15:40:34 INFO - 'HOME': '/home/cltbld', 15:40:34 INFO - 'LANG': 'en_US.UTF-8', 15:40:34 INFO - 'LANGUAGE': 'en_US:en', 15:40:34 INFO - 'LOGNAME': 'cltbld', 15:40:34 INFO - 'MAIL': '/var/mail/cltbld', 15:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:34 INFO - 'MOZ_NO_REMOTE': '1', 15:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:34 INFO - 'NO_EM_RESTART': '1', 15:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:34 INFO - 'PWD': '/builds/slave/test', 15:40:34 INFO - 'SHELL': '/bin/bash', 15:40:34 INFO - 'SHLVL': '1', 15:40:34 INFO - 'TERM': 'linux', 15:40:34 INFO - 'TMOUT': '86400', 15:40:34 INFO - 'USER': 'cltbld', 15:40:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:34 INFO - '_': '/tools/buildbot/bin/python'} 15:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:34 INFO - Downloading/unpacking blobuploader==1.2.4 15:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:36 INFO - Downloading blobuploader-1.2.4.tar.gz 15:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:40:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:40:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:37 INFO - Downloading docopt-0.6.1.tar.gz 15:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:40:37 INFO - Installing collected packages: blobuploader, requests, docopt 15:40:37 INFO - Running setup.py install for blobuploader 15:40:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:40:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:40:37 INFO - Running setup.py install for requests 15:40:37 INFO - Running setup.py install for docopt 15:40:37 INFO - Successfully installed blobuploader requests docopt 15:40:37 INFO - Cleaning up... 15:40:37 INFO - Return code: 0 15:40:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:37 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', '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 15:40:37 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 15:40:37 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 15:40:37 INFO - Using env: {'DISPLAY': ':0', 15:40:37 INFO - 'HOME': '/home/cltbld', 15:40:37 INFO - 'LANG': 'en_US.UTF-8', 15:40:37 INFO - 'LANGUAGE': 'en_US:en', 15:40:37 INFO - 'LOGNAME': 'cltbld', 15:40:37 INFO - 'MAIL': '/var/mail/cltbld', 15:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:37 INFO - 'MOZ_NO_REMOTE': '1', 15:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:37 INFO - 'NO_EM_RESTART': '1', 15:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:37 INFO - 'PWD': '/builds/slave/test', 15:40:37 INFO - 'SHELL': '/bin/bash', 15:40:37 INFO - 'SHLVL': '1', 15:40:37 INFO - 'TERM': 'linux', 15:40:37 INFO - 'TMOUT': '86400', 15:40:37 INFO - 'USER': 'cltbld', 15:40:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:37 INFO - '_': '/tools/buildbot/bin/python'} 15:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:38 INFO - Running setup.py (path:/tmp/pip-bAXyNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:38 INFO - Running setup.py (path:/tmp/pip-nD1baZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:38 INFO - Running setup.py (path:/tmp/pip-J5aSGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:38 INFO - Running setup.py (path:/tmp/pip-pkpYeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:38 INFO - Running setup.py (path:/tmp/pip-ObmptQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:38 INFO - Running setup.py (path:/tmp/pip-IZLBzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:38 INFO - Running setup.py (path:/tmp/pip-fDkTf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:38 INFO - Running setup.py (path:/tmp/pip-PN3S9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:38 INFO - Running setup.py (path:/tmp/pip-kUZxCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:38 INFO - Running setup.py (path:/tmp/pip-QeJDrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:38 INFO - Running setup.py (path:/tmp/pip-1Ap23R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:38 INFO - Running setup.py (path:/tmp/pip-FoobWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:39 INFO - Running setup.py (path:/tmp/pip-k8qMbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:39 INFO - Running setup.py (path:/tmp/pip-kp4TXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:39 INFO - Running setup.py (path:/tmp/pip-iynAPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:39 INFO - Running setup.py (path:/tmp/pip-SRPJz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:39 INFO - Running setup.py (path:/tmp/pip-OrzBlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:40:39 INFO - Running setup.py install for manifestparser 15:40:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:40:39 INFO - Running setup.py install for mozcrash 15:40:39 INFO - Running setup.py install for mozdebug 15:40:39 INFO - Running setup.py install for mozdevice 15:40:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:40:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:40:39 INFO - Running setup.py install for mozfile 15:40:39 INFO - Running setup.py install for mozhttpd 15:40:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Running setup.py install for mozinfo 15:40:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Running setup.py install for mozInstall 15:40:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Running setup.py install for mozleak 15:40:40 INFO - Running setup.py install for mozlog 15:40:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Running setup.py install for moznetwork 15:40:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Running setup.py install for mozprocess 15:40:40 INFO - Running setup.py install for mozprofile 15:40:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Running setup.py install for mozrunner 15:40:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:40:40 INFO - Running setup.py install for mozscreenshot 15:40:40 INFO - Running setup.py install for moztest 15:40:41 INFO - Running setup.py install for mozversion 15:40:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:40:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:40:41 INFO - Cleaning up... 15:40:41 INFO - Return code: 0 15:40:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:41 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', '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 15:40:41 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 15:40:41 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 15:40:41 INFO - Using env: {'DISPLAY': ':0', 15:40:41 INFO - 'HOME': '/home/cltbld', 15:40:41 INFO - 'LANG': 'en_US.UTF-8', 15:40:41 INFO - 'LANGUAGE': 'en_US:en', 15:40:41 INFO - 'LOGNAME': 'cltbld', 15:40:41 INFO - 'MAIL': '/var/mail/cltbld', 15:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:41 INFO - 'MOZ_NO_REMOTE': '1', 15:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:41 INFO - 'NO_EM_RESTART': '1', 15:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:41 INFO - 'PWD': '/builds/slave/test', 15:40:41 INFO - 'SHELL': '/bin/bash', 15:40:41 INFO - 'SHLVL': '1', 15:40:41 INFO - 'TERM': 'linux', 15:40:41 INFO - 'TMOUT': '86400', 15:40:41 INFO - 'USER': 'cltbld', 15:40:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:41 INFO - '_': '/tools/buildbot/bin/python'} 15:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:41 INFO - Running setup.py (path:/tmp/pip-yH0vmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:41 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)) 15:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:41 INFO - Running setup.py (path:/tmp/pip-KNg802-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:41 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)) 15:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:41 INFO - Running setup.py (path:/tmp/pip-mkpulO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:41 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)) 15:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:41 INFO - Running setup.py (path:/tmp/pip-taQdcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:41 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)) 15:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:41 INFO - Running setup.py (path:/tmp/pip-0EkPxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:41 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)) 15:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:41 INFO - Running setup.py (path:/tmp/pip-iruJKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:41 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)) 15:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:41 INFO - Running setup.py (path:/tmp/pip-uP16tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:41 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)) 15:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:41 INFO - Running setup.py (path:/tmp/pip-rtaE2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:41 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)) 15:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:41 INFO - Running setup.py (path:/tmp/pip-uwTn6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:42 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)) 15:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:42 INFO - Running setup.py (path:/tmp/pip-SVhIST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:42 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)) 15:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:42 INFO - Running setup.py (path:/tmp/pip-NmZUld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:42 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)) 15:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:42 INFO - Running setup.py (path:/tmp/pip-yoHcJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:42 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)) 15:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:42 INFO - Running setup.py (path:/tmp/pip-TzNrR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:42 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)) 15:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:42 INFO - Running setup.py (path:/tmp/pip-ypxVf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:42 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)) 15:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:42 INFO - Running setup.py (path:/tmp/pip-VEsIyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:42 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)) 15:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:42 INFO - Running setup.py (path:/tmp/pip-K4yqkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:42 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)) 15:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:42 INFO - Running setup.py (path:/tmp/pip-reiGmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:42 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)) 15:40:42 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)) 15:40:42 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)) 15:40:42 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)) 15:40:42 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)) 15:40:42 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)) 15:40:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:40:42 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 15:40:42 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 15:40:42 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 15:40:42 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 15:40:42 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 15:40:42 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 15:40:45 INFO - Downloading blessings-1.6.tar.gz 15:40:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:40:45 INFO - Installing collected packages: blessings 15:40:45 INFO - Running setup.py install for blessings 15:40:45 INFO - Successfully installed blessings 15:40:45 INFO - Cleaning up... 15:40:45 INFO - Return code: 0 15:40:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:40:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:46 INFO - Reading from file tmpfile_stdout 15:40:46 INFO - Current package versions: 15:40:46 INFO - argparse == 1.2.1 15:40:46 INFO - blessings == 1.6 15:40:46 INFO - blobuploader == 1.2.4 15:40:46 INFO - docopt == 0.6.1 15:40:46 INFO - functools32 == 3.2.3-2 15:40:46 INFO - jsonschema == 2.5.1 15:40:46 INFO - manifestparser == 1.1 15:40:46 INFO - mozInstall == 1.12 15:40:46 INFO - mozcrash == 0.17 15:40:46 INFO - mozdebug == 0.1 15:40:46 INFO - mozdevice == 0.48 15:40:46 INFO - mozfile == 1.2 15:40:46 INFO - mozhttpd == 0.7 15:40:46 INFO - mozinfo == 0.9 15:40:46 INFO - mozleak == 0.1 15:40:46 INFO - mozlog == 3.3 15:40:46 INFO - moznetwork == 0.27 15:40:46 INFO - mozprocess == 0.23 15:40:46 INFO - mozprofile == 0.28 15:40:46 INFO - mozrunner == 6.12 15:40:46 INFO - mozscreenshot == 0.1 15:40:46 INFO - mozsystemmonitor == 0.3 15:40:46 INFO - moztest == 0.7 15:40:46 INFO - mozversion == 1.4 15:40:46 INFO - psutil == 3.1.1 15:40:46 INFO - requests == 1.2.3 15:40:46 INFO - wsgiref == 0.1.2 15:40:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:46 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', '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 15:40:46 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 15:40:46 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 15:40:46 INFO - Using env: {'DISPLAY': ':0', 15:40:46 INFO - 'HOME': '/home/cltbld', 15:40:46 INFO - 'LANG': 'en_US.UTF-8', 15:40:46 INFO - 'LANGUAGE': 'en_US:en', 15:40:46 INFO - 'LOGNAME': 'cltbld', 15:40:46 INFO - 'MAIL': '/var/mail/cltbld', 15:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:46 INFO - 'MOZ_NO_REMOTE': '1', 15:40:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:46 INFO - 'NO_EM_RESTART': '1', 15:40:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:46 INFO - 'PWD': '/builds/slave/test', 15:40:46 INFO - 'SHELL': '/bin/bash', 15:40:46 INFO - 'SHLVL': '1', 15:40:46 INFO - 'TERM': 'linux', 15:40:46 INFO - 'TMOUT': '86400', 15:40:46 INFO - 'USER': 'cltbld', 15:40:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:46 INFO - '_': '/tools/buildbot/bin/python'} 15:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:46 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)) 15:40:46 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)) 15:40:46 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)) 15:40:46 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)) 15:40:46 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)) 15:40:46 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)) 15:40:46 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)) 15:40:46 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)) 15:40:46 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)) 15:40:46 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)) 15:40:46 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)) 15:40:46 INFO - Cleaning up... 15:40:46 INFO - Return code: 0 15:40:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:46 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 0x1f2a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x208d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2159400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', '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 15:40:46 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 15:40:46 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 15:40:46 INFO - Using env: {'DISPLAY': ':0', 15:40:46 INFO - 'HOME': '/home/cltbld', 15:40:46 INFO - 'LANG': 'en_US.UTF-8', 15:40:46 INFO - 'LANGUAGE': 'en_US:en', 15:40:46 INFO - 'LOGNAME': 'cltbld', 15:40:46 INFO - 'MAIL': '/var/mail/cltbld', 15:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:46 INFO - 'MOZ_NO_REMOTE': '1', 15:40:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:46 INFO - 'NO_EM_RESTART': '1', 15:40:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:46 INFO - 'PWD': '/builds/slave/test', 15:40:46 INFO - 'SHELL': '/bin/bash', 15:40:46 INFO - 'SHLVL': '1', 15:40:46 INFO - 'TERM': 'linux', 15:40:46 INFO - 'TMOUT': '86400', 15:40:46 INFO - 'USER': 'cltbld', 15:40:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:46 INFO - '_': '/tools/buildbot/bin/python'} 15:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:40:46 INFO - Cleaning up... 15:40:46 INFO - Return code: 0 15:40:46 INFO - Running post-action listener: _resource_record_post_action 15:40:46 INFO - Running post-action listener: _start_resource_monitoring 15:40:46 INFO - Starting resource monitoring. 15:40:46 INFO - [mozharness: 2016-08-08 22:40:46.481383Z] Finished create-virtualenv step (success) 15:40:46 INFO - [mozharness: 2016-08-08 22:40:46.481817Z] Running install step. 15:40:46 INFO - Running pre-action listener: _resource_record_pre_action 15:40:46 INFO - Running main action method: install 15:40:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:46 INFO - Reading from file tmpfile_stdout 15:40:46 INFO - Detecting whether we're running mozinstall >=1.0... 15:40:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:40:46 INFO - Reading from file tmpfile_stdout 15:40:46 INFO - Output received: 15:40:46 INFO - Usage: mozinstall [options] installer 15:40:46 INFO - Options: 15:40:46 INFO - -h, --help show this help message and exit 15:40:46 INFO - -d DEST, --destination=DEST 15:40:46 INFO - Directory to install application into. [default: 15:40:46 INFO - "/builds/slave/test"] 15:40:46 INFO - --app=APP Application being installed. [default: firefox] 15:40:46 INFO - mkdir: /builds/slave/test/build/application 15:40:46 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'] 15:40:46 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 15:41:02 INFO - Reading from file tmpfile_stdout 15:41:02 INFO - Output received: 15:41:02 INFO - /builds/slave/test/build/application/firefox/firefox 15:41:02 INFO - Running post-action listener: _resource_record_post_action 15:41:02 INFO - [mozharness: 2016-08-08 22:41:02.981712Z] Finished install step (success) 15:41:02 INFO - [mozharness: 2016-08-08 22:41:02.981958Z] Running run-tests step. 15:41:02 INFO - Running pre-action listener: _resource_record_pre_action 15:41:02 INFO - Running main action method: run_tests 15:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:41:02 INFO - Python 2.7.3 15:41:02 INFO - Return code: 0 15:41:02 INFO - grabbing minidump binary from tooltool 15:41:02 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')]} 15:41:02 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 0x21e8570>, '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 0x21e9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21e9900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:41:02 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 15:41:02 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 15:41:02 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 15:41:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:41:03 INFO - Return code: 0 15:41:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:41:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:41:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:41:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:41:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 15:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 15:41:03 INFO - Using env: {'DISPLAY': ':0', 15:41:03 INFO - 'HOME': '/home/cltbld', 15:41:03 INFO - 'LANG': 'en_US.UTF-8', 15:41:03 INFO - 'LANGUAGE': 'en_US:en', 15:41:03 INFO - 'LOGNAME': 'cltbld', 15:41:03 INFO - 'MAIL': '/var/mail/cltbld', 15:41:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:41:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:03 INFO - 'MOZ_NO_REMOTE': '1', 15:41:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:03 INFO - 'NO_EM_RESTART': '1', 15:41:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:03 INFO - 'PWD': '/builds/slave/test', 15:41:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:41:03 INFO - 'SHELL': '/bin/bash', 15:41:03 INFO - 'SHLVL': '1', 15:41:03 INFO - 'TERM': 'linux', 15:41:03 INFO - 'TMOUT': '86400', 15:41:03 INFO - 'USER': 'cltbld', 15:41:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950', 15:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:03 INFO - '_': '/tools/buildbot/bin/python'} 15:41:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 15:41:03 INFO - mozversion application_buildid: 20160808135726 15:41:03 INFO - mozversion application_changeset: d1274a312b6b21d58c94357c2cccf78fb13af9c2 15:41:03 INFO - mozversion application_display_name: Nightly 15:41:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:41:03 INFO - mozversion application_name: Firefox 15:41:03 INFO - mozversion application_remotingname: firefox 15:41:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:41:03 INFO - mozversion application_vendor: Mozilla 15:41:03 INFO - mozversion application_version: 51.0a1 15:41:03 INFO - mozversion platform_buildid: 20160808135726 15:41:03 INFO - mozversion platform_changeset: d1274a312b6b21d58c94357c2cccf78fb13af9c2 15:41:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:41:03 INFO - mozversion platform_version: 51.0a1 15:41:03 INFO - using testdate: 1470696063 15:41:03 INFO - actual date: 1470696063 15:41:03 INFO - starting webserver on 'localhost:56448' 15:41:03 INFO - SUITE-START | Running 2 tests 15:41:03 INFO - TEST-START | dromaeo_css 15:41:03 INFO - operating with platform_type : linux_ 15:41:03 INFO - Initialising browser for dromaeo_css test... 15:41:03 INFO - TEST-INFO | started process 12055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgQipp_/profile http://localhost:56448/getInfo.html) 15:41:08 INFO - PROCESS | 12055 | __metrics Screen width/height:1600/1200 15:41:08 INFO - PROCESS | 12055 | colorDepth:24 15:41:08 INFO - PROCESS | 12055 | Browser inner width/height: 1024/697 15:41:08 INFO - PROCESS | 12055 | __metrics 15:41:08 ERROR - PROCESS | 12055 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:41:09 INFO - TEST-INFO | 12055: exit 0 15:41:09 INFO - Browser initialized. 15:41:09 INFO - Running cycle 1/1 for dromaeo_css test... 15:41:09 INFO - TEST-INFO | started process 12175 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgQipp_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:41:21 INFO - PROCESS | 12175 | RSS: Main: 164847616 15:41:21 INFO - PROCESS | 12175 | 15:42:11 INFO - PROCESS | 12175 | 1470696131162 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] 15:44:23 INFO - PROCESS | 12175 | Cycle 1(1): loaded http://localhost:56448/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56448/tests/dromaeo/cssquery-ext.html) 15:44:24 INFO - PROCESS | 12175 | RSS: Main: 167063552 15:44:24 INFO - PROCESS | 12175 | 15:47:27 INFO - PROCESS | 12175 | Cycle 1(1): loaded http://localhost:56448/tests/dromaeo/cssquery-ext.html (next: http://localhost:56448/tests/dromaeo/cssquery-jquery.html) 15:47:27 INFO - PROCESS | 12175 | RSS: Main: 166879232 15:47:27 INFO - PROCESS | 12175 | 15:50:29 INFO - PROCESS | 12175 | Cycle 1(1): loaded http://localhost:56448/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56448/tests/dromaeo/cssquery-mootools.html) 15:50:30 INFO - PROCESS | 12175 | RSS: Main: 170323968 15:50:30 INFO - PROCESS | 12175 | 15:53:32 INFO - PROCESS | 12175 | Cycle 1(1): loaded http://localhost:56448/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56448/tests/dromaeo/cssquery-prototype.html) 15:53:32 INFO - PROCESS | 12175 | RSS: Main: 164675584 15:53:32 INFO - PROCESS | 12175 | 15:56:35 INFO - PROCESS | 12175 | Cycle 1(1): loaded http://localhost:56448/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56448/tests/dromaeo/cssquery-yui.html) 15:56:36 INFO - PROCESS | 12175 | RSS: Main: 167170048 15:56:36 INFO - PROCESS | 12175 | 15:59:39 INFO - PROCESS | 12175 | Cycle 1(1): loaded http://localhost:56448/tests/dromaeo/cssquery-yui.html (next: http://localhost:56448/tests/dromaeo/cssquery-dojo.html) 15:59:39 INFO - PROCESS | 12175 | RSS: Main: 170389504 15:59:39 INFO - PROCESS | 12175 | 15:59:39 INFO - PROCESS | 12175 | __start_tp_report 15:59:39 INFO - PROCESS | 12175 | _x_x_mozilla_page_load 15:59:39 INFO - PROCESS | 12175 | _x_x_mozilla_page_load_details 15:59:39 INFO - PROCESS | 12175 | |i|pagename|runs| 15:59:39 INFO - PROCESS | 12175 | |0;dojo.html;2665.9866700666494;2681.7586417222446;2706.296362945634;2707.2149076767737;2709.7290270972894;4741.691790033646;4887.095887260854;4897.926531102036;4924.2121260598315;4947.455779864216;4809.519048095189;4843;4849.539293767095;4877.463479017314;4926.950730492694;4425.358323043165;4476.418065651461;4494.213512635276;4583.656225783079;4612.930806037912;4580.358749775034;4593.127305811901;4593.563611456906;4598.172328980782;4620.376249206348;4326.199653064162;4403.141387429452;4415.116976604676;4416.801243943998;4459.219636563588;4443.178012067746;4449.466064072332;4451.888702782457;4550.840720574797;4577.816887324503;4425.955740442619;4470.56941778631;4507.977460112711;4516.16450956574;4519.2091384008;4751.738654374008;4823.2282834746275;4844.152273352184;4854.344663470421;4899.436564795059;5142.280080788692;5168.095583272912;5177.068127737006;5194.792208311663;5202.557782588485;5169.198774190007;5218.634695571312;5220.92168617471;5225.686458812484;5225.843224703265;4668.346431499559;4865;4925.335079764258;4925.655204135748;4992.301077849104;5362.758675859518;5377.112776391929;5385.299911011622;5394.811181608625;5421.620486565981;5190;5200.193969934666;5204.4535323791215;5219.556337711261;5248.160294352885;5059.8988020239385;5174.870628234249;5228.241904923765;5243.2659427680155;5253.106971814801;5174.042802081627;5185.714785686748;5187.870303242374;5207.973960130175;5275.788968441219;5180.248863914711;5194.11700010999;5197.350331208599;5205.7397130143345;5221.373435187726;4306.0311429928015;4349.760763157993;4404.11917616478;4463.732176069446;4487.6185524230805;3849.172427928009;3903.394973779069;3904.1996390739832;3904.2191561687778;3949.6050394960275;4453.864264612568;4495.617872480811;4501.347304640809;4504.549545045535;4552.499225085238;5013.974930125399;5169.844904652867;5195.402528709247;5235.952809438128;5313.468653134656;4472.105578884171;4477.395551600493;4483.036147228361;4498.752568608693;4533.863984080483;4723.881902952385;4732.148213321566;4736.242201247784;4745.193317136095;4788.377510923558;4771.141194584939;4782.832600859023;4838.588719958843;4878.853634390974;4940.827071052496;5197.064528384927;5220.060389129993;5224.05966925957;5225.5558277545315;5229.450907654642;4711.623070154448;4874.658773885794;4880.511948805091;4891.682040667345;4895.657303988686;5003.124453220745;5008.073506401327;5011.473795251592;5046.116929537389;5100.923486147636;5165.354330708661;5187.766550505161;5188.325517682677;5217.269582258411;5229.9738501308775;5004.824831130893;5007.198848184273;5020.121478741279;5025.74871256443;5039.3448851649055;4854.805807767791;5010.473900240422;5010.974945125251;5047.318611987334;5130.923036154386;5041.899162016813;5050.217216331474;5064.34163558735;5119.104156772475;5131.563817075441;5123.923141152811;5167.6641018333685;5176.171812509981;5177.715225662625;5235.136202526541;4756.453007903997;4917.0903382874285;4942.777575009205;5049.293098966221;5049.84850454487 15:59:39 INFO - PROCESS | 12175 | |1;ext.html;516.1045585908448;533.0751146760373;542.8859939412723;542.9782808687652;567.7728908436623;34058;37710.8114459428;37810.43284350737;37831.43252851203;37862.242755144915;38246;38582.228355432875;38734.22531549367;38765.8061709691;38894.80552597233;7556.924430755691;7652.081750189957;7710.498817576839;7715.305622493975;7727.613619319011;7635.580043097628;7715.382769378464;7770.33952114071;7774.300312971832;7790.493617914817;7765.7670269892;7788.221177882195;7791.337736292422;7792.220777922219;7806.804829879242;7683.385329173652;7718.035245594301;7746.845063098763;7747.573883436408;7771.261730135628;7623.504472209289;7673.3477654398885;7698.2686644768655;7698.961505192494;7704.036995375578;36138;36246.81876590627;36490.270194596225;36546;36586.08534786625;3110.98444507776;3139.551150102923;3188.1232661018175;3304.3721692878275;3372.9494057589154;28666.182714969007;29125.708742912513;29273.853630731923;29362.119136425943;29368;3018.1398301483973;3022.304869879918;3029.969700302991;3164.0666003528786;3170.25499007733;182570.08714956473;182817;183139;183427;183508.0824595882;50822;51119.744401277756;51133;51387.743061284455;51443.228351574755;53021;53127.734361327944;53215.46784532105;53252.467475325524;53289;13536.796948045787;14628.926855365655;14673;14724.852751472563;14760.188189649458;10551.472426378803;10669.626563070255;10750.569977200981;10757;10795.190360722978;17510;17559.912200439172;17586.560335991704;17619.735703964452;17627.118644068003;6654.900176497356;6664.433523150489;6750.696218670171;6794.320567943166;6805.421539169127;799.160881074869;827.5365795154732;887.2281115429489;893.1604291965532;1023.5854478936043;25925.481490370086;26590.335241618726;27634.309142271202;28275.57586636202;29654.851725741664;918.4994178172778;938.638624129715;939.7791518993031;940.2008292950937;960.8421851668862;13597.252151131584;14240.359183836545;14305.78541321881;14338;14504.854951450561;406716;413324;413436;413796;414726;46879;47033.29450058252;47346;47364;47424.7628761854;1169.2750494693344;1182.379250893288;1207.8429804125233;1224.9571265005682;1227.3311045480234;25394;26478.867605662617;26612.8669356652;27027.459450810482;27068.864655676596;41262.79368603138;41837;41936;42046.36930445985;42102.789486052374;370742;370806;371336;371896;373690;24019.759802402452;24417;24478.388040299134;24499.020039198233;24666.753332467164;40012.799936000134;40121;40522.797386012884;41089.79455102705;41559;34529.48205776966;34899.4765078519;35283.76506822249;35325.82337088298;35765;34723.30553388969;35107.64892351044;35279.64720352764;35308.82345588256;35472.82263588665;33540.49689254712;33669.15827104342;33781.49327760036;34127.14682132967;34609.480857787654;30192.69807301899;31913;32215;32327.35345293128;32439.513407298437;24737.257882263562;24758.25725228246;24921.252362429157;25092.498150037263;25722.228333150037 15:59:39 INFO - PROCESS | 12175 | |2;jquery.html;351.27637067640677;361.88600590813894;368.99446508302395;370.2114496123257;380.518643915447;15494.69010619787;16509;17156.828431715665;17298.394556190535;17429.477115686517;14295.714085718306;14830.777538336934;14836.109833410002;14929.776053359208;14956.32696528656;4860.2709593560985;5023.095842748322;5036.6222533309965;5053.014662140884;5184.274201611758;4958.206686930092;4964.578010869081;4967.379077615298;4989.476105008976;4997.30037794709;4943.728094954794;5405.675659460445;5650.406707295737;5702.942970570303;5794.275715535558;5322.787088516455;5364.088105022117;5560.972195139018;5716.914246286288;5749.655020698771;5210.062188806013;5243.558021544106;5336.67979921206;5379.246905433203;5383.81156659515;12625.431855566521;18981.145848436852;20440.591188176302;20632.587348253102;20635.48411289715;1801.675698374292;2280.224723593986;2393.7606239376096;2407.109369533284;2428.5749993751024;9173.312001599907;9282;9282.443053416817;9395.154436100784;9396.577154028086;1706.8293170682957;1717.6478821841492;1743.128435782109;1767.6022894848684;1781.8040015598274;73744.63127684381;74617.6269118651;75018.62490687566;76076.23923760747;78534.60732696357;8662.826743465095;8755.781105472413;8820.42667226641;10036.799264014679;10088.293819432716;13907.79138312926;13918.860811391958;13919.582412527641;13934.790978135336;14006;6632.204135503771;6766.289539598271;6785.660716964132;6847.828804279933;7148.642567871586;6378.075179099004;6440.967795160994;6485.935140648628;6579.605223686594;6616.86766264672;4270.444842170498;4316.179925814148;4323.567643235714;4334.848280310174;4461.174682683714;1804.2588901709912;1822.8541716662635;1841.686913224755;1853.4254381141889;1875.7373967644542;809.8380323935119;817.5830326533392;860.6471346747803;940.2243149401634;944.2870632672289;16242.75635865463;16501;16545.608150329394;16770.58073548171;17448.91275543614;849.5454931611558;853.0914575976689;856.6701819799298;889.8976617689049;909.0545832334299;8867.48901739835;8980.012198658142;9185.724428267162;9279.953600231956;9417.96402395736;382350;390853;397845;398502;398699;48303;75931;78848;79792.60103699444;79806;764.0754686828999;798.397210106366;798.5528104261632;799.6521513141802;802.0415603353936;13977.720445591234;14352.49766258176;14394.928025359806;14432.278386080445;14451.277436128361;38280.80859595684;38782.4182637255;39233;39676.60323396729;39820.2035959285;51805.22292165696;52901.20648190357;54560.454395455534;55478.44521554733;55760.72119639538;7299.270072992871;7336.96331518339;7479.626018699152;7601.277878601524;7617.238276172338;9476.715698529055;10958.945205274242;11250.887491124984;11519.078473721915;11560.248583842023;9176.816463670555;9459;9676.322657413913;9850.359726617748;10053.346532475658;9766.511674416108;9849.704508864745;10151.492425378849;10205.285630005828;10349.896501034893;9823.607055717692;10034.899651003396;10057.346272492265;10148;10213.438260895722;7498.400127989857;7637.694492220249;7711.305982461606;7824.804379890548;7843.960780196063;9094.499802510925;9909.306348555532;9943.502824858873;10281.12610428122;10560.683179504627 15:59:39 INFO - PROCESS | 12175 | |3;mootools.html;1321.2270821569377;1353.8036984637226;1400.9089409188402;1612.3872928287242;1614.9596260093504;6385.26569444514;7392.889106663404;7443.553386796796;8024.037115546128;8055.395845311603;7552.96223518883;7813.6483858226375;7824.256695613922;7830.608469576527;7844.568548729818;2112.7887211278903;2156.827453803692;2157.8165855902266;2157.9568408631817;2163.3293678959494;2105.1263725553877;2136.8717876927435;2167.566486702658;2174.4129085147;2181.149351752818;2144.9034793434257;2149.892505374733;2154.472154322193;2163.1779923629;2208.8122509586624;2117.237794394017;2118.50215199428;2127.9787202127936;2141.9785802141937;2142.73215848019;2103.968440473394;2147.892605369725;2155.493459037125;2158.4064382294837;2163.599734049206;7523.322900938887;7542.962285188594;7581.772546823604;7582.582957937367;7605.239476052406;4264.829406823724;4414.448193975753;4421.579949904753;4434.135343607965;4436.511983681792;2724.087430710714;2815.338395477061;2820;2904.6659634142134;2948.2629342664336;887.3034667785822;902.9097090290918;934.3179478980383;935.1817159985013;937.4094320577992;10478;10546.841797373045;10550.997655222818;10559.155267578652;10574.682759517227;3898.941515877264;4068.2677118119022;4168.937465938014;4201.075763332062;4203.55862634419;8563.657453701906;8570.357223208284;8586.09845966177;8589.26991205742;8609.182127697859;4429.291313389842;4451.354553589711;4452.131834292347;4480.529544397791;4489.034857505652;3287.227501537137;3912.941305880414;4039.313316736162;4084.6732261419015;4104.322786740214;3544.964550354515;3572.696320812708;3639.79981101042;3651.8174091295327;3713.9442908356395;1153.1812413186565;1156.5720683347047;1166.3526742657907;1173.6537721372215;1178.3401295274673;605.3129697793037;643.0193954219852;675.5136301862651;692.1901375390704;711.4592909388798;4679.766011699401;4792.161371759928;4871.391076115486;4876.707397556158;5096.337476128079;413.43566032365607;415.0143409402669;416.24036134054865;417.2364572831711;422.03564854307757;3389.8135602542097;3452.5511683480986;3495.702865256482;3503.159241781954;3550.3254381667402;8941.46351218929;9158.267338612895;9262.120098590623;9294.628214871329;9313.53432328381;9185.494797786187;9201.769955751026;9212.170904618617;9226.907730922605;9234.676786312446;6915.4121899638085;6973.372396484341;6984.860302794017;7029.29707029293;7043.859122817515;4857.53853383928;4858.27125931099;4901.019796040735;4934.925976110433;5018.247262910592;8354.415190936576;8429.5785210738;8445.239928406472;8499.277561407349;8550.700725474579;8423.663053477792;8614.052454230155;8636.309095272238;8641.697540586048;8676.132386761527;5616.297962754656;6324.367563243639;6497.545171837926;6525.119108920235;6609.702563384563;7149.356557909813;7270.418366530771;7270.854582908418;7288.744893928687;7288.817779555554;6440.452561532322;6516.250631177475;6520.347965203442;6605.240397354173;6720.731170753115;6364.015324453569;6445.097686324012;6453.386928241809;6470.255920569195;6559.14731084975;5949.672767997802;6006.849828754316;6053.848653783691;6055.63666180013;6063.575549711478;4355.847545335898;4457.487388950312;4459.687821852569;4525.841595544141;4527.501974782837;4305.117450922616;4318.179545886397;4379.518252992232;4411.095725376226;4456.933146002877 15:59:39 INFO - PROCESS | 12175 | |4;prototype.html;286.57872926797614;290.5336934220576;295.98372089535064;296.0954284660362;297.348806114609;5111.616628752845;5128.102582048141;5146.382434107908;5146.974265128669;5148.794048238066;5051.5453609175165;5055.140626093564;5059.215821547666;5065.189569668853;5087.287779710843;3735.999999999993;3829.8468061277517;3929.2141571685634;3957.940630890539;3968.4245784361397;3965.2069586082753;3967.7817720025387;3970.4044393341087;3996.6003399660094;4004.1991601679633;3934.704897132712;3956.723029387944;3968.960310396888;3980.20395920817;3981.681465482769;3694.8891533254045;3898.337282661926;3934.4688467056867;3968.523777146732;3990.5211374635082;3377.67912048355;3381.1040074380307;3383.2049468375158;3391.253504445213;3395.47370157626;4972.627052971042;4986.227134794112;4990.8253211137435;4995.052918777902;5001;4232.476308528927;4463.464384273875;4481.7983190756495;4487.349334346534;4504.684672072956;5268.367795864482;5269.549659408393;5291.761870715789;5302.946970530323;5310.681359118426;3681.4293784463453;3696.131409118882;3701.4632878232774;3713.6286371362917;3728.9440658390145;5388.757505912244;5550.583706222009;5599.608027438081;5647.887042259173;5666.603337766358;3735.402335626287;3749.1564398010228;3755.868544600926;3759.3045286622064;3763.6612704856148;3780.3384407728536;3795.259924314732;3814.5231846019246;3823.0251285921913;3838.616138386139;4435.977820110943;4447.288433850568;4453.265211240174;4455.977720111378;4457.264551349056;5235.317650428971;5244.29202057725;5266.552343050884;5364.302640656768;5374.596905232045;1293.5860524632214;1320.854705982341;1322.510671051717;1327.5818117293022;1330.4545136493991;786.3159051625008;805.8388322335556;835.6281454752577;847.089378917666;853.5945425922761;4490.528494508029;4648.2562789953445;4665.136949664323;4696.553827386393;4723.267893476516;5502.936398850431;5518.061929471999;5526.585506086979;5549.833504994856;5552.333719953551;4432;4580.946382332082;4641.489436162019;4656.208444564432;4673.345731597579;2884.682684904659;2904.0271509044283;2913.1551849963275;2929.22375570474;2939.3827296268023;5121.155009423478;5128.205128205134;5130.692158470503;5139.997700448452;5165.896682066413;5397.622166448311;5522.30971128609;5567.66594004361;5625.353084395265;5637.3235211774845;5085.796568137233;5139.948600513947;5143.739783753004;5158.767855446589;5166.726640278265;5482.862928426662;5572;5575.219469274386;5591.077472217039;5592.3009623797025;5110.463401342806;5393.244945707683;5417.214503896992;5427.2823116165555;5447.536959358499;5166.509181627739;5185.766640501111;5188.870278243074;5205.6616319940595;5232.921506177487;3802.904927376838;3833.9616603833606;3842.51968503937;3843.0584506796013;3851.5185601799776;5167.948320516747;5523.254360661259;5542.556595472433;5567.331920169606;5622.5783066271015;5366.5510312216265;5372.516473517402;5388.946110538845;5398.352197736297;5402.189671549299;5194.272801807674;5342.332208473941;5364.356277246756;5381.811636592857;5386.976474469838;5254.474552544715;5293.073712100444;5298.947010529845;5305.389880163676;5334.1732031535175;5155.845324640267;5253;5327.22755200486;5373.516383525502;5457.317835270591;5206.193040078642;5243.921341179809;5247.163492777498;5285.418603953639;5295.391030031596 15:59:39 INFO - PROCESS | 12175 | |5;yui.html;648.7534736800015;648.9870202595948;743.9702411903528;750.4146765522894;765.3341592814253;13342.533011344605;13517.188968661863;14340.498082567125;14406.279686015696;14436.927815360934;15096.622584435367;15239.161846098488;15239.31423085961;15282.69434611307;15284.235788210573;738.5310327941769;743.2121950732228;761.0562902001506;766.7814672818248;767.2365995834152;777.013193244579;783.6669415498419;783.9333656639193;785.2461636828623;787.5747096567846;809.324214281076;809.9433039687224;815.1848151848152;816.5753808019826;821.1911267401605;804.3082948664144;804.9718259860906;806.0770417871533;807.4468988742701;809.7854068671807;585.0346927569502;585.3181044083638;585.6105689716334;586.8122200895715;588.1325045557811;14092.92953535236;14096.788548171786;14129.576112716635;14155.150690958473;14159.150450972975;12778.23330600167;12954;13139.54011609589;13148.6712832179;13352.592200158952;9896.158826499755;9906.455144967023;9915.107640312406;10016.39901605906;10113.08982191599;3168.5088811234295;3188.2457684866113;3226.822524761137;3282.573265475473;3310.453775127101;69346;69609.65195174042;69657;70264.94602580965;70779.2922070783;10306.536205870754;10475;10574.735631609117;10762.892371076188;10867.83698244527;18623.720644190078;18689.439316820517;18731.44102620498;18838.15228314729;18892;6774.898376524356;6879.931200688029;6952.478564107712;6957.756478523227;6984.092068031225;3686.189038411545;3739.6350332128577;3771.905702357463;3776.3580191367532;3809.685573550973;2672.398710290169;2724;2738.411241583069;2758.2690586994463;2772.6395568575954;497.2764627467027;498.89523200127655;502.4046504891715;507.59138893191334;507.70553079213965;453.7504372595125;482.80501800625524;484.1454832221132;490.8404768450268;497.1846172277468;7628.351590114902;7798.337141342936;7902.525848449111;7929.762107136795;7959.3234575060615;434.9891252718644;455.4580049740864;497.102729573124;509.6610753848649;542.1596525385715;3570.6607872252093;3708.6847617952776;3735.234276973214;3760.680342170946;3829.540455145345;104339.478302608;108487;109900.45049774859;112364.43817781023;112388.43805780918;84216.57891710625;95577;96083;96580;96934.51532742432;47670.80822979453;47961.760191198824;48552.5144748555;62140.06789898155;78702.81945770817;6913.412359949461;6996.440284777307;7162.820929476805;7215.314545118205;7363.963180184279;38966.4155037669;40955.39936613225;46663;46940.765296173304;48915.02169956652;39832.80083599564;43791;51134.74432627813;52315.47684523106;52711.736441317546;11133.944330278297;11196.104311655212;11210.439478025903;11289.71775705614;11429.371384573928;11680.649580512598;11940.164188506722;12183.168316831683;12293.262404255773;12771.93614031961;11311.434428278717;11899.46452409661;12127.272363658209;12156.878431215575;12243.641922611074;11478.196526243082;12093.637190884288;12172.695682608006;12587.74824503523;12823.038272129814;11411.372374519482;11471.655850324503;11617.186796924134;12175.452104655134;12188.817167742314;9649.662261821084;9952.303338766507;9996.450195239331;10079.798404032024;10175.7456063599;9356.157945784911;10366.585336586451;10561.10230630405;10699.197560182862;10705.785884282426 15:59:39 INFO - PROCESS | 12175 | __end_tp_report 15:59:39 INFO - PROCESS | 12175 | __start_cc_report 15:59:39 INFO - PROCESS | 12175 | _x_x_mozilla_cycle_collect,390 15:59:39 INFO - PROCESS | 12175 | __end_cc_report 15:59:39 INFO - PROCESS | 12175 | __startTimestamp1470697179504__endTimestamp 15:59:39 INFO - PROCESS | 12175 | 15:59:39 INFO - PROCESS | 12175 | ------- Summary: start ------- 15:59:39 INFO - PROCESS | 12175 | Number of tests: 6 15:59:39 INFO - PROCESS | 12175 | 15:59:39 INFO - PROCESS | 12175 | [#0] dojo.html Cycles:165 Average:4813.34 Median:4925.34 stddev:504.20 (10.2%) stddev-sans-first:476.77 15:59:39 INFO - PROCESS | 12175 | Values: 2666.0 2681.8 2706.3 2707.2 2709.7 4741.7 4887.1 4897.9 4924.2 4947.5 4809.5 4843.0 4849.5 4877.5 4927.0 4425.4 4476.4 4494.2 4583.7 4612.9 4580.4 4593.1 4593.6 4598.2 4620.4 4326.2 4403.1 4415.1 4416.8 4459.2 4443.2 4449.5 4451.9 4550.8 4577.8 4426.0 4470.6 4508.0 4516.2 4519.2 4751.7 4823.2 4844.2 4854.3 4899.4 5142.3 5168.1 5177.1 5194.8 5202.6 5169.2 5218.6 5220.9 5225.7 5225.8 4668.3 4865.0 4925.3 4925.7 4992.3 5362.8 5377.1 5385.3 5394.8 5421.6 5190.0 5200.2 5204.5 5219.6 5248.2 5059.9 5174.9 5228.2 5243.3 5253.1 5174.0 5185.7 5187.9 5208.0 5275.8 5180.2 5194.1 5197.4 5205.7 5221.4 4306.0 4349.8 4404.1 4463.7 4487.6 3849.2 3903.4 3904.2 3904.2 3949.6 4453.9 4495.6 4501.3 4504.5 4552.5 5014.0 5169.8 5195.4 5236.0 5313.5 4472.1 4477.4 4483.0 4498.8 4533.9 4723.9 4732.1 4736.2 4745.2 4788.4 4771.1 4782.8 4838.6 4878.9 4940.8 5197.1 5220.1 5224.1 5225.6 5229.5 4711.6 4874.7 4880.5 4891.7 4895.7 5003.1 5008.1 5011.5 5046.1 5100.9 5165.4 5187.8 5188.3 5217.3 5230.0 5004.8 5007.2 5020.1 5025.7 5039.3 4854.8 5010.5 5011.0 5047.3 5130.9 5041.9 5050.2 5064.3 5119.1 5131.6 5123.9 5167.7 5176.2 5177.7 5235.1 4756.5 4917.1 4942.8 5049.3 5049.8 15:59:39 INFO - PROCESS | 12175 | 15:59:39 INFO - PROCESS | 12175 | [#1] ext.html Cycles:180 Average:47066.07 Median:36566.04 stddev:89485.18 (244.7%) stddev-sans-first:89667.96 15:59:39 INFO - PROCESS | 12175 | Values: 516.1 533.1 542.9 543.0 567.8 34058.0 37710.8 37810.4 37831.4 37862.2 38246.0 38582.2 38734.2 38765.8 38894.8 7556.9 7652.1 7710.5 7715.3 7727.6 7635.6 7715.4 7770.3 7774.3 7790.5 7765.8 7788.2 7791.3 7792.2 7806.8 7683.4 7718.0 7746.8 7747.6 7771.3 7623.5 7673.3 7698.3 7699.0 7704.0 36138.0 36246.8 36490.3 36546.0 36586.1 3111.0 3139.6 3188.1 3304.4 3372.9 28666.2 29125.7 29273.9 29362.1 29368.0 3018.1 3022.3 3030.0 3164.1 3170.3 182570.1 182817.0 183139.0 183427.0 183508.1 50822.0 51119.7 51133.0 51387.7 51443.2 53021.0 53127.7 53215.5 53252.5 53289.0 13536.8 14628.9 14673.0 14724.9 14760.2 10551.5 10669.6 10750.6 10757.0 10795.2 17510.0 17559.9 17586.6 17619.7 17627.1 6654.9 6664.4 6750.7 6794.3 6805.4 799.2 827.5 887.2 893.2 1023.6 25925.5 26590.3 27634.3 28275.6 29654.9 918.5 938.6 939.8 940.2 960.8 13597.3 14240.4 14305.8 14338.0 14504.9 406716.0 413324.0 413436.0 413796.0 414726.0 46879.0 47033.3 47346.0 47364.0 47424.8 1169.3 1182.4 1207.8 1225.0 1227.3 25394.0 26478.9 26612.9 27027.5 27068.9 41262.8 41837.0 41936.0 42046.4 42102.8 370742.0 370806.0 371336.0 371896.0 373690.0 24019.8 24417.0 24478.4 24499.0 24666.8 40012.8 40121.0 40522.8 41089.8 41559.0 34529.5 34899.5 35283.8 35325.8 35765.0 34723.3 35107.6 35279.6 35308.8 35472.8 33540.5 33669.2 33781.5 34127.1 34609.5 30192.7 31913.0 32215.0 32327.4 32439.5 24737.3 24758.3 24921.3 25092.5 25722.2 15:59:39 INFO - PROCESS | 12175 | 15:59:39 INFO - PROCESS | 12175 | [#2] jquery.html Cycles:180 Average:24349.24 Median:5044.82 stddev:65145.49 (1291.3%) stddev-sans-first:65303.32 15:59:39 INFO - PROCESS | 12175 | Values: 351.3 361.9 369.0 370.2 380.5 15494.7 16509.0 17156.8 17298.4 17429.5 14295.7 14830.8 14836.1 14929.8 14956.3 4860.3 5023.1 5036.6 5053.0 5184.3 4958.2 4964.6 4967.4 4989.5 4997.3 4943.7 5405.7 5650.4 5702.9 5794.3 5322.8 5364.1 5561.0 5716.9 5749.7 5210.1 5243.6 5336.7 5379.2 5383.8 12625.4 18981.1 20440.6 20632.6 20635.5 1801.7 2280.2 2393.8 2407.1 2428.6 9173.3 9282.0 9282.4 9395.2 9396.6 1706.8 1717.6 1743.1 1767.6 1781.8 73744.6 74617.6 75018.6 76076.2 78534.6 8662.8 8755.8 8820.4 10036.8 10088.3 13907.8 13918.9 13919.6 13934.8 14006.0 6632.2 6766.3 6785.7 6847.8 7148.6 6378.1 6441.0 6485.9 6579.6 6616.9 4270.4 4316.2 4323.6 4334.8 4461.2 1804.3 1822.9 1841.7 1853.4 1875.7 809.8 817.6 860.6 940.2 944.3 16242.8 16501.0 16545.6 16770.6 17448.9 849.5 853.1 856.7 889.9 909.1 8867.5 8980.0 9185.7 9280.0 9418.0 382350.0 390853.0 397845.0 398502.0 398699.0 48303.0 75931.0 78848.0 79792.6 79806.0 764.1 798.4 798.6 799.7 802.0 13977.7 14352.5 14394.9 14432.3 14451.3 38280.8 38782.4 39233.0 39676.6 39820.2 51805.2 52901.2 54560.5 55478.4 55760.7 7299.3 7337.0 7479.6 7601.3 7617.2 9476.7 10958.9 11250.9 11519.1 11560.2 9176.8 9459.0 9676.3 9850.4 10053.3 9766.5 9849.7 10151.5 10205.3 10349.9 9823.6 10034.9 10057.3 10148.0 10213.4 7498.4 7637.7 7711.3 7824.8 7844.0 9094.5 9909.3 9943.5 10281.1 10560.7 15:59:39 INFO - PROCESS | 12175 | 15:59:39 INFO - PROCESS | 12175 | [#3] mootools.html Cycles:180 Average:4938.07 Median:4735.96 stddev:2785.05 (58.8%) stddev-sans-first:2779.60 15:59:39 INFO - PROCESS | 12175 | Values: 1321.2 1353.8 1400.9 1612.4 1615.0 6385.3 7392.9 7443.6 8024.0 8055.4 7553.0 7813.6 7824.3 7830.6 7844.6 2112.8 2156.8 2157.8 2158.0 2163.3 2105.1 2136.9 2167.6 2174.4 2181.1 2144.9 2149.9 2154.5 2163.2 2208.8 2117.2 2118.5 2128.0 2142.0 2142.7 2104.0 2147.9 2155.5 2158.4 2163.6 7523.3 7543.0 7581.8 7582.6 7605.2 4264.8 4414.4 4421.6 4434.1 4436.5 2724.1 2815.3 2820.0 2904.7 2948.3 887.3 902.9 934.3 935.2 937.4 10478.0 10546.8 10551.0 10559.2 10574.7 3898.9 4068.3 4168.9 4201.1 4203.6 8563.7 8570.4 8586.1 8589.3 8609.2 4429.3 4451.4 4452.1 4480.5 4489.0 3287.2 3912.9 4039.3 4084.7 4104.3 3545.0 3572.7 3639.8 3651.8 3713.9 1153.2 1156.6 1166.4 1173.7 1178.3 605.3 643.0 675.5 692.2 711.5 4679.8 4792.2 4871.4 4876.7 5096.3 413.4 415.0 416.2 417.2 422.0 3389.8 3452.6 3495.7 3503.2 3550.3 8941.5 9158.3 9262.1 9294.6 9313.5 9185.5 9201.8 9212.2 9226.9 9234.7 6915.4 6973.4 6984.9 7029.3 7043.9 4857.5 4858.3 4901.0 4934.9 5018.2 8354.4 8429.6 8445.2 8499.3 8550.7 8423.7 8614.1 8636.3 8641.7 8676.1 5616.3 6324.4 6497.5 6525.1 6609.7 7149.4 7270.4 7270.9 7288.7 7288.8 6440.5 6516.3 6520.3 6605.2 6720.7 6364.0 6445.1 6453.4 6470.3 6559.1 5949.7 6006.8 6053.8 6055.6 6063.6 4355.8 4457.5 4459.7 4525.8 4527.5 4305.1 4318.2 4379.5 4411.1 4456.9 15:59:39 INFO - PROCESS | 12175 | 15:59:39 INFO - PROCESS | 12175 | [#4] prototype.html Cycles:180 Average:4405.07 Median:5098.88 stddev:1308.95 (25.7%) stddev-sans-first:1275.60 15:59:39 INFO - PROCESS | 12175 | Values: 286.6 290.5 296.0 296.1 297.3 5111.6 5128.1 5146.4 5147.0 5148.8 5051.5 5055.1 5059.2 5065.2 5087.3 3736.0 3829.8 3929.2 3957.9 3968.4 3965.2 3967.8 3970.4 3996.6 4004.2 3934.7 3956.7 3969.0 3980.2 3981.7 3694.9 3898.3 3934.5 3968.5 3990.5 3377.7 3381.1 3383.2 3391.3 3395.5 4972.6 4986.2 4990.8 4995.1 5001.0 4232.5 4463.5 4481.8 4487.3 4504.7 5268.4 5269.5 5291.8 5302.9 5310.7 3681.4 3696.1 3701.5 3713.6 3728.9 5388.8 5550.6 5599.6 5647.9 5666.6 3735.4 3749.2 3755.9 3759.3 3763.7 3780.3 3795.3 3814.5 3823.0 3838.6 4436.0 4447.3 4453.3 4456.0 4457.3 5235.3 5244.3 5266.6 5364.3 5374.6 1293.6 1320.9 1322.5 1327.6 1330.5 786.3 805.8 835.6 847.1 853.6 4490.5 4648.3 4665.1 4696.6 4723.3 5502.9 5518.1 5526.6 5549.8 5552.3 4432.0 4580.9 4641.5 4656.2 4673.3 2884.7 2904.0 2913.2 2929.2 2939.4 5121.2 5128.2 5130.7 5140.0 5165.9 5397.6 5522.3 5567.7 5625.4 5637.3 5085.8 5139.9 5143.7 5158.8 5166.7 5482.9 5572.0 5575.2 5591.1 5592.3 5110.5 5393.2 5417.2 5427.3 5447.5 5166.5 5185.8 5188.9 5205.7 5232.9 3802.9 3834.0 3842.5 3843.1 3851.5 5167.9 5523.3 5542.6 5567.3 5622.6 5366.6 5372.5 5388.9 5398.4 5402.2 5194.3 5342.3 5364.4 5381.8 5387.0 5254.5 5293.1 5298.9 5305.4 5334.2 5155.8 5253.0 5327.2 5373.5 5457.3 5206.2 5243.9 5247.2 5285.4 5295.4 15:59:39 INFO - PROCESS | 12175 | 15:59:39 INFO - PROCESS | 12175 | [#5] yui.html Cycles:180 Average:17762.85 Median:20695.19 stddev:26197.72 (126.6%) stddev-sans-first:26239.70 15:59:39 INFO - PROCESS | 12175 | Values: 648.8 649.0 744.0 750.4 765.3 13342.5 13517.2 14340.5 14406.3 14436.9 15096.6 15239.2 15239.3 15282.7 15284.2 738.5 743.2 761.1 766.8 767.2 777.0 783.7 783.9 785.2 787.6 809.3 809.9 815.2 816.6 821.2 804.3 805.0 806.1 807.4 809.8 585.0 585.3 585.6 586.8 588.1 14092.9 14096.8 14129.6 14155.2 14159.2 12778.2 12954.0 13139.5 13148.7 13352.6 9896.2 9906.5 9915.1 10016.4 10113.1 3168.5 3188.2 3226.8 3282.6 3310.5 69346.0 69609.7 69657.0 70264.9 70779.3 10306.5 10475.0 10574.7 10762.9 10867.8 18623.7 18689.4 18731.4 18838.2 18892.0 6774.9 6879.9 6952.5 6957.8 6984.1 3686.2 3739.6 3771.9 3776.4 3809.7 2672.4 2724.0 2738.4 2758.3 2772.6 497.3 498.9 502.4 507.6 507.7 453.8 482.8 484.1 490.8 497.2 7628.4 7798.3 7902.5 7929.8 7959.3 435.0 455.5 497.1 509.7 542.2 3570.7 3708.7 3735.2 3760.7 3829.5 104339.5 108487.0 109900.5 112364.4 112388.4 84216.6 95577.0 96083.0 96580.0 96934.5 47670.8 47961.8 48552.5 62140.1 78702.8 6913.4 6996.4 7162.8 7215.3 7364.0 38966.4 40955.4 46663.0 46940.8 48915.0 39832.8 43791.0 51134.7 52315.5 52711.7 11133.9 11196.1 11210.4 11289.7 11429.4 11680.6 11940.2 12183.2 12293.3 12771.9 11311.4 11899.5 12127.3 12156.9 12243.6 11478.2 12093.6 12172.7 12587.7 12823.0 11411.4 11471.7 11617.2 12175.5 12188.8 9649.7 9952.3 9996.5 10079.8 10175.7 9356.2 10366.6 10561.1 10699.2 10705.8 15:59:39 INFO - PROCESS | 12175 | -------- Summary: end -------- 15:59:39 INFO - PROCESS | 12175 | 15:59:40 INFO - TEST-INFO | 12175: exit 0 15:59:40 INFO - TEST-OK | dromaeo_css | took 1117049ms 15:59:40 INFO - TEST-START | kraken 15:59:40 INFO - operating with platform_type : linux_ 15:59:40 INFO - Initialising browser for kraken test... 15:59:40 INFO - TEST-INFO | started process 12419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpepBL2s/profile http://localhost:56448/getInfo.html) 15:59:44 INFO - PROCESS | 12419 | __metrics Screen width/height:1600/1200 15:59:44 INFO - PROCESS | 12419 | colorDepth:24 15:59:44 INFO - PROCESS | 12419 | Browser inner width/height: 1024/697 15:59:44 INFO - PROCESS | 12419 | __metrics 15:59:45 ERROR - PROCESS | 12419 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:59:46 INFO - TEST-INFO | 12419: exit 0 15:59:46 INFO - Browser initialized. 15:59:46 INFO - Running cycle 1/1 for kraken test... 15:59:46 INFO - TEST-INFO | started process 12540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpepBL2s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:58 INFO - PROCESS | 12540 | RSS: Main: 164786176 15:59:58 INFO - PROCESS | 12540 | 16:00:01 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56448/tests/kraken/driver.html?testName=audio-beat-detection) 16:00:02 INFO - PROCESS | 12540 | RSS: Main: 169967616 16:00:02 INFO - PROCESS | 12540 | 16:00:04 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56448/tests/kraken/driver.html?testName=audio-dft) 16:00:05 INFO - PROCESS | 12540 | RSS: Main: 168157184 16:00:05 INFO - PROCESS | 12540 | 16:00:08 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56448/tests/kraken/driver.html?testName=audio-fft) 16:00:09 INFO - PROCESS | 12540 | RSS: Main: 165330944 16:00:09 INFO - PROCESS | 12540 | 16:00:11 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56448/tests/kraken/driver.html?testName=audio-oscillator) 16:00:11 INFO - PROCESS | 12540 | RSS: Main: 166182912 16:00:11 INFO - PROCESS | 12540 | 16:00:14 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56448/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:00:14 INFO - PROCESS | 12540 | RSS: Main: 166215680 16:00:14 INFO - PROCESS | 12540 | 16:00:17 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56448/tests/kraken/driver.html?testName=imaging-darkroom) 16:00:18 INFO - PROCESS | 12540 | RSS: Main: 166383616 16:00:18 INFO - PROCESS | 12540 | 16:00:22 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56448/tests/kraken/driver.html?testName=imaging-desaturate) 16:00:22 INFO - PROCESS | 12540 | RSS: Main: 163790848 16:00:22 INFO - PROCESS | 12540 | 16:00:25 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56448/tests/kraken/driver.html?testName=json-parse-financial) 16:00:26 INFO - PROCESS | 12540 | RSS: Main: 165781504 16:00:26 INFO - PROCESS | 12540 | 16:00:28 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56448/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:00:28 INFO - PROCESS | 12540 | RSS: Main: 166236160 16:00:28 INFO - PROCESS | 12540 | 16:00:30 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56448/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:00:31 INFO - PROCESS | 12540 | RSS: Main: 165384192 16:00:31 INFO - PROCESS | 12540 | 16:00:33 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56448/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:00:34 INFO - PROCESS | 12540 | RSS: Main: 165584896 16:00:34 INFO - PROCESS | 12540 | 16:00:37 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:00:37 INFO - PROCESS | 12540 | RSS: Main: 166830080 16:00:37 INFO - PROCESS | 12540 | 16:00:40 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:00:41 INFO - PROCESS | 12540 | RSS: Main: 166027264 16:00:41 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | Cycle 1(1): loaded http://localhost:56448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56448/tests/kraken/driver.html?testName=ai-astar) 16:00:43 INFO - PROCESS | 12540 | RSS: Main: 166916096 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | __start_tp_report 16:00:43 INFO - PROCESS | 12540 | _x_x_mozilla_page_load 16:00:43 INFO - PROCESS | 12540 | _x_x_mozilla_page_load_details 16:00:43 INFO - PROCESS | 12540 | |i|pagename|runs| 16:00:43 INFO - PROCESS | 12540 | |0;ai-astar;106;117;108;117;117;115;116;115;114;114 16:00:43 INFO - PROCESS | 12540 | |1;audio-beat-detection;152;131;153;192;123;153;149;125;189;128 16:00:43 INFO - PROCESS | 12540 | |2;audio-dft;165;164;166;168;168;163;165;163;163;164 16:00:43 INFO - PROCESS | 12540 | |3;audio-fft;76;76;78;171;77;78;76;77;168;77 16:00:43 INFO - PROCESS | 12540 | |4;audio-oscillator;87;86;143;86;85;85;133;85;85;128 16:00:43 INFO - PROCESS | 12540 | |5;imaging-gaussian-blur;117;118;118;119;117;117;119;118;124;117 16:00:43 INFO - PROCESS | 12540 | |6;imaging-darkroom;148;149;151;150;147;149;148;150;147;147 16:00:43 INFO - PROCESS | 12540 | |7;imaging-desaturate;95;96;97;95;95;95;95;95;96;96 16:00:43 INFO - PROCESS | 12540 | |8;json-parse-financial;64;66;65;65;66;64;64;64;64;68 16:00:43 INFO - PROCESS | 12540 | |9;json-stringify-tinderbox;65;65;65;65;69;70;65;65;66;66 16:00:43 INFO - PROCESS | 12540 | |10;stanford-crypto-aes;81;80;80;85;84;83;80;85;82;80 16:00:43 INFO - PROCESS | 12540 | |11;stanford-crypto-ccm;143;143;132;135;141;142;143;132;153;141 16:00:43 INFO - PROCESS | 12540 | |12;stanford-crypto-pbkdf2;167;171;171;168;169;164;165;167;168;168 16:00:43 INFO - PROCESS | 12540 | |13;stanford-crypto-sha256-iterative;68;68;69;67;69;73;68;68;66;67 16:00:43 INFO - PROCESS | 12540 | __end_tp_report 16:00:43 INFO - PROCESS | 12540 | __start_cc_report 16:00:43 INFO - PROCESS | 12540 | _x_x_mozilla_cycle_collect,963 16:00:43 INFO - PROCESS | 12540 | __end_cc_report 16:00:43 INFO - PROCESS | 12540 | __startTimestamp1470697243323__endTimestamp 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | ------- Summary: start ------- 16:00:43 INFO - PROCESS | 12540 | Number of tests: 14 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.50 stddev:3.84 (3.3%) stddev-sans-first:2.82 16:00:43 INFO - PROCESS | 12540 | Values: 106.0 117.0 108.0 117.0 117.0 115.0 116.0 115.0 114.0 114.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:152.50 stddev:24.73 (16.2%) stddev-sans-first:26.21 16:00:43 INFO - PROCESS | 12540 | Values: 152.0 131.0 153.0 192.0 123.0 153.0 149.0 125.0 189.0 128.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:1.91 (1.2%) stddev-sans-first:2.03 16:00:43 INFO - PROCESS | 12540 | Values: 165.0 164.0 166.0 168.0 168.0 163.0 165.0 163.0 163.0 164.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#3] audio-fft Cycles:10 Average:95.40 Median:77.00 stddev:39.07 (50.7%) stddev-sans-first:40.80 16:00:43 INFO - PROCESS | 12540 | Values: 76.0 76.0 78.0 171.0 77.0 78.0 76.0 77.0 168.0 77.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:85.00 stddev:24.00 (28.2%) stddev-sans-first:24.96 16:00:43 INFO - PROCESS | 12540 | Values: 87.0 86.0 143.0 86.0 85.0 85.0 133.0 85.0 85.0 128.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:2.12 (1.8%) stddev-sans-first:2.19 16:00:43 INFO - PROCESS | 12540 | Values: 117.0 118.0 118.0 119.0 117.0 117.0 119.0 118.0 124.0 117.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.43 (1.0%) stddev-sans-first:1.50 16:00:43 INFO - PROCESS | 12540 | Values: 148.0 149.0 151.0 150.0 147.0 149.0 148.0 150.0 147.0 147.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 16:00:43 INFO - PROCESS | 12540 | Values: 95.0 96.0 97.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.33 (2.1%) stddev-sans-first:1.36 16:00:43 INFO - PROCESS | 12540 | Values: 64.0 66.0 65.0 65.0 66.0 64.0 64.0 64.0 64.0 68.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:65.50 stddev:1.85 (2.8%) stddev-sans-first:1.92 16:00:43 INFO - PROCESS | 12540 | Values: 65.0 65.0 65.0 65.0 69.0 70.0 65.0 65.0 66.0 66.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:2.11 (2.6%) stddev-sans-first:2.20 16:00:43 INFO - PROCESS | 12540 | Values: 81.0 80.0 80.0 85.0 84.0 83.0 80.0 85.0 82.0 80.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:142.50 stddev:6.26 (4.4%) stddev-sans-first:6.57 16:00:43 INFO - PROCESS | 12540 | Values: 143.0 143.0 132.0 135.0 141.0 142.0 143.0 132.0 153.0 141.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.00 stddev:2.25 (1.3%) stddev-sans-first:2.37 16:00:43 INFO - PROCESS | 12540 | Values: 167.0 171.0 171.0 168.0 169.0 164.0 165.0 167.0 168.0 168.0 16:00:43 INFO - PROCESS | 12540 | 16:00:43 INFO - PROCESS | 12540 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.89 (2.8%) stddev-sans-first:2.00 16:00:43 INFO - PROCESS | 12540 | Values: 68.0 68.0 69.0 67.0 69.0 73.0 68.0 68.0 66.0 67.0 16:00:43 INFO - PROCESS | 12540 | -------- Summary: end -------- 16:00:43 INFO - PROCESS | 12540 | 16:00:44 INFO - TEST-INFO | 12540: exit 0 16:00:44 INFO - TEST-OK | kraken | took 64136ms 16:00:44 INFO - SUITE-END | took 1181s 16:00:44 INFO - Completed test suite (00:19:41) 16:00:44 INFO - javascript benchmark 16:00:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6358.248895510869, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2665.9866700666494, 2681.7586417222446, 2706.296362945634, 2707.2149076767737, 2709.7290270972894, 4741.691790033646, 4887.095887260854, 4897.926531102036, 4924.2121260598315, 4947.455779864216, 4809.519048095189, 4843.0, 4849.539293767095, 4877.463479017314, 4926.950730492694, 4425.358323043165, 4476.418065651461, 4494.213512635276, 4583.656225783079, 4612.930806037912, 4580.358749775034, 4593.127305811901, 4593.563611456906, 4598.172328980782, 4620.376249206348, 4326.199653064162, 4403.141387429452, 4415.116976604676, 4416.801243943998, 4459.219636563588, 4443.178012067746, 4449.466064072332, 4451.888702782457, 4550.840720574797, 4577.816887324503, 4425.955740442619, 4470.56941778631, 4507.977460112711, 4516.16450956574, 4519.2091384008, 4751.738654374008, 4823.2282834746275, 4844.152273352184, 4854.344663470421, 4899.436564795059, 5142.280080788692, 5168.095583272912, 5177.068127737006, 5194.792208311663, 5202.557782588485, 5169.198774190007, 5218.634695571312, 5220.92168617471, 5225.686458812484, 5225.843224703265, 4668.346431499559, 4865.0, 4925.335079764258, 4925.655204135748, 4992.301077849104, 5362.758675859518, 5377.112776391929, 5385.299911011622, 5394.811181608625, 5421.620486565981, 5190.0, 5200.193969934666, 5204.4535323791215, 5219.556337711261, 5248.160294352885, 5059.8988020239385, 5174.870628234249, 5228.241904923765, 5243.2659427680155, 5253.106971814801, 5174.042802081627, 5185.714785686748, 5187.870303242374, 5207.973960130175, 5275.788968441219, 5180.248863914711, 5194.11700010999, 5197.350331208599, 5205.7397130143345, 5221.373435187726, 4306.0311429928015, 4349.760763157993, 4404.11917616478, 4463.732176069446, 4487.6185524230805, 3849.172427928009, 3903.394973779069, 3904.1996390739832, 3904.2191561687778, 3949.6050394960275, 4453.864264612568, 4495.617872480811, 4501.347304640809, 4504.549545045535, 4552.499225085238, 5013.974930125399, 5169.844904652867, 5195.402528709247, 5235.952809438128, 5313.468653134656, 4472.105578884171, 4477.395551600493, 4483.036147228361, 4498.752568608693, 4533.863984080483, 4723.881902952385, 4732.148213321566, 4736.242201247784, 4745.193317136095, 4788.377510923558, 4771.141194584939, 4782.832600859023, 4838.588719958843, 4878.853634390974, 4940.827071052496, 5197.064528384927, 5220.060389129993, 5224.05966925957, 5225.5558277545315, 5229.450907654642, 4711.623070154448, 4874.658773885794, 4880.511948805091, 4891.682040667345, 4895.657303988686, 5003.124453220745, 5008.073506401327, 5011.473795251592, 5046.116929537389, 5100.923486147636, 5165.354330708661, 5187.766550505161, 5188.325517682677, 5217.269582258411, 5229.9738501308775, 5004.824831130893, 5007.198848184273, 5020.121478741279, 5025.74871256443, 5039.3448851649055, 4854.805807767791, 5010.473900240422, 5010.974945125251, 5047.318611987334, 5130.923036154386, 5041.899162016813, 5050.217216331474, 5064.34163558735, 5119.104156772475, 5131.563817075441, 5123.923141152811, 5167.6641018333685, 5176.171812509981, 5177.715225662625, 5235.136202526541, 4756.453007903997, 4917.0903382874285, 4942.777575009205, 5049.293098966221, 5049.84850454487], "value": 4781.01811562158, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.1045585908448, 533.0751146760373, 542.8859939412723, 542.9782808687652, 567.7728908436623, 34058.0, 37710.8114459428, 37810.43284350737, 37831.43252851203, 37862.242755144915, 38246.0, 38582.228355432875, 38734.22531549367, 38765.8061709691, 38894.80552597233, 7556.924430755691, 7652.081750189957, 7710.498817576839, 7715.305622493975, 7727.613619319011, 7635.580043097628, 7715.382769378464, 7770.33952114071, 7774.300312971832, 7790.493617914817, 7765.7670269892, 7788.221177882195, 7791.337736292422, 7792.220777922219, 7806.804829879242, 7683.385329173652, 7718.035245594301, 7746.845063098763, 7747.573883436408, 7771.261730135628, 7623.504472209289, 7673.3477654398885, 7698.2686644768655, 7698.961505192494, 7704.036995375578, 36138.0, 36246.81876590627, 36490.270194596225, 36546.0, 36586.08534786625, 3110.98444507776, 3139.551150102923, 3188.1232661018175, 3304.3721692878275, 3372.9494057589154, 28666.182714969007, 29125.708742912513, 29273.853630731923, 29362.119136425943, 29368.0, 3018.1398301483973, 3022.304869879918, 3029.969700302991, 3164.0666003528786, 3170.25499007733, 182570.08714956473, 182817.0, 183139.0, 183427.0, 183508.0824595882, 50822.0, 51119.744401277756, 51133.0, 51387.743061284455, 51443.228351574755, 53021.0, 53127.734361327944, 53215.46784532105, 53252.467475325524, 53289.0, 13536.796948045787, 14628.926855365655, 14673.0, 14724.852751472563, 14760.188189649458, 10551.472426378803, 10669.626563070255, 10750.569977200981, 10757.0, 10795.190360722978, 17510.0, 17559.912200439172, 17586.560335991704, 17619.735703964452, 17627.118644068003, 6654.900176497356, 6664.433523150489, 6750.696218670171, 6794.320567943166, 6805.421539169127, 799.160881074869, 827.5365795154732, 887.2281115429489, 893.1604291965532, 1023.5854478936043, 25925.481490370086, 26590.335241618726, 27634.309142271202, 28275.57586636202, 29654.851725741664, 918.4994178172778, 938.638624129715, 939.7791518993031, 940.2008292950937, 960.8421851668862, 13597.252151131584, 14240.359183836545, 14305.78541321881, 14338.0, 14504.854951450561, 406716.0, 413324.0, 413436.0, 413796.0, 414726.0, 46879.0, 47033.29450058252, 47346.0, 47364.0, 47424.7628761854, 1169.2750494693344, 1182.379250893288, 1207.8429804125233, 1224.9571265005682, 1227.3311045480234, 25394.0, 26478.867605662617, 26612.8669356652, 27027.459450810482, 27068.864655676596, 41262.79368603138, 41837.0, 41936.0, 42046.36930445985, 42102.789486052374, 370742.0, 370806.0, 371336.0, 371896.0, 373690.0, 24019.759802402452, 24417.0, 24478.388040299134, 24499.020039198233, 24666.753332467164, 40012.799936000134, 40121.0, 40522.797386012884, 41089.79455102705, 41559.0, 34529.48205776966, 34899.4765078519, 35283.76506822249, 35325.82337088298, 35765.0, 34723.30553388969, 35107.64892351044, 35279.64720352764, 35308.82345588256, 35472.82263588665, 33540.49689254712, 33669.15827104342, 33781.49327760036, 34127.14682132967, 34609.480857787654, 30192.69807301899, 31913.0, 32215.0, 32327.35345293128, 32439.513407298437, 24737.257882263562, 24758.25725228246, 24921.252362429157, 25092.498150037263, 25722.228333150037], "value": 17040.18595181564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.27637067640677, 361.88600590813894, 368.99446508302395, 370.2114496123257, 380.518643915447, 15494.69010619787, 16509.0, 17156.828431715665, 17298.394556190535, 17429.477115686517, 14295.714085718306, 14830.777538336934, 14836.109833410002, 14929.776053359208, 14956.32696528656, 4860.2709593560985, 5023.095842748322, 5036.6222533309965, 5053.014662140884, 5184.274201611758, 4958.206686930092, 4964.578010869081, 4967.379077615298, 4989.476105008976, 4997.30037794709, 4943.728094954794, 5405.675659460445, 5650.406707295737, 5702.942970570303, 5794.275715535558, 5322.787088516455, 5364.088105022117, 5560.972195139018, 5716.914246286288, 5749.655020698771, 5210.062188806013, 5243.558021544106, 5336.67979921206, 5379.246905433203, 5383.81156659515, 12625.431855566521, 18981.145848436852, 20440.591188176302, 20632.587348253102, 20635.48411289715, 1801.675698374292, 2280.224723593986, 2393.7606239376096, 2407.109369533284, 2428.5749993751024, 9173.312001599907, 9282.0, 9282.443053416817, 9395.154436100784, 9396.577154028086, 1706.8293170682957, 1717.6478821841492, 1743.128435782109, 1767.6022894848684, 1781.8040015598274, 73744.63127684381, 74617.6269118651, 75018.62490687566, 76076.23923760747, 78534.60732696357, 8662.826743465095, 8755.781105472413, 8820.42667226641, 10036.799264014679, 10088.293819432716, 13907.79138312926, 13918.860811391958, 13919.582412527641, 13934.790978135336, 14006.0, 6632.204135503771, 6766.289539598271, 6785.660716964132, 6847.828804279933, 7148.642567871586, 6378.075179099004, 6440.967795160994, 6485.935140648628, 6579.605223686594, 6616.86766264672, 4270.444842170498, 4316.179925814148, 4323.567643235714, 4334.848280310174, 4461.174682683714, 1804.2588901709912, 1822.8541716662635, 1841.686913224755, 1853.4254381141889, 1875.7373967644542, 809.8380323935119, 817.5830326533392, 860.6471346747803, 940.2243149401634, 944.2870632672289, 16242.75635865463, 16501.0, 16545.608150329394, 16770.58073548171, 17448.91275543614, 849.5454931611558, 853.0914575976689, 856.6701819799298, 889.8976617689049, 909.0545832334299, 8867.48901739835, 8980.012198658142, 9185.724428267162, 9279.953600231956, 9417.96402395736, 382350.0, 390853.0, 397845.0, 398502.0, 398699.0, 48303.0, 75931.0, 78848.0, 79792.60103699444, 79806.0, 764.0754686828999, 798.397210106366, 798.5528104261632, 799.6521513141802, 802.0415603353936, 13977.720445591234, 14352.49766258176, 14394.928025359806, 14432.278386080445, 14451.277436128361, 38280.80859595684, 38782.4182637255, 39233.0, 39676.60323396729, 39820.2035959285, 51805.22292165696, 52901.20648190357, 54560.454395455534, 55478.44521554733, 55760.72119639538, 7299.270072992871, 7336.96331518339, 7479.626018699152, 7601.277878601524, 7617.238276172338, 9476.715698529055, 10958.945205274242, 11250.887491124984, 11519.078473721915, 11560.248583842023, 9176.816463670555, 9459.0, 9676.322657413913, 9850.359726617748, 10053.346532475658, 9766.511674416108, 9849.704508864745, 10151.492425378849, 10205.285630005828, 10349.896501034893, 9823.607055717692, 10034.899651003396, 10057.346272492265, 10148.0, 10213.438260895722, 7498.400127989857, 7637.694492220249, 7711.305982461606, 7824.804379890548, 7843.960780196063, 9094.499802510925, 9909.306348555532, 9943.502824858873, 10281.12610428122, 10560.683179504627], "value": 8063.165384297084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.2270821569377, 1353.8036984637226, 1400.9089409188402, 1612.3872928287242, 1614.9596260093504, 6385.26569444514, 7392.889106663404, 7443.553386796796, 8024.037115546128, 8055.395845311603, 7552.96223518883, 7813.6483858226375, 7824.256695613922, 7830.608469576527, 7844.568548729818, 2112.7887211278903, 2156.827453803692, 2157.8165855902266, 2157.9568408631817, 2163.3293678959494, 2105.1263725553877, 2136.8717876927435, 2167.566486702658, 2174.4129085147, 2181.149351752818, 2144.9034793434257, 2149.892505374733, 2154.472154322193, 2163.1779923629, 2208.8122509586624, 2117.237794394017, 2118.50215199428, 2127.9787202127936, 2141.9785802141937, 2142.73215848019, 2103.968440473394, 2147.892605369725, 2155.493459037125, 2158.4064382294837, 2163.599734049206, 7523.322900938887, 7542.962285188594, 7581.772546823604, 7582.582957937367, 7605.239476052406, 4264.829406823724, 4414.448193975753, 4421.579949904753, 4434.135343607965, 4436.511983681792, 2724.087430710714, 2815.338395477061, 2820.0, 2904.6659634142134, 2948.2629342664336, 887.3034667785822, 902.9097090290918, 934.3179478980383, 935.1817159985013, 937.4094320577992, 10478.0, 10546.841797373045, 10550.997655222818, 10559.155267578652, 10574.682759517227, 3898.941515877264, 4068.2677118119022, 4168.937465938014, 4201.075763332062, 4203.55862634419, 8563.657453701906, 8570.357223208284, 8586.09845966177, 8589.26991205742, 8609.182127697859, 4429.291313389842, 4451.354553589711, 4452.131834292347, 4480.529544397791, 4489.034857505652, 3287.227501537137, 3912.941305880414, 4039.313316736162, 4084.6732261419015, 4104.322786740214, 3544.964550354515, 3572.696320812708, 3639.79981101042, 3651.8174091295327, 3713.9442908356395, 1153.1812413186565, 1156.5720683347047, 1166.3526742657907, 1173.6537721372215, 1178.3401295274673, 605.3129697793037, 643.0193954219852, 675.5136301862651, 692.1901375390704, 711.4592909388798, 4679.766011699401, 4792.161371759928, 4871.391076115486, 4876.707397556158, 5096.337476128079, 413.43566032365607, 415.0143409402669, 416.24036134054865, 417.2364572831711, 422.03564854307757, 3389.8135602542097, 3452.5511683480986, 3495.702865256482, 3503.159241781954, 3550.3254381667402, 8941.46351218929, 9158.267338612895, 9262.120098590623, 9294.628214871329, 9313.53432328381, 9185.494797786187, 9201.769955751026, 9212.170904618617, 9226.907730922605, 9234.676786312446, 6915.4121899638085, 6973.372396484341, 6984.860302794017, 7029.29707029293, 7043.859122817515, 4857.53853383928, 4858.27125931099, 4901.019796040735, 4934.925976110433, 5018.247262910592, 8354.415190936576, 8429.5785210738, 8445.239928406472, 8499.277561407349, 8550.700725474579, 8423.663053477792, 8614.052454230155, 8636.309095272238, 8641.697540586048, 8676.132386761527, 5616.297962754656, 6324.367563243639, 6497.545171837926, 6525.119108920235, 6609.702563384563, 7149.356557909813, 7270.418366530771, 7270.854582908418, 7288.744893928687, 7288.817779555554, 6440.452561532322, 6516.250631177475, 6520.347965203442, 6605.240397354173, 6720.731170753115, 6364.015324453569, 6445.097686324012, 6453.386928241809, 6470.255920569195, 6559.14731084975, 5949.672767997802, 6006.849828754316, 6053.848653783691, 6055.63666180013, 6063.575549711478, 4355.847545335898, 4457.487388950312, 4459.687821852569, 4525.841595544141, 4527.501974782837, 4305.117450922616, 4318.179545886397, 4379.518252992232, 4411.095725376226, 4456.933146002877], "value": 3910.3634600825458, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.57872926797614, 290.5336934220576, 295.98372089535064, 296.0954284660362, 297.348806114609, 5111.616628752845, 5128.102582048141, 5146.382434107908, 5146.974265128669, 5148.794048238066, 5051.5453609175165, 5055.140626093564, 5059.215821547666, 5065.189569668853, 5087.287779710843, 3735.999999999993, 3829.8468061277517, 3929.2141571685634, 3957.940630890539, 3968.4245784361397, 3965.2069586082753, 3967.7817720025387, 3970.4044393341087, 3996.6003399660094, 4004.1991601679633, 3934.704897132712, 3956.723029387944, 3968.960310396888, 3980.20395920817, 3981.681465482769, 3694.8891533254045, 3898.337282661926, 3934.4688467056867, 3968.523777146732, 3990.5211374635082, 3377.67912048355, 3381.1040074380307, 3383.2049468375158, 3391.253504445213, 3395.47370157626, 4972.627052971042, 4986.227134794112, 4990.8253211137435, 4995.052918777902, 5001.0, 4232.476308528927, 4463.464384273875, 4481.7983190756495, 4487.349334346534, 4504.684672072956, 5268.367795864482, 5269.549659408393, 5291.761870715789, 5302.946970530323, 5310.681359118426, 3681.4293784463453, 3696.131409118882, 3701.4632878232774, 3713.6286371362917, 3728.9440658390145, 5388.757505912244, 5550.583706222009, 5599.608027438081, 5647.887042259173, 5666.603337766358, 3735.402335626287, 3749.1564398010228, 3755.868544600926, 3759.3045286622064, 3763.6612704856148, 3780.3384407728536, 3795.259924314732, 3814.5231846019246, 3823.0251285921913, 3838.616138386139, 4435.977820110943, 4447.288433850568, 4453.265211240174, 4455.977720111378, 4457.264551349056, 5235.317650428971, 5244.29202057725, 5266.552343050884, 5364.302640656768, 5374.596905232045, 1293.5860524632214, 1320.854705982341, 1322.510671051717, 1327.5818117293022, 1330.4545136493991, 786.3159051625008, 805.8388322335556, 835.6281454752577, 847.089378917666, 853.5945425922761, 4490.528494508029, 4648.2562789953445, 4665.136949664323, 4696.553827386393, 4723.267893476516, 5502.936398850431, 5518.061929471999, 5526.585506086979, 5549.833504994856, 5552.333719953551, 4432.0, 4580.946382332082, 4641.489436162019, 4656.208444564432, 4673.345731597579, 2884.682684904659, 2904.0271509044283, 2913.1551849963275, 2929.22375570474, 2939.3827296268023, 5121.155009423478, 5128.205128205134, 5130.692158470503, 5139.997700448452, 5165.896682066413, 5397.622166448311, 5522.30971128609, 5567.66594004361, 5625.353084395265, 5637.3235211774845, 5085.796568137233, 5139.948600513947, 5143.739783753004, 5158.767855446589, 5166.726640278265, 5482.862928426662, 5572.0, 5575.219469274386, 5591.077472217039, 5592.3009623797025, 5110.463401342806, 5393.244945707683, 5417.214503896992, 5427.2823116165555, 5447.536959358499, 5166.509181627739, 5185.766640501111, 5188.870278243074, 5205.6616319940595, 5232.921506177487, 3802.904927376838, 3833.9616603833606, 3842.51968503937, 3843.0584506796013, 3851.5185601799776, 5167.948320516747, 5523.254360661259, 5542.556595472433, 5567.331920169606, 5622.5783066271015, 5366.5510312216265, 5372.516473517402, 5388.946110538845, 5398.352197736297, 5402.189671549299, 5194.272801807674, 5342.332208473941, 5364.356277246756, 5381.811636592857, 5386.976474469838, 5254.474552544715, 5293.073712100444, 5298.947010529845, 5305.389880163676, 5334.1732031535175, 5155.845324640267, 5253.0, 5327.22755200486, 5373.516383525502, 5457.317835270591, 5206.193040078642, 5243.921341179809, 5247.163492777498, 5285.418603953639, 5295.391030031596], "value": 3976.800233781553, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.7534736800015, 648.9870202595948, 743.9702411903528, 750.4146765522894, 765.3341592814253, 13342.533011344605, 13517.188968661863, 14340.498082567125, 14406.279686015696, 14436.927815360934, 15096.622584435367, 15239.161846098488, 15239.31423085961, 15282.69434611307, 15284.235788210573, 738.5310327941769, 743.2121950732228, 761.0562902001506, 766.7814672818248, 767.2365995834152, 777.013193244579, 783.6669415498419, 783.9333656639193, 785.2461636828623, 787.5747096567846, 809.324214281076, 809.9433039687224, 815.1848151848152, 816.5753808019826, 821.1911267401605, 804.3082948664144, 804.9718259860906, 806.0770417871533, 807.4468988742701, 809.7854068671807, 585.0346927569502, 585.3181044083638, 585.6105689716334, 586.8122200895715, 588.1325045557811, 14092.92953535236, 14096.788548171786, 14129.576112716635, 14155.150690958473, 14159.150450972975, 12778.23330600167, 12954.0, 13139.54011609589, 13148.6712832179, 13352.592200158952, 9896.158826499755, 9906.455144967023, 9915.107640312406, 10016.39901605906, 10113.08982191599, 3168.5088811234295, 3188.2457684866113, 3226.822524761137, 3282.573265475473, 3310.453775127101, 69346.0, 69609.65195174042, 69657.0, 70264.94602580965, 70779.2922070783, 10306.536205870754, 10475.0, 10574.735631609117, 10762.892371076188, 10867.83698244527, 18623.720644190078, 18689.439316820517, 18731.44102620498, 18838.15228314729, 18892.0, 6774.898376524356, 6879.931200688029, 6952.478564107712, 6957.756478523227, 6984.092068031225, 3686.189038411545, 3739.6350332128577, 3771.905702357463, 3776.3580191367532, 3809.685573550973, 2672.398710290169, 2724.0, 2738.411241583069, 2758.2690586994463, 2772.6395568575954, 497.2764627467027, 498.89523200127655, 502.4046504891715, 507.59138893191334, 507.70553079213965, 453.7504372595125, 482.80501800625524, 484.1454832221132, 490.8404768450268, 497.1846172277468, 7628.351590114902, 7798.337141342936, 7902.525848449111, 7929.762107136795, 7959.3234575060615, 434.9891252718644, 455.4580049740864, 497.102729573124, 509.6610753848649, 542.1596525385715, 3570.6607872252093, 3708.6847617952776, 3735.234276973214, 3760.680342170946, 3829.540455145345, 104339.478302608, 108487.0, 109900.45049774859, 112364.43817781023, 112388.43805780918, 84216.57891710625, 95577.0, 96083.0, 96580.0, 96934.51532742432, 47670.80822979453, 47961.760191198824, 48552.5144748555, 62140.06789898155, 78702.81945770817, 6913.412359949461, 6996.440284777307, 7162.820929476805, 7215.314545118205, 7363.963180184279, 38966.4155037669, 40955.39936613225, 46663.0, 46940.765296173304, 48915.02169956652, 39832.80083599564, 43791.0, 51134.74432627813, 52315.47684523106, 52711.736441317546, 11133.944330278297, 11196.104311655212, 11210.439478025903, 11289.71775705614, 11429.371384573928, 11680.649580512598, 11940.164188506722, 12183.168316831683, 12293.262404255773, 12771.93614031961, 11311.434428278717, 11899.46452409661, 12127.272363658209, 12156.878431215575, 12243.641922611074, 11478.196526243082, 12093.637190884288, 12172.695682608006, 12587.74824503523, 12823.038272129814, 11411.372374519482, 11471.655850324503, 11617.186796924134, 12175.452104655134, 12188.817167742314, 9649.662261821084, 9952.303338766507, 9996.450195239331, 10079.798404032024, 10175.7456063599, 9356.157945784911, 10366.585336586451, 10561.10230630405, 10699.197560182862, 10705.785884282426], "value": 6467.347413794276, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 108.0, 117.0, 117.0, 115.0, 116.0, 115.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 153.0, 192.0, 123.0, 153.0, 149.0, 125.0, 189.0, 128.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 166.0, 168.0, 168.0, 163.0, 165.0, 163.0, 163.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 171.0, 77.0, 78.0, 76.0, 77.0, 168.0, 77.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 143.0, 86.0, 85.0, 85.0, 133.0, 85.0, 85.0, 128.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 119.0, 117.0, 117.0, 119.0, 118.0, 124.0, 117.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 151.0, 150.0, 147.0, 149.0, 148.0, 150.0, 147.0, 147.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 66.0, 64.0, 64.0, 64.0, 64.0, 68.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 69.0, 70.0, 65.0, 65.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 85.0, 84.0, 83.0, 80.0, 85.0, 82.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 143.0, 132.0, 135.0, 141.0, 142.0, 143.0, 132.0, 153.0, 141.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 171.0, 168.0, 169.0, 164.0, 165.0, 167.0, 168.0, 168.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 67.0, 69.0, 73.0, 68.0, 68.0, 66.0, 67.0], "value": 68.3, "unit": "score"}]}]} 16:00:44 INFO - Return code: 0 16:00:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:00:44 ERROR - # TBPL SUCCESS # 16:00:44 INFO - Running post-action listener: _resource_record_post_action 16:00:44 INFO - [mozharness: 2016-08-08 23:00:44.621424Z] Finished run-tests step (success) 16:00:44 INFO - Running post-run listener: _resource_record_post_run 16:00:44 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 309514240; Read time: 0; Write time: 152372 16:00:44 INFO - TinderboxPrint: CPU usage
13.3% 16:00:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:00:44 INFO - TinderboxPrint: I/O write bytes / time
309,514,240 / 152,372 16:00:44 INFO - TinderboxPrint: CPU idle
8,285.9 (86.7%) 16:00:44 INFO - TinderboxPrint: CPU user
1,219.8 (12.8%) 16:00:44 INFO - TinderboxPrint: Swap in / out
0 / 0 16:00:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13803520; Read time: 0; Write time: 3376 16:00:44 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 295333888; Read time: 0; Write time: 148968 16:00:45 INFO - Running post-run listener: _upload_blobber_files 16:00:45 INFO - Blob upload gear active. 16:00:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:00:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:00:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:00:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:00:45 INFO - (blobuploader) - INFO - Open directory for files ... 16:00:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:00:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:00:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:49 INFO - (blobuploader) - INFO - Done attempting. 16:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:00:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:49 INFO - (blobuploader) - INFO - Done attempting. 16:00:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:00:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:00:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:50 INFO - (blobuploader) - INFO - Done attempting. 16:00:50 INFO - (blobuploader) - INFO - Iteration through files over. 16:00:50 INFO - Return code: 0 16:00:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:00:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:00:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/49e1dd58c27106931fe0600dda924dc1f616f60d1c1f3714d350ec9a498c4f653c0bfbe56d42ffb333ea3214c4781eea1cfaf4c6f0e243cbebc1d3d1a184a786", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb0f0caae9973bc35f20720bd1572a5b4afed717807439d653b02aa20f462b9551e088bb85f1570e09c58dff4a09e1c6e534d41c8b1f004a016ad7351cb04f36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/66ab377e165d60f7f03c2ca64cf17c6b6fb09f4beb7b8484e0272eabfe2ac9db533ae3e08368581c2fd169398f0bbc821c23ac5b7182ae19a9808b29db3a4e78"} 16:00:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:00:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:00:50 INFO - Contents: 16:00:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/49e1dd58c27106931fe0600dda924dc1f616f60d1c1f3714d350ec9a498c4f653c0bfbe56d42ffb333ea3214c4781eea1cfaf4c6f0e243cbebc1d3d1a184a786", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb0f0caae9973bc35f20720bd1572a5b4afed717807439d653b02aa20f462b9551e088bb85f1570e09c58dff4a09e1c6e534d41c8b1f004a016ad7351cb04f36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/66ab377e165d60f7f03c2ca64cf17c6b6fb09f4beb7b8484e0272eabfe2ac9db533ae3e08368581c2fd169398f0bbc821c23ac5b7182ae19a9808b29db3a4e78"} 16:00:50 INFO - Running post-run listener: copy_logs_to_upload_dir 16:00:50 INFO - Copying logs to upload dir... 16:00:50 INFO - mkdir: /builds/slave/test/build/upload/logs 16:00:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.066941 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-08-08 16:00:50.287652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 16:00:50.291326) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950 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/Autoland-Non-PGO/sha512/49e1dd58c27106931fe0600dda924dc1f616f60d1c1f3714d350ec9a498c4f653c0bfbe56d42ffb333ea3214c4781eea1cfaf4c6f0e243cbebc1d3d1a184a786", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb0f0caae9973bc35f20720bd1572a5b4afed717807439d653b02aa20f462b9551e088bb85f1570e09c58dff4a09e1c6e534d41c8b1f004a016ad7351cb04f36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/66ab377e165d60f7f03c2ca64cf17c6b6fb09f4beb7b8484e0272eabfe2ac9db533ae3e08368581c2fd169398f0bbc821c23ac5b7182ae19a9808b29db3a4e78"} build_url:https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011126 build_url: 'https://queue.taskcluster.net/v1/task/dqtt3hmnRH-W9Yl1puYrUA/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/Autoland-Non-PGO/sha512/49e1dd58c27106931fe0600dda924dc1f616f60d1c1f3714d350ec9a498c4f653c0bfbe56d42ffb333ea3214c4781eea1cfaf4c6f0e243cbebc1d3d1a184a786", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb0f0caae9973bc35f20720bd1572a5b4afed717807439d653b02aa20f462b9551e088bb85f1570e09c58dff4a09e1c6e534d41c8b1f004a016ad7351cb04f36", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/66ab377e165d60f7f03c2ca64cf17c6b6fb09f4beb7b8484e0272eabfe2ac9db533ae3e08368581c2fd169398f0bbc821c23ac5b7182ae19a9808b29db3a4e78"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 16:00:50.316743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 16:00:50.317088) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1470695841.923614-922141950 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 16:00:50.399183) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 16:00:50.399543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 16:00:50.399848) ========= ========= Total master_lag: 0.17 =========