builder: larch_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1471914627.17 results: success (0) buildid: 20160822153014 builduid: bc63e52bc197498d974eb26243b8c472 revision: d2339a760bc96d8e8b2cbf819b08872e92e2ffaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:27.167868) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:27.168336) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:27.168622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:27.268280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:27.268651) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 18:10:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.4M=0s 2016-08-22 18:10:27 (37.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:27.456557) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:27.456869) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020799 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:27.506766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 18:10:27.507133) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev d2339a760bc96d8e8b2cbf819b08872e92e2ffaf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev d2339a760bc96d8e8b2cbf819b08872e92e2ffaf --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=6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 18:10:27,780 truncating revision to first 12 chars 2016-08-22 18:10:27,780 Setting DEBUG logging. 2016-08-22 18:10:27,780 attempt 1/10 2016-08-22 18:10:27,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/d2339a760bc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 18:10:28,523 unpacking tar archive at: larch-d2339a760bc9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.090315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 18:10:28.610853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:28.611190) ========= script_repo_revision: d2339a760bc96d8e8b2cbf819b08872e92e2ffaf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:28.611572) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:28.611880) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 18:10:28.621310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-22 18:10:28.621860) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-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=6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:10:28 INFO - MultiFileLogger online at 20160822 18:10:28 in /builds/slave/test 18:10:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 18:10:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:10:28 INFO - {'append_to_log': False, 18:10:28 INFO - 'base_work_dir': '/builds/slave/test', 18:10:28 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 18:10:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:10:28 INFO - 'branch': 'Larch-Non-PGO', 18:10:28 INFO - 'buildbot_json_path': 'buildprops.json', 18:10:28 INFO - 'config_files': ('talos/linux_config.py',), 18:10:28 INFO - 'default_actions': ('clobber', 18:10:28 INFO - 'read-buildbot-config', 18:10:28 INFO - 'download-and-extract', 18:10:28 INFO - 'populate-webroot', 18:10:28 INFO - 'create-virtualenv', 18:10:28 INFO - 'install', 18:10:28 INFO - 'run-tests'), 18:10:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:10:28 INFO - 'download_minidump_stackwalk': True, 18:10:28 INFO - 'download_symbols': 'ondemand', 18:10:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:10:28 INFO - 'tooltool.py': '/tools/tooltool.py', 18:10:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:10:28 INFO - '/tools/misc-python/virtualenv.py')}, 18:10:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:10:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:10:28 INFO - 'installer_path': 'installer.exe', 18:10:28 INFO - 'log_level': 'info', 18:10:28 INFO - 'log_name': 'talos', 18:10:28 INFO - 'log_to_console': True, 18:10:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:10:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:10:28 INFO - 'opt_config_files': (), 18:10:28 INFO - 'pip_index': False, 18:10:28 INFO - 'sps_profile': False, 18:10:28 INFO - 'sps_profile_interval': 0, 18:10:28 INFO - 'suite': 'dromaeojs-e10s', 18:10:28 INFO - 'system_bits': '32', 18:10:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:10:28 INFO - 'title': 'talos-linux64-ix-023', 18:10:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:10:28 INFO - 'use_talos_json': True, 18:10:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:10:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:10:28 INFO - 'work_dir': 'build'} 18:10:28 INFO - [mozharness: 2016-08-23 01:10:28.994623Z] Running clobber step. 18:10:28 INFO - Running pre-action listener: _resource_record_pre_action 18:10:28 INFO - Running main action method: clobber 18:10:28 INFO - rmtree: /builds/slave/test/build 18:10:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:10:29 INFO - Running post-action listener: _resource_record_post_action 18:10:29 INFO - [mozharness: 2016-08-23 01:10:29.460475Z] Finished clobber step (success) 18:10:29 INFO - [mozharness: 2016-08-23 01:10:29.460576Z] Running read-buildbot-config step. 18:10:29 INFO - Running pre-action listener: _resource_record_pre_action 18:10:29 INFO - Running main action method: read_buildbot_config 18:10:29 INFO - Using buildbot properties: 18:10:29 INFO - { 18:10:29 INFO - "project": "", 18:10:29 INFO - "product": "firefox", 18:10:29 INFO - "script_repo_revision": "production", 18:10:29 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 18:10:29 INFO - "repository": "", 18:10:29 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs-e10s", 18:10:29 INFO - "buildid": "20160822153014", 18:10:29 INFO - "pgo_build": "False", 18:10:29 INFO - "basedir": "/builds/slave/test", 18:10:29 INFO - "buildnumber": 2, 18:10:29 INFO - "slavename": "talos-linux64-ix-023", 18:10:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:10:29 INFO - "platform": "ubuntu64_hw", 18:10:29 INFO - "scheduler": "tests-larch-linux64-talos", 18:10:29 INFO - "branch": "larch", 18:10:29 INFO - "repo_path": "projects/larch", 18:10:29 INFO - "revision": "d2339a760bc96d8e8b2cbf819b08872e92e2ffaf", 18:10:29 INFO - "stage_platform": "linux64", 18:10:29 INFO - "builduid": "bc63e52bc197498d974eb26243b8c472", 18:10:29 INFO - "slavebuilddir": "test" 18:10:29 INFO - } 18:10:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:10:29 INFO - Running post-action listener: _resource_record_post_action 18:10:29 INFO - [mozharness: 2016-08-23 01:10:29.463020Z] Finished read-buildbot-config step (success) 18:10:29 INFO - [mozharness: 2016-08-23 01:10:29.463108Z] Running download-and-extract step. 18:10:29 INFO - Running pre-action listener: _resource_record_pre_action 18:10:29 INFO - Running main action method: download_and_extract 18:10:29 INFO - mkdir: /builds/slave/test/build/tests 18:10: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')]} 18:10:29 INFO - trying https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:10:29 INFO - Downloading https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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 18:10:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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 18:10:30 INFO - Downloaded 1361 bytes. 18:10:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:10:30 INFO - Using the following test package requirements: 18:10:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:10:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:10:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:10:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:30 INFO - u'jsshell-linux-x86_64.zip'], 18:10:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:10:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:10:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:10:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:10:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:10:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:10:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:10:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:10: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')]} 18:10:30 INFO - trying https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:10:30 INFO - Downloading https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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 18:10:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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 18:10:30 INFO - Downloaded 20330692 bytes. 18:10:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 18:10:35 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 18:10:35 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')]} 18:10:35 INFO - trying https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:10:35 INFO - Downloading https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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 18:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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 18:10:35 INFO - Downloaded 20330692 bytes. 18:10:35 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 18:10:40 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')]} 18:10:40 INFO - trying https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:10:40 INFO - Downloading https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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 18:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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 18:10:42 INFO - Downloaded 14413981 bytes. 18:10:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 18:10:42 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')]} 18:10:42 INFO - trying https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:10:42 INFO - Downloading https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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 18:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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 18:10:43 INFO - Downloaded 55746317 bytes. 18:10:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:10:43 INFO - mkdir: /builds/slave/test/properties 18:10:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:10:43 INFO - Writing to file /builds/slave/test/properties/build_url 18:10:43 INFO - Contents: 18:10:43 INFO - build_url:https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:10:44 INFO - Running post-action listener: _resource_record_post_action 18:10:44 INFO - Running post-action listener: set_extra_try_arguments 18:10:44 INFO - [mozharness: 2016-08-23 01:10:44.273178Z] Finished download-and-extract step (success) 18:10:44 INFO - [mozharness: 2016-08-23 01:10:44.273433Z] Running populate-webroot step. 18:10:44 INFO - Running pre-action listener: _resource_record_pre_action 18:10:44 INFO - Running main action method: populate_webroot 18:10:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:10:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:10:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:10:44 INFO - '--tppagecycles', 18:10:44 INFO - '7'], 18:10:44 INFO - 'tests': ['tsvgm']}}, 18:10:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:10:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:10:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:10:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:10:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:44 INFO - 'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:10:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:44 INFO - 'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['damp', 'tps']}, 18:10:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:44 INFO - 'tests': ['damp', 'tps']}, 18:10:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['dromaeo_dom']}, 18:10:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:10:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['basic_compositor_video']}, 18:10:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:10:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['a11yr', 18:10:44 INFO - 'ts_paint', 18:10:44 INFO - 'tpaint', 18:10:44 INFO - 'sessionrestore', 18:10:44 INFO - 'sessionrestore_no_auto_restore', 18:10:44 INFO - 'tabpaint']}, 18:10:44 INFO - 'other-e10s': {'tests': ['a11yr', 18:10:44 INFO - 'ts_paint', 18:10:44 INFO - 'tpaint', 18:10:44 INFO - 'sessionrestore', 18:10:44 INFO - 'sessionrestore_no_auto_restore', 18:10:44 INFO - 'tabpaint']}, 18:10:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:10:44 INFO - 'ts_paint', 18:10:44 INFO - 'tpaint', 18:10:44 INFO - 'sessionrestore', 18:10:44 INFO - 'sessionrestore_no_auto_restore', 18:10:44 INFO - 'tabpaint']}, 18:10:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:10:44 INFO - 'ts_paint', 18:10:44 INFO - 'tpaint', 18:10:44 INFO - 'sessionrestore', 18:10:44 INFO - 'sessionrestore_no_auto_restore', 18:10:44 INFO - 'tabpaint']}, 18:10:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['a11yr', 18:10:44 INFO - 'ts_paint', 18:10:44 INFO - 'tpaint', 18:10:44 INFO - 'sessionrestore', 18:10:44 INFO - 'sessionrestore_no_auto_restore', 18:10:44 INFO - 'tabpaint']}, 18:10:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['a11yr', 18:10:44 INFO - 'ts_paint', 18:10:44 INFO - 'tpaint', 18:10:44 INFO - 'sessionrestore', 18:10:44 INFO - 'sessionrestore_no_auto_restore', 18:10:44 INFO - 'tabpaint']}, 18:10:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['tsvgx', 18:10:44 INFO - 'tsvgr_opacity', 18:10:44 INFO - 'tart', 18:10:44 INFO - 'tscrollx', 18:10:44 INFO - 'cart']}, 18:10:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:10:44 INFO - 'tsvgr_opacity', 18:10:44 INFO - 'tart', 18:10:44 INFO - 'tscrollx', 18:10:44 INFO - 'cart']}, 18:10:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:44 INFO - 'talos_options': ['--disable-e10s'], 18:10:44 INFO - 'tests': ['tp5o']}, 18:10:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:44 INFO - 'tests': ['tp5o']}, 18:10:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:44 INFO - 'talos_options': ['--disable-e10s', 18:10:44 INFO - '--xperf_path', 18:10:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:44 INFO - 'tests': ['tp5n']}, 18:10:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:10:44 INFO - 'talos_options': ['--xperf_path', 18:10:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:10:44 INFO - 'tests': ['tp5n']}}, 18:10:44 INFO - 'talos.zip': {'path': '', 18:10:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:10:44 INFO - Running post-action listener: _resource_record_post_action 18:10:44 INFO - [mozharness: 2016-08-23 01:10:44.292111Z] Finished populate-webroot step (success) 18:10:44 INFO - [mozharness: 2016-08-23 01:10:44.292200Z] Running create-virtualenv step. 18:10:44 INFO - Running pre-action listener: _resource_record_pre_action 18:10:44 INFO - Running main action method: create_virtualenv 18:10:44 INFO - Creating virtualenv /builds/slave/test/build/venv 18:10:44 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 18:10:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:10:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:10:44 INFO - Using real prefix '/usr' 18:10:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:10:44 INFO - Installing distribute.............................................................................................................................................................................................done. 18:10:46 INFO - Installing pip.................done. 18:10:46 INFO - Return code: 0 18:10:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:10: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')]} 18:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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')]} 18:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d1fa1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', '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 18:10: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', 'pip>=1.5'] in /builds/slave/test/build 18:10: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 pip>=1.5 18:10:46 INFO - Using env: {'DISPLAY': ':0', 18:10:46 INFO - 'HOME': '/home/cltbld', 18:10:46 INFO - 'LANG': 'en_US.UTF-8', 18:10:46 INFO - 'LANGUAGE': 'en_US:en', 18:10:46 INFO - 'LOGNAME': 'cltbld', 18:10:46 INFO - 'MAIL': '/var/mail/cltbld', 18:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:46 INFO - 'MOZ_NO_REMOTE': '1', 18:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:46 INFO - 'NO_EM_RESTART': '1', 18:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:46 INFO - 'PWD': '/builds/slave/test', 18:10:46 INFO - 'SHELL': '/bin/bash', 18:10:46 INFO - 'SHLVL': '1', 18:10:46 INFO - 'TERM': 'linux', 18:10:46 INFO - 'TMOUT': '86400', 18:10:46 INFO - 'USER': 'cltbld', 18:10:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:46 INFO - '_': '/tools/buildbot/bin/python'} 18:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:47 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 18:10:47 INFO - Cleaning up... 18:10:47 INFO - Return code: 0 18:10:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f88d1fa1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', '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 18:10:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:10:47 INFO - Using env: {'DISPLAY': ':0', 18:10:47 INFO - 'HOME': '/home/cltbld', 18:10:47 INFO - 'LANG': 'en_US.UTF-8', 18:10:47 INFO - 'LANGUAGE': 'en_US:en', 18:10:47 INFO - 'LOGNAME': 'cltbld', 18:10:47 INFO - 'MAIL': '/var/mail/cltbld', 18:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:47 INFO - 'MOZ_NO_REMOTE': '1', 18:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:47 INFO - 'NO_EM_RESTART': '1', 18:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:47 INFO - 'PWD': '/builds/slave/test', 18:10:47 INFO - 'SHELL': '/bin/bash', 18:10:47 INFO - 'SHLVL': '1', 18:10:47 INFO - 'TERM': 'linux', 18:10:47 INFO - 'TMOUT': '86400', 18:10:47 INFO - 'USER': 'cltbld', 18:10:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:47 INFO - '_': '/tools/buildbot/bin/python'} 18:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:47 INFO - Downloading/unpacking psutil>=3.1.1 18:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:10:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:49 INFO - Installing collected packages: psutil 18:10:49 INFO - Running setup.py install for psutil 18:10:49 INFO - building 'psutil._psutil_linux' extension 18:10:49 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 18:10:49 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 18:10:49 INFO - building 'psutil._psutil_posix' extension 18:10:49 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 18:10:49 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 18:10:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:10:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:10:49 INFO - Successfully installed psutil 18:10:49 INFO - Cleaning up... 18:10:49 INFO - Return code: 0 18:10:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d1fa1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', '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 18:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:10:49 INFO - Using env: {'DISPLAY': ':0', 18:10:49 INFO - 'HOME': '/home/cltbld', 18:10:49 INFO - 'LANG': 'en_US.UTF-8', 18:10:49 INFO - 'LANGUAGE': 'en_US:en', 18:10:49 INFO - 'LOGNAME': 'cltbld', 18:10:49 INFO - 'MAIL': '/var/mail/cltbld', 18:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:49 INFO - 'MOZ_NO_REMOTE': '1', 18:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:49 INFO - 'NO_EM_RESTART': '1', 18:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:49 INFO - 'PWD': '/builds/slave/test', 18:10:49 INFO - 'SHELL': '/bin/bash', 18:10:49 INFO - 'SHLVL': '1', 18:10:49 INFO - 'TERM': 'linux', 18:10:49 INFO - 'TMOUT': '86400', 18:10:49 INFO - 'USER': 'cltbld', 18:10:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:49 INFO - '_': '/tools/buildbot/bin/python'} 18:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:10:50 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 18:10:50 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 18:10:50 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 18:10:50 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 18:10:50 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 18:10:50 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 18:10:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:10:51 INFO - Installing collected packages: mozsystemmonitor 18:10:51 INFO - Running setup.py install for mozsystemmonitor 18:10:52 INFO - Successfully installed mozsystemmonitor 18:10:52 INFO - Cleaning up... 18:10:52 INFO - Return code: 0 18:10:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f88d1fa1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', '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 18:10:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:10:52 INFO - Using env: {'DISPLAY': ':0', 18:10:52 INFO - 'HOME': '/home/cltbld', 18:10:52 INFO - 'LANG': 'en_US.UTF-8', 18:10:52 INFO - 'LANGUAGE': 'en_US:en', 18:10:52 INFO - 'LOGNAME': 'cltbld', 18:10:52 INFO - 'MAIL': '/var/mail/cltbld', 18:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:52 INFO - 'MOZ_NO_REMOTE': '1', 18:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:52 INFO - 'NO_EM_RESTART': '1', 18:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:52 INFO - 'PWD': '/builds/slave/test', 18:10:52 INFO - 'SHELL': '/bin/bash', 18:10:52 INFO - 'SHLVL': '1', 18:10:52 INFO - 'TERM': 'linux', 18:10:52 INFO - 'TMOUT': '86400', 18:10:52 INFO - 'USER': 'cltbld', 18:10:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:52 INFO - '_': '/tools/buildbot/bin/python'} 18:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:52 INFO - Downloading/unpacking jsonschema==2.5.1 18:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:10:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:10:54 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 18:10:54 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 18:10:54 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 18:10:54 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 18:10:54 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 18:10:54 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 18:10:54 INFO - Downloading functools32-3.2.3-2.tar.gz 18:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:10:54 INFO - warning: no files found matching '*.txt' 18:10:54 INFO - no previously-included directories found matching 'build' 18:10:54 INFO - no previously-included directories found matching 'dist' 18:10:54 INFO - no previously-included directories found matching '.git*' 18:10:54 INFO - Installing collected packages: jsonschema, functools32 18:10:54 INFO - Running setup.py install for functools32 18:10:54 INFO - warning: no files found matching '*.txt' 18:10:54 INFO - no previously-included directories found matching 'build' 18:10:54 INFO - no previously-included directories found matching 'dist' 18:10:54 INFO - no previously-included directories found matching '.git*' 18:10:54 INFO - Successfully installed jsonschema functools32 18:10:54 INFO - Cleaning up... 18:10:54 INFO - Return code: 0 18:10:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:10:54 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')]} 18:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:54 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')]} 18:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:54 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 0x7f88d1fa1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', '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 18:10:54 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 18:10:54 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 18:10:54 INFO - Using env: {'DISPLAY': ':0', 18:10:54 INFO - 'HOME': '/home/cltbld', 18:10:54 INFO - 'LANG': 'en_US.UTF-8', 18:10:54 INFO - 'LANGUAGE': 'en_US:en', 18:10:54 INFO - 'LOGNAME': 'cltbld', 18:10:54 INFO - 'MAIL': '/var/mail/cltbld', 18:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:54 INFO - 'MOZ_NO_REMOTE': '1', 18:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:54 INFO - 'NO_EM_RESTART': '1', 18:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:54 INFO - 'PWD': '/builds/slave/test', 18:10:54 INFO - 'SHELL': '/bin/bash', 18:10:54 INFO - 'SHLVL': '1', 18:10:54 INFO - 'TERM': 'linux', 18:10:54 INFO - 'TMOUT': '86400', 18:10:54 INFO - 'USER': 'cltbld', 18:10:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:54 INFO - '_': '/tools/buildbot/bin/python'} 18:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:10:54 INFO - Cleaning up... 18:10:54 INFO - Return code: 0 18:10:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:10:54 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')]} 18:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:54 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')]} 18:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:54 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 0x7f88d1fa1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', '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 18:10:54 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 18:10:54 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 18:10:54 INFO - Using env: {'DISPLAY': ':0', 18:10:54 INFO - 'HOME': '/home/cltbld', 18:10:54 INFO - 'LANG': 'en_US.UTF-8', 18:10:54 INFO - 'LANGUAGE': 'en_US:en', 18:10:54 INFO - 'LOGNAME': 'cltbld', 18:10:54 INFO - 'MAIL': '/var/mail/cltbld', 18:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:54 INFO - 'MOZ_NO_REMOTE': '1', 18:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:54 INFO - 'NO_EM_RESTART': '1', 18:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:54 INFO - 'PWD': '/builds/slave/test', 18:10:54 INFO - 'SHELL': '/bin/bash', 18:10:54 INFO - 'SHLVL': '1', 18:10:54 INFO - 'TERM': 'linux', 18:10:54 INFO - 'TMOUT': '86400', 18:10:54 INFO - 'USER': 'cltbld', 18:10:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:54 INFO - '_': '/tools/buildbot/bin/python'} 18:10:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:55 INFO - Downloading/unpacking blobuploader==1.2.4 18:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:10:56 INFO - Downloading blobuploader-1.2.4.tar.gz 18:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:10:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:10:57 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 18:10:57 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 18:10:57 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 18:10:57 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 18:10:57 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 18:10:57 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 18:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:10:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:10:57 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 18:10:57 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 18:10:57 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 18:10:57 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 18:10:57 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 18:10:57 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 18:10:57 INFO - Downloading docopt-0.6.1.tar.gz 18:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:10:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:10:57 INFO - Running setup.py install for blobuploader 18:10:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:10:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:10:57 INFO - Running setup.py install for requests 18:10:58 INFO - Running setup.py install for docopt 18:10:58 INFO - Successfully installed blobuploader requests docopt 18:10:58 INFO - Cleaning up... 18:10:58 INFO - Return code: 0 18:10:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:10:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:10:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:10:58 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 0x7f88d1fa1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', '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 18:10:58 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 18:10:58 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 18:10:58 INFO - Using env: {'DISPLAY': ':0', 18:10:58 INFO - 'HOME': '/home/cltbld', 18:10:58 INFO - 'LANG': 'en_US.UTF-8', 18:10:58 INFO - 'LANGUAGE': 'en_US:en', 18:10:58 INFO - 'LOGNAME': 'cltbld', 18:10:58 INFO - 'MAIL': '/var/mail/cltbld', 18:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:10:58 INFO - 'MOZ_NO_REMOTE': '1', 18:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:10:58 INFO - 'NO_EM_RESTART': '1', 18:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:10:58 INFO - 'PWD': '/builds/slave/test', 18:10:58 INFO - 'SHELL': '/bin/bash', 18:10:58 INFO - 'SHLVL': '1', 18:10:58 INFO - 'TERM': 'linux', 18:10:58 INFO - 'TMOUT': '86400', 18:10:58 INFO - 'USER': 'cltbld', 18:10:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:10:58 INFO - '_': '/tools/buildbot/bin/python'} 18:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:10:58 INFO - Running setup.py (path:/tmp/pip-8w5HHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:10:58 INFO - Running setup.py (path:/tmp/pip-3WuhBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:10:58 INFO - Running setup.py (path:/tmp/pip-O045L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:10:58 INFO - Running setup.py (path:/tmp/pip-b0hev2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:10:58 INFO - Running setup.py (path:/tmp/pip-r3imDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:10:58 INFO - Running setup.py (path:/tmp/pip-drTqgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:10:58 INFO - Running setup.py (path:/tmp/pip-g5awGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:10:59 INFO - Running setup.py (path:/tmp/pip-BvZS5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:10:59 INFO - Running setup.py (path:/tmp/pip-0NNxkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:10:59 INFO - Running setup.py (path:/tmp/pip-Vy5dG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:10:59 INFO - Running setup.py (path:/tmp/pip-yCBGZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:10:59 INFO - Running setup.py (path:/tmp/pip-zkPi1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:10:59 INFO - Running setup.py (path:/tmp/pip-6y_GBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:10:59 INFO - Running setup.py (path:/tmp/pip-Ej3pyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:59 INFO - Running setup.py (path:/tmp/pip-JifCJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:10:59 INFO - Running setup.py (path:/tmp/pip-zzXhLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:10:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:10:59 INFO - Running setup.py (path:/tmp/pip-PvSTk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:10:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:10:59 INFO - Running setup.py install for manifestparser 18:10:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:10:59 INFO - Running setup.py install for mozcrash 18:10:59 INFO - Running setup.py install for mozdebug 18:11:00 INFO - Running setup.py install for mozdevice 18:11:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:11:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:11:00 INFO - Running setup.py install for mozfile 18:11:00 INFO - Running setup.py install for mozhttpd 18:11:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:11:00 INFO - Running setup.py install for mozinfo 18:11:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:11:00 INFO - Running setup.py install for mozInstall 18:11:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:11:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:11:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:11:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:11:00 INFO - Running setup.py install for mozleak 18:11:00 INFO - Running setup.py install for mozlog 18:11:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:11:00 INFO - Running setup.py install for moznetwork 18:11:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:11:00 INFO - Running setup.py install for mozprocess 18:11:01 INFO - Running setup.py install for mozprofile 18:11:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:11:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:11:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:11:01 INFO - Running setup.py install for mozrunner 18:11:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:11:01 INFO - Running setup.py install for mozscreenshot 18:11:01 INFO - Running setup.py install for moztest 18:11:01 INFO - Running setup.py install for mozversion 18:11:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:11:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:11:01 INFO - Cleaning up... 18:11:01 INFO - Return code: 0 18:11:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:01 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 0x7f88d1fa1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', '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 18:11:01 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 18:11:01 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 18:11:01 INFO - Using env: {'DISPLAY': ':0', 18:11:01 INFO - 'HOME': '/home/cltbld', 18:11:01 INFO - 'LANG': 'en_US.UTF-8', 18:11:01 INFO - 'LANGUAGE': 'en_US:en', 18:11:01 INFO - 'LOGNAME': 'cltbld', 18:11:01 INFO - 'MAIL': '/var/mail/cltbld', 18:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:01 INFO - 'MOZ_NO_REMOTE': '1', 18:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:01 INFO - 'NO_EM_RESTART': '1', 18:11:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:01 INFO - 'PWD': '/builds/slave/test', 18:11:01 INFO - 'SHELL': '/bin/bash', 18:11:01 INFO - 'SHLVL': '1', 18:11:01 INFO - 'TERM': 'linux', 18:11:01 INFO - 'TMOUT': '86400', 18:11:01 INFO - 'USER': 'cltbld', 18:11:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:01 INFO - '_': '/tools/buildbot/bin/python'} 18:11:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:11:01 INFO - Running setup.py (path:/tmp/pip-nNjC1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:11:01 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)) 18:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:11:01 INFO - Running setup.py (path:/tmp/pip-jTsYHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:11:01 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)) 18:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:11:01 INFO - Running setup.py (path:/tmp/pip-hhG0ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:11:02 INFO - Running setup.py (path:/tmp/pip-XEqDJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:11:02 INFO - Running setup.py (path:/tmp/pip-ZbmKux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:11:02 INFO - Running setup.py (path:/tmp/pip-muyBT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:11:02 INFO - Running setup.py (path:/tmp/pip-xkDmk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:11:02 INFO - Running setup.py (path:/tmp/pip-YmBgtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:11:02 INFO - Running setup.py (path:/tmp/pip-GGwJ4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:11:02 INFO - Running setup.py (path:/tmp/pip-6OZgvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:11:02 INFO - Running setup.py (path:/tmp/pip-QxEisb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:11:02 INFO - Running setup.py (path:/tmp/pip-ZChHl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:11:02 INFO - Running setup.py (path:/tmp/pip-vsWs4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:11:02 INFO - Running setup.py (path:/tmp/pip-DllpIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:02 INFO - Running setup.py (path:/tmp/pip-Id52P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:11:02 INFO - Running setup.py (path:/tmp/pip-FCLmpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:11:02 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)) 18:11:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:11:02 INFO - Running setup.py (path:/tmp/pip-sTW0aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 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)) 18:11:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:11:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:11:04 INFO - Downloading blessings-1.6.tar.gz 18:11:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:11:05 INFO - Installing collected packages: blessings 18:11:05 INFO - Running setup.py install for blessings 18:11:05 INFO - Successfully installed blessings 18:11:05 INFO - Cleaning up... 18:11:05 INFO - Return code: 0 18:11:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:11:05 INFO - Reading from file tmpfile_stdout 18:11:05 INFO - Current package versions: 18:11:05 INFO - argparse == 1.2.1 18:11:05 INFO - blessings == 1.6 18:11:05 INFO - blobuploader == 1.2.4 18:11:05 INFO - docopt == 0.6.1 18:11:05 INFO - functools32 == 3.2.3-2 18:11:05 INFO - jsonschema == 2.5.1 18:11:05 INFO - manifestparser == 1.1 18:11:05 INFO - mozInstall == 1.12 18:11:05 INFO - mozcrash == 0.17 18:11:05 INFO - mozdebug == 0.1 18:11:05 INFO - mozdevice == 0.48 18:11:05 INFO - mozfile == 1.2 18:11:05 INFO - mozhttpd == 0.7 18:11:05 INFO - mozinfo == 0.9 18:11:05 INFO - mozleak == 0.1 18:11:05 INFO - mozlog == 3.3 18:11:05 INFO - moznetwork == 0.27 18:11:05 INFO - mozprocess == 0.23 18:11:05 INFO - mozprofile == 0.28 18:11:05 INFO - mozrunner == 6.12 18:11:05 INFO - mozscreenshot == 0.1 18:11:05 INFO - mozsystemmonitor == 0.3 18:11:05 INFO - moztest == 0.7 18:11:05 INFO - mozversion == 1.4 18:11:05 INFO - psutil == 3.1.1 18:11:05 INFO - requests == 1.2.3 18:11:05 INFO - wsgiref == 0.1.2 18:11:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:11:05 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')]} 18:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:05 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')]} 18:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:05 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 0x7f88d1fa1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', '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 18:11:05 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 18:11:05 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 18:11:05 INFO - Using env: {'DISPLAY': ':0', 18:11:05 INFO - 'HOME': '/home/cltbld', 18:11:05 INFO - 'LANG': 'en_US.UTF-8', 18:11:05 INFO - 'LANGUAGE': 'en_US:en', 18:11:05 INFO - 'LOGNAME': 'cltbld', 18:11:05 INFO - 'MAIL': '/var/mail/cltbld', 18:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:05 INFO - 'MOZ_NO_REMOTE': '1', 18:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:05 INFO - 'NO_EM_RESTART': '1', 18:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:05 INFO - 'PWD': '/builds/slave/test', 18:11:05 INFO - 'SHELL': '/bin/bash', 18:11:05 INFO - 'SHLVL': '1', 18:11:05 INFO - 'TERM': 'linux', 18:11:05 INFO - 'TMOUT': '86400', 18:11:05 INFO - 'USER': 'cltbld', 18:11:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:05 INFO - '_': '/tools/buildbot/bin/python'} 18:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:05 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)) 18:11:05 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)) 18:11:05 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)) 18:11:05 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)) 18:11:05 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)) 18:11:05 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)) 18:11:05 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)) 18:11:05 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)) 18:11:05 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)) 18:11:05 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)) 18:11:05 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)) 18:11:05 INFO - Cleaning up... 18:11:05 INFO - Return code: 0 18:11:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:11:05 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')]} 18:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:05 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')]} 18:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:05 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 0x7f88d1fa1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107a230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, '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': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', '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 18:11:05 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 18:11:05 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 18:11:05 INFO - Using env: {'DISPLAY': ':0', 18:11:05 INFO - 'HOME': '/home/cltbld', 18:11:05 INFO - 'LANG': 'en_US.UTF-8', 18:11:05 INFO - 'LANGUAGE': 'en_US:en', 18:11:05 INFO - 'LOGNAME': 'cltbld', 18:11:05 INFO - 'MAIL': '/var/mail/cltbld', 18:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:05 INFO - 'MOZ_NO_REMOTE': '1', 18:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:05 INFO - 'NO_EM_RESTART': '1', 18:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:05 INFO - 'PWD': '/builds/slave/test', 18:11:05 INFO - 'SHELL': '/bin/bash', 18:11:05 INFO - 'SHLVL': '1', 18:11:05 INFO - 'TERM': 'linux', 18:11:05 INFO - 'TMOUT': '86400', 18:11:05 INFO - 'USER': 'cltbld', 18:11:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:05 INFO - '_': '/tools/buildbot/bin/python'} 18:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:11:05 INFO - Cleaning up... 18:11:05 INFO - Return code: 0 18:11:05 INFO - Running post-action listener: _resource_record_post_action 18:11:05 INFO - Running post-action listener: _start_resource_monitoring 18:11:05 INFO - Starting resource monitoring. 18:11:05 INFO - [mozharness: 2016-08-23 01:11:05.882479Z] Finished create-virtualenv step (success) 18:11:05 INFO - [mozharness: 2016-08-23 01:11:05.882944Z] Running install step. 18:11:05 INFO - Running pre-action listener: _resource_record_pre_action 18:11:05 INFO - Running main action method: install 18:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:11:06 INFO - Reading from file tmpfile_stdout 18:11:06 INFO - Detecting whether we're running mozinstall >=1.0... 18:11:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:11:06 INFO - Reading from file tmpfile_stdout 18:11:06 INFO - Output received: 18:11:06 INFO - Usage: mozinstall [options] installer 18:11:06 INFO - Options: 18:11:06 INFO - -h, --help show this help message and exit 18:11:06 INFO - -d DEST, --destination=DEST 18:11:06 INFO - Directory to install application into. [default: 18:11:06 INFO - "/builds/slave/test"] 18:11:06 INFO - --app=APP Application being installed. [default: firefox] 18:11:06 INFO - mkdir: /builds/slave/test/build/application 18:11:06 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'] 18:11:06 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 18:11:22 INFO - Reading from file tmpfile_stdout 18:11:22 INFO - Output received: 18:11:22 INFO - /builds/slave/test/build/application/firefox/firefox 18:11:22 INFO - Running post-action listener: _resource_record_post_action 18:11:22 INFO - [mozharness: 2016-08-23 01:11:22.309492Z] Finished install step (success) 18:11:22 INFO - [mozharness: 2016-08-23 01:11:22.309749Z] Running run-tests step. 18:11:22 INFO - Running pre-action listener: _resource_record_pre_action 18:11:22 INFO - Running main action method: run_tests 18:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:11:22 INFO - Python 2.7.3 18:11:22 INFO - Return code: 0 18:11:22 INFO - grabbing minidump binary from tooltool 18:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:22 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 0x1074090>, '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 0x10779b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:11:22 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 18:11:22 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 18:11:22 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 18:11:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:11:22 INFO - Return code: 0 18:11:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:11:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:11:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:11:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:11:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 18:11:22 INFO - Using env: {'DISPLAY': ':0', 18:11:22 INFO - 'HOME': '/home/cltbld', 18:11:22 INFO - 'LANG': 'en_US.UTF-8', 18:11:22 INFO - 'LANGUAGE': 'en_US:en', 18:11:22 INFO - 'LOGNAME': 'cltbld', 18:11:22 INFO - 'MAIL': '/var/mail/cltbld', 18:11:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:11:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:22 INFO - 'MOZ_NO_REMOTE': '1', 18:11:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:11:22 INFO - 'NO_EM_RESTART': '1', 18:11:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:22 INFO - 'PWD': '/builds/slave/test', 18:11:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:11:22 INFO - 'SHELL': '/bin/bash', 18:11:22 INFO - 'SHLVL': '1', 18:11:22 INFO - 'TERM': 'linux', 18:11:22 INFO - 'TMOUT': '86400', 18:11:22 INFO - 'USER': 'cltbld', 18:11:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287', 18:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:22 INFO - '_': '/tools/buildbot/bin/python'} 18:11:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:11:22 INFO - mozversion application_buildid: 20160822153014 18:11:22 INFO - mozversion application_changeset: d2339a760bc96d8e8b2cbf819b08872e92e2ffaf 18:11:22 INFO - mozversion application_display_name: Nightly 18:11:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:11:22 INFO - mozversion application_name: Firefox 18:11:22 INFO - mozversion application_remotingname: firefox 18:11:22 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 18:11:22 INFO - mozversion application_vendor: Mozilla 18:11:22 INFO - mozversion application_version: 51.0a1 18:11:22 INFO - mozversion platform_buildid: 20160822153014 18:11:22 INFO - mozversion platform_changeset: d2339a760bc96d8e8b2cbf819b08872e92e2ffaf 18:11:22 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 18:11:22 INFO - mozversion platform_version: 51.0a1 18:11:22 INFO - using testdate: 1471914682 18:11:22 INFO - actual date: 1471914682 18:11:22 INFO - starting webserver on 'localhost:60604' 18:11:22 INFO - SUITE-START | Running 2 tests 18:11:22 INFO - TEST-START | dromaeo_css 18:11:22 INFO - operating with platform_type : linux_ 18:11:22 INFO - Initialising browser for dromaeo_css test... 18:11:22 INFO - TEST-INFO | started process 4113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Wc6Lb/profile http://localhost:60604/getInfo.html) 18:11:27 INFO - PROCESS | 4113 | __metrics Screen width/height:1600/1200 18:11:27 INFO - PROCESS | 4113 | colorDepth:24 18:11:27 INFO - PROCESS | 4113 | Browser inner width/height: 1024/697 18:11:27 INFO - PROCESS | 4113 | __metrics 18:11:27 ERROR - PROCESS | 4113 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 18:11:28 INFO - TEST-INFO | 4113: exit 0 18:11:28 INFO - Browser initialized. 18:11:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:11:28 INFO - TEST-INFO | started process 4232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Wc6Lb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:41 INFO - PROCESS | 4232 | RSS: Main: 189493248 18:11:41 INFO - PROCESS | 4232 | 18:12:30 INFO - PROCESS | 4232 | 1471914750958 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] 18:14:43 INFO - PROCESS | 4232 | Cycle 1(1): loaded http://localhost:60604/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60604/tests/dromaeo/cssquery-ext.html) 18:14:44 INFO - PROCESS | 4232 | RSS: Main: 200601600 18:14:44 INFO - PROCESS | 4232 | 18:17:46 INFO - PROCESS | 4232 | Cycle 1(1): loaded http://localhost:60604/tests/dromaeo/cssquery-ext.html (next: http://localhost:60604/tests/dromaeo/cssquery-jquery.html) 18:17:47 INFO - PROCESS | 4232 | RSS: Main: 199512064 18:17:47 INFO - PROCESS | 4232 | 18:20:49 INFO - PROCESS | 4232 | Cycle 1(1): loaded http://localhost:60604/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60604/tests/dromaeo/cssquery-mootools.html) 18:20:49 INFO - PROCESS | 4232 | RSS: Main: 200982528 18:20:49 INFO - PROCESS | 4232 | 18:23:51 INFO - PROCESS | 4232 | Cycle 1(1): loaded http://localhost:60604/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60604/tests/dromaeo/cssquery-prototype.html) 18:23:52 INFO - PROCESS | 4232 | RSS: Main: 198492160 18:23:52 INFO - PROCESS | 4232 | 18:26:55 INFO - PROCESS | 4232 | Cycle 1(1): loaded http://localhost:60604/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60604/tests/dromaeo/cssquery-yui.html) 18:26:56 INFO - PROCESS | 4232 | RSS: Main: 200470528 18:26:56 INFO - PROCESS | 4232 | 18:29:58 INFO - PROCESS | 4232 | Cycle 1(1): loaded http://localhost:60604/tests/dromaeo/cssquery-yui.html (next: http://localhost:60604/tests/dromaeo/cssquery-dojo.html) 18:29:59 INFO - PROCESS | 4232 | RSS: Main: 200933376 18:29:59 INFO - PROCESS | 4232 | 18:29:59 INFO - PROCESS | 4232 | __start_tp_report 18:29:59 INFO - PROCESS | 4232 | _x_x_mozilla_page_load 18:29:59 INFO - PROCESS | 4232 | _x_x_mozilla_page_load_details 18:29:59 INFO - PROCESS | 4232 | |i|pagename|runs| 18:29:59 INFO - PROCESS | 4232 | |0;dojo.html;2610.5301045811757;2636.340914771308;2650.469906018797;2650.774684151847;2652.3766914775024;4716.056788642268;4805.903881922364;4853.005133947537;4888.486708895568;4903.534164254394;4789;4838.685485443444;4855.708657480544;4862.465128835825;4920.335754673118;4324.762138082404;4488.730676159433;4519.163954668397;4570.771461426915;4571.1543364477675;4483.170613436525;4509.075639493913;4532.274836026237;4564.97717511412;4565.497795242521;4248.702590818644;4345.608895199415;4365.956340436586;4400.603945644875;4452.821887124511;4427.070315233773;4439.089986552781;4442.911141777146;4444.2444784386735;4458.665600079975;4369.890752731176;4399.934000989988;4408.272635015219;4425.579569940851;4425.933610995838;4693.624510039189;4746.121967436035;4768.5946694531;4807.038592281523;4826.0830442215865;5160.5097515736325;5171.276021357013;5181.663191892515;5187.688738675692;5190.870228244324;5027.773750181251;5137.74311284438;5139.254808052849;5151.510606492415;5155.278261043457;4792.614757496886;4825.517448255217;4830.951690483121;4890.217565189552;4898.632602554822;5379.1662292344745;5381.542568881689;5382.703951282717;5383.192521121785;5383.703896285663;4937.382827146606;5154.201098829687;5155.7679904404395;5162.767675454538;5169.81905633301;5087.109755792795;5096.643234973591;5106.66806657566;5229.372475302988;5246.554042906319;5177.223416487482;5181.015607034651;5183.922241166386;5190.169572868323;5194.27280180775;4844.958333958216;5138.743062846843;5145.742712864417;5160.92258616121;5172.146595811724;4168.270552653335;4187.623113919762;4247.745135291831;4299.226139294957;4318.114786468766;3723;3756.286305601927;3758.2671379080816;3760.7743535387963;3760.7743535387963;4353.782310884443;4371.628411584988;4400.845970391085;4402.84590039347;4404.4714634243455;5117.41149767774;5246.475352464723;5250.0549901018185;5251.212318152231;5253.868653283622;4422.579854913778;4450.777461126931;4459.9331010034875;4461.04087621163;4471.642268618502;4545.340925565774;4592.931106033412;4659.790309436084;4667.556582124693;4674.883127921761;4863.051704917507;4881.29221262922;4881.682690625098;4884.389451318585;4895.902081958412;5204.9739751301;5228.529432351107;5234.2672025915645;5246.186841039645;5250.579953603779;4774.806298425394;4802.951970480391;4825.372701548777;4889.804407823647;4894.437139728977;5125.9487405126965;5128.3076784633595;5141.331626888481;5146.562542183956;5152.896942061213;5204.531592156724;5211.218317252291;5236.240745092016;5239.947600523946;5243.68537887728;4899.975500122477;4920.458749537476;4940.950590494049;5046.84859454217;5069.619778516552;5013.197888337849;5021.949780502295;5030.446650868328;5033.974830125826;5042.722650254272;4940.456549779449;4951.653384263067;4953.702777833341;4961.3798275215595;4961.6030717543235;4945.727984960718;4964.404271487445;4979.975100124476;5067.721275329893;5068.543831055223;4933.062718083696;4933.580645645016;4954.430240522242;4961.156603377507;4963.652544322007 18:29:59 INFO - PROCESS | 4232 | |1;ext.html;538.9407165211828;544.1782907809207;547.843864498618;561.7528287553477;577.5581680014786;33237.66762332376;36950.630493695055;37029.259414811684;37041.814790926044;37081.25837483249;36633.26733465329;37178.62821371786;37196.25607487849;37238.813805930935;37242;7504.96247518763;7633.923660763377;7634.580098094602;7649.464537482379;7653.732119375823;7450.478466507347;7549.660265288047;7582.393408527305;7593.658285377143;7604.391648668121;7593.12679041909;7615.5811430371305;7651.196624354446;7656.157822639505;7678.692852285902;7629;7649.541027538337;7658.578778167199;7664.386849052118;7665.808354791119;7163.212046674862;7581.583012934341;7587.544747315179;7597.354224890891;7600.657970391346;35027.124321891904;35271.118222044395;35348.64651353505;35355.11612209689;35679.4648080279;2477.380654836291;2627.1330460947843;2672.6391937088633;2735.86320683965;2774.334159801633;26268.73731262682;27803.58294625582;27859.442811143865;28024.85987570049;28753.856230718713;3504.719622430225;3507.105688049531;3548.8224542951075;3562.9643703562892;3596.388613935611;256130;256590;257179;257890;258765;51031.489685103414;51121;51380.22929656058;51427.228591571155;51611.48388516142;27964.580531292046;28378.71621283802;28793;29692.851535742182;44145.55854441479;13086.214827110214;13154;13162.341882905816;13174;13174.934125329504;9963.750906227402;10027.498625068718;10032.749181270381;10034.548445319979;10071.093601575747;17207;17261.65476690459;17263.56841078958;17269.56826079358;17318.82681173172;6726.2511746945165;6754.129494964621;6764.391204791593;6910.170779506491;7024.735547601481;765.7664412354285;885.4156256870434;893.8569828827357;936.5176933879058;955.9484566976271;26465.47069058608;27383.589246161322;27791.86104069467;28500.429991400055;28604;896.9192772650492;936.7423958411491;939.6382392778829;980.8921018687938;1033.4987531047436;13375.53185638498;14520.419183232763;14603.853961460462;14802;14861.034032787835;370058;374899;375380;375918;377692;47114.5288547117;48080;48244.758776206596;48281.27578086332;48381;1132.2923173016864;1153.9711507212219;1202.5310129049678;1204.3857632607608;1210.6549633354452;25415.856286467522;26895.462090758465;27073.864630676722;27484.312892177855;27720;39603.80198098991;40109.398359025225;40113;40130.39804402995;40196.598034019284;332383;333290;333983;334338;335385;24369.878150609133;24382.146624868044;24452.26643200707;24532.75467245376;24572.508549828544;38965.41551876781;39216.21567568576;39408.80295598618;39489.60510394859;41239.587604123575;29928.25179370533;29998.25004374908;30142.54786178165;30486.237844054078;31205.219869503446;34631;34890.47664284987;34921;35135.29717414834;35913.281734364646;28201.294967625974;28303.71696283011;34094.82952585221;34308.31383372368;34559.13602159966;29244.415111698072;31909.521357179197;31942.68057319397;31979.36041279115;32104.197395064377;24399.51200976006;24625.87687061553;24759.25722228336;24770.806225727112;25035.49929001446 18:29:59 INFO - PROCESS | 4232 | |2;jquery.html;342.83886573310537;359.61700788660073;362.1272732714158;362.3857561433372;374.67029014467283;15786.36854525819;16125.435609753646;17124;17207.311707531717;17250.56873578158;15343.462978795744;15805.051696898194;16059.598510037255;16127.919360403212;16244.350225990976;4682.929756053653;5014.899702005958;5031.471695471978;5059.089363914494;5071.1632580624155;4948.257761335793;5028.647994640377;5034.697918124906;5035.043341765053;5039.269305950635;4755.857324280277;4989.550940415362;4995.475475075119;5004.949950500485;5010.674306170087;4947.431045429767;4978.576820970222;4990.176620857555;4997.325361076263;5000.549950504435;4283.807228674717;4416.381706561084;4447.977760111179;4451.777411129463;4458.1306645204195;19324.80675193244;19326.130324135447;19410.22359105634;19513;19635.116419761143;1868.9626207475774;2132.4242454537343;2367.7040369953756;2388.5461762265113;2515.4466017476125;12533.373331333396;13086.47654093835;13531.526396576073;13720.45118195271;13831.446742130303;1654.8345165483477;1701.893769050115;1712.2294967264781;1723.2159367487764;1843.6957901946296;67655;67891;68195.31804681939;69459.65270173668;70323;9316.580753866092;9522.95238523803;9703.126718595218;9747.220222382193;9962.252831037702;13202.405891734896;13257.734845303234;13263.469461221443;13273.336333183302;13315.467381304834;6919.688614012382;7130.108736407949;7135.215126336099;7300.488965772452;7304.707811687579;6725.4619630430425;6725.6973436195485;6839.247682754893;6912.377885990285;6923.584584924921;6059.394060593905;6067.815586388897;6077.726502307407;6153.96923015391;6243.625382476975;1727.680379129865;1760.216703566926;1766.938157164493;1767.3637490503409;1791.4177892184832;831.4969443486724;841.2386789955101;853.99655404899;866.2853146154448;906.1708536688988;16147.111908845127;17319.307227711004;17536.21087051086;17973.191206395742;18052.651492522516;878.486085639895;884.6461415433878;897.9820403591891;904.6200595749801;961.0965692249264;10217.1826253901;10318.638847640297;10365.585376585002;10426.739331516772;10452.790944181226;397739;402009;402908;405326;405670;65255.99999999905;66121;66147.33852661411;66203;67287.32712672908;916.2990312411011;930.7068273493828;959.947202903847;963.4171326347599;964.0359640359641;14404.567862964128;15399.363243978756;16075.35698572044;16162.272697728866;16363.509094727176;34635.4804677925;35050.82474587713;35141.824290879405;35544.111397215274;36527.26945461129;44833.55166448294;44915.326270105325;46719.29921051119;48372;48444.75777621089;7235.131784185932;7278.781636550912;7297.671604777904;7336.266373362834;7550.848983020199;11144.275622084862;11528.884711153116;11873.881261187624;11914.225575337576;11993.520259189534;10030.398176109456;10065.295429319878;10100.666779962741;10510.737231568966;10575.153987680813;9830.361026533252;10393.84409233847;10412.895871041193;10636.946815265874;10665;9935.304528682922;10131.594736210764;10387.636432724817;10499.107575855833;10567.101796347397;6959.26927672587;7076.186238582423;7128.679209435484;7314.195438501654;7653.311201991847;8866.335024873031;10173.694789156338;10185.387782706506;10499.68500944973;10671.733206669895 18:29:59 INFO - PROCESS | 4232 | |3;mootools.html;1141.880102589228;1142.6286456901503;1265.1207410849458;1645.3500867157472;1682.4027470248054;6548.279689234192;7251.601161936092;7309.159446663635;7894.526328420292;7943.483673561222;7522.699092036326;7768.417368697356;7778.883316750239;7780.494267872585;7844.215578442153;2073.0878413498012;2093.9476513087143;2095.6542170541843;2097.1611355457785;2100.1389430333566;2053.8048885355943;2081.583683263346;2103.9158433662633;2138.518833262519;2154.967675484861;2081.130155436279;2088.2064815370213;2114.693369461427;2115.090511080235;2116.33335499318;2055.804698553635;2062.226665000625;2063.308791554831;2067.0491573876034;2071.399294204679;2034.3795142481538;2059.3101311060814;2081.0739221046642;2107.6522373808302;2108.2515706923973;7720.227977202235;7826.765197044041;7850.2542258485355;7872.212778722139;7882.251186137308;4338.132373525307;4443.355713421536;4447.911041779146;4451.465824101128;4461.464624245079;2731.8199307425916;2819.1542537238747;2858.628378310827;2863.6277283952954;2872.353720412911;852.4629483425402;889.2796834563959;889.3330002498126;893.1827377949169;904.4302089683457;10613.257072004963;10630.521626526825;10643.733906652318;10665.307264803461;10666.093382062612;3699.2971335446177;3892.8637497687446;3914.8042597869994;3953.8220780064967;3968.7817170055346;8844.73465796027;8911.777205569913;9020.413673111227;9056.954715226382;9075.13786190311;4386.298192289219;4412.338149277634;4415.315626077899;4416.24923762961;4428;3451.154467155563;3822.980885095557;3931.9017024574614;4039.4950631171105;4042.717009809344;3430.382531144418;3486.668766467232;3511.6839484446014;3574;3687.483752274684;1106.5794997900907;1129.8587676540433;1130.361345839598;1133.3369978562632;1133.4162906103363;709.8828693265554;735.988960165598;742.721479445208;751.7819832248587;773.3619763694861;4883.949950760603;4956.653034287565;5134.845954621367;5222.268882356473;5274.340707411574;834.4034015678819;885.0839381240386;888.1518150166576;891.4027601507006;896.6054935828345;3324.9501257481156;3432.4508078707286;3490.3193877194212;3520.0847779576984;3541.752077354612;9158.221551168226;9225.815483690289;9487.288453365887;9767;9823.968483309292;9748.853767193497;9769.316147869724;9769.413835169913;9781.755456113511;9795.559199836025;7054.294570542905;7194.100737407824;7327.0841144856895;7366.826786098114;7369.6315184240575;5322.600804939568;5346.224797404432;5438.809641662523;5515.117581187152;5600.747966341443;8911.197992180734;9001.649752537172;9005.774855628662;9059.275257979478;9156.084391560791;8488;8871.556422178735;8907.331950103639;9001.864972025556;9085.364024518485;5792.189093526994;6367.108604795239;6476.5466417350335;6492.545521813617;6579.769708060195;7169.462290328351;7235.746748863765;7282.308180722823;7291.52605080668;7302.196758356683;6276.811695649138;6284.402981716729;6352;6449.7420103195345;6480.319566445455;6342;6411.967940160456;6428.517861160525;6477.319881412383;6490.286068532552;5781.4218578141845;5853.502452291603;5858.121281807763;5861.912071318849;5872.647641141545;4539.682222244412;4550.817967281272;4656.41794775653;4688.882777930443;4726.1020406122725;4518.390017347748;4543.318502224693;4639.791209395653;4640.164770341371;4704.694194877322 18:29:59 INFO - PROCESS | 4232 | |4;prototype.html;286.27143918726836;290.32644265304486;291.05697539970504;294.47583301722943;297.865960317857;5052.343195384599;5108.693478391299;5112.539871411572;5116.283720279154;5121.15500942345;4959.479254678252;4990.675606085602;4997.125503036963;5038.420581633104;5050.873728156798;3683.9263214735756;3798.7150963677836;3850.4609354690365;3903.238868420659;3906.5898080701545;3874.302625527404;3876.2635099331037;3880.592537783534;3887.241987812378;3887.688984881203;3871.8644847430346;3881.6506514413695;3887.961120388788;3892.987823165983;3910.511186101737;3780.2250538639514;3879.12719638082;3879.437481565157;3904.0239940014994;3905.628965248311;3411.181316484051;3412.8293585320635;3421.8802341917913;3426.811525366104;3438.1404648837793;4878.585320247783;4899.461059283476;4927.137750893579;4933.506649335073;4956.752162391866;4418.624416924533;4428.734275943421;4434.866953991385;4444.444444444444;4448.154850578379;4894.755262236874;5214.191800270964;5218.972995662507;5224.791008359661;5283.679080229943;3633.400488919325;3646.179609587848;3647.1246900743895;3663.150109194866;3664.193877347006;5544.0575102232715;5550.639208451437;5569.106503788731;5574.749136288836;5579.38626751057;3594.8741794037082;3636.636336366395;3661.5240018797385;3661.9450708239397;3670.908227294339;3730.8880733578035;3732.5894151643297;3735.3836616958442;3739.9439008414897;3747.512823332949;4340.891477713082;4344.587264209895;4351.08627188294;4358.3680366347335;4358.869233922987;5031.748412579356;5256.553192978563;5301.932246423898;5314.883874386345;5315.760790764425;1300.785370413871;1305.28209484783;1306.2750173653524;1306.4512904579908;1310.882020618149;796.585775396802;820.9630566624517;838.9958050209832;841.7685136587487;842.1999100854091;4315.870523884289;4414.27164517851;4516.277395616686;4556;4575.450945886515;5386.821775152679;5425.538829199483;5428.430014848384;5437.7493176569615;5445.564354851603;4561.2245918193985;4569.1547063793305;4572.748498832596;4588.38056862326;4589.954100459019;2724.891004359843;2873.7700983921236;2877.992702554131;2886.870090845917;2905.3172504461436;5120.718360490135;5126.436092029874;5136.8202112925865;5140.691558506502;5155.74221288934;5386.730663466811;5510.228568000483;5537.667739935536;5543.196236545678;5550.47270509301;4998.300237966688;5009.398872135294;5034.583399967963;5039.77321020555;5042.848714538496;5410.864728381822;5418.994971860437;5423.647462914898;5428.430014848384;5440.959640134949;5081.822136225214;5271.4464981176425;5276.445973172762;5288.418273989935;5293.100172970681;5042.168042272984;5063.392392912874;5072.315237442898;5081.263216833465;5111.105556527518;3724.6834019107596;3730.2353017631863;3732.2908647356917;3735.3836616957897;3739.5699494558476;5291.365036195682;5319.707416092152;5384.892302154013;5423.891522169613;5439.4288599696465;5206.021711749511;5221.6344855859725;5228.660137091077;5238.711870846988;5244.7902083916215;5234.895302094013;5241.44964778708;5250.849490305786;5263.868268322329;5314.5216930476445;4882.584980276716;5131.563162314558;5141.845744627667;5147.3308469898675;5177.301064356264;4936.03747269279;5151.201563757623;5177.385420362843;5191.221316802359;5201.297824793604;5156.948430515647;5165.560927321069;5204.713740744295;5210.843674689765;5228.189630607262 18:29:59 INFO - PROCESS | 4232 | |5;yui.html;572.21034971739;599.2778701664495;626.3736263736266;647.0100745858838;649.4285029174326;11870.169088163831;12233.204841685285;12343.321117338543;12399.628011159668;12620.684482887933;11968.581099661513;12154.149209555335;12207.389630518483;12217.450214740336;12252.326122063283;605.1195510532165;745.4371949178376;760.262545331028;761.5392687424112;761.6420282467259;736.9631518424084;759.2217976574001;763.6410886883184;765.9540427574335;766.0768773627765;793.0721056364068;793.5040599625235;794.2772077409559;794.4359504751633;795.1055063054064;792.6868886789744;793.317746737805;793.7301317552002;794.9443538952276;796.3828033274201;576.7491141353524;577.5148874945024;577.7284676202178;579.3164066401645;580.0718849840264;12101.515939362414;12191.695207619792;12202.511899524008;12207.267563946192;12213.633590992196;12857.485700571966;13071.869281307161;13196.406161722745;13523.729525409535;13691.931540342333;9963.252756043326;9979;10260.230482713827;10300.536475858604;10356.275060745751;3172.2703778130926;3229.80621162731;3249.2364294391036;3291.078498020558;3356.664333566648;61210.403916159245;63295;63307.683461582856;63757.999999999534;64344.678276608785;9873.753156171153;9935.403875767477;10061.647842325483;10089;10110.949445252727;19477.220911163397;19531.316403925794;19532.218711251677;19607.60784784325;19856.404307870787;6517.4134327910715;6528.37980391862;6569;6601.108850305243;6761.966190169018;3663.084228942764;3683.1344634010984;3737.084414318455;3762.097096696773;3934.09515811365;2793.4413117376607;2865.5415133578526;2868.067877939636;2868.6844447110802;2872.468593310244;506.5542322755951;527.9234510995884;535.9923344113121;536.5680627095148;539.3958766181823;485.8615294641081;487.7536843893882;500.35204410288765;526.739264064283;538.5314776144701;7627.199144089791;7835.785453254754;7993.68025278994;8057.35541156706;8356.582170891432;377.92063666630315;393.5356279590111;436.6266841850236;474.7978668501593;526.0819869328047;3545.911352216215;3614.403623402162;3698.852045918187;3834.559025712079;4066.6136717011836;87413;89752;91320;96915.51542242244;98286.64563512038;49895.25157122646;78824;79270;79486.6025669868;80420;44304.3354349685;46883;68165.65917170382;68307.65846170737;68788.6560567204;7473.925260747323;7572.432067594842;7628.313451789366;7665.425093117927;7698.769036928901;42549.36175957301;43411.56588434075;43580.56419435765;44087.33868991904;44472.33291500565;36577.81711091428;36879;36883.262334753694;44053.77973110242;59257.70371148117;9509.61961521559;9614.134727874245;9696.321257511907;9803.754906127404;10059;10725;10777.461126943464;10805.675829725122;10922.890771092505;10948.890511095105;9970.800583988424;10126.645567405105;10159.695209143738;10387.065164134961;10633.255672102878;10106.747331316776;10188.541515631667;10229.897701022894;10432.634857779942;10483.37099774016;10236.33463824849;10354.792904142025;10435.217358697977;10513.9474302628;10613.787724245627;8449.746507604781;8700.173483519056;8765.342599305206;8875.467471951704;9064.909350906406;8643.26532244741;8706.869396959177;8708.433951793113;9094.727158185266;9328.207102396373 18:29:59 INFO - PROCESS | 4232 | __end_tp_report 18:29:59 INFO - PROCESS | 4232 | __start_cc_report 18:29:59 INFO - PROCESS | 4232 | _x_x_mozilla_cycle_collect,393 18:29:59 INFO - PROCESS | 4232 | __end_cc_report 18:29:59 INFO - PROCESS | 4232 | __startTimestamp1471915799030__endTimestamp 18:29:59 INFO - PROCESS | 4232 | 18:29:59 INFO - PROCESS | 4232 | ------- Summary: start ------- 18:29:59 INFO - PROCESS | 4232 | Number of tests: 6 18:29:59 INFO - PROCESS | 4232 | 18:29:59 INFO - PROCESS | 4232 | [#0] dojo.html Cycles:165 Average:4767.49 Median:4895.90 stddev:522.94 (10.7%) stddev-sans-first:496.42 18:29:59 INFO - PROCESS | 4232 | Values: 2610.5 2636.3 2650.5 2650.8 2652.4 4716.1 4805.9 4853.0 4888.5 4903.5 4789.0 4838.7 4855.7 4862.5 4920.3 4324.8 4488.7 4519.2 4570.8 4571.2 4483.2 4509.1 4532.3 4565.0 4565.5 4248.7 4345.6 4366.0 4400.6 4452.8 4427.1 4439.1 4442.9 4444.2 4458.7 4369.9 4399.9 4408.3 4425.6 4425.9 4693.6 4746.1 4768.6 4807.0 4826.1 5160.5 5171.3 5181.7 5187.7 5190.9 5027.8 5137.7 5139.3 5151.5 5155.3 4792.6 4825.5 4831.0 4890.2 4898.6 5379.2 5381.5 5382.7 5383.2 5383.7 4937.4 5154.2 5155.8 5162.8 5169.8 5087.1 5096.6 5106.7 5229.4 5246.6 5177.2 5181.0 5183.9 5190.2 5194.3 4845.0 5138.7 5145.7 5160.9 5172.1 4168.3 4187.6 4247.7 4299.2 4318.1 3723.0 3756.3 3758.3 3760.8 3760.8 4353.8 4371.6 4400.8 4402.8 4404.5 5117.4 5246.5 5250.1 5251.2 5253.9 4422.6 4450.8 4459.9 4461.0 4471.6 4545.3 4592.9 4659.8 4667.6 4674.9 4863.1 4881.3 4881.7 4884.4 4895.9 5205.0 5228.5 5234.3 5246.2 5250.6 4774.8 4803.0 4825.4 4889.8 4894.4 5125.9 5128.3 5141.3 5146.6 5152.9 5204.5 5211.2 5236.2 5239.9 5243.7 4900.0 4920.5 4941.0 5046.8 5069.6 5013.2 5021.9 5030.4 5034.0 5042.7 4940.5 4951.7 4953.7 4961.4 4961.6 4945.7 4964.4 4980.0 5067.7 5068.5 4933.1 4933.6 4954.4 4961.2 4963.7 18:29:59 INFO - PROCESS | 4232 | 18:29:59 INFO - PROCESS | 4232 | [#1] ext.html Cycles:180 Average:45981.43 Median:19321.20 stddev:85862.94 (444.4%) stddev-sans-first:86036.02 18:29:59 INFO - PROCESS | 4232 | Values: 538.9 544.2 547.8 561.8 577.6 33237.7 36950.6 37029.3 37041.8 37081.3 36633.3 37178.6 37196.3 37238.8 37242.0 7505.0 7633.9 7634.6 7649.5 7653.7 7450.5 7549.7 7582.4 7593.7 7604.4 7593.1 7615.6 7651.2 7656.2 7678.7 7629.0 7649.5 7658.6 7664.4 7665.8 7163.2 7581.6 7587.5 7597.4 7600.7 35027.1 35271.1 35348.6 35355.1 35679.5 2477.4 2627.1 2672.6 2735.9 2774.3 26268.7 27803.6 27859.4 28024.9 28753.9 3504.7 3507.1 3548.8 3563.0 3596.4 256130.0 256590.0 257179.0 257890.0 258765.0 51031.5 51121.0 51380.2 51427.2 51611.5 27964.6 28378.7 28793.0 29692.9 44145.6 13086.2 13154.0 13162.3 13174.0 13174.9 9963.8 10027.5 10032.7 10034.5 10071.1 17207.0 17261.7 17263.6 17269.6 17318.8 6726.3 6754.1 6764.4 6910.2 7024.7 765.8 885.4 893.9 936.5 955.9 26465.5 27383.6 27791.9 28500.4 28604.0 896.9 936.7 939.6 980.9 1033.5 13375.5 14520.4 14603.9 14802.0 14861.0 370058.0 374899.0 375380.0 375918.0 377692.0 47114.5 48080.0 48244.8 48281.3 48381.0 1132.3 1154.0 1202.5 1204.4 1210.7 25415.9 26895.5 27073.9 27484.3 27720.0 39603.8 40109.4 40113.0 40130.4 40196.6 332383.0 333290.0 333983.0 334338.0 335385.0 24369.9 24382.1 24452.3 24532.8 24572.5 38965.4 39216.2 39408.8 39489.6 41239.6 29928.3 29998.3 30142.5 30486.2 31205.2 34631.0 34890.5 34921.0 35135.3 35913.3 28201.3 28303.7 34094.8 34308.3 34559.1 29244.4 31909.5 31942.7 31979.4 32104.2 24399.5 24625.9 24759.3 24770.8 25035.5 18:29:59 INFO - PROCESS | 4232 | 18:29:59 INFO - PROCESS | 4232 | [#2] jquery.html Cycles:180 Average:24221.35 Median:405498.00 stddev:66130.72 (16.3%) stddev-sans-first:66291.93 18:29:59 INFO - PROCESS | 4232 | Values: 342.8 359.6 362.1 362.4 374.7 15786.4 16125.4 17124.0 17207.3 17250.6 15343.5 15805.1 16059.6 16127.9 16244.4 4682.9 5014.9 5031.5 5059.1 5071.2 4948.3 5028.6 5034.7 5035.0 5039.3 4755.9 4989.6 4995.5 5004.9 5010.7 4947.4 4978.6 4990.2 4997.3 5000.5 4283.8 4416.4 4448.0 4451.8 4458.1 19324.8 19326.1 19410.2 19513.0 19635.1 1869.0 2132.4 2367.7 2388.5 2515.4 12533.4 13086.5 13531.5 13720.5 13831.4 1654.8 1701.9 1712.2 1723.2 1843.7 67655.0 67891.0 68195.3 69459.7 70323.0 9316.6 9523.0 9703.1 9747.2 9962.3 13202.4 13257.7 13263.5 13273.3 13315.5 6919.7 7130.1 7135.2 7300.5 7304.7 6725.5 6725.7 6839.2 6912.4 6923.6 6059.4 6067.8 6077.7 6154.0 6243.6 1727.7 1760.2 1766.9 1767.4 1791.4 831.5 841.2 854.0 866.3 906.2 16147.1 17319.3 17536.2 17973.2 18052.7 878.5 884.6 898.0 904.6 961.1 10217.2 10318.6 10365.6 10426.7 10452.8 397739.0 402009.0 402908.0 405326.0 405670.0 65256.0 66121.0 66147.3 66203.0 67287.3 916.3 930.7 959.9 963.4 964.0 14404.6 15399.4 16075.4 16162.3 16363.5 34635.5 35050.8 35141.8 35544.1 36527.3 44833.6 44915.3 46719.3 48372.0 48444.8 7235.1 7278.8 7297.7 7336.3 7550.8 11144.3 11528.9 11873.9 11914.2 11993.5 10030.4 10065.3 10100.7 10510.7 10575.2 9830.4 10393.8 10412.9 10636.9 10665.0 9935.3 10131.6 10387.6 10499.1 10567.1 6959.3 7076.2 7128.7 7314.2 7653.3 8866.3 10173.7 10185.4 10499.7 10671.7 18:29:59 INFO - PROCESS | 4232 | 18:29:59 INFO - PROCESS | 4232 | [#3] mootools.html Cycles:180 Average:5024.97 Median:5334.41 stddev:2874.88 (53.9%) stddev-sans-first:2868.14 18:29:59 INFO - PROCESS | 4232 | Values: 1141.9 1142.6 1265.1 1645.4 1682.4 6548.3 7251.6 7309.2 7894.5 7943.5 7522.7 7768.4 7778.9 7780.5 7844.2 2073.1 2093.9 2095.7 2097.2 2100.1 2053.8 2081.6 2103.9 2138.5 2155.0 2081.1 2088.2 2114.7 2115.1 2116.3 2055.8 2062.2 2063.3 2067.0 2071.4 2034.4 2059.3 2081.1 2107.7 2108.3 7720.2 7826.8 7850.3 7872.2 7882.3 4338.1 4443.4 4447.9 4451.5 4461.5 2731.8 2819.2 2858.6 2863.6 2872.4 852.5 889.3 889.3 893.2 904.4 10613.3 10630.5 10643.7 10665.3 10666.1 3699.3 3892.9 3914.8 3953.8 3968.8 8844.7 8911.8 9020.4 9057.0 9075.1 4386.3 4412.3 4415.3 4416.2 4428.0 3451.2 3823.0 3931.9 4039.5 4042.7 3430.4 3486.7 3511.7 3574.0 3687.5 1106.6 1129.9 1130.4 1133.3 1133.4 709.9 736.0 742.7 751.8 773.4 4883.9 4956.7 5134.8 5222.3 5274.3 834.4 885.1 888.2 891.4 896.6 3325.0 3432.5 3490.3 3520.1 3541.8 9158.2 9225.8 9487.3 9767.0 9824.0 9748.9 9769.3 9769.4 9781.8 9795.6 7054.3 7194.1 7327.1 7366.8 7369.6 5322.6 5346.2 5438.8 5515.1 5600.7 8911.2 9001.6 9005.8 9059.3 9156.1 8488.0 8871.6 8907.3 9001.9 9085.4 5792.2 6367.1 6476.5 6492.5 6579.8 7169.5 7235.7 7282.3 7291.5 7302.2 6276.8 6284.4 6352.0 6449.7 6480.3 6342.0 6412.0 6428.5 6477.3 6490.3 5781.4 5853.5 5858.1 5861.9 5872.6 4539.7 4550.8 4656.4 4688.9 4726.1 4518.4 4543.3 4639.8 4640.2 4704.7 18:29:59 INFO - PROCESS | 4232 | 18:29:59 INFO - PROCESS | 4232 | [#4] prototype.html Cycles:180 Average:4330.32 Median:4997.71 stddev:1282.63 (25.7%) stddev-sans-first:1249.80 18:29:59 INFO - PROCESS | 4232 | Values: 286.3 290.3 291.1 294.5 297.9 5052.3 5108.7 5112.5 5116.3 5121.2 4959.5 4990.7 4997.1 5038.4 5050.9 3683.9 3798.7 3850.5 3903.2 3906.6 3874.3 3876.3 3880.6 3887.2 3887.7 3871.9 3881.7 3888.0 3893.0 3910.5 3780.2 3879.1 3879.4 3904.0 3905.6 3411.2 3412.8 3421.9 3426.8 3438.1 4878.6 4899.5 4927.1 4933.5 4956.8 4418.6 4428.7 4434.9 4444.4 4448.2 4894.8 5214.2 5219.0 5224.8 5283.7 3633.4 3646.2 3647.1 3663.2 3664.2 5544.1 5550.6 5569.1 5574.7 5579.4 3594.9 3636.6 3661.5 3661.9 3670.9 3730.9 3732.6 3735.4 3739.9 3747.5 4340.9 4344.6 4351.1 4358.4 4358.9 5031.7 5256.6 5301.9 5314.9 5315.8 1300.8 1305.3 1306.3 1306.5 1310.9 796.6 821.0 839.0 841.8 842.2 4315.9 4414.3 4516.3 4556.0 4575.5 5386.8 5425.5 5428.4 5437.7 5445.6 4561.2 4569.2 4572.7 4588.4 4590.0 2724.9 2873.8 2878.0 2886.9 2905.3 5120.7 5126.4 5136.8 5140.7 5155.7 5386.7 5510.2 5537.7 5543.2 5550.5 4998.3 5009.4 5034.6 5039.8 5042.8 5410.9 5419.0 5423.6 5428.4 5441.0 5081.8 5271.4 5276.4 5288.4 5293.1 5042.2 5063.4 5072.3 5081.3 5111.1 3724.7 3730.2 3732.3 3735.4 3739.6 5291.4 5319.7 5384.9 5423.9 5439.4 5206.0 5221.6 5228.7 5238.7 5244.8 5234.9 5241.4 5250.8 5263.9 5314.5 4882.6 5131.6 5141.8 5147.3 5177.3 4936.0 5151.2 5177.4 5191.2 5201.3 5156.9 5165.6 5204.7 5210.8 5228.2 18:29:59 INFO - PROCESS | 4232 | 18:29:59 INFO - PROCESS | 4232 | [#5] yui.html Cycles:180 Average:15988.75 Median:516.32 stddev:22747.41 (4405.7%) stddev-sans-first:22781.76 18:29:59 INFO - PROCESS | 4232 | Values: 572.2 599.3 626.4 647.0 649.4 11870.2 12233.2 12343.3 12399.6 12620.7 11968.6 12154.1 12207.4 12217.5 12252.3 605.1 745.4 760.3 761.5 761.6 737.0 759.2 763.6 766.0 766.1 793.1 793.5 794.3 794.4 795.1 792.7 793.3 793.7 794.9 796.4 576.7 577.5 577.7 579.3 580.1 12101.5 12191.7 12202.5 12207.3 12213.6 12857.5 13071.9 13196.4 13523.7 13691.9 9963.3 9979.0 10260.2 10300.5 10356.3 3172.3 3229.8 3249.2 3291.1 3356.7 61210.4 63295.0 63307.7 63758.0 64344.7 9873.8 9935.4 10061.6 10089.0 10110.9 19477.2 19531.3 19532.2 19607.6 19856.4 6517.4 6528.4 6569.0 6601.1 6762.0 3663.1 3683.1 3737.1 3762.1 3934.1 2793.4 2865.5 2868.1 2868.7 2872.5 506.6 527.9 536.0 536.6 539.4 485.9 487.8 500.4 526.7 538.5 7627.2 7835.8 7993.7 8057.4 8356.6 377.9 393.5 436.6 474.8 526.1 3545.9 3614.4 3698.9 3834.6 4066.6 87413.0 89752.0 91320.0 96915.5 98286.6 49895.3 78824.0 79270.0 79486.6 80420.0 44304.3 46883.0 68165.7 68307.7 68788.7 7473.9 7572.4 7628.3 7665.4 7698.8 42549.4 43411.6 43580.6 44087.3 44472.3 36577.8 36879.0 36883.3 44053.8 59257.7 9509.6 9614.1 9696.3 9803.8 10059.0 10725.0 10777.5 10805.7 10922.9 10948.9 9970.8 10126.6 10159.7 10387.1 10633.3 10106.7 10188.5 10229.9 10432.6 10483.4 10236.3 10354.8 10435.2 10513.9 10613.8 8449.7 8700.2 8765.3 8875.5 9064.9 8643.3 8706.9 8708.4 9094.7 9328.2 18:29:59 INFO - PROCESS | 4232 | -------- Summary: end -------- 18:29:59 INFO - PROCESS | 4232 | 18:29:59 INFO - TEST-INFO | 4232: exit 0 18:30:00 INFO - TEST-OK | dromaeo_css | took 1117419ms 18:30:00 INFO - TEST-START | kraken 18:30:00 INFO - operating with platform_type : linux_ 18:30:00 INFO - Initialising browser for kraken test... 18:30:00 INFO - TEST-INFO | started process 4588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkSr74U/profile http://localhost:60604/getInfo.html) 18:30:04 INFO - PROCESS | 4588 | __metrics Screen width/height:1600/1200 18:30:04 INFO - PROCESS | 4588 | colorDepth:24 18:30:04 INFO - PROCESS | 4588 | Browser inner width/height: 1024/697 18:30:04 INFO - PROCESS | 4588 | __metrics 18:30:05 ERROR - PROCESS | 4588 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2993: TypeError: this.tabs is undefined 18:30:06 INFO - TEST-INFO | 4588: exit 0 18:30:06 INFO - Browser initialized. 18:30:06 INFO - Running cycle 1/1 for kraken test... 18:30:06 INFO - TEST-INFO | started process 4706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkSr74U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:18 INFO - PROCESS | 4706 | RSS: Main: 189710336 18:30:18 INFO - PROCESS | 4706 | 18:30:21 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60604/tests/kraken/driver.html?testName=audio-beat-detection) 18:30:22 INFO - PROCESS | 4706 | RSS: Main: 202493952 18:30:22 INFO - PROCESS | 4706 | 18:30:25 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60604/tests/kraken/driver.html?testName=audio-dft) 18:30:25 INFO - PROCESS | 4706 | RSS: Main: 201277440 18:30:25 INFO - PROCESS | 4706 | 18:30:28 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60604/tests/kraken/driver.html?testName=audio-fft) 18:30:29 INFO - PROCESS | 4706 | RSS: Main: 197607424 18:30:29 INFO - PROCESS | 4706 | 18:30:31 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60604/tests/kraken/driver.html?testName=audio-oscillator) 18:30:32 INFO - PROCESS | 4706 | RSS: Main: 198189056 18:30:32 INFO - PROCESS | 4706 | 18:30:34 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60604/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:30:35 INFO - PROCESS | 4706 | RSS: Main: 198615040 18:30:35 INFO - PROCESS | 4706 | 18:30:38 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60604/tests/kraken/driver.html?testName=imaging-darkroom) 18:30:39 INFO - PROCESS | 4706 | RSS: Main: 198443008 18:30:39 INFO - PROCESS | 4706 | 18:30:42 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60604/tests/kraken/driver.html?testName=imaging-desaturate) 18:30:43 INFO - PROCESS | 4706 | RSS: Main: 196038656 18:30:43 INFO - PROCESS | 4706 | 18:30:46 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60604/tests/kraken/driver.html?testName=json-parse-financial) 18:30:46 INFO - PROCESS | 4706 | RSS: Main: 198053888 18:30:46 INFO - PROCESS | 4706 | 18:30:48 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60604/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:30:49 INFO - PROCESS | 4706 | RSS: Main: 197890048 18:30:49 INFO - PROCESS | 4706 | 18:30:51 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60604/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:30:52 INFO - PROCESS | 4706 | RSS: Main: 198062080 18:30:52 INFO - PROCESS | 4706 | 18:30:54 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60604/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:30:55 INFO - PROCESS | 4706 | RSS: Main: 198488064 18:30:55 INFO - PROCESS | 4706 | 18:30:57 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:58 INFO - PROCESS | 4706 | RSS: Main: 198840320 18:30:58 INFO - PROCESS | 4706 | 18:31:01 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:31:02 INFO - PROCESS | 4706 | RSS: Main: 198553600 18:31:02 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | Cycle 1(1): loaded http://localhost:60604/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60604/tests/kraken/driver.html?testName=ai-astar) 18:31:04 INFO - PROCESS | 4706 | RSS: Main: 201834496 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | __start_tp_report 18:31:04 INFO - PROCESS | 4706 | _x_x_mozilla_page_load 18:31:04 INFO - PROCESS | 4706 | _x_x_mozilla_page_load_details 18:31:04 INFO - PROCESS | 4706 | |i|pagename|runs| 18:31:04 INFO - PROCESS | 4706 | |0;ai-astar;108;115;112;117;114;114;122;117;116;115 18:31:04 INFO - PROCESS | 4706 | |1;audio-beat-detection;157;125;158;194;127;155;150;129;195;127 18:31:04 INFO - PROCESS | 4706 | |2;audio-dft;184;167;165;165;165;166;165;166;165;168 18:31:04 INFO - PROCESS | 4706 | |3;audio-fft;78;78;82;173;79;79;77;77;165;79 18:31:04 INFO - PROCESS | 4706 | |4;audio-oscillator;89;89;152;88;89;88;151;88;90;155 18:31:04 INFO - PROCESS | 4706 | |5;imaging-gaussian-blur;118;118;117;120;119;119;120;119;119;120 18:31:04 INFO - PROCESS | 4706 | |6;imaging-darkroom;150;148;148;156;149;150;149;148;149;148 18:31:04 INFO - PROCESS | 4706 | |7;imaging-desaturate;96;96;96;96;95;98;96;97;96;96 18:31:04 INFO - PROCESS | 4706 | |8;json-parse-financial;66;67;67;67;76;67;68;66;66;66 18:31:04 INFO - PROCESS | 4706 | |9;json-stringify-tinderbox;67;71;67;68;67;66;68;68;69;68 18:31:04 INFO - PROCESS | 4706 | |10;stanford-crypto-aes;86;85;88;87;86;99;86;91;89;86 18:31:04 INFO - PROCESS | 4706 | |11;stanford-crypto-ccm;143;151;141;141;147;139;143;146;162;142 18:31:04 INFO - PROCESS | 4706 | |12;stanford-crypto-pbkdf2;181;173;181;179;183;183;176;182;179;186 18:31:04 INFO - PROCESS | 4706 | |13;stanford-crypto-sha256-iterative;79;75;73;72;76;71;72;70;71;69 18:31:04 INFO - PROCESS | 4706 | __end_tp_report 18:31:04 INFO - PROCESS | 4706 | __start_cc_report 18:31:04 INFO - PROCESS | 4706 | _x_x_mozilla_cycle_collect,987 18:31:04 INFO - PROCESS | 4706 | __end_cc_report 18:31:04 INFO - PROCESS | 4706 | __startTimestamp1471915864392__endTimestamp 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | ------- Summary: start ------- 18:31:04 INFO - PROCESS | 4706 | Number of tests: 14 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.50 stddev:3.62 (3.1%) stddev-sans-first:2.82 18:31:04 INFO - PROCESS | 4706 | Values: 108.0 115.0 112.0 117.0 114.0 114.0 122.0 117.0 116.0 115.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:156.00 stddev:26.23 (16.8%) stddev-sans-first:27.76 18:31:04 INFO - PROCESS | 4706 | Values: 157.0 125.0 158.0 194.0 127.0 155.0 150.0 129.0 195.0 127.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#2] audio-dft Cycles:10 Average:167.60 Median:166.00 stddev:5.85 (3.5%) stddev-sans-first:1.09 18:31:04 INFO - PROCESS | 4706 | Values: 184.0 167.0 165.0 165.0 165.0 166.0 165.0 166.0 165.0 168.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#3] audio-fft Cycles:10 Average:96.70 Median:78.50 stddev:38.18 (48.6%) stddev-sans-first:39.89 18:31:04 INFO - PROCESS | 4706 | Values: 78.0 78.0 82.0 173.0 79.0 79.0 77.0 77.0 165.0 79.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:88.50 stddev:30.91 (34.9%) stddev-sans-first:32.02 18:31:04 INFO - PROCESS | 4706 | Values: 89.0 89.0 152.0 88.0 89.0 88.0 151.0 88.0 90.0 155.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:119.00 stddev:0.99 (0.8%) stddev-sans-first:1.00 18:31:04 INFO - PROCESS | 4706 | Values: 118.0 118.0 117.0 120.0 119.0 119.0 120.0 119.0 119.0 120.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.00 stddev:2.42 (1.6%) stddev-sans-first:2.55 18:31:04 INFO - PROCESS | 4706 | Values: 150.0 148.0 148.0 156.0 149.0 150.0 149.0 148.0 149.0 148.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 18:31:04 INFO - PROCESS | 4706 | Values: 96.0 96.0 96.0 96.0 95.0 98.0 96.0 97.0 96.0 96.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:67.00 stddev:3.03 (4.5%) stddev-sans-first:3.15 18:31:04 INFO - PROCESS | 4706 | Values: 66.0 67.0 67.0 67.0 76.0 67.0 68.0 66.0 66.0 66.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:1.37 (2.0%) stddev-sans-first:1.41 18:31:04 INFO - PROCESS | 4706 | Values: 67.0 71.0 67.0 68.0 67.0 66.0 68.0 68.0 69.0 68.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:87.50 stddev:4.16 (4.8%) stddev-sans-first:4.33 18:31:04 INFO - PROCESS | 4706 | Values: 86.0 85.0 88.0 87.0 86.0 99.0 86.0 91.0 89.0 86.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:144.50 stddev:6.77 (4.7%) stddev-sans-first:7.12 18:31:04 INFO - PROCESS | 4706 | Values: 143.0 151.0 141.0 141.0 147.0 139.0 143.0 146.0 162.0 142.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:181.50 stddev:3.74 (2.1%) stddev-sans-first:3.96 18:31:04 INFO - PROCESS | 4706 | Values: 181.0 173.0 181.0 179.0 183.0 183.0 176.0 182.0 179.0 186.0 18:31:04 INFO - PROCESS | 4706 | 18:31:04 INFO - PROCESS | 4706 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.50 stddev:3.05 (4.2%) stddev-sans-first:2.26 18:31:04 INFO - PROCESS | 4706 | Values: 79.0 75.0 73.0 72.0 76.0 71.0 72.0 70.0 71.0 69.0 18:31:04 INFO - PROCESS | 4706 | -------- Summary: end -------- 18:31:04 INFO - PROCESS | 4706 | 18:31:05 INFO - TEST-INFO | 4706: exit 0 18:31:05 INFO - TEST-OK | kraken | took 65581ms 18:31:05 INFO - SUITE-END | took 1183s 18:31:06 INFO - Completed test suite (00:19:43) 18:31:06 INFO - javascript benchmark 18:31:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6279.730649948108, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.5301045811757, 2636.340914771308, 2650.469906018797, 2650.774684151847, 2652.3766914775024, 4716.056788642268, 4805.903881922364, 4853.005133947537, 4888.486708895568, 4903.534164254394, 4789.0, 4838.685485443444, 4855.708657480544, 4862.465128835825, 4920.335754673118, 4324.762138082404, 4488.730676159433, 4519.163954668397, 4570.771461426915, 4571.1543364477675, 4483.170613436525, 4509.075639493913, 4532.274836026237, 4564.97717511412, 4565.497795242521, 4248.702590818644, 4345.608895199415, 4365.956340436586, 4400.603945644875, 4452.821887124511, 4427.070315233773, 4439.089986552781, 4442.911141777146, 4444.2444784386735, 4458.665600079975, 4369.890752731176, 4399.934000989988, 4408.272635015219, 4425.579569940851, 4425.933610995838, 4693.624510039189, 4746.121967436035, 4768.5946694531, 4807.038592281523, 4826.0830442215865, 5160.5097515736325, 5171.276021357013, 5181.663191892515, 5187.688738675692, 5190.870228244324, 5027.773750181251, 5137.74311284438, 5139.254808052849, 5151.510606492415, 5155.278261043457, 4792.614757496886, 4825.517448255217, 4830.951690483121, 4890.217565189552, 4898.632602554822, 5379.1662292344745, 5381.542568881689, 5382.703951282717, 5383.192521121785, 5383.703896285663, 4937.382827146606, 5154.201098829687, 5155.7679904404395, 5162.767675454538, 5169.81905633301, 5087.109755792795, 5096.643234973591, 5106.66806657566, 5229.372475302988, 5246.554042906319, 5177.223416487482, 5181.015607034651, 5183.922241166386, 5190.169572868323, 5194.27280180775, 4844.958333958216, 5138.743062846843, 5145.742712864417, 5160.92258616121, 5172.146595811724, 4168.270552653335, 4187.623113919762, 4247.745135291831, 4299.226139294957, 4318.114786468766, 3723.0, 3756.286305601927, 3758.2671379080816, 3760.7743535387963, 3760.7743535387963, 4353.782310884443, 4371.628411584988, 4400.845970391085, 4402.84590039347, 4404.4714634243455, 5117.41149767774, 5246.475352464723, 5250.0549901018185, 5251.212318152231, 5253.868653283622, 4422.579854913778, 4450.777461126931, 4459.9331010034875, 4461.04087621163, 4471.642268618502, 4545.340925565774, 4592.931106033412, 4659.790309436084, 4667.556582124693, 4674.883127921761, 4863.051704917507, 4881.29221262922, 4881.682690625098, 4884.389451318585, 4895.902081958412, 5204.9739751301, 5228.529432351107, 5234.2672025915645, 5246.186841039645, 5250.579953603779, 4774.806298425394, 4802.951970480391, 4825.372701548777, 4889.804407823647, 4894.437139728977, 5125.9487405126965, 5128.3076784633595, 5141.331626888481, 5146.562542183956, 5152.896942061213, 5204.531592156724, 5211.218317252291, 5236.240745092016, 5239.947600523946, 5243.68537887728, 4899.975500122477, 4920.458749537476, 4940.950590494049, 5046.84859454217, 5069.619778516552, 5013.197888337849, 5021.949780502295, 5030.446650868328, 5033.974830125826, 5042.722650254272, 4940.456549779449, 4951.653384263067, 4953.702777833341, 4961.3798275215595, 4961.6030717543235, 4945.727984960718, 4964.404271487445, 4979.975100124476, 5067.721275329893, 5068.543831055223, 4933.062718083696, 4933.580645645016, 4954.430240522242, 4961.156603377507, 4963.652544322007], "value": 4732.479416920477, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.9407165211828, 544.1782907809207, 547.843864498618, 561.7528287553477, 577.5581680014786, 33237.66762332376, 36950.630493695055, 37029.259414811684, 37041.814790926044, 37081.25837483249, 36633.26733465329, 37178.62821371786, 37196.25607487849, 37238.813805930935, 37242.0, 7504.96247518763, 7633.923660763377, 7634.580098094602, 7649.464537482379, 7653.732119375823, 7450.478466507347, 7549.660265288047, 7582.393408527305, 7593.658285377143, 7604.391648668121, 7593.12679041909, 7615.5811430371305, 7651.196624354446, 7656.157822639505, 7678.692852285902, 7629.0, 7649.541027538337, 7658.578778167199, 7664.386849052118, 7665.808354791119, 7163.212046674862, 7581.583012934341, 7587.544747315179, 7597.354224890891, 7600.657970391346, 35027.124321891904, 35271.118222044395, 35348.64651353505, 35355.11612209689, 35679.4648080279, 2477.380654836291, 2627.1330460947843, 2672.6391937088633, 2735.86320683965, 2774.334159801633, 26268.73731262682, 27803.58294625582, 27859.442811143865, 28024.85987570049, 28753.856230718713, 3504.719622430225, 3507.105688049531, 3548.8224542951075, 3562.9643703562892, 3596.388613935611, 256130.0, 256590.0, 257179.0, 257890.0, 258765.0, 51031.489685103414, 51121.0, 51380.22929656058, 51427.228591571155, 51611.48388516142, 27964.580531292046, 28378.71621283802, 28793.0, 29692.851535742182, 44145.55854441479, 13086.214827110214, 13154.0, 13162.341882905816, 13174.0, 13174.934125329504, 9963.750906227402, 10027.498625068718, 10032.749181270381, 10034.548445319979, 10071.093601575747, 17207.0, 17261.65476690459, 17263.56841078958, 17269.56826079358, 17318.82681173172, 6726.2511746945165, 6754.129494964621, 6764.391204791593, 6910.170779506491, 7024.735547601481, 765.7664412354285, 885.4156256870434, 893.8569828827357, 936.5176933879058, 955.9484566976271, 26465.47069058608, 27383.589246161322, 27791.86104069467, 28500.429991400055, 28604.0, 896.9192772650492, 936.7423958411491, 939.6382392778829, 980.8921018687938, 1033.4987531047436, 13375.53185638498, 14520.419183232763, 14603.853961460462, 14802.0, 14861.034032787835, 370058.0, 374899.0, 375380.0, 375918.0, 377692.0, 47114.5288547117, 48080.0, 48244.758776206596, 48281.27578086332, 48381.0, 1132.2923173016864, 1153.9711507212219, 1202.5310129049678, 1204.3857632607608, 1210.6549633354452, 25415.856286467522, 26895.462090758465, 27073.864630676722, 27484.312892177855, 27720.0, 39603.80198098991, 40109.398359025225, 40113.0, 40130.39804402995, 40196.598034019284, 332383.0, 333290.0, 333983.0, 334338.0, 335385.0, 24369.878150609133, 24382.146624868044, 24452.26643200707, 24532.75467245376, 24572.508549828544, 38965.41551876781, 39216.21567568576, 39408.80295598618, 39489.60510394859, 41239.587604123575, 29928.25179370533, 29998.25004374908, 30142.54786178165, 30486.237844054078, 31205.219869503446, 34631.0, 34890.47664284987, 34921.0, 35135.29717414834, 35913.281734364646, 28201.294967625974, 28303.71696283011, 34094.82952585221, 34308.31383372368, 34559.13602159966, 29244.415111698072, 31909.521357179197, 31942.68057319397, 31979.36041279115, 32104.197395064377, 24399.51200976006, 24625.87687061553, 24759.25722228336, 24770.806225727112, 25035.49929001446], "value": 16554.587270918793, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.83886573310537, 359.61700788660073, 362.1272732714158, 362.3857561433372, 374.67029014467283, 15786.36854525819, 16125.435609753646, 17124.0, 17207.311707531717, 17250.56873578158, 15343.462978795744, 15805.051696898194, 16059.598510037255, 16127.919360403212, 16244.350225990976, 4682.929756053653, 5014.899702005958, 5031.471695471978, 5059.089363914494, 5071.1632580624155, 4948.257761335793, 5028.647994640377, 5034.697918124906, 5035.043341765053, 5039.269305950635, 4755.857324280277, 4989.550940415362, 4995.475475075119, 5004.949950500485, 5010.674306170087, 4947.431045429767, 4978.576820970222, 4990.176620857555, 4997.325361076263, 5000.549950504435, 4283.807228674717, 4416.381706561084, 4447.977760111179, 4451.777411129463, 4458.1306645204195, 19324.80675193244, 19326.130324135447, 19410.22359105634, 19513.0, 19635.116419761143, 1868.9626207475774, 2132.4242454537343, 2367.7040369953756, 2388.5461762265113, 2515.4466017476125, 12533.373331333396, 13086.47654093835, 13531.526396576073, 13720.45118195271, 13831.446742130303, 1654.8345165483477, 1701.893769050115, 1712.2294967264781, 1723.2159367487764, 1843.6957901946296, 67655.0, 67891.0, 68195.31804681939, 69459.65270173668, 70323.0, 9316.580753866092, 9522.95238523803, 9703.126718595218, 9747.220222382193, 9962.252831037702, 13202.405891734896, 13257.734845303234, 13263.469461221443, 13273.336333183302, 13315.467381304834, 6919.688614012382, 7130.108736407949, 7135.215126336099, 7300.488965772452, 7304.707811687579, 6725.4619630430425, 6725.6973436195485, 6839.247682754893, 6912.377885990285, 6923.584584924921, 6059.394060593905, 6067.815586388897, 6077.726502307407, 6153.96923015391, 6243.625382476975, 1727.680379129865, 1760.216703566926, 1766.938157164493, 1767.3637490503409, 1791.4177892184832, 831.4969443486724, 841.2386789955101, 853.99655404899, 866.2853146154448, 906.1708536688988, 16147.111908845127, 17319.307227711004, 17536.21087051086, 17973.191206395742, 18052.651492522516, 878.486085639895, 884.6461415433878, 897.9820403591891, 904.6200595749801, 961.0965692249264, 10217.1826253901, 10318.638847640297, 10365.585376585002, 10426.739331516772, 10452.790944181226, 397739.0, 402009.0, 402908.0, 405326.0, 405670.0, 65255.99999999905, 66121.0, 66147.33852661411, 66203.0, 67287.32712672908, 916.2990312411011, 930.7068273493828, 959.947202903847, 963.4171326347599, 964.0359640359641, 14404.567862964128, 15399.363243978756, 16075.35698572044, 16162.272697728866, 16363.509094727176, 34635.4804677925, 35050.82474587713, 35141.824290879405, 35544.111397215274, 36527.26945461129, 44833.55166448294, 44915.326270105325, 46719.29921051119, 48372.0, 48444.75777621089, 7235.131784185932, 7278.781636550912, 7297.671604777904, 7336.266373362834, 7550.848983020199, 11144.275622084862, 11528.884711153116, 11873.881261187624, 11914.225575337576, 11993.520259189534, 10030.398176109456, 10065.295429319878, 10100.666779962741, 10510.737231568966, 10575.153987680813, 9830.361026533252, 10393.84409233847, 10412.895871041193, 10636.946815265874, 10665.0, 9935.304528682922, 10131.594736210764, 10387.636432724817, 10499.107575855833, 10567.101796347397, 6959.26927672587, 7076.186238582423, 7128.679209435484, 7314.195438501654, 7653.311201991847, 8866.335024873031, 10173.694789156338, 10185.387782706506, 10499.68500944973, 10671.733206669895], "value": 8194.524107590534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1141.880102589228, 1142.6286456901503, 1265.1207410849458, 1645.3500867157472, 1682.4027470248054, 6548.279689234192, 7251.601161936092, 7309.159446663635, 7894.526328420292, 7943.483673561222, 7522.699092036326, 7768.417368697356, 7778.883316750239, 7780.494267872585, 7844.215578442153, 2073.0878413498012, 2093.9476513087143, 2095.6542170541843, 2097.1611355457785, 2100.1389430333566, 2053.8048885355943, 2081.583683263346, 2103.9158433662633, 2138.518833262519, 2154.967675484861, 2081.130155436279, 2088.2064815370213, 2114.693369461427, 2115.090511080235, 2116.33335499318, 2055.804698553635, 2062.226665000625, 2063.308791554831, 2067.0491573876034, 2071.399294204679, 2034.3795142481538, 2059.3101311060814, 2081.0739221046642, 2107.6522373808302, 2108.2515706923973, 7720.227977202235, 7826.765197044041, 7850.2542258485355, 7872.212778722139, 7882.251186137308, 4338.132373525307, 4443.355713421536, 4447.911041779146, 4451.465824101128, 4461.464624245079, 2731.8199307425916, 2819.1542537238747, 2858.628378310827, 2863.6277283952954, 2872.353720412911, 852.4629483425402, 889.2796834563959, 889.3330002498126, 893.1827377949169, 904.4302089683457, 10613.257072004963, 10630.521626526825, 10643.733906652318, 10665.307264803461, 10666.093382062612, 3699.2971335446177, 3892.8637497687446, 3914.8042597869994, 3953.8220780064967, 3968.7817170055346, 8844.73465796027, 8911.777205569913, 9020.413673111227, 9056.954715226382, 9075.13786190311, 4386.298192289219, 4412.338149277634, 4415.315626077899, 4416.24923762961, 4428.0, 3451.154467155563, 3822.980885095557, 3931.9017024574614, 4039.4950631171105, 4042.717009809344, 3430.382531144418, 3486.668766467232, 3511.6839484446014, 3574.0, 3687.483752274684, 1106.5794997900907, 1129.8587676540433, 1130.361345839598, 1133.3369978562632, 1133.4162906103363, 709.8828693265554, 735.988960165598, 742.721479445208, 751.7819832248587, 773.3619763694861, 4883.949950760603, 4956.653034287565, 5134.845954621367, 5222.268882356473, 5274.340707411574, 834.4034015678819, 885.0839381240386, 888.1518150166576, 891.4027601507006, 896.6054935828345, 3324.9501257481156, 3432.4508078707286, 3490.3193877194212, 3520.0847779576984, 3541.752077354612, 9158.221551168226, 9225.815483690289, 9487.288453365887, 9767.0, 9823.968483309292, 9748.853767193497, 9769.316147869724, 9769.413835169913, 9781.755456113511, 9795.559199836025, 7054.294570542905, 7194.100737407824, 7327.0841144856895, 7366.826786098114, 7369.6315184240575, 5322.600804939568, 5346.224797404432, 5438.809641662523, 5515.117581187152, 5600.747966341443, 8911.197992180734, 9001.649752537172, 9005.774855628662, 9059.275257979478, 9156.084391560791, 8488.0, 8871.556422178735, 8907.331950103639, 9001.864972025556, 9085.364024518485, 5792.189093526994, 6367.108604795239, 6476.5466417350335, 6492.545521813617, 6579.769708060195, 7169.462290328351, 7235.746748863765, 7282.308180722823, 7291.52605080668, 7302.196758356683, 6276.811695649138, 6284.402981716729, 6352.0, 6449.7420103195345, 6480.319566445455, 6342.0, 6411.967940160456, 6428.517861160525, 6477.319881412383, 6490.286068532552, 5781.4218578141845, 5853.502452291603, 5858.121281807763, 5861.912071318849, 5872.647641141545, 4539.682222244412, 4550.817967281272, 4656.41794775653, 4688.882777930443, 4726.1020406122725, 4518.390017347748, 4543.318502224693, 4639.791209395653, 4640.164770341371, 4704.694194877322], "value": 4016.284961469251, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.27143918726836, 290.32644265304486, 291.05697539970504, 294.47583301722943, 297.865960317857, 5052.343195384599, 5108.693478391299, 5112.539871411572, 5116.283720279154, 5121.15500942345, 4959.479254678252, 4990.675606085602, 4997.125503036963, 5038.420581633104, 5050.873728156798, 3683.9263214735756, 3798.7150963677836, 3850.4609354690365, 3903.238868420659, 3906.5898080701545, 3874.302625527404, 3876.2635099331037, 3880.592537783534, 3887.241987812378, 3887.688984881203, 3871.8644847430346, 3881.6506514413695, 3887.961120388788, 3892.987823165983, 3910.511186101737, 3780.2250538639514, 3879.12719638082, 3879.437481565157, 3904.0239940014994, 3905.628965248311, 3411.181316484051, 3412.8293585320635, 3421.8802341917913, 3426.811525366104, 3438.1404648837793, 4878.585320247783, 4899.461059283476, 4927.137750893579, 4933.506649335073, 4956.752162391866, 4418.624416924533, 4428.734275943421, 4434.866953991385, 4444.444444444444, 4448.154850578379, 4894.755262236874, 5214.191800270964, 5218.972995662507, 5224.791008359661, 5283.679080229943, 3633.400488919325, 3646.179609587848, 3647.1246900743895, 3663.150109194866, 3664.193877347006, 5544.0575102232715, 5550.639208451437, 5569.106503788731, 5574.749136288836, 5579.38626751057, 3594.8741794037082, 3636.636336366395, 3661.5240018797385, 3661.9450708239397, 3670.908227294339, 3730.8880733578035, 3732.5894151643297, 3735.3836616958442, 3739.9439008414897, 3747.512823332949, 4340.891477713082, 4344.587264209895, 4351.08627188294, 4358.3680366347335, 4358.869233922987, 5031.748412579356, 5256.553192978563, 5301.932246423898, 5314.883874386345, 5315.760790764425, 1300.785370413871, 1305.28209484783, 1306.2750173653524, 1306.4512904579908, 1310.882020618149, 796.585775396802, 820.9630566624517, 838.9958050209832, 841.7685136587487, 842.1999100854091, 4315.870523884289, 4414.27164517851, 4516.277395616686, 4556.0, 4575.450945886515, 5386.821775152679, 5425.538829199483, 5428.430014848384, 5437.7493176569615, 5445.564354851603, 4561.2245918193985, 4569.1547063793305, 4572.748498832596, 4588.38056862326, 4589.954100459019, 2724.891004359843, 2873.7700983921236, 2877.992702554131, 2886.870090845917, 2905.3172504461436, 5120.718360490135, 5126.436092029874, 5136.8202112925865, 5140.691558506502, 5155.74221288934, 5386.730663466811, 5510.228568000483, 5537.667739935536, 5543.196236545678, 5550.47270509301, 4998.300237966688, 5009.398872135294, 5034.583399967963, 5039.77321020555, 5042.848714538496, 5410.864728381822, 5418.994971860437, 5423.647462914898, 5428.430014848384, 5440.959640134949, 5081.822136225214, 5271.4464981176425, 5276.445973172762, 5288.418273989935, 5293.100172970681, 5042.168042272984, 5063.392392912874, 5072.315237442898, 5081.263216833465, 5111.105556527518, 3724.6834019107596, 3730.2353017631863, 3732.2908647356917, 3735.3836616957897, 3739.5699494558476, 5291.365036195682, 5319.707416092152, 5384.892302154013, 5423.891522169613, 5439.4288599696465, 5206.021711749511, 5221.6344855859725, 5228.660137091077, 5238.711870846988, 5244.7902083916215, 5234.895302094013, 5241.44964778708, 5250.849490305786, 5263.868268322329, 5314.5216930476445, 4882.584980276716, 5131.563162314558, 5141.845744627667, 5147.3308469898675, 5177.301064356264, 4936.03747269279, 5151.201563757623, 5177.385420362843, 5191.221316802359, 5201.297824793604, 5156.948430515647, 5165.560927321069, 5204.713740744295, 5210.843674689765, 5228.189630607262], "value": 3913.3644572242847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.21034971739, 599.2778701664495, 626.3736263736266, 647.0100745858838, 649.4285029174326, 11870.169088163831, 12233.204841685285, 12343.321117338543, 12399.628011159668, 12620.684482887933, 11968.581099661513, 12154.149209555335, 12207.389630518483, 12217.450214740336, 12252.326122063283, 605.1195510532165, 745.4371949178376, 760.262545331028, 761.5392687424112, 761.6420282467259, 736.9631518424084, 759.2217976574001, 763.6410886883184, 765.9540427574335, 766.0768773627765, 793.0721056364068, 793.5040599625235, 794.2772077409559, 794.4359504751633, 795.1055063054064, 792.6868886789744, 793.317746737805, 793.7301317552002, 794.9443538952276, 796.3828033274201, 576.7491141353524, 577.5148874945024, 577.7284676202178, 579.3164066401645, 580.0718849840264, 12101.515939362414, 12191.695207619792, 12202.511899524008, 12207.267563946192, 12213.633590992196, 12857.485700571966, 13071.869281307161, 13196.406161722745, 13523.729525409535, 13691.931540342333, 9963.252756043326, 9979.0, 10260.230482713827, 10300.536475858604, 10356.275060745751, 3172.2703778130926, 3229.80621162731, 3249.2364294391036, 3291.078498020558, 3356.664333566648, 61210.403916159245, 63295.0, 63307.683461582856, 63757.999999999534, 64344.678276608785, 9873.753156171153, 9935.403875767477, 10061.647842325483, 10089.0, 10110.949445252727, 19477.220911163397, 19531.316403925794, 19532.218711251677, 19607.60784784325, 19856.404307870787, 6517.4134327910715, 6528.37980391862, 6569.0, 6601.108850305243, 6761.966190169018, 3663.084228942764, 3683.1344634010984, 3737.084414318455, 3762.097096696773, 3934.09515811365, 2793.4413117376607, 2865.5415133578526, 2868.067877939636, 2868.6844447110802, 2872.468593310244, 506.5542322755951, 527.9234510995884, 535.9923344113121, 536.5680627095148, 539.3958766181823, 485.8615294641081, 487.7536843893882, 500.35204410288765, 526.739264064283, 538.5314776144701, 7627.199144089791, 7835.785453254754, 7993.68025278994, 8057.35541156706, 8356.582170891432, 377.92063666630315, 393.5356279590111, 436.6266841850236, 474.7978668501593, 526.0819869328047, 3545.911352216215, 3614.403623402162, 3698.852045918187, 3834.559025712079, 4066.6136717011836, 87413.0, 89752.0, 91320.0, 96915.51542242244, 98286.64563512038, 49895.25157122646, 78824.0, 79270.0, 79486.6025669868, 80420.0, 44304.3354349685, 46883.0, 68165.65917170382, 68307.65846170737, 68788.6560567204, 7473.925260747323, 7572.432067594842, 7628.313451789366, 7665.425093117927, 7698.769036928901, 42549.36175957301, 43411.56588434075, 43580.56419435765, 44087.33868991904, 44472.33291500565, 36577.81711091428, 36879.0, 36883.262334753694, 44053.77973110242, 59257.70371148117, 9509.61961521559, 9614.134727874245, 9696.321257511907, 9803.754906127404, 10059.0, 10725.0, 10777.461126943464, 10805.675829725122, 10922.890771092505, 10948.890511095105, 9970.800583988424, 10126.645567405105, 10159.695209143738, 10387.065164134961, 10633.255672102878, 10106.747331316776, 10188.541515631667, 10229.897701022894, 10432.634857779942, 10483.37099774016, 10236.33463824849, 10354.792904142025, 10435.217358697977, 10513.9474302628, 10613.787724245627, 8449.746507604781, 8700.173483519056, 8765.342599305206, 8875.467471951704, 9064.909350906406, 8643.26532244741, 8706.869396959177, 8708.433951793113, 9094.727158185266, 9328.207102396373], "value": 6077.064433798031, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1625.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 112.0, 117.0, 114.0, 114.0, 122.0, 117.0, 116.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 158.0, 194.0, 127.0, 155.0, 150.0, 129.0, 195.0, 127.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 167.0, 165.0, 165.0, 165.0, 166.0, 165.0, 166.0, 165.0, 168.0], "value": 167.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 82.0, 173.0, 79.0, 79.0, 77.0, 77.0, 165.0, 79.0], "value": 96.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 152.0, 88.0, 89.0, 88.0, 151.0, 88.0, 90.0, 155.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 120.0, 119.0, 119.0, 120.0, 119.0, 119.0, 120.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 148.0, 156.0, 149.0, 150.0, 149.0, 148.0, 149.0, 148.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 98.0, 96.0, 97.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 76.0, 67.0, 68.0, 66.0, 66.0, 66.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 68.0, 67.0, 66.0, 68.0, 68.0, 69.0, 68.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 88.0, 87.0, 86.0, 99.0, 86.0, 91.0, 89.0, 86.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 151.0, 141.0, 141.0, 147.0, 139.0, 143.0, 146.0, 162.0, 142.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 173.0, 181.0, 179.0, 183.0, 183.0, 176.0, 182.0, 179.0, 186.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 73.0, 72.0, 76.0, 71.0, 72.0, 70.0, 71.0, 69.0], "value": 72.8, "unit": "score"}]}]} 18:31:06 INFO - Return code: 0 18:31:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:31:06 ERROR - # TBPL SUCCESS # 18:31:06 INFO - Running post-action listener: _resource_record_post_action 18:31:06 INFO - [mozharness: 2016-08-23 01:31:06.207231Z] Finished run-tests step (success) 18:31:06 INFO - Running post-run listener: _resource_record_post_run 18:31:06 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 4096; Write bytes: 413212672; Read time: 16; Write time: 268076 18:31:06 INFO - TinderboxPrint: CPU usage
13.8% 18:31:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:31:06 INFO - TinderboxPrint: I/O write bytes / time
413,212,672 / 268,076 18:31:06 INFO - TinderboxPrint: CPU idle
8,244.7 (86.1%) 18:31:06 INFO - TinderboxPrint: CPU user
1,232.2 (12.9%) 18:31:06 INFO - TinderboxPrint: Swap in / out
0 / 0 18:31:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 121012224; Read time: 0; Write time: 103700 18:31:06 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 0; Write bytes: 292200448; Read time: 0; Write time: 164376 18:31:06 INFO - Running post-run listener: _upload_blobber_files 18:31:06 INFO - Blob upload gear active. 18:31:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:31:06 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 18:31:06 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:31:06 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:31:07 INFO - (blobuploader) - INFO - Open directory for files ... 18:31:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:31:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:31:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:31:08 INFO - (blobuploader) - INFO - Done attempting. 18:31:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:31:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:31:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:31:08 INFO - (blobuploader) - INFO - Done attempting. 18:31:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:31:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:31:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:31:12 INFO - (blobuploader) - INFO - Done attempting. 18:31:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:31:12 INFO - Return code: 0 18:31:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:31:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:31:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5eed4c72d465e673179ec0570262cb81b929eaeb84d5f141745abe1345231b9b37ece76a0a8e9799a464cf4da7e508e6ee6652588124583faed708630c688a1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ff79d3f2b4086164ec2f3cac58276938cab0cb3b04a0183b471cb4b7814c1249546796f9d671dba9487665d14aa32c4c56330c4349f45be62517fe15b2687119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/47bedb8dc6011ef3fc3a95c1b3740ff7dd6d4548dafb2db137b8d0f4b9b690c70e42ca0aa16170fe1d1771df4f1202f58ddeb2ae13815e142717dd9ed8512f76"} 18:31:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:31:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:31:12 INFO - Contents: 18:31:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5eed4c72d465e673179ec0570262cb81b929eaeb84d5f141745abe1345231b9b37ece76a0a8e9799a464cf4da7e508e6ee6652588124583faed708630c688a1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ff79d3f2b4086164ec2f3cac58276938cab0cb3b04a0183b471cb4b7814c1249546796f9d671dba9487665d14aa32c4c56330c4349f45be62517fe15b2687119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/47bedb8dc6011ef3fc3a95c1b3740ff7dd6d4548dafb2db137b8d0f4b9b690c70e42ca0aa16170fe1d1771df4f1202f58ddeb2ae13815e142717dd9ed8512f76"} 18:31:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:31:12 INFO - Copying logs to upload dir... 18:31:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:31:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.568469 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-22 18:31:12.200731) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 18:31:12.204611) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287 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/Larch-Non-PGO/sha512/5eed4c72d465e673179ec0570262cb81b929eaeb84d5f141745abe1345231b9b37ece76a0a8e9799a464cf4da7e508e6ee6652588124583faed708630c688a1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ff79d3f2b4086164ec2f3cac58276938cab0cb3b04a0183b471cb4b7814c1249546796f9d671dba9487665d14aa32c4c56330c4349f45be62517fe15b2687119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/47bedb8dc6011ef3fc3a95c1b3740ff7dd6d4548dafb2db137b8d0f4b9b690c70e42ca0aa16170fe1d1771df4f1202f58ddeb2ae13815e142717dd9ed8512f76"} build_url:https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/X5Zo4kKdTTWnw_0nAjhFgA/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/Larch-Non-PGO/sha512/5eed4c72d465e673179ec0570262cb81b929eaeb84d5f141745abe1345231b9b37ece76a0a8e9799a464cf4da7e508e6ee6652588124583faed708630c688a1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ff79d3f2b4086164ec2f3cac58276938cab0cb3b04a0183b471cb4b7814c1249546796f9d671dba9487665d14aa32c4c56330c4349f45be62517fe15b2687119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/47bedb8dc6011ef3fc3a95c1b3740ff7dd6d4548dafb2db137b8d0f4b9b690c70e42ca0aa16170fe1d1771df4f1202f58ddeb2ae13815e142717dd9ed8512f76"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 18:31:12.230650) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 18:31:12.231124) ========= 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=6d15e502d8e29d5d2676d664000001c3-1471914626.605307-2091098287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 18:31:12.312891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 18:31:12.313283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 18:31:12.313596) ========= ========= Total master_lag: 0.16 =========