builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1469217206.73 results: success (0) buildid: 20160722063002 builduid: 57f36f248c89412dbafd6cf2b9c5a6a1 revision: a31e5c25c77773e26017df7ed4bc8355cd80c2af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:26.732961) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:26.733426) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:26.733702) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:26.748946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:26.749339) ========= 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=db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 12:53:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.5M=0s 2016-07-22 12:53:27 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074543 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:26.837581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:26.837898) ========= 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=db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017171 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:26.887020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:26.887376) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a31e5c25c77773e26017df7ed4bc8355cd80c2af --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 a31e5c25c77773e26017df7ed4bc8355cd80c2af --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=db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 12:53:27,359 truncating revision to first 12 chars 2016-07-22 12:53:27,359 Setting DEBUG logging. 2016-07-22 12:53:27,360 attempt 1/10 2016-07-22 12:53:27,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a31e5c25c777?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 12:53:27,739 unpacking tar archive at: autoland-a31e5c25c777/testing/mozharness/ program finished with exit code 0 elapsedTime=0.757110 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:27.657868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:27.658183) ========= script_repo_revision: a31e5c25c77773e26017df7ed4bc8355cd80c2af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:27.658567) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:27.658828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:27.667549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-22 12:53:27.667842) ========= /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=db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:53:28 INFO - MultiFileLogger online at 20160722 12:53:28 in /builds/slave/test 12:53:28 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 12:53:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:53:28 INFO - {'append_to_log': False, 12:53:28 INFO - 'base_work_dir': '/builds/slave/test', 12:53:28 INFO - 'blob_upload_branch': 'Autoland', 12:53:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:53:28 INFO - 'branch': 'Autoland', 12:53:28 INFO - 'buildbot_json_path': 'buildprops.json', 12:53:28 INFO - 'config_files': ('talos/linux_config.py',), 12:53:28 INFO - 'default_actions': ('clobber', 12:53:28 INFO - 'read-buildbot-config', 12:53:28 INFO - 'download-and-extract', 12:53:28 INFO - 'populate-webroot', 12:53:28 INFO - 'create-virtualenv', 12:53:28 INFO - 'install', 12:53:28 INFO - 'run-tests'), 12:53:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:53:28 INFO - 'download_minidump_stackwalk': True, 12:53:28 INFO - 'download_symbols': 'ondemand', 12:53:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:53:28 INFO - 'tooltool.py': '/tools/tooltool.py', 12:53:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:53:28 INFO - '/tools/misc-python/virtualenv.py')}, 12:53:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:53:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:53:28 INFO - 'installer_path': 'installer.exe', 12:53:28 INFO - 'log_level': 'info', 12:53:28 INFO - 'log_name': 'talos', 12:53:28 INFO - 'log_to_console': True, 12:53:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:53:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:53:28 INFO - 'opt_config_files': (), 12:53:28 INFO - 'pip_index': False, 12:53:28 INFO - 'sps_profile': False, 12:53:28 INFO - 'sps_profile_interval': 0, 12:53:28 INFO - 'suite': 'dromaeojs-e10s', 12:53:28 INFO - 'system_bits': '32', 12:53:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:53:28 INFO - 'title': 'talos-linux64-ix-049', 12:53:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:53:28 INFO - 'use_talos_json': True, 12:53:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:53:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:53:28 INFO - 'work_dir': 'build'} 12:53:28 INFO - [mozharness: 2016-07-22 19:53:28.230402Z] Running clobber step. 12:53:28 INFO - Running pre-action listener: _resource_record_pre_action 12:53:28 INFO - Running main action method: clobber 12:53:28 INFO - rmtree: /builds/slave/test/build 12:53:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:53:28 INFO - Running post-action listener: _resource_record_post_action 12:53:28 INFO - [mozharness: 2016-07-22 19:53:28.704033Z] Finished clobber step (success) 12:53:28 INFO - [mozharness: 2016-07-22 19:53:28.704133Z] Running read-buildbot-config step. 12:53:28 INFO - Running pre-action listener: _resource_record_pre_action 12:53:28 INFO - Running main action method: read_buildbot_config 12:53:28 INFO - Using buildbot properties: 12:53:28 INFO - { 12:53:28 INFO - "project": "", 12:53:28 INFO - "product": "firefox", 12:53:28 INFO - "script_repo_revision": "production", 12:53:28 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 12:53:28 INFO - "repository": "", 12:53:28 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 12:53:28 INFO - "buildid": "20160722063002", 12:53:28 INFO - "pgo_build": "True", 12:53:28 INFO - "basedir": "/builds/slave/test", 12:53:28 INFO - "buildnumber": 50, 12:53:28 INFO - "slavename": "talos-linux64-ix-049", 12:53:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:53:28 INFO - "platform": "ubuntu64_hw", 12:53:28 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 12:53:28 INFO - "branch": "autoland", 12:53:28 INFO - "repo_path": "integration/autoland", 12:53:28 INFO - "revision": "a31e5c25c77773e26017df7ed4bc8355cd80c2af", 12:53:28 INFO - "stage_platform": "linux64-pgo", 12:53:28 INFO - "builduid": "57f36f248c89412dbafd6cf2b9c5a6a1", 12:53:28 INFO - "slavebuilddir": "test" 12:53:28 INFO - } 12:53:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:53:28 INFO - Running post-action listener: _resource_record_post_action 12:53:28 INFO - [mozharness: 2016-07-22 19:53:28.706530Z] Finished read-buildbot-config step (success) 12:53:28 INFO - [mozharness: 2016-07-22 19:53:28.706618Z] Running download-and-extract step. 12:53:28 INFO - Running pre-action listener: _resource_record_pre_action 12:53:28 INFO - Running main action method: download_and_extract 12:53:28 INFO - mkdir: /builds/slave/test/build/tests 12:53:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:28 INFO - https://queue.taskcluster.net/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:53:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:53:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:53:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:53:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:53:29 INFO - Downloaded 1361 bytes. 12:53:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:53:29 INFO - Using the following test package requirements: 12:53:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:53:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:53:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:53:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:29 INFO - u'jsshell-linux-x86_64.zip'], 12:53:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:53:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:53:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:53:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:53:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:53:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:53:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:29 INFO - https://queue.taskcluster.net/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:53:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:53:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:53:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:53:30 INFO - Downloaded 24308714 bytes. 12:53:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:53:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:53:31 INFO - Return code: 0 12:53:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:31 INFO - https://queue.taskcluster.net/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:53:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:53:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:53:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:53:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:53:32 INFO - Downloaded 24308714 bytes. 12:53:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:53:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:53:34 INFO - Return code: 0 12:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:34 INFO - https://queue.taskcluster.net/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:53:35 INFO - Downloaded 14403289 bytes. 12:53:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:53:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:53:35 INFO - Return code: 0 12:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:35 INFO - https://queue.taskcluster.net/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:53:36 INFO - Downloaded 60857663 bytes. 12:53:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:53:36 INFO - mkdir: /builds/slave/test/properties 12:53:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:53:36 INFO - Writing to file /builds/slave/test/properties/build_url 12:53:36 INFO - Contents: 12:53:36 INFO - build_url:https://queue.taskcluster.net/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:53:37 INFO - Running post-action listener: _resource_record_post_action 12:53:37 INFO - Running post-action listener: set_extra_try_arguments 12:53:37 INFO - [mozharness: 2016-07-22 19:53:37.390901Z] Finished download-and-extract step (success) 12:53:37 INFO - [mozharness: 2016-07-22 19:53:37.391131Z] Running populate-webroot step. 12:53:37 INFO - Running pre-action listener: _resource_record_pre_action 12:53:37 INFO - Running main action method: populate_webroot 12:53:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:53:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:53:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:53:37 INFO - '--tppagecycles', 12:53:37 INFO - '7'], 12:53:37 INFO - 'tests': ['tsvgm']}}, 12:53:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:53:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:53:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:53:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:53:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['damp', 'tps']}, 12:53:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'tests': ['damp', 'tps']}, 12:53:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['dromaeo_dom']}, 12:53:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:53:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['basic_compositor_video']}, 12:53:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:53:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'other-e10s': {'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['a11yr', 12:53:37 INFO - 'ts_paint', 12:53:37 INFO - 'tpaint', 12:53:37 INFO - 'sessionrestore', 12:53:37 INFO - 'sessionrestore_no_auto_restore', 12:53:37 INFO - 'tabpaint']}, 12:53:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['tsvgx', 12:53:37 INFO - 'tsvgr_opacity', 12:53:37 INFO - 'tart', 12:53:37 INFO - 'tscrollx', 12:53:37 INFO - 'cart']}, 12:53:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:53:37 INFO - 'tsvgr_opacity', 12:53:37 INFO - 'tart', 12:53:37 INFO - 'tscrollx', 12:53:37 INFO - 'cart']}, 12:53:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'talos_options': ['--disable-e10s'], 12:53:37 INFO - 'tests': ['tp5o']}, 12:53:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'tests': ['tp5o']}, 12:53:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'talos_options': ['--disable-e10s', 12:53:37 INFO - '--xperf_path', 12:53:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:37 INFO - 'tests': ['tp5n']}, 12:53:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:37 INFO - 'talos_options': ['--xperf_path', 12:53:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:37 INFO - 'tests': ['tp5n']}}, 12:53:37 INFO - 'talos.zip': {'path': '', 12:53:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:53:37 INFO - Running post-action listener: _resource_record_post_action 12:53:37 INFO - [mozharness: 2016-07-22 19:53:37.407200Z] Finished populate-webroot step (success) 12:53:37 INFO - [mozharness: 2016-07-22 19:53:37.407288Z] Running create-virtualenv step. 12:53:37 INFO - Running pre-action listener: _resource_record_pre_action 12:53:37 INFO - Running main action method: create_virtualenv 12:53:37 INFO - Creating virtualenv /builds/slave/test/build/venv 12:53:37 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 12:53:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:53:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:53:37 INFO - Using real prefix '/usr' 12:53:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:53:38 INFO - Installing distribute.............................................................................................................................................................................................done. 12:53:40 INFO - Installing pip.................done. 12:53:40 INFO - Return code: 0 12:53:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:40 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 0x1010030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf3b0>, '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 0x12d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', '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 12:53:40 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 12:53:40 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 12:53:40 INFO - Using env: {'DISPLAY': ':0', 12:53:40 INFO - 'HOME': '/home/cltbld', 12:53:40 INFO - 'LANG': 'en_US.UTF-8', 12:53:40 INFO - 'LANGUAGE': 'en_US:en', 12:53:40 INFO - 'LOGNAME': 'cltbld', 12:53:40 INFO - 'MAIL': '/var/mail/cltbld', 12:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:40 INFO - 'MOZ_NO_REMOTE': '1', 12:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:40 INFO - 'NO_EM_RESTART': '1', 12:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:40 INFO - 'PWD': '/builds/slave/test', 12:53:40 INFO - 'SHELL': '/bin/bash', 12:53:40 INFO - 'SHLVL': '1', 12:53:40 INFO - 'TERM': 'linux', 12:53:40 INFO - 'TMOUT': '86400', 12:53:40 INFO - 'USER': 'cltbld', 12:53:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', 12:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:40 INFO - '_': '/tools/buildbot/bin/python'} 12:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:40 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 12:53:40 INFO - Cleaning up... 12:53:40 INFO - Return code: 0 12:53:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:40 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 0x1010030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf3b0>, '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 0x12d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', '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 12:53:40 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 12:53:40 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 12:53:40 INFO - Using env: {'DISPLAY': ':0', 12:53:40 INFO - 'HOME': '/home/cltbld', 12:53:40 INFO - 'LANG': 'en_US.UTF-8', 12:53:40 INFO - 'LANGUAGE': 'en_US:en', 12:53:40 INFO - 'LOGNAME': 'cltbld', 12:53:40 INFO - 'MAIL': '/var/mail/cltbld', 12:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:40 INFO - 'MOZ_NO_REMOTE': '1', 12:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:40 INFO - 'NO_EM_RESTART': '1', 12:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:40 INFO - 'PWD': '/builds/slave/test', 12:53:40 INFO - 'SHELL': '/bin/bash', 12:53:40 INFO - 'SHLVL': '1', 12:53:40 INFO - 'TERM': 'linux', 12:53:40 INFO - 'TMOUT': '86400', 12:53:40 INFO - 'USER': 'cltbld', 12:53:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', 12:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:40 INFO - '_': '/tools/buildbot/bin/python'} 12:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:40 INFO - Downloading/unpacking psutil>=3.1.1 12:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:53:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:42 INFO - Installing collected packages: psutil 12:53:42 INFO - Running setup.py install for psutil 12:53:42 INFO - building 'psutil._psutil_linux' extension 12:53:42 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 12:53:42 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 12:53:42 INFO - building 'psutil._psutil_posix' extension 12:53:42 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 12:53:42 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 12:53:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:42 INFO - Successfully installed psutil 12:53:42 INFO - Cleaning up... 12:53:43 INFO - Return code: 0 12:53:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf3b0>, '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 0x12d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', '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 12:53: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:53: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 mozsystemmonitor==0.3 12:53:43 INFO - Using env: {'DISPLAY': ':0', 12:53:43 INFO - 'HOME': '/home/cltbld', 12:53:43 INFO - 'LANG': 'en_US.UTF-8', 12:53:43 INFO - 'LANGUAGE': 'en_US:en', 12:53:43 INFO - 'LOGNAME': 'cltbld', 12:53:43 INFO - 'MAIL': '/var/mail/cltbld', 12:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:43 INFO - 'MOZ_NO_REMOTE': '1', 12:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:43 INFO - 'NO_EM_RESTART': '1', 12:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:43 INFO - 'PWD': '/builds/slave/test', 12:53:43 INFO - 'SHELL': '/bin/bash', 12:53:43 INFO - 'SHLVL': '1', 12:53:43 INFO - 'TERM': 'linux', 12:53:43 INFO - 'TMOUT': '86400', 12:53:43 INFO - 'USER': 'cltbld', 12:53:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', 12:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:43 INFO - '_': '/tools/buildbot/bin/python'} 12:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:53:43 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 12:53:43 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 12:53:43 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 12:53:43 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 12:53:43 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 12:53:43 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 12:53:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:53:45 INFO - Installing collected packages: mozsystemmonitor 12:53:45 INFO - Running setup.py install for mozsystemmonitor 12:53:45 INFO - Successfully installed mozsystemmonitor 12:53:45 INFO - Cleaning up... 12:53:45 INFO - Return code: 0 12:53:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:45 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 0x1010030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf3b0>, '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 0x12d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', '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 12:53:45 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 12:53:45 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 12:53:45 INFO - Using env: {'DISPLAY': ':0', 12:53:45 INFO - 'HOME': '/home/cltbld', 12:53:45 INFO - 'LANG': 'en_US.UTF-8', 12:53:45 INFO - 'LANGUAGE': 'en_US:en', 12:53:45 INFO - 'LOGNAME': 'cltbld', 12:53:45 INFO - 'MAIL': '/var/mail/cltbld', 12:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:45 INFO - 'MOZ_NO_REMOTE': '1', 12:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:45 INFO - 'NO_EM_RESTART': '1', 12:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:45 INFO - 'PWD': '/builds/slave/test', 12:53:45 INFO - 'SHELL': '/bin/bash', 12:53:45 INFO - 'SHLVL': '1', 12:53:45 INFO - 'TERM': 'linux', 12:53:45 INFO - 'TMOUT': '86400', 12:53:45 INFO - 'USER': 'cltbld', 12:53:45 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', 12:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:45 INFO - '_': '/tools/buildbot/bin/python'} 12:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:45 INFO - Downloading/unpacking jsonschema==2.5.1 12:53:45 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 12:53:45 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 12:53:45 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 12:53:45 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 12:53:45 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 12:53:45 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 12:53:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:53:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:47 INFO - Downloading functools32-3.2.3-2.tar.gz 12:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:53:47 INFO - warning: no files found matching '*.txt' 12:53:47 INFO - no previously-included directories found matching 'build' 12:53:47 INFO - no previously-included directories found matching 'dist' 12:53:47 INFO - no previously-included directories found matching '.git*' 12:53:47 INFO - Installing collected packages: jsonschema, functools32 12:53:47 INFO - Running setup.py install for functools32 12:53:47 INFO - warning: no files found matching '*.txt' 12:53:47 INFO - no previously-included directories found matching 'build' 12:53:47 INFO - no previously-included directories found matching 'dist' 12:53:47 INFO - no previously-included directories found matching '.git*' 12:53:47 INFO - Successfully installed jsonschema functools32 12:53:47 INFO - Cleaning up... 12:53:47 INFO - Return code: 0 12:53:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1010030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf3b0>, '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 0x12d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', '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 12:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:53:48 INFO - Using env: {'DISPLAY': ':0', 12:53:48 INFO - 'HOME': '/home/cltbld', 12:53:48 INFO - 'LANG': 'en_US.UTF-8', 12:53:48 INFO - 'LANGUAGE': 'en_US:en', 12:53:48 INFO - 'LOGNAME': 'cltbld', 12:53:48 INFO - 'MAIL': '/var/mail/cltbld', 12:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:48 INFO - 'MOZ_NO_REMOTE': '1', 12:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:48 INFO - 'NO_EM_RESTART': '1', 12:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:48 INFO - 'PWD': '/builds/slave/test', 12:53:48 INFO - 'SHELL': '/bin/bash', 12:53:48 INFO - 'SHLVL': '1', 12:53:48 INFO - 'TERM': 'linux', 12:53:48 INFO - 'TMOUT': '86400', 12:53:48 INFO - 'USER': 'cltbld', 12:53:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', 12:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:48 INFO - '_': '/tools/buildbot/bin/python'} 12:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:48 INFO - Downloading/unpacking blobuploader==1.2.4 12:53:48 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 12:53:48 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 12:53:48 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 12:53:48 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 12:53:48 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 12:53:48 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 12:53:50 INFO - Downloading blobuploader-1.2.4.tar.gz 12:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:53:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:53:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:50 INFO - Downloading docopt-0.6.1.tar.gz 12:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:53:50 INFO - Installing collected packages: blobuploader, requests, docopt 12:53:50 INFO - Running setup.py install for blobuploader 12:53:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:53:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:53:51 INFO - Running setup.py install for requests 12:53:51 INFO - Running setup.py install for docopt 12:53:51 INFO - Successfully installed blobuploader requests docopt 12:53:51 INFO - Cleaning up... 12:53:51 INFO - Return code: 0 12:53:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:51 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 0x1010030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf3b0>, '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 0x12d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', '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 12:53:51 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 12:53:51 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 12:53:51 INFO - Using env: {'DISPLAY': ':0', 12:53:51 INFO - 'HOME': '/home/cltbld', 12:53:51 INFO - 'LANG': 'en_US.UTF-8', 12:53:51 INFO - 'LANGUAGE': 'en_US:en', 12:53:51 INFO - 'LOGNAME': 'cltbld', 12:53:51 INFO - 'MAIL': '/var/mail/cltbld', 12:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:51 INFO - 'MOZ_NO_REMOTE': '1', 12:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:51 INFO - 'NO_EM_RESTART': '1', 12:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:51 INFO - 'PWD': '/builds/slave/test', 12:53:51 INFO - 'SHELL': '/bin/bash', 12:53:51 INFO - 'SHLVL': '1', 12:53:51 INFO - 'TERM': 'linux', 12:53:51 INFO - 'TMOUT': '86400', 12:53:51 INFO - 'USER': 'cltbld', 12:53:51 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', 12:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:51 INFO - '_': '/tools/buildbot/bin/python'} 12:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:51 INFO - Running setup.py (path:/tmp/pip-gZA0JV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:51 INFO - Running setup.py (path:/tmp/pip-lcmq4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:51 INFO - Running setup.py (path:/tmp/pip-jOLBs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:51 INFO - Running setup.py (path:/tmp/pip-LlIsWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:52 INFO - Running setup.py (path:/tmp/pip-765mTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:52 INFO - Running setup.py (path:/tmp/pip-9SukxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:52 INFO - Running setup.py (path:/tmp/pip-CCTb5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:52 INFO - Running setup.py (path:/tmp/pip-ThIvfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:52 INFO - Running setup.py (path:/tmp/pip-mTw6pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:52 INFO - Running setup.py (path:/tmp/pip-Yk7YR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:52 INFO - Running setup.py (path:/tmp/pip-q4HUri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:52 INFO - Running setup.py (path:/tmp/pip-FjXnZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:52 INFO - Running setup.py (path:/tmp/pip-FMjI2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:52 INFO - Running setup.py (path:/tmp/pip-UzQbxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:52 INFO - Running setup.py (path:/tmp/pip-SGFi4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:52 INFO - Running setup.py (path:/tmp/pip-5ZPQeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:52 INFO - Running setup.py (path:/tmp/pip-b7_Peb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:53:52 INFO - Running setup.py install for manifestparser 12:53:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Running setup.py install for mozcrash 12:53:53 INFO - Running setup.py install for mozdebug 12:53:53 INFO - Running setup.py install for mozdevice 12:53:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Running setup.py install for mozfile 12:53:53 INFO - Running setup.py install for mozhttpd 12:53:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Running setup.py install for mozinfo 12:53:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Running setup.py install for mozInstall 12:53:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Running setup.py install for mozleak 12:53:53 INFO - Running setup.py install for mozlog 12:53:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:53:53 INFO - Running setup.py install for moznetwork 12:53:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:53:54 INFO - Running setup.py install for mozprocess 12:53:54 INFO - Running setup.py install for mozprofile 12:53:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:53:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:53:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:53:54 INFO - Running setup.py install for mozrunner 12:53:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:53:54 INFO - Running setup.py install for mozscreenshot 12:53:54 INFO - Running setup.py install for moztest 12:53:54 INFO - Running setup.py install for mozversion 12:53:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:53:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:53:54 INFO - Cleaning up... 12:53:54 INFO - Return code: 0 12:53:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:54 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 0x1010030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf3b0>, '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 0x12d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', '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 12:53:54 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 12:53:54 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 12:53:54 INFO - Using env: {'DISPLAY': ':0', 12:53:54 INFO - 'HOME': '/home/cltbld', 12:53:54 INFO - 'LANG': 'en_US.UTF-8', 12:53:54 INFO - 'LANGUAGE': 'en_US:en', 12:53:54 INFO - 'LOGNAME': 'cltbld', 12:53:54 INFO - 'MAIL': '/var/mail/cltbld', 12:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:54 INFO - 'MOZ_NO_REMOTE': '1', 12:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:54 INFO - 'NO_EM_RESTART': '1', 12:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:54 INFO - 'PWD': '/builds/slave/test', 12:53:54 INFO - 'SHELL': '/bin/bash', 12:53:54 INFO - 'SHLVL': '1', 12:53:54 INFO - 'TERM': 'linux', 12:53:54 INFO - 'TMOUT': '86400', 12:53:54 INFO - 'USER': 'cltbld', 12:53:54 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', 12:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:54 INFO - '_': '/tools/buildbot/bin/python'} 12:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:54 INFO - Running setup.py (path:/tmp/pip-28F9JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:55 INFO - Running setup.py (path:/tmp/pip-lGVT67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:55 INFO - Running setup.py (path:/tmp/pip-77unvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:55 INFO - Running setup.py (path:/tmp/pip-cuTddV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:55 INFO - Running setup.py (path:/tmp/pip-DtgHBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:55 INFO - Running setup.py (path:/tmp/pip-4TVnt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:55 INFO - Running setup.py (path:/tmp/pip-8r0rZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:55 INFO - Running setup.py (path:/tmp/pip-Phvxn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:55 INFO - Running setup.py (path:/tmp/pip-qH3dIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:55 INFO - Running setup.py (path:/tmp/pip-Wg1mEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:55 INFO - Running setup.py (path:/tmp/pip-sehcEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:55 INFO - Running setup.py (path:/tmp/pip-5HaSzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:55 INFO - Running setup.py (path:/tmp/pip-K1dHNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:55 INFO - Running setup.py (path:/tmp/pip-uCpHZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:55 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)) 12:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:55 INFO - Running setup.py (path:/tmp/pip-BWYjPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:56 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)) 12:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:56 INFO - Running setup.py (path:/tmp/pip-fECLpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:56 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)) 12:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:56 INFO - Running setup.py (path:/tmp/pip-ri467R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:56 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)) 12:53:56 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)) 12:53:56 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)) 12:53:56 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)) 12:53:56 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)) 12:53:56 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)) 12:53:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:56 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 12:53:56 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 12:53:56 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 12:53:56 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 12:53:56 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 12:53:56 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 12:53:58 INFO - Downloading blessings-1.6.tar.gz 12:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:53:58 INFO - Installing collected packages: blessings 12:53:58 INFO - Running setup.py install for blessings 12:53:58 INFO - Successfully installed blessings 12:53:58 INFO - Cleaning up... 12:53:58 INFO - Return code: 0 12:53:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:53:58 INFO - Reading from file tmpfile_stdout 12:53:58 INFO - Current package versions: 12:53:58 INFO - argparse == 1.2.1 12:53:58 INFO - blessings == 1.6 12:53:58 INFO - blobuploader == 1.2.4 12:53:58 INFO - docopt == 0.6.1 12:53:58 INFO - functools32 == 3.2.3-2 12:53:58 INFO - jsonschema == 2.5.1 12:53:58 INFO - manifestparser == 1.1 12:53:58 INFO - mozInstall == 1.12 12:53:58 INFO - mozcrash == 0.17 12:53:58 INFO - mozdebug == 0.1 12:53:58 INFO - mozdevice == 0.48 12:53:58 INFO - mozfile == 1.2 12:53:58 INFO - mozhttpd == 0.7 12:53:58 INFO - mozinfo == 0.9 12:53:58 INFO - mozleak == 0.1 12:53:58 INFO - mozlog == 3.3 12:53:58 INFO - moznetwork == 0.27 12:53:58 INFO - mozprocess == 0.23 12:53:58 INFO - mozprofile == 0.28 12:53:58 INFO - mozrunner == 6.12 12:53:58 INFO - mozscreenshot == 0.1 12:53:58 INFO - mozsystemmonitor == 0.3 12:53:58 INFO - moztest == 0.7 12:53:58 INFO - mozversion == 1.4 12:53:58 INFO - psutil == 3.1.1 12:53:58 INFO - requests == 1.2.3 12:53:58 INFO - wsgiref == 0.1.2 12:53:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:58 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 0x1010030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf3b0>, '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 0x12d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', '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 12:53:58 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 12:53:58 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 12:53:58 INFO - Using env: {'DISPLAY': ':0', 12:53:58 INFO - 'HOME': '/home/cltbld', 12:53:58 INFO - 'LANG': 'en_US.UTF-8', 12:53:58 INFO - 'LANGUAGE': 'en_US:en', 12:53:58 INFO - 'LOGNAME': 'cltbld', 12:53:58 INFO - 'MAIL': '/var/mail/cltbld', 12:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:58 INFO - 'MOZ_NO_REMOTE': '1', 12:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:58 INFO - 'NO_EM_RESTART': '1', 12:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:58 INFO - 'PWD': '/builds/slave/test', 12:53:58 INFO - 'SHELL': '/bin/bash', 12:53:58 INFO - 'SHLVL': '1', 12:53:58 INFO - 'TERM': 'linux', 12:53:58 INFO - 'TMOUT': '86400', 12:53:58 INFO - 'USER': 'cltbld', 12:53:58 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', 12:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:58 INFO - '_': '/tools/buildbot/bin/python'} 12:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:58 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)) 12:53:58 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)) 12:53:58 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)) 12:53:58 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)) 12:53:58 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)) 12:53:58 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)) 12:53:58 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)) 12:53:58 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)) 12:53:58 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)) 12:53:58 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)) 12:53:58 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)) 12:53:58 INFO - Cleaning up... 12:53:58 INFO - Return code: 0 12:53:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:58 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 0x1010030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12cf3b0>, '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 0x12d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0740>, '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': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', '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 12:53:58 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 12:53:58 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 12:53:58 INFO - Using env: {'DISPLAY': ':0', 12:53:58 INFO - 'HOME': '/home/cltbld', 12:53:58 INFO - 'LANG': 'en_US.UTF-8', 12:53:58 INFO - 'LANGUAGE': 'en_US:en', 12:53:58 INFO - 'LOGNAME': 'cltbld', 12:53:58 INFO - 'MAIL': '/var/mail/cltbld', 12:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:58 INFO - 'MOZ_NO_REMOTE': '1', 12:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:58 INFO - 'NO_EM_RESTART': '1', 12:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:58 INFO - 'PWD': '/builds/slave/test', 12:53:58 INFO - 'SHELL': '/bin/bash', 12:53:58 INFO - 'SHLVL': '1', 12:53:58 INFO - 'TERM': 'linux', 12:53:58 INFO - 'TMOUT': '86400', 12:53:58 INFO - 'USER': 'cltbld', 12:53:58 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', 12:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:58 INFO - '_': '/tools/buildbot/bin/python'} 12:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:53:58 INFO - Cleaning up... 12:53:58 INFO - Return code: 0 12:53:58 INFO - Running post-action listener: _resource_record_post_action 12:53:58 INFO - Running post-action listener: _start_resource_monitoring 12:53:59 INFO - Starting resource monitoring. 12:53:59 INFO - [mozharness: 2016-07-22 19:53:59.009010Z] Finished create-virtualenv step (success) 12:53:59 INFO - [mozharness: 2016-07-22 19:53:59.009494Z] Running install step. 12:53:59 INFO - Running pre-action listener: _resource_record_pre_action 12:53:59 INFO - Running main action method: install 12:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:53:59 INFO - Reading from file tmpfile_stdout 12:53:59 INFO - Detecting whether we're running mozinstall >=1.0... 12:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:53:59 INFO - Reading from file tmpfile_stdout 12:53:59 INFO - Output received: 12:53:59 INFO - Usage: mozinstall [options] installer 12:53:59 INFO - Options: 12:53:59 INFO - -h, --help show this help message and exit 12:53:59 INFO - -d DEST, --destination=DEST 12:53:59 INFO - Directory to install application into. [default: 12:53:59 INFO - "/builds/slave/test"] 12:53:59 INFO - --app=APP Application being installed. [default: firefox] 12:53:59 INFO - mkdir: /builds/slave/test/build/application 12:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:54:16 INFO - Reading from file tmpfile_stdout 12:54:16 INFO - Output received: 12:54:16 INFO - /builds/slave/test/build/application/firefox/firefox 12:54:16 INFO - Running post-action listener: _resource_record_post_action 12:54:16 INFO - [mozharness: 2016-07-22 19:54:16.567741Z] Finished install step (success) 12:54:16 INFO - [mozharness: 2016-07-22 19:54:16.568024Z] Running run-tests step. 12:54:16 INFO - Running pre-action listener: _resource_record_pre_action 12:54:16 INFO - Running main action method: run_tests 12:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:54:16 INFO - Python 2.7.3 12:54:16 INFO - Return code: 0 12:54:16 INFO - grabbing minidump binary from tooltool 12:54:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:16 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 0x12cf3b0>, '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 0x12d02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:54:16 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 12:54:16 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 12:54:16 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 12:54:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:54:16 INFO - Return code: 0 12:54:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:54:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:54:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:54:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:54:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:54:16 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/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 12:54:16 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/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 12:54:16 INFO - Using env: {'DISPLAY': ':0', 12:54:16 INFO - 'HOME': '/home/cltbld', 12:54:16 INFO - 'LANG': 'en_US.UTF-8', 12:54:16 INFO - 'LANGUAGE': 'en_US:en', 12:54:16 INFO - 'LOGNAME': 'cltbld', 12:54:16 INFO - 'MAIL': '/var/mail/cltbld', 12:54:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:16 INFO - 'MOZ_NO_REMOTE': '1', 12:54:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:16 INFO - 'NO_EM_RESTART': '1', 12:54:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:16 INFO - 'PWD': '/builds/slave/test', 12:54:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:16 INFO - 'SHELL': '/bin/bash', 12:54:16 INFO - 'SHLVL': '1', 12:54:16 INFO - 'TERM': 'linux', 12:54:16 INFO - 'TMOUT': '86400', 12:54:16 INFO - 'USER': 'cltbld', 12:54:16 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977', 12:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:16 INFO - '_': '/tools/buildbot/bin/python'} 12:54:16 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/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 12:54:16 INFO - mozversion application_buildid: 20160722063002 12:54:16 INFO - mozversion application_changeset: a31e5c25c77773e26017df7ed4bc8355cd80c2af 12:54:16 INFO - mozversion application_display_name: Nightly 12:54:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:54:16 INFO - mozversion application_name: Firefox 12:54:16 INFO - mozversion application_remotingname: firefox 12:54:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:54:16 INFO - mozversion application_vendor: Mozilla 12:54:16 INFO - mozversion application_version: 50.0a1 12:54:16 INFO - mozversion platform_buildid: 20160722063002 12:54:16 INFO - mozversion platform_changeset: a31e5c25c77773e26017df7ed4bc8355cd80c2af 12:54:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:54:16 INFO - mozversion platform_version: 50.0a1 12:54:16 INFO - using testdate: 1469217256 12:54:16 INFO - actual date: 1469217256 12:54:16 INFO - starting webserver on 'localhost:45672' 12:54:16 INFO - SUITE-START | Running 2 tests 12:54:16 INFO - TEST-START | dromaeo_css 12:54:16 INFO - operating with platform_type : linux_ 12:54:16 INFO - Initialising browser for dromaeo_css test... 12:54:16 INFO - TEST-INFO | started process 7536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqzJhc3/profile http://localhost:45672/getInfo.html) 12:54:20 INFO - PROCESS | 7536 | JavaScript error: , line 0: uncaught exception: undefined 12:54:21 INFO - PROCESS | 7536 | __metrics Screen width/height:1600/1200 12:54:21 INFO - PROCESS | 7536 | colorDepth:24 12:54:21 INFO - PROCESS | 7536 | Browser inner width/height: 1024/697 12:54:21 INFO - PROCESS | 7536 | __metrics 12:54:22 ERROR - PROCESS | 7536 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 12:54:22 INFO - TEST-INFO | 7536: exit 0 12:54:22 INFO - Browser initialized. 12:54:22 INFO - Running cycle 1/1 for dromaeo_css test... 12:54:22 INFO - TEST-INFO | started process 7653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqzJhc3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:34 INFO - PROCESS | 7653 | RSS: Main: 167497728 12:54:34 INFO - PROCESS | 7653 | 12:55:24 INFO - PROCESS | 7653 | 1469217324323 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] 12:57:32 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:45672/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45672/tests/dromaeo/cssquery-ext.html) 12:57:33 INFO - PROCESS | 7653 | RSS: Main: 172191744 12:57:33 INFO - PROCESS | 7653 | 13:00:35 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:45672/tests/dromaeo/cssquery-ext.html (next: http://localhost:45672/tests/dromaeo/cssquery-jquery.html) 13:00:36 INFO - PROCESS | 7653 | RSS: Main: 168865792 13:00:36 INFO - PROCESS | 7653 | 13:03:38 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:45672/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45672/tests/dromaeo/cssquery-mootools.html) 13:03:38 INFO - PROCESS | 7653 | RSS: Main: 173342720 13:03:38 INFO - PROCESS | 7653 | 13:06:40 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:45672/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45672/tests/dromaeo/cssquery-prototype.html) 13:06:41 INFO - PROCESS | 7653 | RSS: Main: 167788544 13:06:41 INFO - PROCESS | 7653 | 13:09:43 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:45672/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45672/tests/dromaeo/cssquery-yui.html) 13:09:44 INFO - PROCESS | 7653 | RSS: Main: 170135552 13:09:44 INFO - PROCESS | 7653 | 13:12:47 INFO - PROCESS | 7653 | Cycle 1(1): loaded http://localhost:45672/tests/dromaeo/cssquery-yui.html (next: http://localhost:45672/tests/dromaeo/cssquery-dojo.html) 13:12:47 INFO - PROCESS | 7653 | RSS: Main: 172933120 13:12:47 INFO - PROCESS | 7653 | 13:12:47 INFO - PROCESS | 7653 | __start_tp_report 13:12:47 INFO - PROCESS | 7653 | _x_x_mozilla_page_load 13:12:47 INFO - PROCESS | 7653 | _x_x_mozilla_page_load_details 13:12:47 INFO - PROCESS | 7653 | |i|pagename|runs| 13:12:47 INFO - PROCESS | 7653 | |0;dojo.html;3065.03451412805;3084.845757712114;3089.62924449066;3119.6412412572545;3120.4071226466967;5377.300950876385;5409.05341565226;5422.647527910688;5464.644798088131;5469.835904922858;5288.973555132228;5362.6514276572;5386.48828361306;5434.076207044802;5434.809781657643;4858.17411040124;4884.951150488503;4968.503149685021;5014.8244811431605;5039.874003149932;4882.658213925027;5050.318207042039;5080.542751152396;5085.0592640361465;5093.414257360396;4889.828855990023;4915.852524424273;4929.088118698052;4952.306677065214;5021.447640759532;4974.452810190876;4983.426905905831;4984.451710311862;4997.875053123665;5038.370203724535;4914.754262286907;4931.0630980113665;4938.358013458227;4943.307936888838;5000.924986125211;5232.764525596357;5330.493603107699;5357.517823395874;5461.453854614547;5465.754041068161;5794.913076303858;5801.129830525413;5811.593188476808;5839.620424672383;5870.530357571427;5828.591998560102;5835.299764028301;5838.737256823453;5846.327672317695;5857.092150716646;5254.553362964152;5390.946090539044;5397.3523177218985;5398.190271459273;5440.972795136078;5980.910286345621;5982.850428739229;5988;6026.397360264026;6051.636901785907;5738.626989245686;5746.712664366765;5749.850029993934;5754.165645981309;5758.452946970031;5649.887002259932;5750.396208398141;5800.332961709373;5836;5838.065909454552;5592.440755924456;5713.628614140151;5772.336181339199;5860.3260625027815;5880.14737863016;5733.168690539848;5739.426057394311;5741;5791.710414479259;5793.710314484259;4314.1371725655;4410.779461027;4423.867283981485;4425.159219748238;4466.59800617946;3916.4516967624554;3929.4302326162547;3944.60553944609;3953.5453422856162;3989.58109398509;5549.972250138723;5556.499915007668;5591.3569939456665;5606.103023516218;5681.886362272731;5687.658740475585;5868.618539794899;5893.6463812171405;5895.056790913433;5907.881842363215;5531.917021244684;5562.471565201299;5579.776808927679;5592;5608.635438696471;5012.949870501248;5022.372203474566;5022.748862556858;5039.193729003342;5095.210242412432;5854.092615644582;6060.181875446759;6061.363556826558;6065.8180254592435;6084.878302433926;5776.5089967352405;5838.241028666246;5854.151148083589;5897.941020589739;5929.940700592939;6022.096685497036;6045.244344456943;6047.9395206047375;6052.303985041776;6058.818235452944;5509.8071567496545;5720.056190728483;5721.570882183936;5767.192593037062;5768.682722450306;5789.797357092481;5824.21373114641;5830.038043722739;5862.443067908542;5929.407059294036;5712.685802280748;5717.885642287214;5718.79984200551;5721.570882183936;5723.742431590672;5546.057170281143;5704.543636508986;5707.429257074259;5716;5726.055200891807;5555.944440555542;5620.297462817148;5629.211910332639;5651.095824668033;5653.236813030188;5699.430056994267;5717.028105222039;5721.656700597811;5749.942500574941;5752.13717942312;5491.615586908878;5587.329520457572;5614.129809879475;5626.07169816992;5631 13:12:47 INFO - PROCESS | 7653 | |1;ext.html;555.6102847010147;592.1975722895477;601.9247594050744;612.0421540289447;642.4378668664918;38735.22529549407;42648.573514264885;42779.78610106953;42819.35770963438;42943.35584966228;43042.78478607602;43384;43803;43816.15195012322;43899;8789.472631642106;8953.283737301;8961.507117108556;8977.147171018776;9009.414388064755;8755.168259015383;8883.689070882521;8942.821143577125;8950.641974321052;8955.552222388887;8929.866052009193;8938.910610893905;8975.102489751038;8999.505027223533;9004.00955894851;8915.821683566324;8989.595468203914;9006.504642244674;9009.504477253748;9014.692869533881;8854.822903541894;8867;8901.109889011048;8917.152870477294;8923.776905577348;41456.79271603653;41467.7926610365;41799.37300940488;41867;41901.58098419007;3471.4098603237258;3610.3681855675413;3710.424884142962;3785.6971442284826;4009.7794621295816;32611.18472038194;32659.510107348407;32750.67249327524;32771;32949.17627059319;4380.34294855771;4438.689291749579;4450.065486247891;4567.817287308504;4675.228587283094;375944;376521;376802;378073.10963445005;379651.99999999726;56476.458559364924;56530.43469565252;56945;56960;56983.43016569864;35247.29505409929;35683.28633427317;35971.4604280936;37655;37774.811125944194;14145.222012789189;14165.645858853612;14372.712545749026;14378.640533986734;14637.341319640642;10820.350778953289;10835.67492975212;10909.781804363869;11000.174986875856;11054.060404865515;19438.7665858716;19538;19550.3225903176;19560.510987225432;19712.507187320145;7323.670434830446;7413.184549699528;7428.739994100289;7530.811729706801;7539.170691223961;957.2342126298932;1064.1965316186383;1134.7049767060623;1137.8293256011664;1147.0937959012454;33069.33861322808;33304.00087997364;33304.50043249353;33374.666253337644;33773.49339759906;1117.8658560972735;1156.7917774800449;1192.6183621241294;1219.1292645849392;1231.975360492803;17032.318707251572;17284.22221000058;17286.740698889527;17412.564685882953;17498.95006299626;629501;632444;632887;634571;635106;59169.70415147897;59679;59719;59766.40233597608;59926.10110848341;1293.7606542789615;1306.301128896036;1323.4970711129902;1352.4319785690034;1353.0190611806559;30580.388392231587;32164.356712865145;32258.677413225567;32398.51402228921;32701.672983270815;51883.74058129685;51980.48019519756;52298.73850630722;52302.738486307324;52316.73841630767;523466;523643;525356;526367;527738;27944;28243.576346355232;28284.575731363635;28649.713502864706;28661.856690716413;48419.757901210265;48614.27078593753;48686.75656621694;48740.512594875014;49554.504454954986;40077.95449008928;42241.57758422499;42794.35808462813;42801;43057.96667664422;41042.38436423396;42033.369499458146;42332.36501452542;42764.78617606892;43154;41066.178676425705;41474.37788433236;41645.375319369625;41776.79111604422;42566.148677026904;34939.30121397608;37212.25575488529;37370.626293737805;37885.81057094697;38140.23719525539;28163.155105346872;28253.71746282511;28300.71699282981;28361.85819070974;28583.714162858105 13:12:47 INFO - PROCESS | 7653 | |2;jquery.html;377.79032636886535;387.4401489847172;396.5241709948061;397.5269429379039;414.21299530891304;14022.228777417238;18657.440276791684;18958.431247062592;20146.89926550367;20219.595608087828;18645.7203141953;18885.716714249298;19224.71162932557;19241;19277.903610481964;5580.972095139518;5678.914816277759;5710.914336284959;5747.770089196427;5794.130880367937;5564.944350556483;5722.771089156449;5753.424657534255;5757.193992840985;5761.020626493506;5585.218069470277;5601.271834661488;5663.5186009189265;5680.829575112753;5711.485966263035;5694.145878118295;5695.772169113251;5711.05767548354;5723.771049158049;5750.65496070233;5020.623453240985;5055.266986286968;5061.620378471629;5077.390713114413;5080.568151707109;22766.430839228986;23141.305760827203;23449.296521104396;23545.529089418287;23715.407114822094;2293.2317673579373;2334.0897050150456;2424.381782645432;2634.2755742171057;2813.43731253748;9849.113579777782;14050.648733781634;14886.404543818235;15209.239538023165;15248.31382587775;1928.623918335925;1972.5956178983274;1993.362124120282;2029.989850050755;2075.7197778300037;83654;85126.57436712777;86524.56737716334;86555;87830.99999999936;10763;11059.557617695364;11102.945954998351;11145;11213.159013074051;15358.923205384124;15378.384864605514;15393.307301171475;15401.306941187673;15473.84526154724;7268.328234926643;7388.482806203621;7534.208908064684;7567.545947243183;7600.581967991703;6902.102726645604;6931.757388491378;7078.787636370917;7171.103612048494;7365.889511657329;4582;4597.839075632337;4705.082508910798;4787.521247875185;4803.735794531264;1972.398418482348;2000.3498862869626;2004.959900801976;2018.8384929205629;2048;934.8550974598948;940.4686352210979;998.8002399519979;1023.4319952426326;1058.4072919165292;17591.208395622227;18227.453176404728;18542.81457185438;18963.33628323002;19267.325643602406;936.2042264075482;969.9878999464335;977.2084611464736;997.3842375351976;1029.8867124616286;10387.740306492247;10778.514966826511;10850.348979061282;10912.618058368078;10931.852155523555;517070;534688;541581.213033287;564782;565937;90837;93558.59662105073;94806.76328502371;96769.51615241879;96950.51524742472;956.7703751099685;988.7972965542046;991.5508693526976;999.7655240537393;1005.5374527717332;16139.596510087342;16941.66116677635;17242.482725518254;17292.827071729625;17422.825771742628;32049.359012819146;38307.23385532218;41251;43771;44300;59656.40343596508;60073.699631501564;60486.39513604984;61276;62885.37114628795;8343.707970221014;8439.156084391512;8494.405391622528;8527.914720852712;8963.193312601898;11648.184627076023;11988.700282493008;12214.145009849226;12642.115051946275;12807.423665934868;10916.945415272872;11210.66368008961;11237.4381280934;11294.887051129712;11697.824532632187;10613;10665.786684266426;10763.085137763064;11157.107431405306;11374.772504549697;10959.945200273947;11286;11367.488463019019;11395.202335836411;11644.301341919512;7978.920210797818;8007.439479236397;8056;8297.336213102817;8622.78443038929;8936.553172341486;11095.722606934569;11308.83036754433;11644.2431241969;11707.765844682888 13:12:47 INFO - PROCESS | 7653 | |3;mootools.html;1503.2709136069009;1539.4457995121754;1705.9402920897762;1841.7421560981456;1850.8334249917505;7696.96151519243;8631.093735157812;8742.956285218574;9448.622055117796;9454.007329230426;8666.263367613745;8822.77943051424;8940.955295223515;9053.230475409582;9074.410163339395;2362.444825466014;2405.4467472481338;2431.3435372449517;2432.0514999150346;2432.9878350608224;2383.5828729972272;2413.9758602414013;2439.829211955164;2449.2040086971715;2449.8285120041605;2408.121035821921;2432.3675844280524;2444.6455263986713;2446.437319416535;2450.0567281596623;2323.2101085630966;2325.732540757818;2332.1487657005155;2357.929262122139;2399.3761621978238;2343.355577216262;2363.869987150706;2372.833901626887;2397.484540823714;2407.879606019692;9000.099990001014;9044.909550904473;9089.81820363589;9095.317851161124;9096.954515227448;5352.411234764173;5419.268398766195;5431.864203394946;5466.371367292772;5467.289252397163;3526.5944416392185;3540.079579309398;3584.1577229351083;3591.102224443889;3592.946105808415;1120.966371008871;1135.7955567997758;1143.5597295041468;1144.250515912079;1160.5531870230022;12330.32183229922;12562.120651554304;12596.370181490889;12615.180013299107;12617.495300187982;4751.691140075884;4783.402074740658;4804.807807687724;4872.3665923430435;4943.950560494349;10951.780964380669;10967.945160274148;10970.890291097146;11018.44907754609;11018.614348497764;5422.15956526739;5439.918401223985;5462.126059830408;5478.808241711521;5480.369757477862;4135.048938744106;4839.467658557556;4937.506249375106;4953.628477864175;4993.151164302078;4173.207090652766;4197.559256278108;4228.682848786292;4242.724222925562;4301.870943871689;1287.3498883063992;1311.6065180445828;1313.6190504753706;1335.8196643453205;1343.8857697095857;865.3164000439582;904.1997831918668;981.7054883534911;999.48526508848;1041.2763129624989;5940.435658612425;6171.259448866164;6274.6548939808745;6300.464460520815;6415.422611964852;1013.3312014070679;1013.4426065663855;1013.5894962540183;1032.0970290066798;1033.6847261585137;4046.635802777764;4255.085156691326;4266.5946735060115;4271.658267338606;4308.719933204332;10823.350598964087;10889.891101089046;11017.669469915916;11038.227324087398;11166.218364714554;10899.83650245247;10934.289271197347;10971.561137554409;11089.05743011853;11103.500342484445;8495.872561911576;8500.829983400297;8657.653693852175;8660.783480412914;8686.739397818075;5982.820515384546;5996.220491336098;6063;6121.663308518075;6136.2943261523715;10313.071823535918;10361.4301213434;10384.740381490523;10418.531166097695;10501.842472362769;10377.16982641402;10658.520366583678;10677.412742298937;10767.6231331903;10866.402347870942;6546.312637173029;7424.96287518559;7633.160352361347;7781.649825757741;7871.685132594632;9137.908620913706;9150.588223529823;9168;9210.585523651318;9214.769630759285;7763.107242667165;7800.219978002381;7817.843643127219;8040.276375126266;8054.275115239657;7827.45207835446;7924.128345881833;7992.200779921961;8047.557384343683;8203.179682031749;7205.171405288459;7331.560106393634;7372.152202496782;7394.7781566553085;7437.702491900263;5242.76407561653;5300.734963251899;5339.172428273624;5348.438413966477;5440.700761458158;5201.713905735221;5245.449227831023;5284.497972692588;5329.401179646013;5430.864228394164 13:12:47 INFO - PROCESS | 7653 | |4;prototype.html;312.6435863116047;320.87165133946417;326.1389930583259;328.829008915364;335.4515367374342;5438.401775804658;5522.3649280332675;5643.351014633318;5702.258706368171;5703.401142879995;5487.149491828773;5514.972425137868;5541.5289700375515;5541.9168712469345;5562.582806289524;4318.719283246594;4323.437953066097;4338.414314067592;4350.71720338177;4355.412019377391;4095.037666148453;4279.315309550472;4317.848875289365;4345.543717909622;4358.716683415583;4243.72415792974;4266.445362102922;4268.850590229343;4284.378765079077;4292.59220374064;4274.252005898955;4282.8715138545895;4301.806418711166;4324.913501729948;4336.349547567858;3561.732870034758;3760.623937606245;3778.622137786227;3785.4511095890944;3789.7157713171346;5349.197620356938;5386.326709161355;5394.649347792381;5397.379301380352;5419.241306217133;4896.338994235768;4898.534639209305;4900.411950565955;4948.57937075349;4980.726060066695;5522.585806064521;5703;5754.4750641080145;5755.834291139857;5778.219940308089;4123.546409894909;4130.43912774082;4140.710150289481;4149.651363306907;4165.8958526037095;6067.605605635619;6077.36187700294;6118.1434599156155;6144.600600960968;6152.507799376039;4167.91664166715;4210.494740631144;4238.406623072772;4273.957260427356;4286.992556749162;4254.893627659271;4255.787210639455;4275.914481710349;4276.657867370603;4296.398504209413;4946.826861059845;4952.579030782352;4954.826581069718;4955.4548999610015;4956.752162391938;5756.856078598069;5816.1566572846705;5884.676342801102;5910.940890591039;5947.6431414115295;1459.3360021190333;1475.387714098637;1477.490265858277;1480.2302802542617;1489.8435664255314;897.3583887520455;924.9732796595773;928.79102202004;931.7437704631145;944.7779771753633;4886.975565122223;4889.315495830587;4911.323328785749;4951.895444436101;4967.801287948441;5247.895042099137;5254.605904557174;5286.810467644749;5291.550218231493;5298.258243845865;4749.216379297446;5000.67495612784;5082.771275292621;5088.745562721923;5091.592672586185;2758.7241275872652;2798.439427923468;2822;2823.8023338366115;2867.5985362049328;5425.019867748243;5434.673919564839;5443.510084092451;5446.004697416405;5476.58925580583;5124.436312005676;5324.866878328073;5337.412884582693;5349.849782296825;5396.595255355864;5378.831405660722;5434.255700871035;5461.078323097124;5488.725563721798;5491.670499770026;5092.516210959953;5266.077881573122;5317.341329335332;5332;5335.786568537215;5190.584753219658;5201.349831271091;5202;5205.687658740488;5211.739413029258;5382.596305277041;5402.972985135049;5413.215083812904;5430.3437451576065;5503.2020357048805;3928.4500169975654;4106.650934670586;4178.12259425524;4183.205191013698;4183.414321994862;5928.288605367211;5937.168796368425;5943.8706645737175;5943.881122377615;5947.821565353046;5696.772129114789;5756.481916627524;5816.970915145397;5824.009918313812;5851.191428114444;5709.571782116275;5758.683272420057;5763.328634695891;5768.740406681625;5778.393268706894;5716.9428305718075;5739.2252045973255;5746.597738158456;5765.4811067004175;5772.393898640582;5643.322801263875;5783.971080144573;5867.178594996619;5872.500837428866;5885.440883116097;5679.261695979661;5700.745835916092;5703.429657034263;5707.400722924033;5735.942640573541 13:12:47 INFO - PROCESS | 7653 | |5;yui.html;724.7680742162506;751.6579956119965;775.1124961918604;825.8596038673433;853.24487828272;15117.244137793108;16175.191240437975;16175.595610109753;16188.109653969057;16330.265138068786;14725.190114543695;14765;14849;14861.108333499971;14910.925445372784;654.1463390275712;773.2422226218296;794.1264608930188;816.5304949653943;817.546261824687;811.1320886651285;813.9145389734082;815.4006804998321;816.2042009041197;817.4196320612373;869.3306154261215;875.8598624220126;876.132628697588;876.3602570123782;876.5222953490331;867.6269204242174;869.0570730757136;870.9042005379404;871.3639043498218;871.481468526229;622.5299898576591;629.7606909374455;631.3370960491511;635.9618422894641;636.8726254749068;14892.255387230703;14925.10449373041;14964.850351496563;14984.70030599382;14989.250537473083;12834.422450989729;12851.742965140738;13066.477340906353;13141.737165256642;13318.667033324147;11509.366984815832;11854;12106.81839772404;12175.817362739566;12290.754184916252;3904.2386734586767;3915;3919.510061242345;3932.58707835676;4042.8382864685377;73872.63063684647;74356;76488.8526672106;76552.23447765563;76628.61685691592;11400.201985861077;11594.246373985665;11720.238184517979;11827.940860295643;12249.938750306192;21775.693458392547;21822;21829.345119646438;21858.672119918214;21947;8626.18051285127;8649.43778654398;8674.73975780715;8970.147835955573;8977;4553.54464553542;4578.336141259499;4626.930596041062;4786.425628924551;4793.976030119897;3424.229548351601;3519.718422526243;3535.7878527288444;3556.342076715816;3565.554305711786;619.9597026193283;626.3579830673596;630.7666163519435;637.9649119298483;639.1626968671055;571.3144226927703;615.6860001399318;640.9647469389135;708.3412426443457;725.7419992156753;9163.81672366549;10048.14590759779;10151.543180556893;10210.846837297446;10415.1667866572;717.5515302935665;764.9732259370895;768.6080099149362;770.6647608290411;791.161368948916;4486.371907932892;4886.951130488721;4996.575291100225;4997.475265097185;5039.647224694236;106665;111526.44236778926;113520.43239783749;114235;120130;81871;100734.49632751936;101564.49217754012;102584;104484;81309;82700;83352.58323708343;83882;83887.5805620968;8884.689035883714;8957.820843582962;9030.954845225731;9065.728028158903;9202.558209253415;50411.243831341824;50457;52158.21762673639;52298.21552676637;52507.212391814915;69386.65306673435;73637.63181184274;73674.26325736889;74456.25543744494;75222;11751.47118379692;11752;12104.152709310263;12168.756624867276;12326.50693972231;12655.93672031634;12964.546240881524;13066.794254557642;13140.671483212996;13196.802047969097;11034.565506484105;11133.665990020312;11213.495392707184;11371.147163962902;11637.88362116368;12540.310282934526;12569.87430125687;12777.744445111231;12859.357032148167;12965.22208667483;12038.638840834788;12376.62870113898;12518.186317889307;12854.871451285742;13270.203787772765;10628.468576571295;10706.089982351587;10741.462926853783;10865.674029779118;10881.292715973437;9568.330216884751;10789.1368690503;10845.186611004365;10893;11019.338839669645 13:12:47 INFO - PROCESS | 7653 | __end_tp_report 13:12:47 INFO - PROCESS | 7653 | __start_cc_report 13:12:47 INFO - PROCESS | 7653 | _x_x_mozilla_cycle_collect,338 13:12:47 INFO - PROCESS | 7653 | __end_cc_report 13:12:47 INFO - PROCESS | 7653 | __startTimestamp1469218367461__endTimestamp 13:12:47 INFO - PROCESS | 7653 | 13:12:47 INFO - PROCESS | 7653 | ------- Summary: start ------- 13:12:47 INFO - PROCESS | 7653 | Number of tests: 6 13:12:47 INFO - PROCESS | 7653 | 13:12:47 INFO - PROCESS | 7653 | [#0] dojo.html Cycles:165 Average:5408.34 Median:5626.07 stddev:623.67 (11.1%) stddev-sans-first:597.87 13:12:47 INFO - PROCESS | 7653 | Values: 3065.0 3084.8 3089.6 3119.6 3120.4 5377.3 5409.1 5422.6 5464.6 5469.8 5289.0 5362.7 5386.5 5434.1 5434.8 4858.2 4885.0 4968.5 5014.8 5039.9 4882.7 5050.3 5080.5 5085.1 5093.4 4889.8 4915.9 4929.1 4952.3 5021.4 4974.5 4983.4 4984.5 4997.9 5038.4 4914.8 4931.1 4938.4 4943.3 5000.9 5232.8 5330.5 5357.5 5461.5 5465.8 5794.9 5801.1 5811.6 5839.6 5870.5 5828.6 5835.3 5838.7 5846.3 5857.1 5254.6 5390.9 5397.4 5398.2 5441.0 5980.9 5982.9 5988.0 6026.4 6051.6 5738.6 5746.7 5749.9 5754.2 5758.5 5649.9 5750.4 5800.3 5836.0 5838.1 5592.4 5713.6 5772.3 5860.3 5880.1 5733.2 5739.4 5741.0 5791.7 5793.7 4314.1 4410.8 4423.9 4425.2 4466.6 3916.5 3929.4 3944.6 3953.5 3989.6 5550.0 5556.5 5591.4 5606.1 5681.9 5687.7 5868.6 5893.6 5895.1 5907.9 5531.9 5562.5 5579.8 5592.0 5608.6 5012.9 5022.4 5022.7 5039.2 5095.2 5854.1 6060.2 6061.4 6065.8 6084.9 5776.5 5838.2 5854.2 5897.9 5929.9 6022.1 6045.2 6047.9 6052.3 6058.8 5509.8 5720.1 5721.6 5767.2 5768.7 5789.8 5824.2 5830.0 5862.4 5929.4 5712.7 5717.9 5718.8 5721.6 5723.7 5546.1 5704.5 5707.4 5716.0 5726.1 5555.9 5620.3 5629.2 5651.1 5653.2 5699.4 5717.0 5721.7 5749.9 5752.1 5491.6 5587.3 5614.1 5626.1 5631.0 13:12:47 INFO - PROCESS | 7653 | 13:12:47 INFO - PROCESS | 7653 | [#1] ext.html Cycles:180 Average:65597.80 Median:41967.48 stddev:139399.38 (332.2%) stddev-sans-first:139704.90 13:12:47 INFO - PROCESS | 7653 | Values: 555.6 592.2 601.9 612.0 642.4 38735.2 42648.6 42779.8 42819.4 42943.4 43042.8 43384.0 43803.0 43816.2 43899.0 8789.5 8953.3 8961.5 8977.1 9009.4 8755.2 8883.7 8942.8 8950.6 8955.6 8929.9 8938.9 8975.1 8999.5 9004.0 8915.8 8989.6 9006.5 9009.5 9014.7 8854.8 8867.0 8901.1 8917.2 8923.8 41456.8 41467.8 41799.4 41867.0 41901.6 3471.4 3610.4 3710.4 3785.7 4009.8 32611.2 32659.5 32750.7 32771.0 32949.2 4380.3 4438.7 4450.1 4567.8 4675.2 375944.0 376521.0 376802.0 378073.1 379652.0 56476.5 56530.4 56945.0 56960.0 56983.4 35247.3 35683.3 35971.5 37655.0 37774.8 14145.2 14165.6 14372.7 14378.6 14637.3 10820.4 10835.7 10909.8 11000.2 11054.1 19438.8 19538.0 19550.3 19560.5 19712.5 7323.7 7413.2 7428.7 7530.8 7539.2 957.2 1064.2 1134.7 1137.8 1147.1 33069.3 33304.0 33304.5 33374.7 33773.5 1117.9 1156.8 1192.6 1219.1 1232.0 17032.3 17284.2 17286.7 17412.6 17499.0 629501.0 632444.0 632887.0 634571.0 635106.0 59169.7 59679.0 59719.0 59766.4 59926.1 1293.8 1306.3 1323.5 1352.4 1353.0 30580.4 32164.4 32258.7 32398.5 32701.7 51883.7 51980.5 52298.7 52302.7 52316.7 523466.0 523643.0 525356.0 526367.0 527738.0 27944.0 28243.6 28284.6 28649.7 28661.9 48419.8 48614.3 48686.8 48740.5 49554.5 40078.0 42241.6 42794.4 42801.0 43058.0 41042.4 42033.4 42332.4 42764.8 43154.0 41066.2 41474.4 41645.4 41776.8 42566.1 34939.3 37212.3 37370.6 37885.8 38140.2 28163.2 28253.7 28300.7 28361.9 28583.7 13:12:47 INFO - PROCESS | 7653 | 13:12:47 INFO - PROCESS | 7653 | [#2] jquery.html Cycles:180 Average:30665.32 Median:391.98 stddev:89788.02 (22906.1%) stddev-sans-first:90011.10 13:12:47 INFO - PROCESS | 7653 | Values: 377.8 387.4 396.5 397.5 414.2 14022.2 18657.4 18958.4 20146.9 20219.6 18645.7 18885.7 19224.7 19241.0 19277.9 5581.0 5678.9 5710.9 5747.8 5794.1 5564.9 5722.8 5753.4 5757.2 5761.0 5585.2 5601.3 5663.5 5680.8 5711.5 5694.1 5695.8 5711.1 5723.8 5750.7 5020.6 5055.3 5061.6 5077.4 5080.6 22766.4 23141.3 23449.3 23545.5 23715.4 2293.2 2334.1 2424.4 2634.3 2813.4 9849.1 14050.6 14886.4 15209.2 15248.3 1928.6 1972.6 1993.4 2030.0 2075.7 83654.0 85126.6 86524.6 86555.0 87831.0 10763.0 11059.6 11102.9 11145.0 11213.2 15358.9 15378.4 15393.3 15401.3 15473.8 7268.3 7388.5 7534.2 7567.5 7600.6 6902.1 6931.8 7078.8 7171.1 7365.9 4582.0 4597.8 4705.1 4787.5 4803.7 1972.4 2000.3 2005.0 2018.8 2048.0 934.9 940.5 998.8 1023.4 1058.4 17591.2 18227.5 18542.8 18963.3 19267.3 936.2 970.0 977.2 997.4 1029.9 10387.7 10778.5 10850.3 10912.6 10931.9 517070.0 534688.0 541581.2 564782.0 565937.0 90837.0 93558.6 94806.8 96769.5 96950.5 956.8 988.8 991.6 999.8 1005.5 16139.6 16941.7 17242.5 17292.8 17422.8 32049.4 38307.2 41251.0 43771.0 44300.0 59656.4 60073.7 60486.4 61276.0 62885.4 8343.7 8439.2 8494.4 8527.9 8963.2 11648.2 11988.7 12214.1 12642.1 12807.4 10916.9 11210.7 11237.4 11294.9 11697.8 10613.0 10665.8 10763.1 11157.1 11374.8 10959.9 11286.0 11367.5 11395.2 11644.3 7978.9 8007.4 8056.0 8297.3 8622.8 8936.6 11095.7 11308.8 11644.2 11707.8 13:12:47 INFO - PROCESS | 7653 | 13:12:47 INFO - PROCESS | 7653 | [#3] mootools.html Cycles:180 Average:5982.74 Median:4305.30 stddev:3382.03 (78.6%) stddev-sans-first:3374.76 13:12:47 INFO - PROCESS | 7653 | Values: 1503.3 1539.4 1705.9 1841.7 1850.8 7697.0 8631.1 8743.0 9448.6 9454.0 8666.3 8822.8 8941.0 9053.2 9074.4 2362.4 2405.4 2431.3 2432.1 2433.0 2383.6 2414.0 2439.8 2449.2 2449.8 2408.1 2432.4 2444.6 2446.4 2450.1 2323.2 2325.7 2332.1 2357.9 2399.4 2343.4 2363.9 2372.8 2397.5 2407.9 9000.1 9044.9 9089.8 9095.3 9097.0 5352.4 5419.3 5431.9 5466.4 5467.3 3526.6 3540.1 3584.2 3591.1 3592.9 1121.0 1135.8 1143.6 1144.3 1160.6 12330.3 12562.1 12596.4 12615.2 12617.5 4751.7 4783.4 4804.8 4872.4 4944.0 10951.8 10967.9 10970.9 11018.4 11018.6 5422.2 5439.9 5462.1 5478.8 5480.4 4135.0 4839.5 4937.5 4953.6 4993.2 4173.2 4197.6 4228.7 4242.7 4301.9 1287.3 1311.6 1313.6 1335.8 1343.9 865.3 904.2 981.7 999.5 1041.3 5940.4 6171.3 6274.7 6300.5 6415.4 1013.3 1013.4 1013.6 1032.1 1033.7 4046.6 4255.1 4266.6 4271.7 4308.7 10823.4 10889.9 11017.7 11038.2 11166.2 10899.8 10934.3 10971.6 11089.1 11103.5 8495.9 8500.8 8657.7 8660.8 8686.7 5982.8 5996.2 6063.0 6121.7 6136.3 10313.1 10361.4 10384.7 10418.5 10501.8 10377.2 10658.5 10677.4 10767.6 10866.4 6546.3 7425.0 7633.2 7781.6 7871.7 9137.9 9150.6 9168.0 9210.6 9214.8 7763.1 7800.2 7817.8 8040.3 8054.3 7827.5 7924.1 7992.2 8047.6 8203.2 7205.2 7331.6 7372.2 7394.8 7437.7 5242.8 5300.7 5339.2 5348.4 5440.7 5201.7 5245.4 5284.5 5329.4 5430.9 13:12:47 INFO - PROCESS | 7653 | 13:12:47 INFO - PROCESS | 7653 | [#4] prototype.html Cycles:180 Average:4704.44 Median:5289.18 stddev:1365.66 (25.8%) stddev-sans-first:1329.11 13:12:47 INFO - PROCESS | 7653 | Values: 312.6 320.9 326.1 328.8 335.5 5438.4 5522.4 5643.4 5702.3 5703.4 5487.1 5515.0 5541.5 5541.9 5562.6 4318.7 4323.4 4338.4 4350.7 4355.4 4095.0 4279.3 4317.8 4345.5 4358.7 4243.7 4266.4 4268.9 4284.4 4292.6 4274.3 4282.9 4301.8 4324.9 4336.3 3561.7 3760.6 3778.6 3785.5 3789.7 5349.2 5386.3 5394.6 5397.4 5419.2 4896.3 4898.5 4900.4 4948.6 4980.7 5522.6 5703.0 5754.5 5755.8 5778.2 4123.5 4130.4 4140.7 4149.7 4165.9 6067.6 6077.4 6118.1 6144.6 6152.5 4167.9 4210.5 4238.4 4274.0 4287.0 4254.9 4255.8 4275.9 4276.7 4296.4 4946.8 4952.6 4954.8 4955.5 4956.8 5756.9 5816.2 5884.7 5910.9 5947.6 1459.3 1475.4 1477.5 1480.2 1489.8 897.4 925.0 928.8 931.7 944.8 4887.0 4889.3 4911.3 4951.9 4967.8 5247.9 5254.6 5286.8 5291.6 5298.3 4749.2 5000.7 5082.8 5088.7 5091.6 2758.7 2798.4 2822.0 2823.8 2867.6 5425.0 5434.7 5443.5 5446.0 5476.6 5124.4 5324.9 5337.4 5349.8 5396.6 5378.8 5434.3 5461.1 5488.7 5491.7 5092.5 5266.1 5317.3 5332.0 5335.8 5190.6 5201.3 5202.0 5205.7 5211.7 5382.6 5403.0 5413.2 5430.3 5503.2 3928.5 4106.7 4178.1 4183.2 4183.4 5928.3 5937.2 5943.9 5943.9 5947.8 5696.8 5756.5 5817.0 5824.0 5851.2 5709.6 5758.7 5763.3 5768.7 5778.4 5716.9 5739.2 5746.6 5765.5 5772.4 5643.3 5784.0 5867.2 5872.5 5885.4 5679.3 5700.7 5703.4 5707.4 5735.9 13:12:47 INFO - PROCESS | 7653 | 13:12:47 INFO - PROCESS | 7653 | [#5] yui.html Cycles:180 Average:20388.17 Median:3987.71 stddev:29517.99 (740.2%) stddev-sans-first:29563.87 13:12:47 INFO - PROCESS | 7653 | Values: 724.8 751.7 775.1 825.9 853.2 15117.2 16175.2 16175.6 16188.1 16330.3 14725.2 14765.0 14849.0 14861.1 14910.9 654.1 773.2 794.1 816.5 817.5 811.1 813.9 815.4 816.2 817.4 869.3 875.9 876.1 876.4 876.5 867.6 869.1 870.9 871.4 871.5 622.5 629.8 631.3 636.0 636.9 14892.3 14925.1 14964.9 14984.7 14989.3 12834.4 12851.7 13066.5 13141.7 13318.7 11509.4 11854.0 12106.8 12175.8 12290.8 3904.2 3915.0 3919.5 3932.6 4042.8 73872.6 74356.0 76488.9 76552.2 76628.6 11400.2 11594.2 11720.2 11827.9 12249.9 21775.7 21822.0 21829.3 21858.7 21947.0 8626.2 8649.4 8674.7 8970.1 8977.0 4553.5 4578.3 4626.9 4786.4 4794.0 3424.2 3519.7 3535.8 3556.3 3565.6 620.0 626.4 630.8 638.0 639.2 571.3 615.7 641.0 708.3 725.7 9163.8 10048.1 10151.5 10210.8 10415.2 717.6 765.0 768.6 770.7 791.2 4486.4 4887.0 4996.6 4997.5 5039.6 106665.0 111526.4 113520.4 114235.0 120130.0 81871.0 100734.5 101564.5 102584.0 104484.0 81309.0 82700.0 83352.6 83882.0 83887.6 8884.7 8957.8 9031.0 9065.7 9202.6 50411.2 50457.0 52158.2 52298.2 52507.2 69386.7 73637.6 73674.3 74456.3 75222.0 11751.5 11752.0 12104.2 12168.8 12326.5 12655.9 12964.5 13066.8 13140.7 13196.8 11034.6 11133.7 11213.5 11371.1 11637.9 12540.3 12569.9 12777.7 12859.4 12965.2 12038.6 12376.6 12518.2 12854.9 13270.2 10628.5 10706.1 10741.5 10865.7 10881.3 9568.3 10789.1 10845.2 10893.0 11019.3 13:12:47 INFO - PROCESS | 7653 | -------- Summary: end -------- 13:12:47 INFO - PROCESS | 7653 | 13:12:48 INFO - TEST-INFO | 7653: exit 0 13:12:48 INFO - TEST-OK | dromaeo_css | took 1111408ms 13:12:48 INFO - TEST-START | kraken 13:12:48 INFO - operating with platform_type : linux_ 13:12:48 INFO - Initialising browser for kraken test... 13:12:48 INFO - TEST-INFO | started process 7897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLGx6DD/profile http://localhost:45672/getInfo.html) 13:12:51 INFO - PROCESS | 7897 | JavaScript error: , line 0: uncaught exception: undefined 13:12:53 INFO - PROCESS | 7897 | __metrics Screen width/height:1600/1200 13:12:53 INFO - PROCESS | 7897 | colorDepth:24 13:12:53 INFO - PROCESS | 7897 | Browser inner width/height: 1024/697 13:12:53 INFO - PROCESS | 7897 | __metrics 13:12:53 ERROR - PROCESS | 7897 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:12:54 INFO - TEST-INFO | 7897: exit 0 13:12:54 INFO - Browser initialized. 13:12:54 INFO - Running cycle 1/1 for kraken test... 13:12:54 INFO - TEST-INFO | started process 8014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLGx6DD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:06 INFO - PROCESS | 8014 | RSS: Main: 167440384 13:13:06 INFO - PROCESS | 8014 | 13:13:08 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45672/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:09 INFO - PROCESS | 8014 | RSS: Main: 173088768 13:13:09 INFO - PROCESS | 8014 | 13:13:12 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45672/tests/kraken/driver.html?testName=audio-dft) 13:13:13 INFO - PROCESS | 8014 | RSS: Main: 171560960 13:13:13 INFO - PROCESS | 8014 | 13:13:15 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45672/tests/kraken/driver.html?testName=audio-fft) 13:13:16 INFO - PROCESS | 8014 | RSS: Main: 167833600 13:13:16 INFO - PROCESS | 8014 | 13:13:18 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45672/tests/kraken/driver.html?testName=audio-oscillator) 13:13:19 INFO - PROCESS | 8014 | RSS: Main: 168951808 13:13:19 INFO - PROCESS | 8014 | 13:13:21 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45672/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:13:22 INFO - PROCESS | 8014 | RSS: Main: 169025536 13:13:22 INFO - PROCESS | 8014 | 13:13:25 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45672/tests/kraken/driver.html?testName=imaging-darkroom) 13:13:25 INFO - PROCESS | 8014 | RSS: Main: 169697280 13:13:25 INFO - PROCESS | 8014 | 13:13:29 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45672/tests/kraken/driver.html?testName=imaging-desaturate) 13:13:30 INFO - PROCESS | 8014 | RSS: Main: 167690240 13:13:30 INFO - PROCESS | 8014 | 13:13:32 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45672/tests/kraken/driver.html?testName=json-parse-financial) 13:13:33 INFO - PROCESS | 8014 | RSS: Main: 168521728 13:13:33 INFO - PROCESS | 8014 | 13:13:35 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45672/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:13:35 INFO - PROCESS | 8014 | RSS: Main: 168914944 13:13:35 INFO - PROCESS | 8014 | 13:13:37 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45672/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:13:38 INFO - PROCESS | 8014 | RSS: Main: 168853504 13:13:38 INFO - PROCESS | 8014 | 13:13:40 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45672/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:13:40 INFO - PROCESS | 8014 | RSS: Main: 169684992 13:13:40 INFO - PROCESS | 8014 | 13:13:43 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:13:44 INFO - PROCESS | 8014 | RSS: Main: 169811968 13:13:44 INFO - PROCESS | 8014 | 13:13:46 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:13:47 INFO - PROCESS | 8014 | RSS: Main: 169435136 13:13:47 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | Cycle 1(1): loaded http://localhost:45672/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45672/tests/kraken/driver.html?testName=ai-astar) 13:13:49 INFO - PROCESS | 8014 | RSS: Main: 170549248 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | __start_tp_report 13:13:49 INFO - PROCESS | 8014 | _x_x_mozilla_page_load 13:13:49 INFO - PROCESS | 8014 | _x_x_mozilla_page_load_details 13:13:49 INFO - PROCESS | 8014 | |i|pagename|runs| 13:13:49 INFO - PROCESS | 8014 | |0;ai-astar;109;111;105;112;113;112;98;112;111;112 13:13:49 INFO - PROCESS | 8014 | |1;audio-beat-detection;158;118;141;181;120;155;148;119;195;118 13:13:49 INFO - PROCESS | 8014 | |2;audio-dft;163;161;163;163;167;165;194;165;161;163 13:13:49 INFO - PROCESS | 8014 | |3;audio-fft;76;75;75;176;76;76;74;75;179;78 13:13:49 INFO - PROCESS | 8014 | |4;audio-oscillator;84;85;151;85;85;84;141;85;84;152 13:13:49 INFO - PROCESS | 8014 | |5;imaging-gaussian-blur;118;117;118;117;118;117;117;117;117;118 13:13:49 INFO - PROCESS | 8014 | |6;imaging-darkroom;147;147;146;147;149;149;149;148;148;148 13:13:49 INFO - PROCESS | 8014 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 13:13:49 INFO - PROCESS | 8014 | |8;json-parse-financial;59;54;56;53;56;52;53;54;53;54 13:13:49 INFO - PROCESS | 8014 | |9;json-stringify-tinderbox;61;62;62;61;63;62;62;62;62;62 13:13:49 INFO - PROCESS | 8014 | |10;stanford-crypto-aes;76;77;76;82;75;81;75;75;81;75 13:13:49 INFO - PROCESS | 8014 | |11;stanford-crypto-ccm;139;120;125;128;129;131;124;122;165;123 13:13:49 INFO - PROCESS | 8014 | |12;stanford-crypto-pbkdf2;157;161;163;159;159;159;157;164;156;158 13:13:49 INFO - PROCESS | 8014 | |13;stanford-crypto-sha256-iterative;64;64;64;64;69;64;63;65;64;64 13:13:49 INFO - PROCESS | 8014 | __end_tp_report 13:13:49 INFO - PROCESS | 8014 | __start_cc_report 13:13:49 INFO - PROCESS | 8014 | _x_x_mozilla_cycle_collect,913 13:13:49 INFO - PROCESS | 8014 | __end_cc_report 13:13:49 INFO - PROCESS | 8014 | __startTimestamp1469218429302__endTimestamp 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | ------- Summary: start ------- 13:13:49 INFO - PROCESS | 8014 | Number of tests: 14 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#0] ai-astar Cycles:10 Average:109.50 Median:112.00 stddev:4.65 (4.2%) stddev-sans-first:4.93 13:13:49 INFO - PROCESS | 8014 | Values: 109.0 111.0 105.0 112.0 113.0 112.0 98.0 112.0 111.0 112.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:151.50 stddev:27.58 (18.2%) stddev-sans-first:28.87 13:13:49 INFO - PROCESS | 8014 | Values: 158.0 118.0 141.0 181.0 120.0 155.0 148.0 119.0 195.0 118.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#2] audio-dft Cycles:10 Average:166.50 Median:164.00 stddev:9.83 (6.0%) stddev-sans-first:10.35 13:13:49 INFO - PROCESS | 8014 | Values: 163.0 161.0 163.0 163.0 167.0 165.0 194.0 165.0 161.0 163.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#3] audio-fft Cycles:10 Average:96.00 Median:75.50 stddev:42.97 (56.9%) stddev-sans-first:44.97 13:13:49 INFO - PROCESS | 8014 | Values: 76.0 75.0 75.0 176.0 76.0 76.0 74.0 75.0 179.0 78.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.50 stddev:30.78 (36.4%) stddev-sans-first:31.82 13:13:49 INFO - PROCESS | 8014 | Values: 84.0 85.0 151.0 85.0 85.0 84.0 141.0 85.0 84.0 152.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:13:49 INFO - PROCESS | 8014 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 13:13:49 INFO - PROCESS | 8014 | Values: 147.0 147.0 146.0 147.0 149.0 149.0 149.0 148.0 148.0 148.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:13:49 INFO - PROCESS | 8014 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:2.07 (3.8%) stddev-sans-first:1.36 13:13:49 INFO - PROCESS | 8014 | Values: 59.0 54.0 56.0 53.0 56.0 52.0 53.0 54.0 53.0 54.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 13:13:49 INFO - PROCESS | 8014 | Values: 61.0 62.0 62.0 61.0 63.0 62.0 62.0 62.0 62.0 62.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.50 stddev:2.87 (3.8%) stddev-sans-first:3.00 13:13:49 INFO - PROCESS | 8014 | Values: 76.0 77.0 76.0 82.0 75.0 81.0 75.0 75.0 81.0 75.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:128.50 stddev:13.26 (10.3%) stddev-sans-first:13.71 13:13:49 INFO - PROCESS | 8014 | Values: 139.0 120.0 125.0 128.0 129.0 131.0 124.0 122.0 165.0 123.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:159.00 stddev:2.63 (1.7%) stddev-sans-first:2.65 13:13:49 INFO - PROCESS | 8014 | Values: 157.0 161.0 163.0 159.0 159.0 159.0 157.0 164.0 156.0 158.0 13:13:49 INFO - PROCESS | 8014 | 13:13:49 INFO - PROCESS | 8014 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.00 stddev:1.65 (2.6%) stddev-sans-first:1.74 13:13:49 INFO - PROCESS | 8014 | Values: 64.0 64.0 64.0 64.0 69.0 64.0 63.0 65.0 64.0 64.0 13:13:49 INFO - PROCESS | 8014 | -------- Summary: end -------- 13:13:49 INFO - PROCESS | 8014 | 13:13:50 INFO - TEST-INFO | 8014: exit 0 13:13:50 INFO - TEST-OK | kraken | took 62053ms 13:13:50 INFO - SUITE-END | took 1173s 13:13:50 INFO - Completed test suite (00:19:33) 13:13:50 INFO - javascript benchmark 13:13:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7297.563689192823, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.03451412805, 3084.845757712114, 3089.62924449066, 3119.6412412572545, 3120.4071226466967, 5377.300950876385, 5409.05341565226, 5422.647527910688, 5464.644798088131, 5469.835904922858, 5288.973555132228, 5362.6514276572, 5386.48828361306, 5434.076207044802, 5434.809781657643, 4858.17411040124, 4884.951150488503, 4968.503149685021, 5014.8244811431605, 5039.874003149932, 4882.658213925027, 5050.318207042039, 5080.542751152396, 5085.0592640361465, 5093.414257360396, 4889.828855990023, 4915.852524424273, 4929.088118698052, 4952.306677065214, 5021.447640759532, 4974.452810190876, 4983.426905905831, 4984.451710311862, 4997.875053123665, 5038.370203724535, 4914.754262286907, 4931.0630980113665, 4938.358013458227, 4943.307936888838, 5000.924986125211, 5232.764525596357, 5330.493603107699, 5357.517823395874, 5461.453854614547, 5465.754041068161, 5794.913076303858, 5801.129830525413, 5811.593188476808, 5839.620424672383, 5870.530357571427, 5828.591998560102, 5835.299764028301, 5838.737256823453, 5846.327672317695, 5857.092150716646, 5254.553362964152, 5390.946090539044, 5397.3523177218985, 5398.190271459273, 5440.972795136078, 5980.910286345621, 5982.850428739229, 5988.0, 6026.397360264026, 6051.636901785907, 5738.626989245686, 5746.712664366765, 5749.850029993934, 5754.165645981309, 5758.452946970031, 5649.887002259932, 5750.396208398141, 5800.332961709373, 5836.0, 5838.065909454552, 5592.440755924456, 5713.628614140151, 5772.336181339199, 5860.3260625027815, 5880.14737863016, 5733.168690539848, 5739.426057394311, 5741.0, 5791.710414479259, 5793.710314484259, 4314.1371725655, 4410.779461027, 4423.867283981485, 4425.159219748238, 4466.59800617946, 3916.4516967624554, 3929.4302326162547, 3944.60553944609, 3953.5453422856162, 3989.58109398509, 5549.972250138723, 5556.499915007668, 5591.3569939456665, 5606.103023516218, 5681.886362272731, 5687.658740475585, 5868.618539794899, 5893.6463812171405, 5895.056790913433, 5907.881842363215, 5531.917021244684, 5562.471565201299, 5579.776808927679, 5592.0, 5608.635438696471, 5012.949870501248, 5022.372203474566, 5022.748862556858, 5039.193729003342, 5095.210242412432, 5854.092615644582, 6060.181875446759, 6061.363556826558, 6065.8180254592435, 6084.878302433926, 5776.5089967352405, 5838.241028666246, 5854.151148083589, 5897.941020589739, 5929.940700592939, 6022.096685497036, 6045.244344456943, 6047.9395206047375, 6052.303985041776, 6058.818235452944, 5509.8071567496545, 5720.056190728483, 5721.570882183936, 5767.192593037062, 5768.682722450306, 5789.797357092481, 5824.21373114641, 5830.038043722739, 5862.443067908542, 5929.407059294036, 5712.685802280748, 5717.885642287214, 5718.79984200551, 5721.570882183936, 5723.742431590672, 5546.057170281143, 5704.543636508986, 5707.429257074259, 5716.0, 5726.055200891807, 5555.944440555542, 5620.297462817148, 5629.211910332639, 5651.095824668033, 5653.236813030188, 5699.430056994267, 5717.028105222039, 5721.656700597811, 5749.942500574941, 5752.13717942312, 5491.615586908878, 5587.329520457572, 5614.129809879475, 5626.07169816992, 5631.0], "value": 5365.200114415707, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6102847010147, 592.1975722895477, 601.9247594050744, 612.0421540289447, 642.4378668664918, 38735.22529549407, 42648.573514264885, 42779.78610106953, 42819.35770963438, 42943.35584966228, 43042.78478607602, 43384.0, 43803.0, 43816.15195012322, 43899.0, 8789.472631642106, 8953.283737301, 8961.507117108556, 8977.147171018776, 9009.414388064755, 8755.168259015383, 8883.689070882521, 8942.821143577125, 8950.641974321052, 8955.552222388887, 8929.866052009193, 8938.910610893905, 8975.102489751038, 8999.505027223533, 9004.00955894851, 8915.821683566324, 8989.595468203914, 9006.504642244674, 9009.504477253748, 9014.692869533881, 8854.822903541894, 8867.0, 8901.109889011048, 8917.152870477294, 8923.776905577348, 41456.79271603653, 41467.7926610365, 41799.37300940488, 41867.0, 41901.58098419007, 3471.4098603237258, 3610.3681855675413, 3710.424884142962, 3785.6971442284826, 4009.7794621295816, 32611.18472038194, 32659.510107348407, 32750.67249327524, 32771.0, 32949.17627059319, 4380.34294855771, 4438.689291749579, 4450.065486247891, 4567.817287308504, 4675.228587283094, 375944.0, 376521.0, 376802.0, 378073.10963445005, 379651.99999999726, 56476.458559364924, 56530.43469565252, 56945.0, 56960.0, 56983.43016569864, 35247.29505409929, 35683.28633427317, 35971.4604280936, 37655.0, 37774.811125944194, 14145.222012789189, 14165.645858853612, 14372.712545749026, 14378.640533986734, 14637.341319640642, 10820.350778953289, 10835.67492975212, 10909.781804363869, 11000.174986875856, 11054.060404865515, 19438.7665858716, 19538.0, 19550.3225903176, 19560.510987225432, 19712.507187320145, 7323.670434830446, 7413.184549699528, 7428.739994100289, 7530.811729706801, 7539.170691223961, 957.2342126298932, 1064.1965316186383, 1134.7049767060623, 1137.8293256011664, 1147.0937959012454, 33069.33861322808, 33304.00087997364, 33304.50043249353, 33374.666253337644, 33773.49339759906, 1117.8658560972735, 1156.7917774800449, 1192.6183621241294, 1219.1292645849392, 1231.975360492803, 17032.318707251572, 17284.22221000058, 17286.740698889527, 17412.564685882953, 17498.95006299626, 629501.0, 632444.0, 632887.0, 634571.0, 635106.0, 59169.70415147897, 59679.0, 59719.0, 59766.40233597608, 59926.10110848341, 1293.7606542789615, 1306.301128896036, 1323.4970711129902, 1352.4319785690034, 1353.0190611806559, 30580.388392231587, 32164.356712865145, 32258.677413225567, 32398.51402228921, 32701.672983270815, 51883.74058129685, 51980.48019519756, 52298.73850630722, 52302.738486307324, 52316.73841630767, 523466.0, 523643.0, 525356.0, 526367.0, 527738.0, 27944.0, 28243.576346355232, 28284.575731363635, 28649.713502864706, 28661.856690716413, 48419.757901210265, 48614.27078593753, 48686.75656621694, 48740.512594875014, 49554.504454954986, 40077.95449008928, 42241.57758422499, 42794.35808462813, 42801.0, 43057.96667664422, 41042.38436423396, 42033.369499458146, 42332.36501452542, 42764.78617606892, 43154.0, 41066.178676425705, 41474.37788433236, 41645.375319369625, 41776.79111604422, 42566.148677026904, 34939.30121397608, 37212.25575488529, 37370.626293737805, 37885.81057094697, 38140.23719525539, 28163.155105346872, 28253.71746282511, 28300.71699282981, 28361.85819070974, 28583.714162858105], "value": 20154.63700683294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.79032636886535, 387.4401489847172, 396.5241709948061, 397.5269429379039, 414.21299530891304, 14022.228777417238, 18657.440276791684, 18958.431247062592, 20146.89926550367, 20219.595608087828, 18645.7203141953, 18885.716714249298, 19224.71162932557, 19241.0, 19277.903610481964, 5580.972095139518, 5678.914816277759, 5710.914336284959, 5747.770089196427, 5794.130880367937, 5564.944350556483, 5722.771089156449, 5753.424657534255, 5757.193992840985, 5761.020626493506, 5585.218069470277, 5601.271834661488, 5663.5186009189265, 5680.829575112753, 5711.485966263035, 5694.145878118295, 5695.772169113251, 5711.05767548354, 5723.771049158049, 5750.65496070233, 5020.623453240985, 5055.266986286968, 5061.620378471629, 5077.390713114413, 5080.568151707109, 22766.430839228986, 23141.305760827203, 23449.296521104396, 23545.529089418287, 23715.407114822094, 2293.2317673579373, 2334.0897050150456, 2424.381782645432, 2634.2755742171057, 2813.43731253748, 9849.113579777782, 14050.648733781634, 14886.404543818235, 15209.239538023165, 15248.31382587775, 1928.623918335925, 1972.5956178983274, 1993.362124120282, 2029.989850050755, 2075.7197778300037, 83654.0, 85126.57436712777, 86524.56737716334, 86555.0, 87830.99999999936, 10763.0, 11059.557617695364, 11102.945954998351, 11145.0, 11213.159013074051, 15358.923205384124, 15378.384864605514, 15393.307301171475, 15401.306941187673, 15473.84526154724, 7268.328234926643, 7388.482806203621, 7534.208908064684, 7567.545947243183, 7600.581967991703, 6902.102726645604, 6931.757388491378, 7078.787636370917, 7171.103612048494, 7365.889511657329, 4582.0, 4597.839075632337, 4705.082508910798, 4787.521247875185, 4803.735794531264, 1972.398418482348, 2000.3498862869626, 2004.959900801976, 2018.8384929205629, 2048.0, 934.8550974598948, 940.4686352210979, 998.8002399519979, 1023.4319952426326, 1058.4072919165292, 17591.208395622227, 18227.453176404728, 18542.81457185438, 18963.33628323002, 19267.325643602406, 936.2042264075482, 969.9878999464335, 977.2084611464736, 997.3842375351976, 1029.8867124616286, 10387.740306492247, 10778.514966826511, 10850.348979061282, 10912.618058368078, 10931.852155523555, 517070.0, 534688.0, 541581.213033287, 564782.0, 565937.0, 90837.0, 93558.59662105073, 94806.76328502371, 96769.51615241879, 96950.51524742472, 956.7703751099685, 988.7972965542046, 991.5508693526976, 999.7655240537393, 1005.5374527717332, 16139.596510087342, 16941.66116677635, 17242.482725518254, 17292.827071729625, 17422.825771742628, 32049.359012819146, 38307.23385532218, 41251.0, 43771.0, 44300.0, 59656.40343596508, 60073.699631501564, 60486.39513604984, 61276.0, 62885.37114628795, 8343.707970221014, 8439.156084391512, 8494.405391622528, 8527.914720852712, 8963.193312601898, 11648.184627076023, 11988.700282493008, 12214.145009849226, 12642.115051946275, 12807.423665934868, 10916.945415272872, 11210.66368008961, 11237.4381280934, 11294.887051129712, 11697.824532632187, 10613.0, 10665.786684266426, 10763.085137763064, 11157.107431405306, 11374.772504549697, 10959.945200273947, 11286.0, 11367.488463019019, 11395.202335836411, 11644.301341919512, 7978.920210797818, 8007.439479236397, 8056.0, 8297.336213102817, 8622.78443038929, 8936.553172341486, 11095.722606934569, 11308.83036754433, 11644.2431241969, 11707.765844682888], "value": 9184.921224074527, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1503.2709136069009, 1539.4457995121754, 1705.9402920897762, 1841.7421560981456, 1850.8334249917505, 7696.96151519243, 8631.093735157812, 8742.956285218574, 9448.622055117796, 9454.007329230426, 8666.263367613745, 8822.77943051424, 8940.955295223515, 9053.230475409582, 9074.410163339395, 2362.444825466014, 2405.4467472481338, 2431.3435372449517, 2432.0514999150346, 2432.9878350608224, 2383.5828729972272, 2413.9758602414013, 2439.829211955164, 2449.2040086971715, 2449.8285120041605, 2408.121035821921, 2432.3675844280524, 2444.6455263986713, 2446.437319416535, 2450.0567281596623, 2323.2101085630966, 2325.732540757818, 2332.1487657005155, 2357.929262122139, 2399.3761621978238, 2343.355577216262, 2363.869987150706, 2372.833901626887, 2397.484540823714, 2407.879606019692, 9000.099990001014, 9044.909550904473, 9089.81820363589, 9095.317851161124, 9096.954515227448, 5352.411234764173, 5419.268398766195, 5431.864203394946, 5466.371367292772, 5467.289252397163, 3526.5944416392185, 3540.079579309398, 3584.1577229351083, 3591.102224443889, 3592.946105808415, 1120.966371008871, 1135.7955567997758, 1143.5597295041468, 1144.250515912079, 1160.5531870230022, 12330.32183229922, 12562.120651554304, 12596.370181490889, 12615.180013299107, 12617.495300187982, 4751.691140075884, 4783.402074740658, 4804.807807687724, 4872.3665923430435, 4943.950560494349, 10951.780964380669, 10967.945160274148, 10970.890291097146, 11018.44907754609, 11018.614348497764, 5422.15956526739, 5439.918401223985, 5462.126059830408, 5478.808241711521, 5480.369757477862, 4135.048938744106, 4839.467658557556, 4937.506249375106, 4953.628477864175, 4993.151164302078, 4173.207090652766, 4197.559256278108, 4228.682848786292, 4242.724222925562, 4301.870943871689, 1287.3498883063992, 1311.6065180445828, 1313.6190504753706, 1335.8196643453205, 1343.8857697095857, 865.3164000439582, 904.1997831918668, 981.7054883534911, 999.48526508848, 1041.2763129624989, 5940.435658612425, 6171.259448866164, 6274.6548939808745, 6300.464460520815, 6415.422611964852, 1013.3312014070679, 1013.4426065663855, 1013.5894962540183, 1032.0970290066798, 1033.6847261585137, 4046.635802777764, 4255.085156691326, 4266.5946735060115, 4271.658267338606, 4308.719933204332, 10823.350598964087, 10889.891101089046, 11017.669469915916, 11038.227324087398, 11166.218364714554, 10899.83650245247, 10934.289271197347, 10971.561137554409, 11089.05743011853, 11103.500342484445, 8495.872561911576, 8500.829983400297, 8657.653693852175, 8660.783480412914, 8686.739397818075, 5982.820515384546, 5996.220491336098, 6063.0, 6121.663308518075, 6136.2943261523715, 10313.071823535918, 10361.4301213434, 10384.740381490523, 10418.531166097695, 10501.842472362769, 10377.16982641402, 10658.520366583678, 10677.412742298937, 10767.6231331903, 10866.402347870942, 6546.312637173029, 7424.96287518559, 7633.160352361347, 7781.649825757741, 7871.685132594632, 9137.908620913706, 9150.588223529823, 9168.0, 9210.585523651318, 9214.769630759285, 7763.107242667165, 7800.219978002381, 7817.843643127219, 8040.276375126266, 8054.275115239657, 7827.45207835446, 7924.128345881833, 7992.200779921961, 8047.557384343683, 8203.179682031749, 7205.171405288459, 7331.560106393634, 7372.152202496782, 7394.7781566553085, 7437.702491900263, 5242.76407561653, 5300.734963251899, 5339.172428273624, 5348.438413966477, 5440.700761458158, 5201.713905735221, 5245.449227831023, 5284.497972692588, 5329.401179646013, 5430.864228394164], "value": 4798.078525689652, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.6435863116047, 320.87165133946417, 326.1389930583259, 328.829008915364, 335.4515367374342, 5438.401775804658, 5522.3649280332675, 5643.351014633318, 5702.258706368171, 5703.401142879995, 5487.149491828773, 5514.972425137868, 5541.5289700375515, 5541.9168712469345, 5562.582806289524, 4318.719283246594, 4323.437953066097, 4338.414314067592, 4350.71720338177, 4355.412019377391, 4095.037666148453, 4279.315309550472, 4317.848875289365, 4345.543717909622, 4358.716683415583, 4243.72415792974, 4266.445362102922, 4268.850590229343, 4284.378765079077, 4292.59220374064, 4274.252005898955, 4282.8715138545895, 4301.806418711166, 4324.913501729948, 4336.349547567858, 3561.732870034758, 3760.623937606245, 3778.622137786227, 3785.4511095890944, 3789.7157713171346, 5349.197620356938, 5386.326709161355, 5394.649347792381, 5397.379301380352, 5419.241306217133, 4896.338994235768, 4898.534639209305, 4900.411950565955, 4948.57937075349, 4980.726060066695, 5522.585806064521, 5703.0, 5754.4750641080145, 5755.834291139857, 5778.219940308089, 4123.546409894909, 4130.43912774082, 4140.710150289481, 4149.651363306907, 4165.8958526037095, 6067.605605635619, 6077.36187700294, 6118.1434599156155, 6144.600600960968, 6152.507799376039, 4167.91664166715, 4210.494740631144, 4238.406623072772, 4273.957260427356, 4286.992556749162, 4254.893627659271, 4255.787210639455, 4275.914481710349, 4276.657867370603, 4296.398504209413, 4946.826861059845, 4952.579030782352, 4954.826581069718, 4955.4548999610015, 4956.752162391938, 5756.856078598069, 5816.1566572846705, 5884.676342801102, 5910.940890591039, 5947.6431414115295, 1459.3360021190333, 1475.387714098637, 1477.490265858277, 1480.2302802542617, 1489.8435664255314, 897.3583887520455, 924.9732796595773, 928.79102202004, 931.7437704631145, 944.7779771753633, 4886.975565122223, 4889.315495830587, 4911.323328785749, 4951.895444436101, 4967.801287948441, 5247.895042099137, 5254.605904557174, 5286.810467644749, 5291.550218231493, 5298.258243845865, 4749.216379297446, 5000.67495612784, 5082.771275292621, 5088.745562721923, 5091.592672586185, 2758.7241275872652, 2798.439427923468, 2822.0, 2823.8023338366115, 2867.5985362049328, 5425.019867748243, 5434.673919564839, 5443.510084092451, 5446.004697416405, 5476.58925580583, 5124.436312005676, 5324.866878328073, 5337.412884582693, 5349.849782296825, 5396.595255355864, 5378.831405660722, 5434.255700871035, 5461.078323097124, 5488.725563721798, 5491.670499770026, 5092.516210959953, 5266.077881573122, 5317.341329335332, 5332.0, 5335.786568537215, 5190.584753219658, 5201.349831271091, 5202.0, 5205.687658740488, 5211.739413029258, 5382.596305277041, 5402.972985135049, 5413.215083812904, 5430.3437451576065, 5503.2020357048805, 3928.4500169975654, 4106.650934670586, 4178.12259425524, 4183.205191013698, 4183.414321994862, 5928.288605367211, 5937.168796368425, 5943.8706645737175, 5943.881122377615, 5947.821565353046, 5696.772129114789, 5756.481916627524, 5816.970915145397, 5824.009918313812, 5851.191428114444, 5709.571782116275, 5758.683272420057, 5763.328634695891, 5768.740406681625, 5778.393268706894, 5716.9428305718075, 5739.2252045973255, 5746.597738158456, 5765.4811067004175, 5772.393898640582, 5643.322801263875, 5783.971080144573, 5867.178594996619, 5872.500837428866, 5885.440883116097, 5679.261695979661, 5700.745835916092, 5703.429657034263, 5707.400722924033, 5735.942640573541], "value": 4263.768873901027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.7680742162506, 751.6579956119965, 775.1124961918604, 825.8596038673433, 853.24487828272, 15117.244137793108, 16175.191240437975, 16175.595610109753, 16188.109653969057, 16330.265138068786, 14725.190114543695, 14765.0, 14849.0, 14861.108333499971, 14910.925445372784, 654.1463390275712, 773.2422226218296, 794.1264608930188, 816.5304949653943, 817.546261824687, 811.1320886651285, 813.9145389734082, 815.4006804998321, 816.2042009041197, 817.4196320612373, 869.3306154261215, 875.8598624220126, 876.132628697588, 876.3602570123782, 876.5222953490331, 867.6269204242174, 869.0570730757136, 870.9042005379404, 871.3639043498218, 871.481468526229, 622.5299898576591, 629.7606909374455, 631.3370960491511, 635.9618422894641, 636.8726254749068, 14892.255387230703, 14925.10449373041, 14964.850351496563, 14984.70030599382, 14989.250537473083, 12834.422450989729, 12851.742965140738, 13066.477340906353, 13141.737165256642, 13318.667033324147, 11509.366984815832, 11854.0, 12106.81839772404, 12175.817362739566, 12290.754184916252, 3904.2386734586767, 3915.0, 3919.510061242345, 3932.58707835676, 4042.8382864685377, 73872.63063684647, 74356.0, 76488.8526672106, 76552.23447765563, 76628.61685691592, 11400.201985861077, 11594.246373985665, 11720.238184517979, 11827.940860295643, 12249.938750306192, 21775.693458392547, 21822.0, 21829.345119646438, 21858.672119918214, 21947.0, 8626.18051285127, 8649.43778654398, 8674.73975780715, 8970.147835955573, 8977.0, 4553.54464553542, 4578.336141259499, 4626.930596041062, 4786.425628924551, 4793.976030119897, 3424.229548351601, 3519.718422526243, 3535.7878527288444, 3556.342076715816, 3565.554305711786, 619.9597026193283, 626.3579830673596, 630.7666163519435, 637.9649119298483, 639.1626968671055, 571.3144226927703, 615.6860001399318, 640.9647469389135, 708.3412426443457, 725.7419992156753, 9163.81672366549, 10048.14590759779, 10151.543180556893, 10210.846837297446, 10415.1667866572, 717.5515302935665, 764.9732259370895, 768.6080099149362, 770.6647608290411, 791.161368948916, 4486.371907932892, 4886.951130488721, 4996.575291100225, 4997.475265097185, 5039.647224694236, 106665.0, 111526.44236778926, 113520.43239783749, 114235.0, 120130.0, 81871.0, 100734.49632751936, 101564.49217754012, 102584.0, 104484.0, 81309.0, 82700.0, 83352.58323708343, 83882.0, 83887.5805620968, 8884.689035883714, 8957.820843582962, 9030.954845225731, 9065.728028158903, 9202.558209253415, 50411.243831341824, 50457.0, 52158.21762673639, 52298.21552676637, 52507.212391814915, 69386.65306673435, 73637.63181184274, 73674.26325736889, 74456.25543744494, 75222.0, 11751.47118379692, 11752.0, 12104.152709310263, 12168.756624867276, 12326.50693972231, 12655.93672031634, 12964.546240881524, 13066.794254557642, 13140.671483212996, 13196.802047969097, 11034.565506484105, 11133.665990020312, 11213.495392707184, 11371.147163962902, 11637.88362116368, 12540.310282934526, 12569.87430125687, 12777.744445111231, 12859.357032148167, 12965.22208667483, 12038.638840834788, 12376.62870113898, 12518.186317889307, 12854.871451285742, 13270.203787772765, 10628.468576571295, 10706.089982351587, 10741.462926853783, 10865.674029779118, 10881.292715973437, 9568.330216884751, 10789.1368690503, 10845.186611004365, 10893.0, 11019.338839669645], "value": 7432.3562556924435, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 105.0, 112.0, 113.0, 112.0, 98.0, 112.0, 111.0, 112.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 118.0, 141.0, 181.0, 120.0, 155.0, 148.0, 119.0, 195.0, 118.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 163.0, 167.0, 165.0, 194.0, 165.0, 161.0, 163.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 176.0, 76.0, 76.0, 74.0, 75.0, 179.0, 78.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 151.0, 85.0, 85.0, 84.0, 141.0, 85.0, 84.0, 152.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 149.0, 149.0, 149.0, 148.0, 148.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 54.0, 56.0, 53.0, 56.0, 52.0, 53.0, 54.0, 53.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 82.0, 75.0, 81.0, 75.0, 75.0, 81.0, 75.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 120.0, 125.0, 128.0, 129.0, 131.0, 124.0, 122.0, 165.0, 123.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 163.0, 159.0, 159.0, 159.0, 157.0, 164.0, 156.0, 158.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 69.0, 64.0, 63.0, 65.0, 64.0, 64.0], "value": 64.5, "unit": "score"}]}]} 13:13:50 INFO - Return code: 0 13:13:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:13:50 ERROR - # TBPL SUCCESS # 13:13:50 INFO - Running post-action listener: _resource_record_post_action 13:13:50 INFO - [mozharness: 2016-07-22 20:13:50.608115Z] Finished run-tests step (success) 13:13:50 INFO - Running post-run listener: _resource_record_post_run 13:13:50 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 562876416; Read time: 0; Write time: 491640 13:13:50 INFO - TinderboxPrint: CPU usage
13.4% 13:13:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:13:50 INFO - TinderboxPrint: I/O write bytes / time
562,876,416 / 491,640 13:13:50 INFO - TinderboxPrint: CPU idle
8,225.9 (86.6%) 13:13:50 INFO - TinderboxPrint: CPU user
1,218.0 (12.8%) 13:13:50 INFO - TinderboxPrint: Swap in / out
0 / 0 13:13:50 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 268353536; Read time: 0; Write time: 292576 13:13:50 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 294281216; Read time: 0; Write time: 198988 13:13:51 INFO - Running post-run listener: _upload_blobber_files 13:13:51 INFO - Blob upload gear active. 13:13:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:13:51 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 13:13:51 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'] 13:13:51 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 13:13:51 INFO - (blobuploader) - INFO - Open directory for files ... 13:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:52 INFO - (blobuploader) - INFO - Done attempting. 13:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:53 INFO - (blobuploader) - INFO - Done attempting. 13:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:14:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:00 INFO - (blobuploader) - INFO - Done attempting. 13:14:00 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:00 INFO - Return code: 0 13:14:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d991ff19f05fcc8c332c293aaa2bcb95bca07ac246bf0a33083d559213cca7aa199f15edcd9be0632b67ccea9faae104c2aa75a403d65ed09375ed4c25e5e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae18d2ce14fe39da5fc57bc615a1898f4b2c58b2324f7b7c75223ce9fb6cd5e5d14cafff6d489c1823a27093d874e842a4c9e409abf3310c695ef4a85c67f38b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e8671aa3fe837c8a1a4bdcd5fc8be2dcb383d4e6ab6b0288f2fb8bd715470d417c71d682690e65dd684a5fa78dc89764d5341be329f7b08963e98484534eb144"} 13:14:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:00 INFO - Contents: 13:14:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d991ff19f05fcc8c332c293aaa2bcb95bca07ac246bf0a33083d559213cca7aa199f15edcd9be0632b67ccea9faae104c2aa75a403d65ed09375ed4c25e5e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae18d2ce14fe39da5fc57bc615a1898f4b2c58b2324f7b7c75223ce9fb6cd5e5d14cafff6d489c1823a27093d874e842a4c9e409abf3310c695ef4a85c67f38b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e8671aa3fe837c8a1a4bdcd5fc8be2dcb383d4e6ab6b0288f2fb8bd715470d417c71d682690e65dd684a5fa78dc89764d5341be329f7b08963e98484534eb144"} 13:14:00 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:00 INFO - Copying logs to upload dir... 13:14:00 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.582484 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-22 13:14:00.266226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 13:14:00.269649) ========= 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=db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977 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/6d991ff19f05fcc8c332c293aaa2bcb95bca07ac246bf0a33083d559213cca7aa199f15edcd9be0632b67ccea9faae104c2aa75a403d65ed09375ed4c25e5e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae18d2ce14fe39da5fc57bc615a1898f4b2c58b2324f7b7c75223ce9fb6cd5e5d14cafff6d489c1823a27093d874e842a4c9e409abf3310c695ef4a85c67f38b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e8671aa3fe837c8a1a4bdcd5fc8be2dcb383d4e6ab6b0288f2fb8bd715470d417c71d682690e65dd684a5fa78dc89764d5341be329f7b08963e98484534eb144"} build_url:https://queue.taskcluster.net/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/T7TiM5WgRg-kK5jJcZh3SQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6d991ff19f05fcc8c332c293aaa2bcb95bca07ac246bf0a33083d559213cca7aa199f15edcd9be0632b67ccea9faae104c2aa75a403d65ed09375ed4c25e5e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ae18d2ce14fe39da5fc57bc615a1898f4b2c58b2324f7b7c75223ce9fb6cd5e5d14cafff6d489c1823a27093d874e842a4c9e409abf3310c695ef4a85c67f38b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e8671aa3fe837c8a1a4bdcd5fc8be2dcb383d4e6ab6b0288f2fb8bd715470d417c71d682690e65dd684a5fa78dc89764d5341be329f7b08963e98484534eb144"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 13:14:00.294533) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:14:00.294865) ========= 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=db7e7c15f3ca076d53731445000001ba-1469217206.129832-25840977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:14:00.381546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 13:14:00.381881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 13:14:00.382219) ========= ========= Total master_lag: 0.17 =========