builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1472552844.52 results: success (0) buildid: 20160830003007 builduid: df504f4ef21c4b0eacd6f4e3ddabf499 revision: 0efb2a2aff2791f08e19eb5f13d6167a8fd44fe0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:24.522373) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:24.522833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:24.523140) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:24.604941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:24.605212) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 03:27:25-- 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.6M=0s 2016-08-30 03:27:25 (37.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103592 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:24.733646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:24.733956) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021488 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:24.787039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:24.787362) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0efb2a2aff2791f08e19eb5f13d6167a8fd44fe0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 0efb2a2aff2791f08e19eb5f13d6167a8fd44fe0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 03:27:25,404 truncating revision to first 12 chars 2016-08-30 03:27:25,404 Setting DEBUG logging. 2016-08-30 03:27:25,404 attempt 1/10 2016-08-30 03:27:25,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0efb2a2aff27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 03:27:25,661 unpacking tar archive at: autoland-0efb2a2aff27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:25.337626) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:25.337960) ========= script_repo_revision: 0efb2a2aff2791f08e19eb5f13d6167a8fd44fe0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:25.338408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:25.338676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 03:27:25.351929) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-30 03:27:25.352250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:26 INFO - MultiFileLogger online at 20160830 03:27:26 in /builds/slave/test 03:27:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:27:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:26 INFO - {'append_to_log': False, 03:27:26 INFO - 'base_work_dir': '/builds/slave/test', 03:27:26 INFO - 'blob_upload_branch': 'Autoland', 03:27:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:26 INFO - 'branch': 'Autoland', 03:27:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:26 INFO - 'config_files': ('talos/linux_config.py',), 03:27:26 INFO - 'default_actions': ('clobber', 03:27:26 INFO - 'read-buildbot-config', 03:27:26 INFO - 'download-and-extract', 03:27:26 INFO - 'populate-webroot', 03:27:26 INFO - 'create-virtualenv', 03:27:26 INFO - 'install', 03:27:26 INFO - 'run-tests'), 03:27:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:26 INFO - 'download_minidump_stackwalk': True, 03:27:26 INFO - 'download_symbols': 'ondemand', 03:27:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:26 INFO - 'installer_path': 'installer.exe', 03:27:26 INFO - 'log_level': 'info', 03:27:26 INFO - 'log_name': 'talos', 03:27:26 INFO - 'log_to_console': True, 03:27:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:26 INFO - 'opt_config_files': (), 03:27:26 INFO - 'pip_index': False, 03:27:26 INFO - 'sps_profile': False, 03:27:26 INFO - 'sps_profile_interval': 0, 03:27:26 INFO - 'suite': 'dromaeojs-e10s', 03:27:26 INFO - 'system_bits': '32', 03:27:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:26 INFO - 'title': 'talos-linux64-ix-041', 03:27:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:26 INFO - 'use_talos_json': True, 03:27:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:26 INFO - 'work_dir': 'build'} 03:27:26 INFO - [mozharness: 2016-08-30 10:27:26.066689Z] Running clobber step. 03:27:26 INFO - Running pre-action listener: _resource_record_pre_action 03:27:26 INFO - Running main action method: clobber 03:27:26 INFO - rmtree: /builds/slave/test/build 03:27:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:27 INFO - Running post-action listener: _resource_record_post_action 03:27:27 INFO - [mozharness: 2016-08-30 10:27:27.034665Z] Finished clobber step (success) 03:27:27 INFO - [mozharness: 2016-08-30 10:27:27.034765Z] Running read-buildbot-config step. 03:27:27 INFO - Running pre-action listener: _resource_record_pre_action 03:27:27 INFO - Running main action method: read_buildbot_config 03:27:27 INFO - Using buildbot properties: 03:27:27 INFO - { 03:27:27 INFO - "project": "", 03:27:27 INFO - "product": "firefox", 03:27:27 INFO - "script_repo_revision": "production", 03:27:27 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 03:27:27 INFO - "repository": "", 03:27:27 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 03:27:27 INFO - "buildid": "20160830003007", 03:27:27 INFO - "pgo_build": "True", 03:27:27 INFO - "basedir": "/builds/slave/test", 03:27:27 INFO - "buildnumber": 154, 03:27:27 INFO - "slavename": "talos-linux64-ix-041", 03:27:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:27:27 INFO - "platform": "ubuntu64_hw", 03:27:27 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 03:27:27 INFO - "branch": "autoland", 03:27:27 INFO - "repo_path": "integration/autoland", 03:27:27 INFO - "revision": "0efb2a2aff2791f08e19eb5f13d6167a8fd44fe0", 03:27:27 INFO - "stage_platform": "linux64-pgo", 03:27:27 INFO - "builduid": "df504f4ef21c4b0eacd6f4e3ddabf499", 03:27:27 INFO - "slavebuilddir": "test" 03:27:27 INFO - } 03:27:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 03:27:27 INFO - Running post-action listener: _resource_record_post_action 03:27:27 INFO - [mozharness: 2016-08-30 10:27:27.037244Z] Finished read-buildbot-config step (success) 03:27:27 INFO - [mozharness: 2016-08-30 10:27:27.037335Z] Running download-and-extract step. 03:27:27 INFO - Running pre-action listener: _resource_record_pre_action 03:27:27 INFO - Running main action method: download_and_extract 03:27:27 INFO - mkdir: /builds/slave/test/build/tests 03:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:27 INFO - trying https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:27:27 INFO - Downloading https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/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 03:27:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/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 03:27:27 INFO - Downloaded 1361 bytes. 03:27:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 03:27:27 INFO - Using the following test package requirements: 03:27:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:27:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:27:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:27:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:27 INFO - u'jsshell-linux-x86_64.zip'], 03:27:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:27:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 03:27:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:27:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:27:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:27:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 03:27:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:27:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:27 INFO - trying https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:27:27 INFO - Downloading https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/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 03:27:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/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 03:27:28 INFO - Downloaded 21886940 bytes. 03:27:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 03:27:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:32 INFO - trying https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 03:27:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/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 03:27:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/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 03:27:33 INFO - Downloaded 21886940 bytes. 03:27:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 03:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:38 INFO - trying https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 03:27:38 INFO - Downloading https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/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 03:27:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/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 03:27:39 INFO - Downloaded 14413998 bytes. 03:27:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 03:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:39 INFO - trying https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:27:39 INFO - Downloading https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/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 03:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/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 03:27:40 INFO - Downloaded 59718720 bytes. 03:27:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:27:40 INFO - mkdir: /builds/slave/test/properties 03:27:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:27:40 INFO - Writing to file /builds/slave/test/properties/build_url 03:27:40 INFO - Contents: 03:27:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 03:27:41 INFO - Running post-action listener: _resource_record_post_action 03:27:41 INFO - Running post-action listener: set_extra_try_arguments 03:27:41 INFO - [mozharness: 2016-08-30 10:27:41.157469Z] Finished download-and-extract step (success) 03:27:41 INFO - [mozharness: 2016-08-30 10:27:41.157698Z] Running populate-webroot step. 03:27:41 INFO - Running pre-action listener: _resource_record_pre_action 03:27:41 INFO - Running main action method: populate_webroot 03:27:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:27:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:27:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:27:41 INFO - '--tppagecycles', 03:27:41 INFO - '7'], 03:27:41 INFO - 'tests': ['tsvgm']}}, 03:27:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:27:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:27:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:27:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:27:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:41 INFO - 'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:41 INFO - 'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['damp', 'tps']}, 03:27:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:41 INFO - 'tests': ['damp', 'tps']}, 03:27:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['dromaeo_dom']}, 03:27:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:27:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['basic_compositor_video']}, 03:27:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:27:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['a11yr', 03:27:41 INFO - 'ts_paint', 03:27:41 INFO - 'tpaint', 03:27:41 INFO - 'sessionrestore', 03:27:41 INFO - 'sessionrestore_no_auto_restore', 03:27:41 INFO - 'tabpaint']}, 03:27:41 INFO - 'other-e10s': {'tests': ['a11yr', 03:27:41 INFO - 'ts_paint', 03:27:41 INFO - 'tpaint', 03:27:41 INFO - 'sessionrestore', 03:27:41 INFO - 'sessionrestore_no_auto_restore', 03:27:41 INFO - 'tabpaint']}, 03:27:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:27:41 INFO - 'ts_paint', 03:27:41 INFO - 'tpaint', 03:27:41 INFO - 'sessionrestore', 03:27:41 INFO - 'sessionrestore_no_auto_restore', 03:27:41 INFO - 'tabpaint']}, 03:27:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:27:41 INFO - 'ts_paint', 03:27:41 INFO - 'tpaint', 03:27:41 INFO - 'sessionrestore', 03:27:41 INFO - 'sessionrestore_no_auto_restore', 03:27:41 INFO - 'tabpaint']}, 03:27:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['a11yr', 03:27:41 INFO - 'ts_paint', 03:27:41 INFO - 'tpaint', 03:27:41 INFO - 'sessionrestore', 03:27:41 INFO - 'sessionrestore_no_auto_restore', 03:27:41 INFO - 'tabpaint']}, 03:27:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['a11yr', 03:27:41 INFO - 'ts_paint', 03:27:41 INFO - 'tpaint', 03:27:41 INFO - 'sessionrestore', 03:27:41 INFO - 'sessionrestore_no_auto_restore', 03:27:41 INFO - 'tabpaint']}, 03:27:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['tsvgx', 03:27:41 INFO - 'tsvgr_opacity', 03:27:41 INFO - 'tart', 03:27:41 INFO - 'tscrollx', 03:27:41 INFO - 'cart']}, 03:27:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:27:41 INFO - 'tsvgr_opacity', 03:27:41 INFO - 'tart', 03:27:41 INFO - 'tscrollx', 03:27:41 INFO - 'cart']}, 03:27:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:41 INFO - 'talos_options': ['--disable-e10s'], 03:27:41 INFO - 'tests': ['tp5o']}, 03:27:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:41 INFO - 'tests': ['tp5o']}, 03:27:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:41 INFO - 'talos_options': ['--disable-e10s', 03:27:41 INFO - '--xperf_path', 03:27:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:41 INFO - 'tests': ['tp5n']}, 03:27:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:41 INFO - 'talos_options': ['--xperf_path', 03:27:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:41 INFO - 'tests': ['tp5n']}}, 03:27:41 INFO - 'talos.zip': {'path': '', 03:27:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:27:41 INFO - Running post-action listener: _resource_record_post_action 03:27:41 INFO - [mozharness: 2016-08-30 10:27:41.172924Z] Finished populate-webroot step (success) 03:27:41 INFO - [mozharness: 2016-08-30 10:27:41.173014Z] Running create-virtualenv step. 03:27:41 INFO - Running pre-action listener: _resource_record_pre_action 03:27:41 INFO - Running main action method: create_virtualenv 03:27:41 INFO - Creating virtualenv /builds/slave/test/build/venv 03:27:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:27:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:27:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:27:41 INFO - Using real prefix '/usr' 03:27:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:27:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:43 INFO - Installing pip.................done. 03:27:43 INFO - Return code: 0 03:27:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27:43 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')]} 03:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:43 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')]} 03:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:43 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 0x7f3062b4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', '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 03:27:43 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 03:27:43 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 03:27:43 INFO - Using env: {'DISPLAY': ':0', 03:27:43 INFO - 'HOME': '/home/cltbld', 03:27:43 INFO - 'LANG': 'en_US.UTF-8', 03:27:43 INFO - 'LANGUAGE': 'en_US:en', 03:27:43 INFO - 'LOGNAME': 'cltbld', 03:27:43 INFO - 'MAIL': '/var/mail/cltbld', 03:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:43 INFO - 'MOZ_NO_REMOTE': '1', 03:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:43 INFO - 'NO_EM_RESTART': '1', 03:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:43 INFO - 'PWD': '/builds/slave/test', 03:27:43 INFO - 'SHELL': '/bin/bash', 03:27:43 INFO - 'SHLVL': '1', 03:27:43 INFO - 'TERM': 'linux', 03:27:43 INFO - 'TMOUT': '86400', 03:27:43 INFO - 'USER': 'cltbld', 03:27:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:43 INFO - '_': '/tools/buildbot/bin/python'} 03:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:43 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 03:27:43 INFO - Cleaning up... 03:27:43 INFO - Return code: 0 03:27:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:27:43 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')]} 03:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:43 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')]} 03:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:43 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 0x7f3062b4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', '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 03:27:43 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 03:27:43 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 03:27:43 INFO - Using env: {'DISPLAY': ':0', 03:27:43 INFO - 'HOME': '/home/cltbld', 03:27:43 INFO - 'LANG': 'en_US.UTF-8', 03:27:43 INFO - 'LANGUAGE': 'en_US:en', 03:27:43 INFO - 'LOGNAME': 'cltbld', 03:27:43 INFO - 'MAIL': '/var/mail/cltbld', 03:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:43 INFO - 'MOZ_NO_REMOTE': '1', 03:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:43 INFO - 'NO_EM_RESTART': '1', 03:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:43 INFO - 'PWD': '/builds/slave/test', 03:27:43 INFO - 'SHELL': '/bin/bash', 03:27:43 INFO - 'SHLVL': '1', 03:27:43 INFO - 'TERM': 'linux', 03:27:43 INFO - 'TMOUT': '86400', 03:27:43 INFO - 'USER': 'cltbld', 03:27:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:43 INFO - '_': '/tools/buildbot/bin/python'} 03:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:44 INFO - Downloading/unpacking psutil>=3.1.1 03:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:46 INFO - Installing collected packages: psutil 03:27:46 INFO - Running setup.py install for psutil 03:27:46 INFO - building 'psutil._psutil_linux' extension 03:27:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:27:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:27:46 INFO - building 'psutil._psutil_posix' extension 03:27:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:27:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:27:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:46 INFO - Successfully installed psutil 03:27:46 INFO - Cleaning up... 03:27:46 INFO - Return code: 0 03:27:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3062b4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', '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 03:27: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:27: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 mozsystemmonitor==0.3 03:27:46 INFO - Using env: {'DISPLAY': ':0', 03:27:46 INFO - 'HOME': '/home/cltbld', 03:27:46 INFO - 'LANG': 'en_US.UTF-8', 03:27:46 INFO - 'LANGUAGE': 'en_US:en', 03:27:46 INFO - 'LOGNAME': 'cltbld', 03:27:46 INFO - 'MAIL': '/var/mail/cltbld', 03:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:46 INFO - 'MOZ_NO_REMOTE': '1', 03:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:46 INFO - 'NO_EM_RESTART': '1', 03:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:46 INFO - 'PWD': '/builds/slave/test', 03:27:46 INFO - 'SHELL': '/bin/bash', 03:27:46 INFO - 'SHLVL': '1', 03:27:46 INFO - 'TERM': 'linux', 03:27:46 INFO - 'TMOUT': '86400', 03:27:46 INFO - 'USER': 'cltbld', 03:27:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:46 INFO - '_': '/tools/buildbot/bin/python'} 03:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:27:48 INFO - Installing collected packages: mozsystemmonitor 03:27:48 INFO - Running setup.py install for mozsystemmonitor 03:27:48 INFO - Successfully installed mozsystemmonitor 03:27:48 INFO - Cleaning up... 03:27:49 INFO - Return code: 0 03:27:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3062b4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', '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 03:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:27:49 INFO - Using env: {'DISPLAY': ':0', 03:27:49 INFO - 'HOME': '/home/cltbld', 03:27:49 INFO - 'LANG': 'en_US.UTF-8', 03:27:49 INFO - 'LANGUAGE': 'en_US:en', 03:27:49 INFO - 'LOGNAME': 'cltbld', 03:27:49 INFO - 'MAIL': '/var/mail/cltbld', 03:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:49 INFO - 'MOZ_NO_REMOTE': '1', 03:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:49 INFO - 'NO_EM_RESTART': '1', 03:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:49 INFO - 'PWD': '/builds/slave/test', 03:27:49 INFO - 'SHELL': '/bin/bash', 03:27:49 INFO - 'SHLVL': '1', 03:27:49 INFO - 'TERM': 'linux', 03:27:49 INFO - 'TMOUT': '86400', 03:27:49 INFO - 'USER': 'cltbld', 03:27:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:49 INFO - '_': '/tools/buildbot/bin/python'} 03:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:49 INFO - Downloading/unpacking jsonschema==2.5.1 03:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:27:51 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 03:27:51 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 03:27:51 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 03:27:51 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 03:27:51 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 03:27:51 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 03:27:51 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:51 INFO - warning: no files found matching '*.txt' 03:27:51 INFO - no previously-included directories found matching 'build' 03:27:51 INFO - no previously-included directories found matching 'dist' 03:27:51 INFO - no previously-included directories found matching '.git*' 03:27:51 INFO - Installing collected packages: jsonschema, functools32 03:27:51 INFO - Running setup.py install for functools32 03:27:51 INFO - warning: no files found matching '*.txt' 03:27:51 INFO - no previously-included directories found matching 'build' 03:27:51 INFO - no previously-included directories found matching 'dist' 03:27:51 INFO - no previously-included directories found matching '.git*' 03:27:51 INFO - Successfully installed jsonschema functools32 03:27:51 INFO - Cleaning up... 03:27:51 INFO - Return code: 0 03:27:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:27:51 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')]} 03:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:51 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')]} 03:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:51 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 0x7f3062b4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', '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 03:27:51 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 03:27:51 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 03:27:51 INFO - Using env: {'DISPLAY': ':0', 03:27:51 INFO - 'HOME': '/home/cltbld', 03:27:51 INFO - 'LANG': 'en_US.UTF-8', 03:27:51 INFO - 'LANGUAGE': 'en_US:en', 03:27:51 INFO - 'LOGNAME': 'cltbld', 03:27:51 INFO - 'MAIL': '/var/mail/cltbld', 03:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:51 INFO - 'MOZ_NO_REMOTE': '1', 03:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:51 INFO - 'NO_EM_RESTART': '1', 03:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:51 INFO - 'PWD': '/builds/slave/test', 03:27:51 INFO - 'SHELL': '/bin/bash', 03:27:51 INFO - 'SHLVL': '1', 03:27:51 INFO - 'TERM': 'linux', 03:27:51 INFO - 'TMOUT': '86400', 03:27:51 INFO - 'USER': 'cltbld', 03:27:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:51 INFO - '_': '/tools/buildbot/bin/python'} 03:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:27:51 INFO - Cleaning up... 03:27:51 INFO - Return code: 0 03:27:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:27:51 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')]} 03:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:51 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')]} 03:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:51 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 0x7f3062b4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', '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 03:27:51 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 03:27:51 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 03:27:51 INFO - Using env: {'DISPLAY': ':0', 03:27:51 INFO - 'HOME': '/home/cltbld', 03:27:51 INFO - 'LANG': 'en_US.UTF-8', 03:27:51 INFO - 'LANGUAGE': 'en_US:en', 03:27:51 INFO - 'LOGNAME': 'cltbld', 03:27:51 INFO - 'MAIL': '/var/mail/cltbld', 03:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:51 INFO - 'MOZ_NO_REMOTE': '1', 03:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:51 INFO - 'NO_EM_RESTART': '1', 03:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:51 INFO - 'PWD': '/builds/slave/test', 03:27:51 INFO - 'SHELL': '/bin/bash', 03:27:51 INFO - 'SHLVL': '1', 03:27:51 INFO - 'TERM': 'linux', 03:27:51 INFO - 'TMOUT': '86400', 03:27:51 INFO - 'USER': 'cltbld', 03:27:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:51 INFO - '_': '/tools/buildbot/bin/python'} 03:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:27:51 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 03:27:51 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 03:27:51 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 03:27:51 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 03:27:51 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 03:27:51 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 03:27:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27:54 INFO - Downloading docopt-0.6.1.tar.gz 03:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:54 INFO - Running setup.py install for blobuploader 03:27:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:54 INFO - Running setup.py install for requests 03:27:55 INFO - Running setup.py install for docopt 03:27:55 INFO - Successfully installed blobuploader requests docopt 03:27:55 INFO - Cleaning up... 03:27:55 INFO - Return code: 0 03:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:55 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')]} 03:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:55 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')]} 03:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:55 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 0x7f3062b4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', '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 03:27:55 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 03:27:55 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 03:27:55 INFO - Using env: {'DISPLAY': ':0', 03:27:55 INFO - 'HOME': '/home/cltbld', 03:27:55 INFO - 'LANG': 'en_US.UTF-8', 03:27:55 INFO - 'LANGUAGE': 'en_US:en', 03:27:55 INFO - 'LOGNAME': 'cltbld', 03:27:55 INFO - 'MAIL': '/var/mail/cltbld', 03:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:55 INFO - 'MOZ_NO_REMOTE': '1', 03:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:55 INFO - 'NO_EM_RESTART': '1', 03:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:55 INFO - 'PWD': '/builds/slave/test', 03:27:55 INFO - 'SHELL': '/bin/bash', 03:27:55 INFO - 'SHLVL': '1', 03:27:55 INFO - 'TERM': 'linux', 03:27:55 INFO - 'TMOUT': '86400', 03:27:55 INFO - 'USER': 'cltbld', 03:27:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:55 INFO - '_': '/tools/buildbot/bin/python'} 03:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:55 INFO - Running setup.py (path:/tmp/pip-PPFhVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:55 INFO - Running setup.py (path:/tmp/pip-FCiifd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:55 INFO - Running setup.py (path:/tmp/pip-JffL_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:55 INFO - Running setup.py (path:/tmp/pip-PvZlbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:55 INFO - Running setup.py (path:/tmp/pip-38eEwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:55 INFO - Running setup.py (path:/tmp/pip-enrO_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:55 INFO - Running setup.py (path:/tmp/pip-ElGWvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:55 INFO - Running setup.py (path:/tmp/pip-liuCNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:56 INFO - Running setup.py (path:/tmp/pip-pXgeSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:56 INFO - Running setup.py (path:/tmp/pip-ELoSq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:56 INFO - Running setup.py (path:/tmp/pip-25B4CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:56 INFO - Running setup.py (path:/tmp/pip-uAYNVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:56 INFO - Running setup.py (path:/tmp/pip-10XhwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:56 INFO - Running setup.py (path:/tmp/pip-uIlDZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:56 INFO - Running setup.py (path:/tmp/pip-oe4Ww1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:56 INFO - Running setup.py (path:/tmp/pip-LyAiq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:56 INFO - Running setup.py (path:/tmp/pip-Zs8_7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:56 INFO - Running setup.py install for manifestparser 03:27:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:56 INFO - Running setup.py install for mozcrash 03:27:56 INFO - Running setup.py install for mozdebug 03:27:56 INFO - Running setup.py install for mozdevice 03:27:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozfile 03:27:57 INFO - Running setup.py install for mozhttpd 03:27:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozinfo 03:27:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozInstall 03:27:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozleak 03:27:57 INFO - Running setup.py install for mozlog 03:27:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for moznetwork 03:27:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozprocess 03:27:57 INFO - Running setup.py install for mozprofile 03:27:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Running setup.py install for mozrunner 03:27:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Running setup.py install for mozscreenshot 03:27:58 INFO - Running setup.py install for moztest 03:27:58 INFO - Running setup.py install for mozversion 03:27:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:58 INFO - Cleaning up... 03:27:58 INFO - Return code: 0 03:27:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:58 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 0x7f3062b4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', '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 03:27:58 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 03:27:58 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 03:27:58 INFO - Using env: {'DISPLAY': ':0', 03:27:58 INFO - 'HOME': '/home/cltbld', 03:27:58 INFO - 'LANG': 'en_US.UTF-8', 03:27:58 INFO - 'LANGUAGE': 'en_US:en', 03:27:58 INFO - 'LOGNAME': 'cltbld', 03:27:58 INFO - 'MAIL': '/var/mail/cltbld', 03:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:58 INFO - 'MOZ_NO_REMOTE': '1', 03:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:58 INFO - 'NO_EM_RESTART': '1', 03:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:58 INFO - 'PWD': '/builds/slave/test', 03:27:58 INFO - 'SHELL': '/bin/bash', 03:27:58 INFO - 'SHLVL': '1', 03:27:58 INFO - 'TERM': 'linux', 03:27:58 INFO - 'TMOUT': '86400', 03:27:58 INFO - 'USER': 'cltbld', 03:27:58 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:58 INFO - '_': '/tools/buildbot/bin/python'} 03:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:58 INFO - Running setup.py (path:/tmp/pip-i_9bjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:58 INFO - Running setup.py (path:/tmp/pip-Ys6FJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:58 INFO - Running setup.py (path:/tmp/pip-vjoFd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:58 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)) 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:58 INFO - Running setup.py (path:/tmp/pip-CVwfQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:58 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:59 INFO - Running setup.py (path:/tmp/pip-mnmoWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:59 INFO - Running setup.py (path:/tmp/pip-OvfIwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:59 INFO - Running setup.py (path:/tmp/pip-M1DaS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:59 INFO - Running setup.py (path:/tmp/pip-xx3t4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:59 INFO - Running setup.py (path:/tmp/pip-MCA1An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:59 INFO - Running setup.py (path:/tmp/pip-GY5KOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:59 INFO - Running setup.py (path:/tmp/pip-y9Oq_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:59 INFO - Running setup.py (path:/tmp/pip-v36uAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:59 INFO - Running setup.py (path:/tmp/pip-HiATzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:59 INFO - Running setup.py (path:/tmp/pip-A496hS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:59 INFO - Running setup.py (path:/tmp/pip-d392d7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:59 INFO - Running setup.py (path:/tmp/pip-wogS9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:59 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)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:59 INFO - Running setup.py (path:/tmp/pip-4BOj9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:59 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)) 03:27:59 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)) 03:27:59 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)) 03:27:59 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)) 03:27:59 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)) 03:27:59 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)) 03:27:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:59 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 03:27:59 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 03:27:59 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 03:27:59 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 03:27:59 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 03:27:59 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 03:28:01 INFO - Downloading blessings-1.6.tar.gz 03:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:01 INFO - Installing collected packages: blessings 03:28:01 INFO - Running setup.py install for blessings 03:28:02 INFO - Successfully installed blessings 03:28:02 INFO - Cleaning up... 03:28:02 INFO - Return code: 0 03:28:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:02 INFO - Reading from file tmpfile_stdout 03:28:02 INFO - Current package versions: 03:28:02 INFO - argparse == 1.2.1 03:28:02 INFO - blessings == 1.6 03:28:02 INFO - blobuploader == 1.2.4 03:28:02 INFO - docopt == 0.6.1 03:28:02 INFO - functools32 == 3.2.3-2 03:28:02 INFO - jsonschema == 2.5.1 03:28:02 INFO - manifestparser == 1.1 03:28:02 INFO - mozInstall == 1.12 03:28:02 INFO - mozcrash == 0.17 03:28:02 INFO - mozdebug == 0.1 03:28:02 INFO - mozdevice == 0.48 03:28:02 INFO - mozfile == 1.2 03:28:02 INFO - mozhttpd == 0.7 03:28:02 INFO - mozinfo == 0.9 03:28:02 INFO - mozleak == 0.1 03:28:02 INFO - mozlog == 3.3 03:28:02 INFO - moznetwork == 0.27 03:28:02 INFO - mozprocess == 0.23 03:28:02 INFO - mozprofile == 0.28 03:28:02 INFO - mozrunner == 6.12 03:28:02 INFO - mozscreenshot == 0.1 03:28:02 INFO - mozsystemmonitor == 0.3 03:28:02 INFO - moztest == 0.7 03:28:02 INFO - mozversion == 1.4 03:28:02 INFO - psutil == 3.1.1 03:28:02 INFO - requests == 1.2.3 03:28:02 INFO - wsgiref == 0.1.2 03:28:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:02 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 0x7f3062b4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', '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 03:28:02 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 03:28:02 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 03:28:02 INFO - Using env: {'DISPLAY': ':0', 03:28:02 INFO - 'HOME': '/home/cltbld', 03:28:02 INFO - 'LANG': 'en_US.UTF-8', 03:28:02 INFO - 'LANGUAGE': 'en_US:en', 03:28:02 INFO - 'LOGNAME': 'cltbld', 03:28:02 INFO - 'MAIL': '/var/mail/cltbld', 03:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:02 INFO - 'MOZ_NO_REMOTE': '1', 03:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:02 INFO - 'NO_EM_RESTART': '1', 03:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:02 INFO - 'PWD': '/builds/slave/test', 03:28:02 INFO - 'SHELL': '/bin/bash', 03:28:02 INFO - 'SHLVL': '1', 03:28:02 INFO - 'TERM': 'linux', 03:28:02 INFO - 'TMOUT': '86400', 03:28:02 INFO - 'USER': 'cltbld', 03:28:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:02 INFO - '_': '/tools/buildbot/bin/python'} 03:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:02 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)) 03:28:02 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)) 03:28:02 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)) 03:28:02 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)) 03:28:02 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)) 03:28:02 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)) 03:28:02 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)) 03:28:02 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)) 03:28:02 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)) 03:28:02 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)) 03:28:02 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)) 03:28:02 INFO - Cleaning up... 03:28:02 INFO - Return code: 0 03:28:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:02 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 0x7f3062b4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', '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 03:28:02 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 03:28:02 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 03:28:02 INFO - Using env: {'DISPLAY': ':0', 03:28:02 INFO - 'HOME': '/home/cltbld', 03:28:02 INFO - 'LANG': 'en_US.UTF-8', 03:28:02 INFO - 'LANGUAGE': 'en_US:en', 03:28:02 INFO - 'LOGNAME': 'cltbld', 03:28:02 INFO - 'MAIL': '/var/mail/cltbld', 03:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:02 INFO - 'MOZ_NO_REMOTE': '1', 03:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:02 INFO - 'NO_EM_RESTART': '1', 03:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:02 INFO - 'PWD': '/builds/slave/test', 03:28:02 INFO - 'SHELL': '/bin/bash', 03:28:02 INFO - 'SHLVL': '1', 03:28:02 INFO - 'TERM': 'linux', 03:28:02 INFO - 'TMOUT': '86400', 03:28:02 INFO - 'USER': 'cltbld', 03:28:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:02 INFO - '_': '/tools/buildbot/bin/python'} 03:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:02 INFO - Cleaning up... 03:28:02 INFO - Return code: 0 03:28:02 INFO - Running post-action listener: _resource_record_post_action 03:28:02 INFO - Running post-action listener: _start_resource_monitoring 03:28:02 INFO - Starting resource monitoring. 03:28:02 INFO - [mozharness: 2016-08-30 10:28:02.799142Z] Finished create-virtualenv step (success) 03:28:02 INFO - [mozharness: 2016-08-30 10:28:02.799598Z] Running install step. 03:28:02 INFO - Running pre-action listener: _resource_record_pre_action 03:28:02 INFO - Running main action method: install 03:28:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:03 INFO - Reading from file tmpfile_stdout 03:28:03 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:03 INFO - Reading from file tmpfile_stdout 03:28:03 INFO - Output received: 03:28:03 INFO - Usage: mozinstall [options] installer 03:28:03 INFO - Options: 03:28:03 INFO - -h, --help show this help message and exit 03:28:03 INFO - -d DEST, --destination=DEST 03:28:03 INFO - Directory to install application into. [default: 03:28:03 INFO - "/builds/slave/test"] 03:28:03 INFO - --app=APP Application being installed. [default: firefox] 03:28:03 INFO - mkdir: /builds/slave/test/build/application 03:28:03 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'] 03:28:03 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 03:28:20 INFO - Reading from file tmpfile_stdout 03:28:20 INFO - Output received: 03:28:20 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:20 INFO - Running post-action listener: _resource_record_post_action 03:28:20 INFO - [mozharness: 2016-08-30 10:28:20.096265Z] Finished install step (success) 03:28:20 INFO - [mozharness: 2016-08-30 10:28:20.096553Z] Running run-tests step. 03:28:20 INFO - Running pre-action listener: _resource_record_pre_action 03:28:20 INFO - Running main action method: run_tests 03:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:20 INFO - Python 2.7.3 03:28:20 INFO - Return code: 0 03:28:20 INFO - grabbing minidump binary from tooltool 03:28:20 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')]} 03:28:20 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 0x231b370>, '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 0x231e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ed80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:20 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 03:28:20 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 03:28:20 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 03:28:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:20 INFO - Return code: 0 03:28:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:28:20 INFO - Using env: {'DISPLAY': ':0', 03:28:20 INFO - 'HOME': '/home/cltbld', 03:28:20 INFO - 'LANG': 'en_US.UTF-8', 03:28:20 INFO - 'LANGUAGE': 'en_US:en', 03:28:20 INFO - 'LOGNAME': 'cltbld', 03:28:20 INFO - 'MAIL': '/var/mail/cltbld', 03:28:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:20 INFO - 'MOZ_NO_REMOTE': '1', 03:28:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:20 INFO - 'NO_EM_RESTART': '1', 03:28:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:20 INFO - 'PWD': '/builds/slave/test', 03:28:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:20 INFO - 'SHELL': '/bin/bash', 03:28:20 INFO - 'SHLVL': '1', 03:28:20 INFO - 'TERM': 'linux', 03:28:20 INFO - 'TMOUT': '86400', 03:28:20 INFO - 'USER': 'cltbld', 03:28:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635', 03:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:20 INFO - '_': '/tools/buildbot/bin/python'} 03:28:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:28:20 INFO - mozversion application_buildid: 20160830003007 03:28:20 INFO - mozversion application_changeset: 0efb2a2aff2791f08e19eb5f13d6167a8fd44fe0 03:28:20 INFO - mozversion application_display_name: Nightly 03:28:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:20 INFO - mozversion application_name: Firefox 03:28:20 INFO - mozversion application_remotingname: firefox 03:28:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:28:20 INFO - mozversion application_vendor: Mozilla 03:28:20 INFO - mozversion application_version: 51.0a1 03:28:20 INFO - mozversion platform_buildid: 20160830003007 03:28:20 INFO - mozversion platform_changeset: 0efb2a2aff2791f08e19eb5f13d6167a8fd44fe0 03:28:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:28:20 INFO - mozversion platform_version: 51.0a1 03:28:20 INFO - using testdate: 1472552900 03:28:20 INFO - actual date: 1472552900 03:28:20 INFO - starting webserver on 'localhost:49117' 03:28:20 INFO - SUITE-START | Running 2 tests 03:28:20 INFO - TEST-START | dromaeo_css 03:28:20 INFO - operating with platform_type : linux_ 03:28:20 INFO - Initialising browser for dromaeo_css test... 03:28:20 INFO - TEST-INFO | started process 6397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppWAd7h/profile http://localhost:49117/getInfo.html) 03:28:25 INFO - PROCESS | 6397 | __metrics Screen width/height:1600/1200 03:28:25 INFO - PROCESS | 6397 | colorDepth:24 03:28:25 INFO - PROCESS | 6397 | Browser inner width/height: 1024/697 03:28:25 INFO - PROCESS | 6397 | __metrics 03:28:25 ERROR - PROCESS | 6397 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 03:28:26 INFO - TEST-INFO | 6397: exit 0 03:28:26 INFO - Browser initialized. 03:28:26 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:26 INFO - TEST-INFO | started process 6518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppWAd7h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:38 INFO - PROCESS | 6518 | RSS: Main: 191672320 03:28:38 INFO - PROCESS | 6518 | 03:29:28 INFO - PROCESS | 6518 | 1472552968540 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] 03:31:38 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:49117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49117/tests/dromaeo/cssquery-ext.html) 03:31:39 INFO - PROCESS | 6518 | RSS: Main: 206958592 03:31:39 INFO - PROCESS | 6518 | 03:34:41 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:49117/tests/dromaeo/cssquery-ext.html (next: http://localhost:49117/tests/dromaeo/cssquery-jquery.html) 03:34:42 INFO - PROCESS | 6518 | RSS: Main: 201134080 03:34:42 INFO - PROCESS | 6518 | 03:37:44 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:49117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49117/tests/dromaeo/cssquery-mootools.html) 03:37:44 INFO - PROCESS | 6518 | RSS: Main: 199430144 03:37:44 INFO - PROCESS | 6518 | 03:40:46 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:49117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49117/tests/dromaeo/cssquery-prototype.html) 03:40:47 INFO - PROCESS | 6518 | RSS: Main: 193503232 03:40:47 INFO - PROCESS | 6518 | 03:43:49 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:49117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49117/tests/dromaeo/cssquery-yui.html) 03:43:50 INFO - PROCESS | 6518 | RSS: Main: 196976640 03:43:50 INFO - PROCESS | 6518 | 03:46:53 INFO - PROCESS | 6518 | Cycle 1(1): loaded http://localhost:49117/tests/dromaeo/cssquery-yui.html (next: http://localhost:49117/tests/dromaeo/cssquery-dojo.html) 03:46:53 INFO - PROCESS | 6518 | RSS: Main: 197562368 03:46:53 INFO - PROCESS | 6518 | 03:46:53 INFO - PROCESS | 6518 | __start_tp_report 03:46:53 INFO - PROCESS | 6518 | _x_x_mozilla_page_load 03:46:53 INFO - PROCESS | 6518 | _x_x_mozilla_page_load_details 03:46:53 INFO - PROCESS | 6518 | |i|pagename|runs| 03:46:53 INFO - PROCESS | 6518 | |0;dojo.html;3117.158367240845;3134.890278840241;3137.6548579656246;3176.317091825257;3189.5056266278734;5415.0523658359825;5468.7539060742265;5504.0918248489;5609.691466969325;5654.123610840316;5442.782288708457;5478.178273259013;5549.306336707911;5561.277033985576;5614.242077319561;4961.801527938878;4992.276119962603;5032.11937910866;5046.066477701618;5111.284420181178;5016.147254966646;5061.266116413118;5075.3909530856345;5123.743812809364;5126.333576635032;4872.4640289568115;4931.728754918478;4970.925436118443;4988;5001.224810154432;4888.584470320027;4945.208766597327;4978.153713868651;4978.278149668314;4996.975015124901;4895.461499235082;4924.3105965164905;4933.555979961785;4939.185034469308;4948.752562371867;5375;5464.808731694372;5496.148097044965;5499;5501.367342755554;5814.069748840166;5874.3244526879525;5897.380775018647;5951.226340575698;6012.428819262207;5944.4352786485215;5951.613145145595;5956.493698035672;5964.135200395962;5970.432808883149;5404.91892621611;5528.723563821793;5537.58468114889;5539.861503462445;5552.972235138839;5874.32445268791;5909.6158749681135;5910.822675319747;5928.9407105928385;5994.610350327215;5697.829065128053;5720.856978575485;5721.199032135504;5732.799352022659;5739.454751798572;5647.407022262685;5734.283214598176;5783.103618939072;5800.361960184377;5801.7389217485315;5644.435556444405;5744.109663002241;5746.109353050284;5762.164486149485;5820.970895145497;5833.854153646108;5835.387284335084;5867.354590994987;5876.059830427112;5892.941070589325;4448.332750087448;4511.052678937394;4517.983453722886;4522.570355816192;4568.908621827545;4039;4054.4526488924207;4058.2289365021143;4095.774732389747;4111.6299533042165;5575.944240557543;5643.181738647873;5643.774249030075;5664.801731939362;5665.971670141623;5771.845630873842;5861.1501332307425;5976.103584462366;5976.581639285208;5979.820605381846;5601.159826026047;5602.719864006784;5642.181883626851;5677.829665110054;5710;5080.5681517070725;5087.23691446286;5092.668976516515;5096.872578185501;5147.6654017488745;5877.382874798255;6014.398560143951;6151.2618485781995;6167.537434692416;6184.6598437085495;5842.883142337215;5900.232969713909;5903.645781253139;5924.200232968667;5936.495397891227;6081.300650425258;6122.081687746873;6128.50971922254;6140.662263575547;6147.44672979434;5637.49262566371;5744.798932037525;5800.477956983892;5806.506446952057;5844.649321040752;5733.541316694738;5777.04678728022;5779.797707080232;5819.127130930395;5883.735231914488;5653.038983372754;5654.46282603152;5665.773369065356;5667.659940403589;5669.801556945652;5564.582656300713;5615.747291371979;5624.550035997028;5663.688497132533;5671.829845104653;5610.887782244414;5640.85897852557;5747.339056008445;5760.855978600569;5798.5651076168615;5798.971005145116;5835.708214589338;5844.532437404912;5851.034579294369;5868.061110222515;5681.602287839812;5684.204211410489;5723.6851973141875;5727;5742.28221472316 03:46:53 INFO - PROCESS | 6518 | |1;ext.html;547.9296223267103;581.2385774635226;593.8634114153746;596.9283685957685;618.4897459595835;38249.80875095624;42903.570964290426;42922.14155716888;42996.57003429965;43166;42787.35818962718;43252;43364;43388.56611433885;43444.34833477493;8859.601317940693;8974.641014359418;8994.28045756338;8995.190432861042;9010.54947252638;8792.120787921189;8850.247728943048;8867.911320886773;8919.197272245498;8929.598168082419;8928.330375221853;8953;8970.775730606754;9003.774905627379;9029.729108126767;8891.555422228896;8909.777255568597;8937.687180948635;8946;8947.955260223689;8793.12068793122;8830.735077947671;8844.55777211137;8867.246284065863;8876.112388761137;41203;41356.79321603403;41412.171756565;41479.7926010371;41583.792081039704;3538.2569660371355;3549.07723991764;3594.658507441789;3615.7107431405425;4001.1197536541913;32368;32653.673463265302;32723.997033777967;33138.6686133138;33187.50218746721;4015.1768887378016;4043.777592232426;4089.1003979124544;4119.526254480743;4129.97935010326;376825;378791;379238;379869;380243;58668;59168.40831591715;59169;59227.26181905437;59313.703431482565;36978.26043479169;37767.24465510674;37889;39427.802860986085;39429;16713;16826.747598786027;16993.40523081711;16995.49013529596;16995.74506382405;12970.610881673565;13022.153560018569;13028.80456793149;13065.477380904656;13076.542321018718;19241.230350785812;19285.934685020984;19287.035648217814;19389.80610193908;19578.510537236398;7049.920273519324;7052.471064670171;7084.256153103953;7112.226231769614;7182.676779544933;924;969.9272554558436;1000.7998400319965;1027.8766548014287;1038.5378506564507;32988.3402331952;33065.71602608293;33283;33358.3328333432;33378;1081.3619964221148;1093.606301731376;1101.1081024370285;1142.4976156354533;1194.4863708605383;16497.17514124289;17060;17188.22652980619;17219;17370.39203627867;574567;579036;580176;582706;582877;59305.40694593085;59805;59819.401805982256;59828.102578460486;59999.10001349983;1299.6101169649257;1350.59482155353;1355.627202519315;1364.290568904184;1366.8906487480979;30625.387492250476;30984.69015309818;31485.702859428664;32326.83836580802;32767.50848737223;50700;51121.48878511167;51190;51462;51547.22679159741;453582;455822;456997;457061;458810;28908.132756017352;29259.97590084337;29487.852560737058;29617.703822962358;29683;48791.5120848787;49361;49647;49951.25073123979;50370.99258014746;40389.39415908705;41523.169536609705;42474.36288455738;43914.36269388551;45225.32162017506;42104.3684344729;42591;43085;43443.78278108715;43547.34678979754;35044.29911401706;39925.80037099796;40839.7958010208;41031.79484102561;42130;36020.63979360173;36795.26409471849;37208.953507557344;37863.43204851874;38452.615473846025;28486.57270140991;28802.855985719936;28912.42175156527;29124;29249.7075029247 03:46:53 INFO - PROCESS | 6518 | |2;jquery.html;390.5001597954619;390.6933057549826;406.7803386171467;408.81807595619944;421.81440166326814;18673.813261867377;20425;20448.284310049152;20502.179912803487;21184.78815211851;19397.515062123417;19777.40667779969;20201;20305.289314873982;20428.591428171465;5470.890582188354;5807.41925807418;5845.327787304472;5860.560457965648;5862.149988251701;5643.971780141093;5746.109353050284;5821.3305469870875;5822.097574875901;5845.444682755153;5693.402192769761;5741.368449470576;5746.770129194848;5748.568857335696;5756.683382413987;5606.859828504279;5756.539476841843;5769.971150144264;5780.682062486561;5799.710014499258;5204.42751297357;5222.712750798704;5243.737813109367;5247.658902171346;5254.264402983586;24088.51822963531;24303.270901872973;24477.87761061201;24588.385290367703;24995.87502062478;2369.076060336453;2409.3494756415844;2421.9394515137087;2511.485145545159;2969.836658983755;14675.559733208021;14939.402423903031;15158.696826063528;15602.141882196474;15642.296096675676;1893.3657224829699;1994.5312851479891;2025.0988310201967;2034.349008317339;2034.8473864460077;65764.3423565763;78178.99999999943;78289;81487.5925620374;82471.17528824756;9593.13661770444;10144.159635302127;10280.383177009404;10282.794344113076;11455.255408398427;13900.957428192723;13963.067755771403;13968.511102111377;14027.158370497802;14078.480379905024;7765.417593680497;7858.882116768253;7980.561069141137;8038.236367545074;8188.672453101928;7899.210078992055;8024.197580241929;8179.631916563769;8201.671933122609;8380.8742868857;4172.415861779354;4267.97866010668;4313.029568347097;4376.256036473807;4435.870782024646;2023.3929821053625;2031.674932010871;2076.781937896529;2095.9371218863457;2105.368389483149;929.7489677786959;932.8554074118523;967.6032826541084;990.782027953849;1001.5893483671659;19425.805741942684;20485.180592776123;20895.26866559663;20968.370948871558;20979.895100524398;960.490939801906;964.5659453246068;966.2318456826839;979.2753362511833;1015.2892974917587;11020.173486988508;11593.6521904343;11700.35648039349;11773.352465614302;11777.646670599896;169032;169537;171663;172703;360807;97476.51261743646;97960.51019744856;99279;99918.50040749896;103677.48161259296;984.5815528400544;997.1972562087444;1024.6004058417222;1032.442481060234;1036.290141253244;18041.368552100612;18121.63756724832;18747.43757687217;18834.340798072;18888.750405064857;39476;43927.560724392344;44122.558774411846;44190.77904610585;45378.31932521081;51058;57243;59329.406705932386;60157.09764353451;60387.09419358801;7814.492058016211;8008.479448835807;8262.17378262169;8267.421280510307;8546.188112129337;13223.669408264486;13571.660708482366;13788.517401890886;13837.30813459303;13843.723125537634;11666.70833229176;11989.880101199225;12021.09841761854;12046.51813927433;12090.214136081127;11872;11993.940030299793;12021.699457513632;12031.699207519881;12267.325297108388;12094.758104837678;12249.571265005681;12406.952852779552;12426;12528.624141275777;7834.216578342348;7938.206179382247;7971.80070498219;7994.080680721791;8176.67293308261;11114.444277785917;11915.106367022334;11946.163768536118;12268.938655307024;12401.75196496047 03:46:53 INFO - PROCESS | 6518 | |3;mootools.html;1447.4065633090431;1492.0749135535968;1604.679064187162;1745.982540174598;1766.8233176682334;8263;8863.601137948792;9001.324900632462;9610.855837162439;9641.325107242496;9011.18899299063;9401.623935042608;9410.81178376432;9422.246220302377;9425.57584908679;2412.529556736433;2459.987700061506;2460.458699086198;2465.174166654173;2470.3453584799954;2387.3072360616793;2421.370443684646;2431.756824317572;2438.426969662128;2442.255112190781;2427.890744916474;2447.1312683997103;2452.5708001099824;2459.5695753243112;2462.7660372264604;2312.7687231276823;2327.976720232801;2330.8135349172026;2332.125452955142;2349.4596242864236;2279.293419040103;2280.749117597063;2281.4638559938403;2297.1615360393334;2303.995523894206;9303.348765586412;9360.765980850534;9366.157045865904;9381.624735010591;9440.433573985514;5455.454454554552;5639.68981706006;5651.463111004448;5655.293088363955;5655.5475561954945;3493.1092571394133;3507.0530956641564;3530.5410296661526;3590.425531914881;3593.2094939113613;1227.5826219085554;1233.2908577567844;1235.2711899979056;1237.3998610673907;1238.1704258146974;13092.803607945889;13108.410121544553;13131.34343282832;13142.211467312087;13145.474181032747;4804.711717296974;4886.560209581084;4903.53416425439;4937.432195297515;5110.054639891632;10862.34825910448;10895.782084358269;10914.836277455845;10930.945345273381;10953.34279943206;5536.197251398525;5580.497755202051;5584.720763961785;5587.860303492445;5588.385277619459;4430.313301438282;4973.254011898244;4993.775280112403;5068.113080210948;5101.285819985205;4155.085881106213;4163.91672166555;4204.789760511962;4229.238737027303;4261.4673165854265;1349.4197495077015;1362.8023936529346;1365.9112157709717;1406.866347696967;1409.5278081842494;852.9402941794139;873.2053831013874;943.7687766497252;956.268454632207;988.4020167798523;6004.969975150184;6060.606060606046;6113.113598528189;6201.542637480188;6223.502119830403;485.3738677106564;487.51735781575985;488.66282265236873;496.1565338923844;499.6652242997201;4117.341225403921;4125.463689720317;4141.40555885986;4156.896077598084;4201.264778663722;11348.602798901999;11659.825102623297;11703.707407314885;11715.472803723853;11718.531258749554;11576.826347604792;11594.536218551331;11635.941820290844;11685.941570292263;11691.415429228504;8126.796830079177;8451.577421128919;8482.533460659723;8503.1921967413;8674.609642565974;6060.303065147388;6106.358832322542;6188.597741146811;6272.278687950944;6285.59143655661;10666.093382062301;10775.784484310114;10785.029347358775;10846.566137354734;10929.39888306119;10793.514291856729;10802.135829133493;10962;11004.284721493077;11017.889821102008;7173.461990350849;8090.433669643068;8118.147594502492;8212.425130240827;8313.085560588452;9084.636614535344;9162.129597688208;9169.679061233091;9169.954150229207;9172.954135229282;7870.134285228506;7978.242067003625;8042.638081286474;8112.797180070309;8213.671453141807;7982.640781164745;8006.559639219899;8027.59862006909;8048.758537243892;8156.510609363457;7405.296496832792;7466.36535894455;7471.813204669927;7485.513441626277;7582.203868593719;5188.4953363524155;5283.841484755463;5293.153095504701;5298.549623282064;5488.451154884639;5188.403333616682;5367.624266301322;5389.676619402849;5411.161270003156;5524.447555244604 03:46:53 INFO - PROCESS | 6518 | |4;prototype.html;344.2340791738381;345.4316906357328;345.80116433050995;351.56230493036173;353.8814497143457;5572.832815015546;5576.972115139423;5596.244506991555;5605.663660180392;5636.7181640918;5451.155070964007;5457.918131228025;5465.426130256325;5470.617056806025;5482.314710661168;4122.866211791758;4134.3178375567995;4218.198542276958;4296.656267498608;4297.634701050414;4258.893527661802;4262.936055959163;4273.414584176575;4274.957250427487;4292.077203401268;4218.957810421903;4247.384129301249;4261.78691065447;4263.040815816447;4286.699931004831;3989.6209860063245;4198.223328684173;4204.978975105105;4216.198922204802;4266.509351424595;3741.8129093545213;3745.6628903398823;3747.775133491999;3751.662350388478;3759.3984962406157;5386.461353864622;5417.756200970965;5436.836894893159;5438.8912221755345;5447.101228297326;4594.494605593382;4814.566688997972;4877.170880950247;4931.852044438672;4966.1557535218735;5701.429857014306;5717.48542631161;5726.971365143189;5764.933487304862;5788.160716696056;4046.1705350403095;4052.169305292408;4058.107216412414;4075.412113308041;4076.7757773322455;5873.353931067579;5958.285005799288;5994.550408719363;6023.126646636257;6041.456268935817;4224.957750422518;4227.577242275748;4263.232618128766;4265.658747300208;4266.274733295348;4290.377895205178;4313.654907607447;4314.935275970863;4319.97840010798;4320.913581728348;4676.602488788491;4843.467218606021;4873.488283730228;4902.2156454967035;4908.901821963541;5714.657120572779;5739.540836733051;5763.337216220189;5774.162746401748;5807.361190269067;1449.5506393018197;1457.846926072747;1460.4596299369302;1470.3971371737537;1473.9387640898535;917.5274733512247;923.9861402078974;924.945562059253;968.7674958010027;1013.9442330671884;5486.341639003345;5533.916991245134;5535.557155427556;5539.8892022160135;5595.608307418523;5847.415258474119;5864;5874.50066744323;5885.823425297248;5951;5267.683938963674;5369.5972802040005;5438.7280635968045;5438.75525601341;5568.7215639217875;3047.725704686589;3094.319249765048;3110.73558747509;3114.968850311513;3116.25209949615;5816.941830581724;5977.282726072812;6040.758369665252;6071.848203794852;6090.33006369299;6021.57848950578;6054.850528062474;6067.7876274331065;6076.665783381868;6091.329953705089;6115.205023346936;6115.938840611537;6183.628982261079;6196.938030619726;6197.808128813665;5670.943290567042;5848.9179501792305;5851.297844258546;5864.266966629171;5956.493698035542;5803.216565763737;5832.329282132439;5855.91665541859;5863.73613187399;5894.410558944071;5815.487973127102;6061.605995610271;6085.604435711664;6090.756369745161;6118.877622447615;4202.4536810215695;4230.984563704627;4259.446271984622;4296.785160741888;4305.354196870369;6024.638521688713;6038.184845045863;6059.697015149313;6069.36271691466;6071.846349193639;5543.833684989457;5588.916166257428;5681.857953551194;5793.94206057934;5796.59423840344;5745.712714364348;5751.166080918159;5777.8555536111935;5785.768569257351;5785.991284531936;5588.6646801192055;5654.943450565442;5688.033034384247;5808.912866307093;5812.360640329476;5784.7107644618445;5803.604891138732;5852.619579727304;5867.266591676041;5920.615160014585;5700.315962084576;5744.856378590569;5770.172615418499;5791.218185544897;5794.652320860761 03:46:53 INFO - PROCESS | 6518 | |5;yui.html;771.7337518556097;798.8162722573808;814.8248126652768;817.583032653347;832.7557183879592;15641.530754077381;16982.15089245539;17020.744688829676;17207.655846883055;17290.56773580661;14186.787198192036;14244.92877535611;14245.216513091777;14370.784438233435;14384.99305048647;798.409177208867;806.3871457692167;840.1598401598402;843.7763992541982;845.9154084591522;834.5743670727942;837.1461109668135;837.2130197614254;837.4975014990987;837.5853952293623;877.4779006491159;877.5743764274322;878.4685265414428;879.278991227194;879.7536689726886;864.1142828600734;870.4994628088874;873.0352959979195;877.2061284537504;878.3895192840978;627.8147946355836;628.4940622798646;628.4972022382076;629.8393909553081;631.0754744299577;15350.692986140326;15490.845091549052;15507.767383489258;15537.844621553753;15594.37622495099;14103;14267.215303158322;14538.636534086627;14644.707105857824;14717.632059198606;11932.224405413706;12293.3238671873;12345;12370;12440.129190956637;3873.6126387361037;3888.6889048876023;3895.1430685249484;3964.5837187095517;3998.8200530975887;79461;90596.54701726515;91304.54347728286;92514;95217.52391238068;11924.582639607572;11945.343006134746;12039.759204815855;12171.452284647212;12179.939100304442;21632.459188520414;21843.890780545997;21878.781212187994;21884.12463501474;21909.233176838734;8774.780630484289;8867.556622168866;9039.954800225956;9221.861672074925;9260.259179265777;4662.673612847068;4856.1016212000895;4865.270209468608;4868.513148685174;4871.902561948741;3690.501782259414;3736.1406876418578;3769.6041915599017;3793.260314238697;3801.9429708554394;616.3620652624602;622.9159063526366;627.3976982097238;645.6803882078401;646.3536463536464;637.7927173668576;693.6254422611734;699.0318409003567;731.8243621530794;733.7798660401965;9576.138147566613;9707.6116955321;9751.3661611995;9818.90181098194;9853.852192217122;603.8248907816771;676.972921083161;682.0928165539821;696.5959743348845;733.7872017115084;4440.578145076212;4497.572730590588;4501.437320334958;4682.461516925598;4709.740964246999;126333.36833315775;133488.33255833658;136523.31738341443;137102;140278.2986085063;107659;111627;113003.4349828262;113090;114011;59707.402925970186;84755;95617;96773.51613242029;98293.50853245688;8910.59902304385;8912.108789121296;8925.687600933936;8961.955190224267;8991.640334386551;55964.720176398856;56846.43153568577;57126.428735712114;57610.423895760505;58134.70932645479;52934;59751;65732;66167.33832661805;68109;13583.252921089435;13929.442822286996;14129.293535323399;14162.858371416154;14932;14485.710285794436;14550.272486375427;14814.25928703539;15036.248187590796;15056.924715376354;14384.856151438351;14950.401983920521;15682.76475852886;15808.130552819704;15820.841791581937;13059.151155174883;13392;14168.433262669378;14412.495562655256;14458.927705361406;11803.468843902217;12148.271103733805;13093.476260949456;14672.624248021852;15744.212789360716;10545.525451354553;10861.131109511378;11340.432978350884;11404.087672985976;12016.158868879094;11597.362145082101;11752.58865939688;11991.700207494883;12685.682857928256;12827.871721282667 03:46:53 INFO - PROCESS | 6518 | __end_tp_report 03:46:53 INFO - PROCESS | 6518 | __start_cc_report 03:46:53 INFO - PROCESS | 6518 | _x_x_mozilla_cycle_collect,331 03:46:53 INFO - PROCESS | 6518 | __end_cc_report 03:46:53 INFO - PROCESS | 6518 | __startTimestamp1472554013747__endTimestamp 03:46:53 INFO - PROCESS | 6518 | 03:46:53 INFO - PROCESS | 6518 | ------- Summary: start ------- 03:46:53 INFO - PROCESS | 6518 | Number of tests: 6 03:46:53 INFO - PROCESS | 6518 | 03:46:53 INFO - PROCESS | 6518 | [#0] dojo.html Cycles:165 Average:5458.14 Median:5664.80 stddev:614.89 (10.9%) stddev-sans-first:588.72 03:46:53 INFO - PROCESS | 6518 | Values: 3117.2 3134.9 3137.7 3176.3 3189.5 5415.1 5468.8 5504.1 5609.7 5654.1 5442.8 5478.2 5549.3 5561.3 5614.2 4961.8 4992.3 5032.1 5046.1 5111.3 5016.1 5061.3 5075.4 5123.7 5126.3 4872.5 4931.7 4970.9 4988.0 5001.2 4888.6 4945.2 4978.2 4978.3 4997.0 4895.5 4924.3 4933.6 4939.2 4948.8 5375.0 5464.8 5496.1 5499.0 5501.4 5814.1 5874.3 5897.4 5951.2 6012.4 5944.4 5951.6 5956.5 5964.1 5970.4 5404.9 5528.7 5537.6 5539.9 5553.0 5874.3 5909.6 5910.8 5928.9 5994.6 5697.8 5720.9 5721.2 5732.8 5739.5 5647.4 5734.3 5783.1 5800.4 5801.7 5644.4 5744.1 5746.1 5762.2 5821.0 5833.9 5835.4 5867.4 5876.1 5892.9 4448.3 4511.1 4518.0 4522.6 4568.9 4039.0 4054.5 4058.2 4095.8 4111.6 5575.9 5643.2 5643.8 5664.8 5666.0 5771.8 5861.2 5976.1 5976.6 5979.8 5601.2 5602.7 5642.2 5677.8 5710.0 5080.6 5087.2 5092.7 5096.9 5147.7 5877.4 6014.4 6151.3 6167.5 6184.7 5842.9 5900.2 5903.6 5924.2 5936.5 6081.3 6122.1 6128.5 6140.7 6147.4 5637.5 5744.8 5800.5 5806.5 5844.6 5733.5 5777.0 5779.8 5819.1 5883.7 5653.0 5654.5 5665.8 5667.7 5669.8 5564.6 5615.7 5624.6 5663.7 5671.8 5610.9 5640.9 5747.3 5760.9 5798.6 5799.0 5835.7 5844.5 5851.0 5868.1 5681.6 5684.2 5723.7 5727.0 5742.3 03:46:53 INFO - PROCESS | 6518 | 03:46:53 INFO - PROCESS | 6518 | [#1] ext.html Cycles:180 Average:62459.34 Median:41384.48 stddev:127274.90 (307.5%) stddev-sans-first:127547.05 03:46:53 INFO - PROCESS | 6518 | Values: 547.9 581.2 593.9 596.9 618.5 38249.8 42903.6 42922.1 42996.6 43166.0 42787.4 43252.0 43364.0 43388.6 43444.3 8859.6 8974.6 8994.3 8995.2 9010.5 8792.1 8850.2 8867.9 8919.2 8929.6 8928.3 8953.0 8970.8 9003.8 9029.7 8891.6 8909.8 8937.7 8946.0 8948.0 8793.1 8830.7 8844.6 8867.2 8876.1 41203.0 41356.8 41412.2 41479.8 41583.8 3538.3 3549.1 3594.7 3615.7 4001.1 32368.0 32653.7 32724.0 33138.7 33187.5 4015.2 4043.8 4089.1 4119.5 4130.0 376825.0 378791.0 379238.0 379869.0 380243.0 58668.0 59168.4 59169.0 59227.3 59313.7 36978.3 37767.2 37889.0 39427.8 39429.0 16713.0 16826.7 16993.4 16995.5 16995.7 12970.6 13022.2 13028.8 13065.5 13076.5 19241.2 19285.9 19287.0 19389.8 19578.5 7049.9 7052.5 7084.3 7112.2 7182.7 924.0 969.9 1000.8 1027.9 1038.5 32988.3 33065.7 33283.0 33358.3 33378.0 1081.4 1093.6 1101.1 1142.5 1194.5 16497.2 17060.0 17188.2 17219.0 17370.4 574567.0 579036.0 580176.0 582706.0 582877.0 59305.4 59805.0 59819.4 59828.1 59999.1 1299.6 1350.6 1355.6 1364.3 1366.9 30625.4 30984.7 31485.7 32326.8 32767.5 50700.0 51121.5 51190.0 51462.0 51547.2 453582.0 455822.0 456997.0 457061.0 458810.0 28908.1 29260.0 29487.9 29617.7 29683.0 48791.5 49361.0 49647.0 49951.3 50371.0 40389.4 41523.2 42474.4 43914.4 45225.3 42104.4 42591.0 43085.0 43443.8 43547.3 35044.3 39925.8 40839.8 41031.8 42130.0 36020.6 36795.3 37209.0 37863.4 38452.6 28486.6 28802.9 28912.4 29124.0 29249.7 03:46:53 INFO - PROCESS | 6518 | 03:46:53 INFO - PROCESS | 6518 | [#2] jquery.html Cycles:180 Average:21621.62 Median:24792.13 stddev:40168.22 (162.0%) stddev-sans-first:40249.27 03:46:53 INFO - PROCESS | 6518 | Values: 390.5 390.7 406.8 408.8 421.8 18673.8 20425.0 20448.3 20502.2 21184.8 19397.5 19777.4 20201.0 20305.3 20428.6 5470.9 5807.4 5845.3 5860.6 5862.1 5644.0 5746.1 5821.3 5822.1 5845.4 5693.4 5741.4 5746.8 5748.6 5756.7 5606.9 5756.5 5770.0 5780.7 5799.7 5204.4 5222.7 5243.7 5247.7 5254.3 24088.5 24303.3 24477.9 24588.4 24995.9 2369.1 2409.3 2421.9 2511.5 2969.8 14675.6 14939.4 15158.7 15602.1 15642.3 1893.4 1994.5 2025.1 2034.3 2034.8 65764.3 78179.0 78289.0 81487.6 82471.2 9593.1 10144.2 10280.4 10282.8 11455.3 13901.0 13963.1 13968.5 14027.2 14078.5 7765.4 7858.9 7980.6 8038.2 8188.7 7899.2 8024.2 8179.6 8201.7 8380.9 4172.4 4268.0 4313.0 4376.3 4435.9 2023.4 2031.7 2076.8 2095.9 2105.4 929.7 932.9 967.6 990.8 1001.6 19425.8 20485.2 20895.3 20968.4 20979.9 960.5 964.6 966.2 979.3 1015.3 11020.2 11593.7 11700.4 11773.4 11777.6 169032.0 169537.0 171663.0 172703.0 360807.0 97476.5 97960.5 99279.0 99918.5 103677.5 984.6 997.2 1024.6 1032.4 1036.3 18041.4 18121.6 18747.4 18834.3 18888.8 39476.0 43927.6 44122.6 44190.8 45378.3 51058.0 57243.0 59329.4 60157.1 60387.1 7814.5 8008.5 8262.2 8267.4 8546.2 13223.7 13571.7 13788.5 13837.3 13843.7 11666.7 11989.9 12021.1 12046.5 12090.2 11872.0 11993.9 12021.7 12031.7 12267.3 12094.8 12249.6 12407.0 12426.0 12528.6 7834.2 7938.2 7971.8 7994.1 8176.7 11114.4 11915.1 11946.2 12268.9 12401.8 03:46:53 INFO - PROCESS | 6518 | 03:46:53 INFO - PROCESS | 6518 | [#3] mootools.html Cycles:180 Average:6095.82 Median:4895.05 stddev:3542.15 (72.4%) stddev-sans-first:3534.86 03:46:53 INFO - PROCESS | 6518 | Values: 1447.4 1492.1 1604.7 1746.0 1766.8 8263.0 8863.6 9001.3 9610.9 9641.3 9011.2 9401.6 9410.8 9422.2 9425.6 2412.5 2460.0 2460.5 2465.2 2470.3 2387.3 2421.4 2431.8 2438.4 2442.3 2427.9 2447.1 2452.6 2459.6 2462.8 2312.8 2328.0 2330.8 2332.1 2349.5 2279.3 2280.7 2281.5 2297.2 2304.0 9303.3 9360.8 9366.2 9381.6 9440.4 5455.5 5639.7 5651.5 5655.3 5655.5 3493.1 3507.1 3530.5 3590.4 3593.2 1227.6 1233.3 1235.3 1237.4 1238.2 13092.8 13108.4 13131.3 13142.2 13145.5 4804.7 4886.6 4903.5 4937.4 5110.1 10862.3 10895.8 10914.8 10930.9 10953.3 5536.2 5580.5 5584.7 5587.9 5588.4 4430.3 4973.3 4993.8 5068.1 5101.3 4155.1 4163.9 4204.8 4229.2 4261.5 1349.4 1362.8 1365.9 1406.9 1409.5 852.9 873.2 943.8 956.3 988.4 6005.0 6060.6 6113.1 6201.5 6223.5 485.4 487.5 488.7 496.2 499.7 4117.3 4125.5 4141.4 4156.9 4201.3 11348.6 11659.8 11703.7 11715.5 11718.5 11576.8 11594.5 11635.9 11685.9 11691.4 8126.8 8451.6 8482.5 8503.2 8674.6 6060.3 6106.4 6188.6 6272.3 6285.6 10666.1 10775.8 10785.0 10846.6 10929.4 10793.5 10802.1 10962.0 11004.3 11017.9 7173.5 8090.4 8118.1 8212.4 8313.1 9084.6 9162.1 9169.7 9170.0 9173.0 7870.1 7978.2 8042.6 8112.8 8213.7 7982.6 8006.6 8027.6 8048.8 8156.5 7405.3 7466.4 7471.8 7485.5 7582.2 5188.5 5283.8 5293.2 5298.5 5488.5 5188.4 5367.6 5389.7 5411.2 5524.4 03:46:53 INFO - PROCESS | 6518 | 03:46:53 INFO - PROCESS | 6518 | [#4] prototype.html Cycles:180 Average:4851.55 Median:5570.78 stddev:1437.60 (25.8%) stddev-sans-first:1401.26 03:46:53 INFO - PROCESS | 6518 | Values: 344.2 345.4 345.8 351.6 353.9 5572.8 5577.0 5596.2 5605.7 5636.7 5451.2 5457.9 5465.4 5470.6 5482.3 4122.9 4134.3 4218.2 4296.7 4297.6 4258.9 4262.9 4273.4 4275.0 4292.1 4219.0 4247.4 4261.8 4263.0 4286.7 3989.6 4198.2 4205.0 4216.2 4266.5 3741.8 3745.7 3747.8 3751.7 3759.4 5386.5 5417.8 5436.8 5438.9 5447.1 4594.5 4814.6 4877.2 4931.9 4966.2 5701.4 5717.5 5727.0 5764.9 5788.2 4046.2 4052.2 4058.1 4075.4 4076.8 5873.4 5958.3 5994.6 6023.1 6041.5 4225.0 4227.6 4263.2 4265.7 4266.3 4290.4 4313.7 4314.9 4320.0 4320.9 4676.6 4843.5 4873.5 4902.2 4908.9 5714.7 5739.5 5763.3 5774.2 5807.4 1449.6 1457.8 1460.5 1470.4 1473.9 917.5 924.0 924.9 968.8 1013.9 5486.3 5533.9 5535.6 5539.9 5595.6 5847.4 5864.0 5874.5 5885.8 5951.0 5267.7 5369.6 5438.7 5438.8 5568.7 3047.7 3094.3 3110.7 3115.0 3116.3 5816.9 5977.3 6040.8 6071.8 6090.3 6021.6 6054.9 6067.8 6076.7 6091.3 6115.2 6115.9 6183.6 6196.9 6197.8 5670.9 5848.9 5851.3 5864.3 5956.5 5803.2 5832.3 5855.9 5863.7 5894.4 5815.5 6061.6 6085.6 6090.8 6118.9 4202.5 4231.0 4259.4 4296.8 4305.4 6024.6 6038.2 6059.7 6069.4 6071.8 5543.8 5588.9 5681.9 5793.9 5796.6 5745.7 5751.2 5777.9 5785.8 5786.0 5588.7 5654.9 5688.0 5808.9 5812.4 5784.7 5803.6 5852.6 5867.3 5920.6 5700.3 5744.9 5770.2 5791.2 5794.7 03:46:53 INFO - PROCESS | 6518 | 03:46:53 INFO - PROCESS | 6518 | [#5] yui.html Cycles:180 Average:22141.11 Median:4469.08 stddev:33213.06 (743.2%) stddev-sans-first:33267.47 03:46:53 INFO - PROCESS | 6518 | Values: 771.7 798.8 814.8 817.6 832.8 15641.5 16982.2 17020.7 17207.7 17290.6 14186.8 14244.9 14245.2 14370.8 14385.0 798.4 806.4 840.2 843.8 845.9 834.6 837.1 837.2 837.5 837.6 877.5 877.6 878.5 879.3 879.8 864.1 870.5 873.0 877.2 878.4 627.8 628.5 628.5 629.8 631.1 15350.7 15490.8 15507.8 15537.8 15594.4 14103.0 14267.2 14538.6 14644.7 14717.6 11932.2 12293.3 12345.0 12370.0 12440.1 3873.6 3888.7 3895.1 3964.6 3998.8 79461.0 90596.5 91304.5 92514.0 95217.5 11924.6 11945.3 12039.8 12171.5 12179.9 21632.5 21843.9 21878.8 21884.1 21909.2 8774.8 8867.6 9040.0 9221.9 9260.3 4662.7 4856.1 4865.3 4868.5 4871.9 3690.5 3736.1 3769.6 3793.3 3801.9 616.4 622.9 627.4 645.7 646.4 637.8 693.6 699.0 731.8 733.8 9576.1 9707.6 9751.4 9818.9 9853.9 603.8 677.0 682.1 696.6 733.8 4440.6 4497.6 4501.4 4682.5 4709.7 126333.4 133488.3 136523.3 137102.0 140278.3 107659.0 111627.0 113003.4 113090.0 114011.0 59707.4 84755.0 95617.0 96773.5 98293.5 8910.6 8912.1 8925.7 8962.0 8991.6 55964.7 56846.4 57126.4 57610.4 58134.7 52934.0 59751.0 65732.0 66167.3 68109.0 13583.3 13929.4 14129.3 14162.9 14932.0 14485.7 14550.3 14814.3 15036.2 15056.9 14384.9 14950.4 15682.8 15808.1 15820.8 13059.2 13392.0 14168.4 14412.5 14458.9 11803.5 12148.3 13093.5 14672.6 15744.2 10545.5 10861.1 11340.4 11404.1 12016.2 11597.4 11752.6 11991.7 12685.7 12827.9 03:46:53 INFO - PROCESS | 6518 | -------- Summary: end -------- 03:46:53 INFO - PROCESS | 6518 | 03:46:54 INFO - TEST-INFO | 6518: exit 0 03:46:54 INFO - TEST-OK | dromaeo_css | took 1114344ms 03:46:54 INFO - TEST-START | kraken 03:46:54 INFO - operating with platform_type : linux_ 03:46:54 INFO - Initialising browser for kraken test... 03:46:54 INFO - TEST-INFO | started process 6874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjggF8g/profile http://localhost:49117/getInfo.html) 03:46:59 INFO - PROCESS | 6874 | __metrics Screen width/height:1600/1200 03:46:59 INFO - PROCESS | 6874 | colorDepth:24 03:46:59 INFO - PROCESS | 6874 | Browser inner width/height: 1024/697 03:46:59 INFO - PROCESS | 6874 | __metrics 03:46:59 ERROR - PROCESS | 6874 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 03:47:00 INFO - TEST-INFO | 6874: exit 0 03:47:00 INFO - Browser initialized. 03:47:00 INFO - Running cycle 1/1 for kraken test... 03:47:00 INFO - TEST-INFO | started process 6996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjggF8g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:12 INFO - PROCESS | 6996 | RSS: Main: 191750144 03:47:12 INFO - PROCESS | 6996 | 03:47:15 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49117/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:16 INFO - PROCESS | 6996 | RSS: Main: 204492800 03:47:16 INFO - PROCESS | 6996 | 03:47:19 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49117/tests/kraken/driver.html?testName=audio-dft) 03:47:19 INFO - PROCESS | 6996 | RSS: Main: 204095488 03:47:19 INFO - PROCESS | 6996 | 03:47:22 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49117/tests/kraken/driver.html?testName=audio-fft) 03:47:23 INFO - PROCESS | 6996 | RSS: Main: 194555904 03:47:23 INFO - PROCESS | 6996 | 03:47:25 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49117/tests/kraken/driver.html?testName=audio-oscillator) 03:47:25 INFO - PROCESS | 6996 | RSS: Main: 195235840 03:47:25 INFO - PROCESS | 6996 | 03:47:28 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:28 INFO - PROCESS | 6996 | RSS: Main: 195178496 03:47:28 INFO - PROCESS | 6996 | 03:47:31 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49117/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:32 INFO - PROCESS | 6996 | RSS: Main: 196055040 03:47:32 INFO - PROCESS | 6996 | 03:47:35 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49117/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:36 INFO - PROCESS | 6996 | RSS: Main: 192184320 03:47:36 INFO - PROCESS | 6996 | 03:47:39 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49117/tests/kraken/driver.html?testName=json-parse-financial) 03:47:40 INFO - PROCESS | 6996 | RSS: Main: 194191360 03:47:40 INFO - PROCESS | 6996 | 03:47:41 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:42 INFO - PROCESS | 6996 | RSS: Main: 194105344 03:47:42 INFO - PROCESS | 6996 | 03:47:44 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49117/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:44 INFO - PROCESS | 6996 | RSS: Main: 194195456 03:47:44 INFO - PROCESS | 6996 | 03:47:46 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:47 INFO - PROCESS | 6996 | RSS: Main: 195514368 03:47:47 INFO - PROCESS | 6996 | 03:47:50 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:50 INFO - PROCESS | 6996 | RSS: Main: 194564096 03:47:50 INFO - PROCESS | 6996 | 03:47:53 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:54 INFO - PROCESS | 6996 | RSS: Main: 194998272 03:47:54 INFO - PROCESS | 6996 | 03:47:55 INFO - PROCESS | 6996 | Cycle 1(1): loaded http://localhost:49117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49117/tests/kraken/driver.html?testName=ai-astar) 03:47:56 INFO - PROCESS | 6996 | RSS: Main: 196882432 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | __start_tp_report 03:47:56 INFO - PROCESS | 6996 | _x_x_mozilla_page_load 03:47:56 INFO - PROCESS | 6996 | _x_x_mozilla_page_load_details 03:47:56 INFO - PROCESS | 6996 | |i|pagename|runs| 03:47:56 INFO - PROCESS | 6996 | |0;ai-astar;107;113;114;112;113;113;113;115;113;129 03:47:56 INFO - PROCESS | 6996 | |1;audio-beat-detection;146;118;165;184;125;152;149;118;180;122 03:47:56 INFO - PROCESS | 6996 | |2;audio-dft;164;164;164;168;169;163;167;164;162;163 03:47:56 INFO - PROCESS | 6996 | |3;audio-fft;75;76;77;179;80;76;76;75;158;78 03:47:56 INFO - PROCESS | 6996 | |4;audio-oscillator;81;82;147;83;82;83;135;84;84;156 03:47:56 INFO - PROCESS | 6996 | |5;imaging-gaussian-blur;118;119;117;117;118;118;117;118;118;117 03:47:56 INFO - PROCESS | 6996 | |6;imaging-darkroom;148;146;147;147;148;148;149;147;146;149 03:47:56 INFO - PROCESS | 6996 | |7;imaging-desaturate;102;96;95;96;96;96;96;96;96;95 03:47:56 INFO - PROCESS | 6996 | |8;json-parse-financial;53;53;54;54;53;52;54;54;52;59 03:47:56 INFO - PROCESS | 6996 | |9;json-stringify-tinderbox;61;62;71;63;63;62;63;62;62;63 03:47:56 INFO - PROCESS | 6996 | |10;stanford-crypto-aes;82;81;80;79;81;87;80;79;84;80 03:47:56 INFO - PROCESS | 6996 | |11;stanford-crypto-ccm;134;136;129;131;138;141;128;130;165;129 03:47:56 INFO - PROCESS | 6996 | |12;stanford-crypto-pbkdf2;168;168;163;163;164;171;169;163;167;161 03:47:56 INFO - PROCESS | 6996 | |13;stanford-crypto-sha256-iterative;67;67;66;66;65;66;65;67;67;65 03:47:56 INFO - PROCESS | 6996 | __end_tp_report 03:47:56 INFO - PROCESS | 6996 | __start_cc_report 03:47:56 INFO - PROCESS | 6996 | _x_x_mozilla_cycle_collect,794 03:47:56 INFO - PROCESS | 6996 | __end_cc_report 03:47:56 INFO - PROCESS | 6996 | __startTimestamp1472554076148__endTimestamp 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | ------- Summary: start ------- 03:47:56 INFO - PROCESS | 6996 | Number of tests: 14 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#0] ai-astar Cycles:10 Average:114.20 Median:113.00 stddev:5.61 (5.0%) stddev-sans-first:5.32 03:47:56 INFO - PROCESS | 6996 | Values: 107.0 113.0 114.0 112.0 113.0 113.0 113.0 115.0 113.0 129.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:150.50 stddev:24.92 (16.6%) stddev-sans-first:26.44 03:47:56 INFO - PROCESS | 6996 | Values: 146.0 118.0 165.0 184.0 125.0 152.0 149.0 118.0 180.0 122.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:2.35 (1.4%) stddev-sans-first:2.47 03:47:56 INFO - PROCESS | 6996 | Values: 164.0 164.0 164.0 168.0 169.0 163.0 167.0 164.0 162.0 163.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#3] audio-fft Cycles:10 Average:95.00 Median:76.00 stddev:39.08 (51.4%) stddev-sans-first:40.78 03:47:56 INFO - PROCESS | 6996 | Values: 75.0 76.0 77.0 179.0 80.0 76.0 76.0 75.0 158.0 78.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:82.50 stddev:30.98 (37.6%) stddev-sans-first:31.95 03:47:56 INFO - PROCESS | 6996 | Values: 81.0 82.0 147.0 83.0 82.0 83.0 135.0 84.0 84.0 156.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:47:56 INFO - PROCESS | 6996 | Values: 118.0 119.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 03:47:56 INFO - PROCESS | 6996 | Values: 148.0 146.0 147.0 147.0 148.0 148.0 149.0 147.0 146.0 149.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:2.01 (2.1%) stddev-sans-first:0.44 03:47:56 INFO - PROCESS | 6996 | Values: 102.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.99 (3.7%) stddev-sans-first:2.09 03:47:56 INFO - PROCESS | 6996 | Values: 53.0 53.0 54.0 54.0 53.0 52.0 54.0 54.0 52.0 59.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:2.82 (4.5%) stddev-sans-first:2.88 03:47:56 INFO - PROCESS | 6996 | Values: 61.0 62.0 71.0 63.0 63.0 62.0 63.0 62.0 62.0 63.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.00 stddev:2.50 (3.1%) stddev-sans-first:2.64 03:47:56 INFO - PROCESS | 6996 | Values: 82.0 81.0 80.0 79.0 81.0 87.0 80.0 79.0 84.0 80.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:135.00 stddev:11.04 (8.2%) stddev-sans-first:11.68 03:47:56 INFO - PROCESS | 6996 | Values: 134.0 136.0 129.0 131.0 138.0 141.0 128.0 130.0 165.0 129.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:167.50 stddev:3.30 (2.0%) stddev-sans-first:3.40 03:47:56 INFO - PROCESS | 6996 | Values: 168.0 168.0 163.0 163.0 164.0 171.0 169.0 163.0 167.0 161.0 03:47:56 INFO - PROCESS | 6996 | 03:47:56 INFO - PROCESS | 6996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:0.88 (1.3%) stddev-sans-first:0.87 03:47:56 INFO - PROCESS | 6996 | Values: 67.0 67.0 66.0 66.0 65.0 66.0 65.0 67.0 67.0 65.0 03:47:56 INFO - PROCESS | 6996 | -------- Summary: end -------- 03:47:56 INFO - PROCESS | 6996 | 03:47:57 INFO - TEST-INFO | 6996: exit 0 03:47:57 INFO - TEST-OK | kraken | took 62562ms 03:47:57 INFO - SUITE-END | took 1176s 03:47:57 INFO - Completed test suite (00:19:36) 03:47:57 INFO - javascript benchmark 03:47:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7392.217307512521, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.158367240845, 3134.890278840241, 3137.6548579656246, 3176.317091825257, 3189.5056266278734, 5415.0523658359825, 5468.7539060742265, 5504.0918248489, 5609.691466969325, 5654.123610840316, 5442.782288708457, 5478.178273259013, 5549.306336707911, 5561.277033985576, 5614.242077319561, 4961.801527938878, 4992.276119962603, 5032.11937910866, 5046.066477701618, 5111.284420181178, 5016.147254966646, 5061.266116413118, 5075.3909530856345, 5123.743812809364, 5126.333576635032, 4872.4640289568115, 4931.728754918478, 4970.925436118443, 4988.0, 5001.224810154432, 4888.584470320027, 4945.208766597327, 4978.153713868651, 4978.278149668314, 4996.975015124901, 4895.461499235082, 4924.3105965164905, 4933.555979961785, 4939.185034469308, 4948.752562371867, 5375.0, 5464.808731694372, 5496.148097044965, 5499.0, 5501.367342755554, 5814.069748840166, 5874.3244526879525, 5897.380775018647, 5951.226340575698, 6012.428819262207, 5944.4352786485215, 5951.613145145595, 5956.493698035672, 5964.135200395962, 5970.432808883149, 5404.91892621611, 5528.723563821793, 5537.58468114889, 5539.861503462445, 5552.972235138839, 5874.32445268791, 5909.6158749681135, 5910.822675319747, 5928.9407105928385, 5994.610350327215, 5697.829065128053, 5720.856978575485, 5721.199032135504, 5732.799352022659, 5739.454751798572, 5647.407022262685, 5734.283214598176, 5783.103618939072, 5800.361960184377, 5801.7389217485315, 5644.435556444405, 5744.109663002241, 5746.109353050284, 5762.164486149485, 5820.970895145497, 5833.854153646108, 5835.387284335084, 5867.354590994987, 5876.059830427112, 5892.941070589325, 4448.332750087448, 4511.052678937394, 4517.983453722886, 4522.570355816192, 4568.908621827545, 4039.0, 4054.4526488924207, 4058.2289365021143, 4095.774732389747, 4111.6299533042165, 5575.944240557543, 5643.181738647873, 5643.774249030075, 5664.801731939362, 5665.971670141623, 5771.845630873842, 5861.1501332307425, 5976.103584462366, 5976.581639285208, 5979.820605381846, 5601.159826026047, 5602.719864006784, 5642.181883626851, 5677.829665110054, 5710.0, 5080.5681517070725, 5087.23691446286, 5092.668976516515, 5096.872578185501, 5147.6654017488745, 5877.382874798255, 6014.398560143951, 6151.2618485781995, 6167.537434692416, 6184.6598437085495, 5842.883142337215, 5900.232969713909, 5903.645781253139, 5924.200232968667, 5936.495397891227, 6081.300650425258, 6122.081687746873, 6128.50971922254, 6140.662263575547, 6147.44672979434, 5637.49262566371, 5744.798932037525, 5800.477956983892, 5806.506446952057, 5844.649321040752, 5733.541316694738, 5777.04678728022, 5779.797707080232, 5819.127130930395, 5883.735231914488, 5653.038983372754, 5654.46282603152, 5665.773369065356, 5667.659940403589, 5669.801556945652, 5564.582656300713, 5615.747291371979, 5624.550035997028, 5663.688497132533, 5671.829845104653, 5610.887782244414, 5640.85897852557, 5747.339056008445, 5760.855978600569, 5798.5651076168615, 5798.971005145116, 5835.708214589338, 5844.532437404912, 5851.034579294369, 5868.061110222515, 5681.602287839812, 5684.204211410489, 5723.6851973141875, 5727.0, 5742.28221472316], "value": 5416.700819964512, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.9296223267103, 581.2385774635226, 593.8634114153746, 596.9283685957685, 618.4897459595835, 38249.80875095624, 42903.570964290426, 42922.14155716888, 42996.57003429965, 43166.0, 42787.35818962718, 43252.0, 43364.0, 43388.56611433885, 43444.34833477493, 8859.601317940693, 8974.641014359418, 8994.28045756338, 8995.190432861042, 9010.54947252638, 8792.120787921189, 8850.247728943048, 8867.911320886773, 8919.197272245498, 8929.598168082419, 8928.330375221853, 8953.0, 8970.775730606754, 9003.774905627379, 9029.729108126767, 8891.555422228896, 8909.777255568597, 8937.687180948635, 8946.0, 8947.955260223689, 8793.12068793122, 8830.735077947671, 8844.55777211137, 8867.246284065863, 8876.112388761137, 41203.0, 41356.79321603403, 41412.171756565, 41479.7926010371, 41583.792081039704, 3538.2569660371355, 3549.07723991764, 3594.658507441789, 3615.7107431405425, 4001.1197536541913, 32368.0, 32653.673463265302, 32723.997033777967, 33138.6686133138, 33187.50218746721, 4015.1768887378016, 4043.777592232426, 4089.1003979124544, 4119.526254480743, 4129.97935010326, 376825.0, 378791.0, 379238.0, 379869.0, 380243.0, 58668.0, 59168.40831591715, 59169.0, 59227.26181905437, 59313.703431482565, 36978.26043479169, 37767.24465510674, 37889.0, 39427.802860986085, 39429.0, 16713.0, 16826.747598786027, 16993.40523081711, 16995.49013529596, 16995.74506382405, 12970.610881673565, 13022.153560018569, 13028.80456793149, 13065.477380904656, 13076.542321018718, 19241.230350785812, 19285.934685020984, 19287.035648217814, 19389.80610193908, 19578.510537236398, 7049.920273519324, 7052.471064670171, 7084.256153103953, 7112.226231769614, 7182.676779544933, 924.0, 969.9272554558436, 1000.7998400319965, 1027.8766548014287, 1038.5378506564507, 32988.3402331952, 33065.71602608293, 33283.0, 33358.3328333432, 33378.0, 1081.3619964221148, 1093.606301731376, 1101.1081024370285, 1142.4976156354533, 1194.4863708605383, 16497.17514124289, 17060.0, 17188.22652980619, 17219.0, 17370.39203627867, 574567.0, 579036.0, 580176.0, 582706.0, 582877.0, 59305.40694593085, 59805.0, 59819.401805982256, 59828.102578460486, 59999.10001349983, 1299.6101169649257, 1350.59482155353, 1355.627202519315, 1364.290568904184, 1366.8906487480979, 30625.387492250476, 30984.69015309818, 31485.702859428664, 32326.83836580802, 32767.50848737223, 50700.0, 51121.48878511167, 51190.0, 51462.0, 51547.22679159741, 453582.0, 455822.0, 456997.0, 457061.0, 458810.0, 28908.132756017352, 29259.97590084337, 29487.852560737058, 29617.703822962358, 29683.0, 48791.5120848787, 49361.0, 49647.0, 49951.25073123979, 50370.99258014746, 40389.39415908705, 41523.169536609705, 42474.36288455738, 43914.36269388551, 45225.32162017506, 42104.3684344729, 42591.0, 43085.0, 43443.78278108715, 43547.34678979754, 35044.29911401706, 39925.80037099796, 40839.7958010208, 41031.79484102561, 42130.0, 36020.63979360173, 36795.26409471849, 37208.953507557344, 37863.43204851874, 38452.615473846025, 28486.57270140991, 28802.855985719936, 28912.42175156527, 29124.0, 29249.7075029247], "value": 20082.579113894084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.5001597954619, 390.6933057549826, 406.7803386171467, 408.81807595619944, 421.81440166326814, 18673.813261867377, 20425.0, 20448.284310049152, 20502.179912803487, 21184.78815211851, 19397.515062123417, 19777.40667779969, 20201.0, 20305.289314873982, 20428.591428171465, 5470.890582188354, 5807.41925807418, 5845.327787304472, 5860.560457965648, 5862.149988251701, 5643.971780141093, 5746.109353050284, 5821.3305469870875, 5822.097574875901, 5845.444682755153, 5693.402192769761, 5741.368449470576, 5746.770129194848, 5748.568857335696, 5756.683382413987, 5606.859828504279, 5756.539476841843, 5769.971150144264, 5780.682062486561, 5799.710014499258, 5204.42751297357, 5222.712750798704, 5243.737813109367, 5247.658902171346, 5254.264402983586, 24088.51822963531, 24303.270901872973, 24477.87761061201, 24588.385290367703, 24995.87502062478, 2369.076060336453, 2409.3494756415844, 2421.9394515137087, 2511.485145545159, 2969.836658983755, 14675.559733208021, 14939.402423903031, 15158.696826063528, 15602.141882196474, 15642.296096675676, 1893.3657224829699, 1994.5312851479891, 2025.0988310201967, 2034.349008317339, 2034.8473864460077, 65764.3423565763, 78178.99999999943, 78289.0, 81487.5925620374, 82471.17528824756, 9593.13661770444, 10144.159635302127, 10280.383177009404, 10282.794344113076, 11455.255408398427, 13900.957428192723, 13963.067755771403, 13968.511102111377, 14027.158370497802, 14078.480379905024, 7765.417593680497, 7858.882116768253, 7980.561069141137, 8038.236367545074, 8188.672453101928, 7899.210078992055, 8024.197580241929, 8179.631916563769, 8201.671933122609, 8380.8742868857, 4172.415861779354, 4267.97866010668, 4313.029568347097, 4376.256036473807, 4435.870782024646, 2023.3929821053625, 2031.674932010871, 2076.781937896529, 2095.9371218863457, 2105.368389483149, 929.7489677786959, 932.8554074118523, 967.6032826541084, 990.782027953849, 1001.5893483671659, 19425.805741942684, 20485.180592776123, 20895.26866559663, 20968.370948871558, 20979.895100524398, 960.490939801906, 964.5659453246068, 966.2318456826839, 979.2753362511833, 1015.2892974917587, 11020.173486988508, 11593.6521904343, 11700.35648039349, 11773.352465614302, 11777.646670599896, 169032.0, 169537.0, 171663.0, 172703.0, 360807.0, 97476.51261743646, 97960.51019744856, 99279.0, 99918.50040749896, 103677.48161259296, 984.5815528400544, 997.1972562087444, 1024.6004058417222, 1032.442481060234, 1036.290141253244, 18041.368552100612, 18121.63756724832, 18747.43757687217, 18834.340798072, 18888.750405064857, 39476.0, 43927.560724392344, 44122.558774411846, 44190.77904610585, 45378.31932521081, 51058.0, 57243.0, 59329.406705932386, 60157.09764353451, 60387.09419358801, 7814.492058016211, 8008.479448835807, 8262.17378262169, 8267.421280510307, 8546.188112129337, 13223.669408264486, 13571.660708482366, 13788.517401890886, 13837.30813459303, 13843.723125537634, 11666.70833229176, 11989.880101199225, 12021.09841761854, 12046.51813927433, 12090.214136081127, 11872.0, 11993.940030299793, 12021.699457513632, 12031.699207519881, 12267.325297108388, 12094.758104837678, 12249.571265005681, 12406.952852779552, 12426.0, 12528.624141275777, 7834.216578342348, 7938.206179382247, 7971.80070498219, 7994.080680721791, 8176.67293308261, 11114.444277785917, 11915.106367022334, 11946.163768536118, 12268.938655307024, 12401.75196496047], "value": 9190.03510705911, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.4065633090431, 1492.0749135535968, 1604.679064187162, 1745.982540174598, 1766.8233176682334, 8263.0, 8863.601137948792, 9001.324900632462, 9610.855837162439, 9641.325107242496, 9011.18899299063, 9401.623935042608, 9410.81178376432, 9422.246220302377, 9425.57584908679, 2412.529556736433, 2459.987700061506, 2460.458699086198, 2465.174166654173, 2470.3453584799954, 2387.3072360616793, 2421.370443684646, 2431.756824317572, 2438.426969662128, 2442.255112190781, 2427.890744916474, 2447.1312683997103, 2452.5708001099824, 2459.5695753243112, 2462.7660372264604, 2312.7687231276823, 2327.976720232801, 2330.8135349172026, 2332.125452955142, 2349.4596242864236, 2279.293419040103, 2280.749117597063, 2281.4638559938403, 2297.1615360393334, 2303.995523894206, 9303.348765586412, 9360.765980850534, 9366.157045865904, 9381.624735010591, 9440.433573985514, 5455.454454554552, 5639.68981706006, 5651.463111004448, 5655.293088363955, 5655.5475561954945, 3493.1092571394133, 3507.0530956641564, 3530.5410296661526, 3590.425531914881, 3593.2094939113613, 1227.5826219085554, 1233.2908577567844, 1235.2711899979056, 1237.3998610673907, 1238.1704258146974, 13092.803607945889, 13108.410121544553, 13131.34343282832, 13142.211467312087, 13145.474181032747, 4804.711717296974, 4886.560209581084, 4903.53416425439, 4937.432195297515, 5110.054639891632, 10862.34825910448, 10895.782084358269, 10914.836277455845, 10930.945345273381, 10953.34279943206, 5536.197251398525, 5580.497755202051, 5584.720763961785, 5587.860303492445, 5588.385277619459, 4430.313301438282, 4973.254011898244, 4993.775280112403, 5068.113080210948, 5101.285819985205, 4155.085881106213, 4163.91672166555, 4204.789760511962, 4229.238737027303, 4261.4673165854265, 1349.4197495077015, 1362.8023936529346, 1365.9112157709717, 1406.866347696967, 1409.5278081842494, 852.9402941794139, 873.2053831013874, 943.7687766497252, 956.268454632207, 988.4020167798523, 6004.969975150184, 6060.606060606046, 6113.113598528189, 6201.542637480188, 6223.502119830403, 485.3738677106564, 487.51735781575985, 488.66282265236873, 496.1565338923844, 499.6652242997201, 4117.341225403921, 4125.463689720317, 4141.40555885986, 4156.896077598084, 4201.264778663722, 11348.602798901999, 11659.825102623297, 11703.707407314885, 11715.472803723853, 11718.531258749554, 11576.826347604792, 11594.536218551331, 11635.941820290844, 11685.941570292263, 11691.415429228504, 8126.796830079177, 8451.577421128919, 8482.533460659723, 8503.1921967413, 8674.609642565974, 6060.303065147388, 6106.358832322542, 6188.597741146811, 6272.278687950944, 6285.59143655661, 10666.093382062301, 10775.784484310114, 10785.029347358775, 10846.566137354734, 10929.39888306119, 10793.514291856729, 10802.135829133493, 10962.0, 11004.284721493077, 11017.889821102008, 7173.461990350849, 8090.433669643068, 8118.147594502492, 8212.425130240827, 8313.085560588452, 9084.636614535344, 9162.129597688208, 9169.679061233091, 9169.954150229207, 9172.954135229282, 7870.134285228506, 7978.242067003625, 8042.638081286474, 8112.797180070309, 8213.671453141807, 7982.640781164745, 8006.559639219899, 8027.59862006909, 8048.758537243892, 8156.510609363457, 7405.296496832792, 7466.36535894455, 7471.813204669927, 7485.513441626277, 7582.203868593719, 5188.4953363524155, 5283.841484755463, 5293.153095504701, 5298.549623282064, 5488.451154884639, 5188.403333616682, 5367.624266301322, 5389.676619402849, 5411.161270003156, 5524.447555244604], "value": 4769.410643828412, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.2340791738381, 345.4316906357328, 345.80116433050995, 351.56230493036173, 353.8814497143457, 5572.832815015546, 5576.972115139423, 5596.244506991555, 5605.663660180392, 5636.7181640918, 5451.155070964007, 5457.918131228025, 5465.426130256325, 5470.617056806025, 5482.314710661168, 4122.866211791758, 4134.3178375567995, 4218.198542276958, 4296.656267498608, 4297.634701050414, 4258.893527661802, 4262.936055959163, 4273.414584176575, 4274.957250427487, 4292.077203401268, 4218.957810421903, 4247.384129301249, 4261.78691065447, 4263.040815816447, 4286.699931004831, 3989.6209860063245, 4198.223328684173, 4204.978975105105, 4216.198922204802, 4266.509351424595, 3741.8129093545213, 3745.6628903398823, 3747.775133491999, 3751.662350388478, 3759.3984962406157, 5386.461353864622, 5417.756200970965, 5436.836894893159, 5438.8912221755345, 5447.101228297326, 4594.494605593382, 4814.566688997972, 4877.170880950247, 4931.852044438672, 4966.1557535218735, 5701.429857014306, 5717.48542631161, 5726.971365143189, 5764.933487304862, 5788.160716696056, 4046.1705350403095, 4052.169305292408, 4058.107216412414, 4075.412113308041, 4076.7757773322455, 5873.353931067579, 5958.285005799288, 5994.550408719363, 6023.126646636257, 6041.456268935817, 4224.957750422518, 4227.577242275748, 4263.232618128766, 4265.658747300208, 4266.274733295348, 4290.377895205178, 4313.654907607447, 4314.935275970863, 4319.97840010798, 4320.913581728348, 4676.602488788491, 4843.467218606021, 4873.488283730228, 4902.2156454967035, 4908.901821963541, 5714.657120572779, 5739.540836733051, 5763.337216220189, 5774.162746401748, 5807.361190269067, 1449.5506393018197, 1457.846926072747, 1460.4596299369302, 1470.3971371737537, 1473.9387640898535, 917.5274733512247, 923.9861402078974, 924.945562059253, 968.7674958010027, 1013.9442330671884, 5486.341639003345, 5533.916991245134, 5535.557155427556, 5539.8892022160135, 5595.608307418523, 5847.415258474119, 5864.0, 5874.50066744323, 5885.823425297248, 5951.0, 5267.683938963674, 5369.5972802040005, 5438.7280635968045, 5438.75525601341, 5568.7215639217875, 3047.725704686589, 3094.319249765048, 3110.73558747509, 3114.968850311513, 3116.25209949615, 5816.941830581724, 5977.282726072812, 6040.758369665252, 6071.848203794852, 6090.33006369299, 6021.57848950578, 6054.850528062474, 6067.7876274331065, 6076.665783381868, 6091.329953705089, 6115.205023346936, 6115.938840611537, 6183.628982261079, 6196.938030619726, 6197.808128813665, 5670.943290567042, 5848.9179501792305, 5851.297844258546, 5864.266966629171, 5956.493698035542, 5803.216565763737, 5832.329282132439, 5855.91665541859, 5863.73613187399, 5894.410558944071, 5815.487973127102, 6061.605995610271, 6085.604435711664, 6090.756369745161, 6118.877622447615, 4202.4536810215695, 4230.984563704627, 4259.446271984622, 4296.785160741888, 4305.354196870369, 6024.638521688713, 6038.184845045863, 6059.697015149313, 6069.36271691466, 6071.846349193639, 5543.833684989457, 5588.916166257428, 5681.857953551194, 5793.94206057934, 5796.59423840344, 5745.712714364348, 5751.166080918159, 5777.8555536111935, 5785.768569257351, 5785.991284531936, 5588.6646801192055, 5654.943450565442, 5688.033034384247, 5808.912866307093, 5812.360640329476, 5784.7107644618445, 5803.604891138732, 5852.619579727304, 5867.266591676041, 5920.615160014585, 5700.315962084576, 5744.856378590569, 5770.172615418499, 5791.218185544897, 5794.652320860761], "value": 4391.753907218024, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.7337518556097, 798.8162722573808, 814.8248126652768, 817.583032653347, 832.7557183879592, 15641.530754077381, 16982.15089245539, 17020.744688829676, 17207.655846883055, 17290.56773580661, 14186.787198192036, 14244.92877535611, 14245.216513091777, 14370.784438233435, 14384.99305048647, 798.409177208867, 806.3871457692167, 840.1598401598402, 843.7763992541982, 845.9154084591522, 834.5743670727942, 837.1461109668135, 837.2130197614254, 837.4975014990987, 837.5853952293623, 877.4779006491159, 877.5743764274322, 878.4685265414428, 879.278991227194, 879.7536689726886, 864.1142828600734, 870.4994628088874, 873.0352959979195, 877.2061284537504, 878.3895192840978, 627.8147946355836, 628.4940622798646, 628.4972022382076, 629.8393909553081, 631.0754744299577, 15350.692986140326, 15490.845091549052, 15507.767383489258, 15537.844621553753, 15594.37622495099, 14103.0, 14267.215303158322, 14538.636534086627, 14644.707105857824, 14717.632059198606, 11932.224405413706, 12293.3238671873, 12345.0, 12370.0, 12440.129190956637, 3873.6126387361037, 3888.6889048876023, 3895.1430685249484, 3964.5837187095517, 3998.8200530975887, 79461.0, 90596.54701726515, 91304.54347728286, 92514.0, 95217.52391238068, 11924.582639607572, 11945.343006134746, 12039.759204815855, 12171.452284647212, 12179.939100304442, 21632.459188520414, 21843.890780545997, 21878.781212187994, 21884.12463501474, 21909.233176838734, 8774.780630484289, 8867.556622168866, 9039.954800225956, 9221.861672074925, 9260.259179265777, 4662.673612847068, 4856.1016212000895, 4865.270209468608, 4868.513148685174, 4871.902561948741, 3690.501782259414, 3736.1406876418578, 3769.6041915599017, 3793.260314238697, 3801.9429708554394, 616.3620652624602, 622.9159063526366, 627.3976982097238, 645.6803882078401, 646.3536463536464, 637.7927173668576, 693.6254422611734, 699.0318409003567, 731.8243621530794, 733.7798660401965, 9576.138147566613, 9707.6116955321, 9751.3661611995, 9818.90181098194, 9853.852192217122, 603.8248907816771, 676.972921083161, 682.0928165539821, 696.5959743348845, 733.7872017115084, 4440.578145076212, 4497.572730590588, 4501.437320334958, 4682.461516925598, 4709.740964246999, 126333.36833315775, 133488.33255833658, 136523.31738341443, 137102.0, 140278.2986085063, 107659.0, 111627.0, 113003.4349828262, 113090.0, 114011.0, 59707.402925970186, 84755.0, 95617.0, 96773.51613242029, 98293.50853245688, 8910.59902304385, 8912.108789121296, 8925.687600933936, 8961.955190224267, 8991.640334386551, 55964.720176398856, 56846.43153568577, 57126.428735712114, 57610.423895760505, 58134.70932645479, 52934.0, 59751.0, 65732.0, 66167.33832661805, 68109.0, 13583.252921089435, 13929.442822286996, 14129.293535323399, 14162.858371416154, 14932.0, 14485.710285794436, 14550.272486375427, 14814.25928703539, 15036.248187590796, 15056.924715376354, 14384.856151438351, 14950.401983920521, 15682.76475852886, 15808.130552819704, 15820.841791581937, 13059.151155174883, 13392.0, 14168.433262669378, 14412.495562655256, 14458.927705361406, 11803.468843902217, 12148.271103733805, 13093.476260949456, 14672.624248021852, 15744.212789360716, 10545.525451354553, 10861.131109511378, 11340.432978350884, 11404.087672985976, 12016.158868879094, 11597.362145082101, 11752.58865939688, 11991.700207494883, 12685.682857928256, 12827.871721282667], "value": 7791.694221814234, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 115.0, 113.0, 129.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 165.0, 184.0, 125.0, 152.0, 149.0, 118.0, 180.0, 122.0], "value": 145.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 168.0, 169.0, 163.0, 167.0, 164.0, 162.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 179.0, 80.0, 76.0, 76.0, 75.0, 158.0, 78.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 147.0, 83.0, 82.0, 83.0, 135.0, 84.0, 84.0, 156.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 148.0, 148.0, 149.0, 147.0, 146.0, 149.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 53.0, 52.0, 54.0, 54.0, 52.0, 59.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 71.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 80.0, 79.0, 81.0, 87.0, 80.0, 79.0, 84.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 129.0, 131.0, 138.0, 141.0, 128.0, 130.0, 165.0, 129.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 163.0, 163.0, 164.0, 171.0, 169.0, 163.0, 167.0, 161.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 65.0, 66.0, 65.0, 67.0, 67.0, 65.0], "value": 66.1, "unit": "score"}]}]} 03:47:57 INFO - Return code: 0 03:47:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:47:57 ERROR - # TBPL SUCCESS # 03:47:57 INFO - Running post-action listener: _resource_record_post_action 03:47:57 INFO - [mozharness: 2016-08-30 10:47:57.447839Z] Finished run-tests step (success) 03:47:57 INFO - Running post-run listener: _resource_record_post_run 03:47:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 407683072; Read time: 0; Write time: 334908 03:47:57 INFO - TinderboxPrint: CPU usage
13.3% 03:47:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:47:57 INFO - TinderboxPrint: I/O write bytes / time
407,683,072 / 334,908 03:47:57 INFO - TinderboxPrint: CPU idle
8,249.8 (86.6%) 03:47:57 INFO - TinderboxPrint: CPU user
1,210.5 (12.7%) 03:47:57 INFO - TinderboxPrint: Swap in / out
0 / 0 03:47:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117485568; Read time: 0; Write time: 88004 03:47:57 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289267712; Read time: 0; Write time: 246880 03:47:58 INFO - Running post-run listener: _upload_blobber_files 03:47:58 INFO - Blob upload gear active. 03:47:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:58 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 03:47:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:47:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:47:58 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:05 INFO - (blobuploader) - INFO - Done attempting. 03:48:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:48:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:05 INFO - (blobuploader) - INFO - Done attempting. 03:48:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:48:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:48:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:06 INFO - (blobuploader) - INFO - Done attempting. 03:48:06 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:06 INFO - Return code: 0 03:48:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2bdcff783c2de8f03542673aed22b64bb098527a4b4531633a5bad82cc2f73c5ee5c68837f29526d694feb1c60ecf6a07825a31573ce437c31cac3850f8c11d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9c5ffddd3cfa479d4dfa4cb8877ae95f087f8008a955e645142ee32c61afeaa3bb64b325cc3afbcc37be4ae9f49949b4aa8b29da8fe9a07ed4226cb1db882ff3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0bd94dbb8004adb008b18921b84b18e6f5861fe992477b9b056eeb5f410c1288fe50ccd950bb711769780e7037173ff289d050360c8fca42b9109b26b7722fb8"} 03:48:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:06 INFO - Contents: 03:48:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2bdcff783c2de8f03542673aed22b64bb098527a4b4531633a5bad82cc2f73c5ee5c68837f29526d694feb1c60ecf6a07825a31573ce437c31cac3850f8c11d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9c5ffddd3cfa479d4dfa4cb8877ae95f087f8008a955e645142ee32c61afeaa3bb64b325cc3afbcc37be4ae9f49949b4aa8b29da8fe9a07ed4226cb1db882ff3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0bd94dbb8004adb008b18921b84b18e6f5861fe992477b9b056eeb5f410c1288fe50ccd950bb711769780e7037173ff289d050360c8fca42b9109b26b7722fb8"} 03:48:06 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:06 INFO - Copying logs to upload dir... 03:48:06 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.633676 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-30 03:48:06.005192) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 03:48:06.008489) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2bdcff783c2de8f03542673aed22b64bb098527a4b4531633a5bad82cc2f73c5ee5c68837f29526d694feb1c60ecf6a07825a31573ce437c31cac3850f8c11d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9c5ffddd3cfa479d4dfa4cb8877ae95f087f8008a955e645142ee32c61afeaa3bb64b325cc3afbcc37be4ae9f49949b4aa8b29da8fe9a07ed4226cb1db882ff3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0bd94dbb8004adb008b18921b84b18e6f5861fe992477b9b056eeb5f410c1288fe50ccd950bb711769780e7037173ff289d050360c8fca42b9109b26b7722fb8"} build_url:https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/ZxghHGCiS5OFL9ha_Xe4yA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d2bdcff783c2de8f03542673aed22b64bb098527a4b4531633a5bad82cc2f73c5ee5c68837f29526d694feb1c60ecf6a07825a31573ce437c31cac3850f8c11d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9c5ffddd3cfa479d4dfa4cb8877ae95f087f8008a955e645142ee32c61afeaa3bb64b325cc3afbcc37be4ae9f49949b4aa8b29da8fe9a07ed4226cb1db882ff3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0bd94dbb8004adb008b18921b84b18e6f5861fe992477b9b056eeb5f410c1288fe50ccd950bb711769780e7037173ff289d050360c8fca42b9109b26b7722fb8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 03:48:06.033406) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:48:06.033714) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1472551996.414751-1740594635 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 03:48:06.116620) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 03:48:06.116912) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 03:48:06.117216) ========= ========= Total master_lag: 0.18 =========