builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1468116737.4 results: success (0) buildid: 20160709163003 builduid: a5041026c4fe4d73a6e166a8058da815 revision: 2393f903d0a732960e73ae00489d0758d5f526f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:17.398057) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:17.398476) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:17.398802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:17.443025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:17.443357) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 19:12:18-- 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% 229M=0s 2016-07-09 19:12:18 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126990 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:17.585125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:17.585447) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:17.635485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:17.635853) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 2393f903d0a732960e73ae00489d0758d5f526f0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 2393f903d0a732960e73ae00489d0758d5f526f0 --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=5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 19:12:18,785 truncating revision to first 12 chars 2016-07-09 19:12:18,785 Setting DEBUG logging. 2016-07-09 19:12:18,785 attempt 1/10 2016-07-09 19:12:18,785 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/2393f903d0a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 19:12:19,362 unpacking tar archive at: mozilla-inbound-2393f903d0a7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914904 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:18.564429) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:18.564775) ========= script_repo_revision: 2393f903d0a732960e73ae00489d0758d5f526f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:18.565189) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:18.565489) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 19:12:18.581132) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-09 19:12:18.581430) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:12:19 INFO - MultiFileLogger online at 20160709 19:12:19 in /builds/slave/test 19:12:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:12:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:12:19 INFO - {'append_to_log': False, 19:12:19 INFO - 'base_work_dir': '/builds/slave/test', 19:12:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:12:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:12:19 INFO - 'branch': 'Mozilla-Inbound', 19:12:19 INFO - 'buildbot_json_path': 'buildprops.json', 19:12:19 INFO - 'config_files': ('talos/linux_config.py',), 19:12:19 INFO - 'default_actions': ('clobber', 19:12:19 INFO - 'read-buildbot-config', 19:12:19 INFO - 'download-and-extract', 19:12:19 INFO - 'populate-webroot', 19:12:19 INFO - 'create-virtualenv', 19:12:19 INFO - 'install', 19:12:19 INFO - 'run-tests'), 19:12:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:12:19 INFO - 'download_minidump_stackwalk': True, 19:12:19 INFO - 'download_symbols': 'ondemand', 19:12:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:12:19 INFO - 'tooltool.py': '/tools/tooltool.py', 19:12:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:12:19 INFO - '/tools/misc-python/virtualenv.py')}, 19:12:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:12:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:12:19 INFO - 'installer_path': 'installer.exe', 19:12:19 INFO - 'log_level': 'info', 19:12:19 INFO - 'log_name': 'talos', 19:12:19 INFO - 'log_to_console': True, 19:12:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:12:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:12:19 INFO - 'opt_config_files': (), 19:12:19 INFO - 'pip_index': False, 19:12:19 INFO - 'sps_profile': False, 19:12:19 INFO - 'sps_profile_interval': 0, 19:12:19 INFO - 'suite': 'dromaeojs-e10s', 19:12:19 INFO - 'system_bits': '32', 19:12:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:12:19 INFO - 'title': 'talos-linux64-ix-039', 19:12:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:12:19 INFO - 'use_talos_json': True, 19:12:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:12:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:12:19 INFO - 'work_dir': 'build'} 19:12:19 INFO - ##### 19:12:19 INFO - ##### Running clobber step. 19:12:19 INFO - ##### 19:12:19 INFO - Running pre-action listener: _resource_record_pre_action 19:12:19 INFO - Running main action method: clobber 19:12:19 INFO - rmtree: /builds/slave/test/build 19:12:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:12:20 INFO - Running post-action listener: _resource_record_post_action 19:12:20 INFO - ##### 19:12:20 INFO - ##### Finished clobber step (success) 19:12:20 INFO - ##### 19:12:20 INFO - ##### 19:12:20 INFO - ##### Running read-buildbot-config step. 19:12:20 INFO - ##### 19:12:20 INFO - Running pre-action listener: _resource_record_pre_action 19:12:20 INFO - Running main action method: read_buildbot_config 19:12:20 INFO - Using buildbot properties: 19:12:20 INFO - { 19:12:20 INFO - "project": "", 19:12:20 INFO - "product": "firefox", 19:12:20 INFO - "script_repo_revision": "production", 19:12:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:12:20 INFO - "repository": "", 19:12:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:12:20 INFO - "buildid": "20160709163003", 19:12:20 INFO - "pgo_build": "True", 19:12:20 INFO - "basedir": "/builds/slave/test", 19:12:20 INFO - "buildnumber": 809, 19:12:20 INFO - "slavename": "talos-linux64-ix-039", 19:12:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:12:20 INFO - "platform": "ubuntu64_hw", 19:12:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:12:20 INFO - "branch": "mozilla-inbound", 19:12:20 INFO - "repo_path": "integration/mozilla-inbound", 19:12:20 INFO - "revision": "2393f903d0a732960e73ae00489d0758d5f526f0", 19:12:20 INFO - "stage_platform": "linux64-pgo", 19:12:20 INFO - "builduid": "a5041026c4fe4d73a6e166a8058da815", 19:12:20 INFO - "slavebuilddir": "test" 19:12:20 INFO - } 19:12:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:12:20 INFO - Running post-action listener: _resource_record_post_action 19:12:20 INFO - ##### 19:12:20 INFO - ##### Finished read-buildbot-config step (success) 19:12:20 INFO - ##### 19:12:20 INFO - ##### 19:12:20 INFO - ##### Running download-and-extract step. 19:12:20 INFO - ##### 19:12:20 INFO - Running pre-action listener: _resource_record_pre_action 19:12:20 INFO - Running main action method: download_and_extract 19:12:20 INFO - mkdir: /builds/slave/test/build/tests 19:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:12:20 INFO - https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:12:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:12:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:12:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 19:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 19:12:28 INFO - retry: attempt #1 caught exception: '' 19:12:28 INFO - retry: Failed, sleeping 30 seconds before retrying 19:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 #2 19:12:59 INFO - Downloaded 1361 bytes. 19:12:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:12:59 INFO - Using the following test package requirements: 19:12:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:12:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:12:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:12:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:59 INFO - u'jsshell-linux-x86_64.zip'], 19:12:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:12:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:12:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:12:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:12:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:12:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:12:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:12:59 INFO - https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 19:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 19:13:00 INFO - Downloaded 24304334 bytes. 19:13:00 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'] 19:13:00 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 19:13:01 INFO - Return code: 0 19:13:01 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 19:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:13:01 INFO - https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:13:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:13:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:13:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 19:13:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 19:13:02 INFO - Downloaded 24304334 bytes. 19:13:02 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'] 19:13:02 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 19:13:03 INFO - Return code: 0 19:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:13:03 INFO - https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:13:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:13:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:13:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 19:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 19:13:04 INFO - Downloaded 14403333 bytes. 19:13:04 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'] 19:13:04 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 19:13:05 INFO - Return code: 0 19:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:13:05 INFO - https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:13:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 19:13:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E9CZ37GfSFa0u5kqu7agFw/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 19:13:06 INFO - Downloaded 60481389 bytes. 19:13:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:06 INFO - mkdir: /builds/slave/test/properties 19:13:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:13:06 INFO - Writing to file /builds/slave/test/properties/build_url 19:13:06 INFO - Contents: 19:13:06 INFO - build_url:https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:13:07 INFO - Running post-action listener: _resource_record_post_action 19:13:07 INFO - Running post-action listener: set_extra_try_arguments 19:13:07 INFO - ##### 19:13:07 INFO - ##### Finished download-and-extract step (success) 19:13:07 INFO - ##### 19:13:07 INFO - ##### 19:13:07 INFO - ##### Running populate-webroot step. 19:13:07 INFO - ##### 19:13:07 INFO - Running pre-action listener: _resource_record_pre_action 19:13:07 INFO - Running main action method: populate_webroot 19:13:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:13:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:13:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:13:07 INFO - '--tppagecycles', 19:13:07 INFO - '7'], 19:13:07 INFO - 'tests': ['tsvgm']}}, 19:13:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:13:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:13:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:13:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:13:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:07 INFO - 'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:13:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:13:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:07 INFO - 'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['damp', 'tps']}, 19:13:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:07 INFO - 'tests': ['damp', 'tps']}, 19:13:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['dromaeo_dom']}, 19:13:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:13:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['basic_compositor_video']}, 19:13:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:13:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['a11yr', 19:13:07 INFO - 'ts_paint', 19:13:07 INFO - 'tpaint', 19:13:07 INFO - 'sessionrestore', 19:13:07 INFO - 'sessionrestore_no_auto_restore', 19:13:07 INFO - 'tabpaint']}, 19:13:07 INFO - 'other-e10s': {'tests': ['a11yr', 19:13:07 INFO - 'ts_paint', 19:13:07 INFO - 'tpaint', 19:13:07 INFO - 'sessionrestore', 19:13:07 INFO - 'sessionrestore_no_auto_restore', 19:13:07 INFO - 'tabpaint']}, 19:13:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:13:07 INFO - 'ts_paint', 19:13:07 INFO - 'tpaint', 19:13:07 INFO - 'sessionrestore', 19:13:07 INFO - 'sessionrestore_no_auto_restore', 19:13:07 INFO - 'tabpaint']}, 19:13:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:13:07 INFO - 'ts_paint', 19:13:07 INFO - 'tpaint', 19:13:07 INFO - 'sessionrestore', 19:13:07 INFO - 'sessionrestore_no_auto_restore', 19:13:07 INFO - 'tabpaint']}, 19:13:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['a11yr', 19:13:07 INFO - 'ts_paint', 19:13:07 INFO - 'tpaint', 19:13:07 INFO - 'sessionrestore', 19:13:07 INFO - 'sessionrestore_no_auto_restore', 19:13:07 INFO - 'tabpaint']}, 19:13:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['a11yr', 19:13:07 INFO - 'ts_paint', 19:13:07 INFO - 'tpaint', 19:13:07 INFO - 'sessionrestore', 19:13:07 INFO - 'sessionrestore_no_auto_restore', 19:13:07 INFO - 'tabpaint']}, 19:13:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['tsvgx', 19:13:07 INFO - 'tsvgr_opacity', 19:13:07 INFO - 'tart', 19:13:07 INFO - 'tscrollx', 19:13:07 INFO - 'cart']}, 19:13:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:13:07 INFO - 'tsvgr_opacity', 19:13:07 INFO - 'tart', 19:13:07 INFO - 'tscrollx', 19:13:07 INFO - 'cart']}, 19:13:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:07 INFO - 'talos_options': ['--disable-e10s'], 19:13:07 INFO - 'tests': ['tp5o']}, 19:13:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:07 INFO - 'tests': ['tp5o']}, 19:13:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:07 INFO - 'talos_options': ['--disable-e10s', 19:13:07 INFO - '--xperf_path', 19:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:13:07 INFO - 'tests': ['tp5n']}, 19:13:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:13:07 INFO - 'talos_options': ['--xperf_path', 19:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:13:07 INFO - 'tests': ['tp5n']}}, 19:13:07 INFO - 'talos.zip': {'path': '', 19:13:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:13:07 INFO - Running post-action listener: _resource_record_post_action 19:13:07 INFO - ##### 19:13:07 INFO - ##### Finished populate-webroot step (success) 19:13:07 INFO - ##### 19:13:07 INFO - ##### 19:13:07 INFO - ##### Running create-virtualenv step. 19:13:07 INFO - ##### 19:13:07 INFO - Running pre-action listener: _resource_record_pre_action 19:13:07 INFO - Running main action method: create_virtualenv 19:13:07 INFO - Creating virtualenv /builds/slave/test/build/venv 19:13:07 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 19:13:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:13:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:13:07 INFO - Using real prefix '/usr' 19:13:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:13:07 INFO - Installing distribute.............................................................................................................................................................................................done. 19:13:09 INFO - Installing pip.................done. 19:13:09 INFO - Return code: 0 19:13:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:13:09 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')]} 19:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:09 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')]} 19:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:09 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 0x224b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2509570>, '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 0x250a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', '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 19:13:09 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 19:13:09 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 19:13:09 INFO - Using env: {'DISPLAY': ':0', 19:13:09 INFO - 'HOME': '/home/cltbld', 19:13:09 INFO - 'LANG': 'en_US.UTF-8', 19:13:09 INFO - 'LANGUAGE': 'en_US:en', 19:13:09 INFO - 'LOGNAME': 'cltbld', 19:13:09 INFO - 'MAIL': '/var/mail/cltbld', 19:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:09 INFO - 'MOZ_NO_REMOTE': '1', 19:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:09 INFO - 'NO_EM_RESTART': '1', 19:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:09 INFO - 'PWD': '/builds/slave/test', 19:13:09 INFO - 'SHELL': '/bin/bash', 19:13:09 INFO - 'SHLVL': '1', 19:13:09 INFO - 'TERM': 'linux', 19:13:09 INFO - 'TMOUT': '86400', 19:13:09 INFO - 'USER': 'cltbld', 19:13:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', 19:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:09 INFO - '_': '/tools/buildbot/bin/python'} 19:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:10 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 19:13:10 INFO - Cleaning up... 19:13:10 INFO - Return code: 0 19:13:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:13:10 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')]} 19:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:10 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')]} 19:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:10 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 0x224b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2509570>, '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 0x250a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', '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 19:13:10 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 19:13:10 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 19:13:10 INFO - Using env: {'DISPLAY': ':0', 19:13:10 INFO - 'HOME': '/home/cltbld', 19:13:10 INFO - 'LANG': 'en_US.UTF-8', 19:13:10 INFO - 'LANGUAGE': 'en_US:en', 19:13:10 INFO - 'LOGNAME': 'cltbld', 19:13:10 INFO - 'MAIL': '/var/mail/cltbld', 19:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:10 INFO - 'MOZ_NO_REMOTE': '1', 19:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:10 INFO - 'NO_EM_RESTART': '1', 19:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:10 INFO - 'PWD': '/builds/slave/test', 19:13:10 INFO - 'SHELL': '/bin/bash', 19:13:10 INFO - 'SHLVL': '1', 19:13:10 INFO - 'TERM': 'linux', 19:13:10 INFO - 'TMOUT': '86400', 19:13:10 INFO - 'USER': 'cltbld', 19:13:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', 19:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:10 INFO - '_': '/tools/buildbot/bin/python'} 19:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:10 INFO - Downloading/unpacking psutil>=3.1.1 19:13:10 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 19:13:10 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 19:13:10 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 19:13:10 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 19:13:10 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 19:13:10 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 19:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:13:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:12 INFO - Installing collected packages: psutil 19:13:12 INFO - Running setup.py install for psutil 19:13:12 INFO - building 'psutil._psutil_linux' extension 19:13:12 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 19:13:12 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 19:13:12 INFO - building 'psutil._psutil_posix' extension 19:13:12 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 19:13:12 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 19:13:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:12 INFO - Successfully installed psutil 19:13:12 INFO - Cleaning up... 19:13:12 INFO - Return code: 0 19:13:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:13:12 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')]} 19:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:12 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')]} 19:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:12 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 0x224b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2509570>, '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 0x250a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', '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 19:13:12 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 19:13:12 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 19:13:12 INFO - Using env: {'DISPLAY': ':0', 19:13:12 INFO - 'HOME': '/home/cltbld', 19:13:12 INFO - 'LANG': 'en_US.UTF-8', 19:13:12 INFO - 'LANGUAGE': 'en_US:en', 19:13:12 INFO - 'LOGNAME': 'cltbld', 19:13:12 INFO - 'MAIL': '/var/mail/cltbld', 19:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:12 INFO - 'MOZ_NO_REMOTE': '1', 19:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:12 INFO - 'NO_EM_RESTART': '1', 19:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:12 INFO - 'PWD': '/builds/slave/test', 19:13:12 INFO - 'SHELL': '/bin/bash', 19:13:12 INFO - 'SHLVL': '1', 19:13:12 INFO - 'TERM': 'linux', 19:13:12 INFO - 'TMOUT': '86400', 19:13:12 INFO - 'USER': 'cltbld', 19:13:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', 19:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:12 INFO - '_': '/tools/buildbot/bin/python'} 19:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:13:13 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 19:13:13 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 19:13:13 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 19:13:13 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 19:13:13 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 19:13:13 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 19:13:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:13:15 INFO - Installing collected packages: mozsystemmonitor 19:13:15 INFO - Running setup.py install for mozsystemmonitor 19:13:15 INFO - Successfully installed mozsystemmonitor 19:13:15 INFO - Cleaning up... 19:13:15 INFO - Return code: 0 19:13:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:13:15 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')]} 19:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:15 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')]} 19:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:15 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 0x224b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2509570>, '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 0x250a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', '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 19:13:15 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 19:13:15 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 19:13:15 INFO - Using env: {'DISPLAY': ':0', 19:13:15 INFO - 'HOME': '/home/cltbld', 19:13:15 INFO - 'LANG': 'en_US.UTF-8', 19:13:15 INFO - 'LANGUAGE': 'en_US:en', 19:13:15 INFO - 'LOGNAME': 'cltbld', 19:13:15 INFO - 'MAIL': '/var/mail/cltbld', 19:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:15 INFO - 'MOZ_NO_REMOTE': '1', 19:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:15 INFO - 'NO_EM_RESTART': '1', 19:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:15 INFO - 'PWD': '/builds/slave/test', 19:13:15 INFO - 'SHELL': '/bin/bash', 19:13:15 INFO - 'SHLVL': '1', 19:13:15 INFO - 'TERM': 'linux', 19:13:15 INFO - 'TMOUT': '86400', 19:13:15 INFO - 'USER': 'cltbld', 19:13:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', 19:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:15 INFO - '_': '/tools/buildbot/bin/python'} 19:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:13:15 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 19:13:15 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 19:13:15 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 19:13:15 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 19:13:15 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 19:13:15 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 19:13:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:13:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:13:17 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 19:13:17 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 19:13:17 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 19:13:17 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 19:13:17 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 19:13:17 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 19:13:17 INFO - Downloading functools32-3.2.3-2.tar.gz 19:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:13:17 INFO - warning: no files found matching '*.txt' 19:13:17 INFO - no previously-included directories found matching 'build' 19:13:17 INFO - no previously-included directories found matching 'dist' 19:13:17 INFO - no previously-included directories found matching '.git*' 19:13:17 INFO - Installing collected packages: jsonschema, functools32 19:13:17 INFO - Running setup.py install for functools32 19:13:17 INFO - warning: no files found matching '*.txt' 19:13:17 INFO - no previously-included directories found matching 'build' 19:13:17 INFO - no previously-included directories found matching 'dist' 19:13:17 INFO - no previously-included directories found matching '.git*' 19:13:17 INFO - Successfully installed jsonschema functools32 19:13:17 INFO - Cleaning up... 19:13:17 INFO - Return code: 0 19:13:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:13:17 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')]} 19:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:17 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')]} 19:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:17 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 0x224b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2509570>, '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 0x250a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', '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 19:13:17 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 19:13:17 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 19:13:17 INFO - Using env: {'DISPLAY': ':0', 19:13:17 INFO - 'HOME': '/home/cltbld', 19:13:17 INFO - 'LANG': 'en_US.UTF-8', 19:13:17 INFO - 'LANGUAGE': 'en_US:en', 19:13:17 INFO - 'LOGNAME': 'cltbld', 19:13:17 INFO - 'MAIL': '/var/mail/cltbld', 19:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:17 INFO - 'MOZ_NO_REMOTE': '1', 19:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:17 INFO - 'NO_EM_RESTART': '1', 19:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:17 INFO - 'PWD': '/builds/slave/test', 19:13:17 INFO - 'SHELL': '/bin/bash', 19:13:17 INFO - 'SHLVL': '1', 19:13:17 INFO - 'TERM': 'linux', 19:13:17 INFO - 'TMOUT': '86400', 19:13:17 INFO - 'USER': 'cltbld', 19:13:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', 19:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:17 INFO - '_': '/tools/buildbot/bin/python'} 19:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:17 INFO - Downloading/unpacking blobuploader==1.2.4 19:13:17 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 19:13:17 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 19:13:17 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 19:13:17 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 19:13:17 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 19:13:17 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 19:13:19 INFO - Downloading blobuploader-1.2.4.tar.gz 19:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:13:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:13:19 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 19:13:19 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 19:13:19 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 19:13:19 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 19:13:19 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 19:13:19 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 19:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:13:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:13:20 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 19:13:20 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 19:13:20 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 19:13:20 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 19:13:20 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 19:13:20 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 19:13:20 INFO - Downloading docopt-0.6.1.tar.gz 19:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:13:20 INFO - Installing collected packages: blobuploader, requests, docopt 19:13:20 INFO - Running setup.py install for blobuploader 19:13:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:13:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:13:20 INFO - Running setup.py install for requests 19:13:21 INFO - Running setup.py install for docopt 19:13:21 INFO - Successfully installed blobuploader requests docopt 19:13:21 INFO - Cleaning up... 19:13:21 INFO - Return code: 0 19:13:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:21 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 0x224b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2509570>, '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 0x250a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', '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 19:13:21 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 19:13:21 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 19:13:21 INFO - Using env: {'DISPLAY': ':0', 19:13:21 INFO - 'HOME': '/home/cltbld', 19:13:21 INFO - 'LANG': 'en_US.UTF-8', 19:13:21 INFO - 'LANGUAGE': 'en_US:en', 19:13:21 INFO - 'LOGNAME': 'cltbld', 19:13:21 INFO - 'MAIL': '/var/mail/cltbld', 19:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:21 INFO - 'MOZ_NO_REMOTE': '1', 19:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:21 INFO - 'NO_EM_RESTART': '1', 19:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:21 INFO - 'PWD': '/builds/slave/test', 19:13:21 INFO - 'SHELL': '/bin/bash', 19:13:21 INFO - 'SHLVL': '1', 19:13:21 INFO - 'TERM': 'linux', 19:13:21 INFO - 'TMOUT': '86400', 19:13:21 INFO - 'USER': 'cltbld', 19:13:21 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', 19:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:21 INFO - '_': '/tools/buildbot/bin/python'} 19:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:13:21 INFO - Running setup.py (path:/tmp/pip-8WTi5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:13:21 INFO - Running setup.py (path:/tmp/pip-zrS8Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:13:21 INFO - Running setup.py (path:/tmp/pip-aeKm_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:13:21 INFO - Running setup.py (path:/tmp/pip-Fv7ySb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:13:21 INFO - Running setup.py (path:/tmp/pip-QoSFC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:13:21 INFO - Running setup.py (path:/tmp/pip-0yQUKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:13:21 INFO - Running setup.py (path:/tmp/pip-sFFufi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:13:21 INFO - Running setup.py (path:/tmp/pip-rVH0PU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:13:21 INFO - Running setup.py (path:/tmp/pip-fJQysp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:13:22 INFO - Running setup.py (path:/tmp/pip-ji8d0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:13:22 INFO - Running setup.py (path:/tmp/pip-qDqVvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:13:22 INFO - Running setup.py (path:/tmp/pip-WyQ5e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:13:22 INFO - Running setup.py (path:/tmp/pip-wtnDVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:13:22 INFO - Running setup.py (path:/tmp/pip-taRcDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:22 INFO - Running setup.py (path:/tmp/pip-Yzc0q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:13:22 INFO - Running setup.py (path:/tmp/pip-EykKcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:13:22 INFO - Running setup.py (path:/tmp/pip-KFYK9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:13:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:13:22 INFO - Running setup.py install for manifestparser 19:13:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:13:22 INFO - Running setup.py install for mozcrash 19:13:22 INFO - Running setup.py install for mozdebug 19:13:22 INFO - Running setup.py install for mozdevice 19:13:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Running setup.py install for mozfile 19:13:23 INFO - Running setup.py install for mozhttpd 19:13:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Running setup.py install for mozinfo 19:13:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Running setup.py install for mozInstall 19:13:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Running setup.py install for mozleak 19:13:23 INFO - Running setup.py install for mozlog 19:13:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Running setup.py install for moznetwork 19:13:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Running setup.py install for mozprocess 19:13:23 INFO - Running setup.py install for mozprofile 19:13:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:13:23 INFO - Running setup.py install for mozrunner 19:13:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:13:24 INFO - Running setup.py install for mozscreenshot 19:13:24 INFO - Running setup.py install for moztest 19:13:24 INFO - Running setup.py install for mozversion 19:13:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:13:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:13:24 INFO - Cleaning up... 19:13:24 INFO - Return code: 0 19:13:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:13:24 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')]} 19:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:24 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')]} 19:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:24 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 0x224b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2509570>, '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 0x250a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', '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 19:13:24 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 19:13:24 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 19:13:24 INFO - Using env: {'DISPLAY': ':0', 19:13:24 INFO - 'HOME': '/home/cltbld', 19:13:24 INFO - 'LANG': 'en_US.UTF-8', 19:13:24 INFO - 'LANGUAGE': 'en_US:en', 19:13:24 INFO - 'LOGNAME': 'cltbld', 19:13:24 INFO - 'MAIL': '/var/mail/cltbld', 19:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:24 INFO - 'MOZ_NO_REMOTE': '1', 19:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:24 INFO - 'NO_EM_RESTART': '1', 19:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:24 INFO - 'PWD': '/builds/slave/test', 19:13:24 INFO - 'SHELL': '/bin/bash', 19:13:24 INFO - 'SHLVL': '1', 19:13:24 INFO - 'TERM': 'linux', 19:13:24 INFO - 'TMOUT': '86400', 19:13:24 INFO - 'USER': 'cltbld', 19:13:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', 19:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:24 INFO - '_': '/tools/buildbot/bin/python'} 19:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:13:24 INFO - Running setup.py (path:/tmp/pip-jkz4rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:13:24 INFO - Running setup.py (path:/tmp/pip-mw4unt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:13:24 INFO - Running setup.py (path:/tmp/pip-RkYEaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:13:24 INFO - Running setup.py (path:/tmp/pip-upqL9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:13:24 INFO - Running setup.py (path:/tmp/pip-S4bE5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:13:24 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)) 19:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:13:25 INFO - Running setup.py (path:/tmp/pip-P36EUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:13:25 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:13:25 INFO - Running setup.py (path:/tmp/pip-vE3krX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:13:25 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:13:25 INFO - Running setup.py (path:/tmp/pip-6UY9cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:13:25 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:13:25 INFO - Running setup.py (path:/tmp/pip-Hk42MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:13:25 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:13:25 INFO - Running setup.py (path:/tmp/pip-klgGOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:13:25 INFO - Running setup.py (path:/tmp/pip-qxK0nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:13:25 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:13:25 INFO - Running setup.py (path:/tmp/pip-E_1KZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:13:25 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:13:25 INFO - Running setup.py (path:/tmp/pip-AldXes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:13:25 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:13:25 INFO - Running setup.py (path:/tmp/pip-UeLzLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:13:25 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:25 INFO - Running setup.py (path:/tmp/pip-jKPtQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:25 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:13:25 INFO - Running setup.py (path:/tmp/pip-hPDtgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:13:25 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)) 19:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:13:25 INFO - Running setup.py (path:/tmp/pip-MsPUQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:13:25 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)) 19:13:25 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)) 19:13:25 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)) 19:13:25 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)) 19:13:25 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)) 19:13:25 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)) 19:13:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:13:25 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 19:13:25 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 19:13:25 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 19:13:25 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 19:13:25 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 19:13:25 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 19:13:27 INFO - Downloading blessings-1.6.tar.gz 19:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:13:27 INFO - Installing collected packages: blessings 19:13:27 INFO - Running setup.py install for blessings 19:13:27 INFO - Successfully installed blessings 19:13:27 INFO - Cleaning up... 19:13:27 INFO - Return code: 0 19:13:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:13:28 INFO - Reading from file tmpfile_stdout 19:13:28 INFO - Current package versions: 19:13:28 INFO - argparse == 1.2.1 19:13:28 INFO - blessings == 1.6 19:13:28 INFO - blobuploader == 1.2.4 19:13:28 INFO - docopt == 0.6.1 19:13:28 INFO - functools32 == 3.2.3-2 19:13:28 INFO - jsonschema == 2.5.1 19:13:28 INFO - manifestparser == 1.1 19:13:28 INFO - mozInstall == 1.12 19:13:28 INFO - mozcrash == 0.17 19:13:28 INFO - mozdebug == 0.1 19:13:28 INFO - mozdevice == 0.48 19:13:28 INFO - mozfile == 1.2 19:13:28 INFO - mozhttpd == 0.7 19:13:28 INFO - mozinfo == 0.9 19:13:28 INFO - mozleak == 0.1 19:13:28 INFO - mozlog == 3.2 19:13:28 INFO - moznetwork == 0.27 19:13:28 INFO - mozprocess == 0.23 19:13:28 INFO - mozprofile == 0.28 19:13:28 INFO - mozrunner == 6.12 19:13:28 INFO - mozscreenshot == 0.1 19:13:28 INFO - mozsystemmonitor == 0.3 19:13:28 INFO - moztest == 0.7 19:13:28 INFO - mozversion == 1.4 19:13:28 INFO - psutil == 3.1.1 19:13:28 INFO - requests == 1.2.3 19:13:28 INFO - wsgiref == 0.1.2 19:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:13: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')]} 19:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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')]} 19:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:28 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 0x224b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2509570>, '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 0x250a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', '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 19:13:28 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 19:13:28 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 19:13:28 INFO - Using env: {'DISPLAY': ':0', 19:13:28 INFO - 'HOME': '/home/cltbld', 19:13:28 INFO - 'LANG': 'en_US.UTF-8', 19:13:28 INFO - 'LANGUAGE': 'en_US:en', 19:13:28 INFO - 'LOGNAME': 'cltbld', 19:13:28 INFO - 'MAIL': '/var/mail/cltbld', 19:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:28 INFO - 'MOZ_NO_REMOTE': '1', 19:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:28 INFO - 'NO_EM_RESTART': '1', 19:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:28 INFO - 'PWD': '/builds/slave/test', 19:13:28 INFO - 'SHELL': '/bin/bash', 19:13:28 INFO - 'SHLVL': '1', 19:13:28 INFO - 'TERM': 'linux', 19:13:28 INFO - 'TMOUT': '86400', 19:13:28 INFO - 'USER': 'cltbld', 19:13:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', 19:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:28 INFO - '_': '/tools/buildbot/bin/python'} 19:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:28 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)) 19:13:28 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)) 19:13:28 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)) 19:13:28 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)) 19:13:28 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)) 19:13:28 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)) 19:13:28 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)) 19:13:28 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)) 19:13:28 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)) 19:13:28 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)) 19:13:28 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)) 19:13:28 INFO - Cleaning up... 19:13:28 INFO - Return code: 0 19:13:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:13: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')]} 19:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13: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')]} 19:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:28 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 0x224b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x247a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2509570>, '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 0x250a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a900>, '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': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', '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 19:13:28 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 19:13:28 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 19:13:28 INFO - Using env: {'DISPLAY': ':0', 19:13:28 INFO - 'HOME': '/home/cltbld', 19:13:28 INFO - 'LANG': 'en_US.UTF-8', 19:13:28 INFO - 'LANGUAGE': 'en_US:en', 19:13:28 INFO - 'LOGNAME': 'cltbld', 19:13:28 INFO - 'MAIL': '/var/mail/cltbld', 19:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:28 INFO - 'MOZ_NO_REMOTE': '1', 19:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:28 INFO - 'NO_EM_RESTART': '1', 19:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:28 INFO - 'PWD': '/builds/slave/test', 19:13:28 INFO - 'SHELL': '/bin/bash', 19:13:28 INFO - 'SHLVL': '1', 19:13:28 INFO - 'TERM': 'linux', 19:13:28 INFO - 'TMOUT': '86400', 19:13:28 INFO - 'USER': 'cltbld', 19:13:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', 19:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:28 INFO - '_': '/tools/buildbot/bin/python'} 19:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:13:28 INFO - Cleaning up... 19:13:28 INFO - Return code: 0 19:13:28 INFO - Running post-action listener: _resource_record_post_action 19:13:28 INFO - Running post-action listener: _start_resource_monitoring 19:13:28 INFO - Starting resource monitoring. 19:13:28 INFO - ##### 19:13:28 INFO - ##### Finished create-virtualenv step (success) 19:13:28 INFO - ##### 19:13:28 INFO - ##### 19:13:28 INFO - ##### Running install step. 19:13:28 INFO - ##### 19:13:28 INFO - Running pre-action listener: _resource_record_pre_action 19:13:28 INFO - Running main action method: install 19:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:13:28 INFO - Reading from file tmpfile_stdout 19:13:28 INFO - Detecting whether we're running mozinstall >=1.0... 19:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:13:28 INFO - Reading from file tmpfile_stdout 19:13:28 INFO - Output received: 19:13:28 INFO - Usage: mozinstall [options] installer 19:13:28 INFO - Options: 19:13:28 INFO - -h, --help show this help message and exit 19:13:28 INFO - -d DEST, --destination=DEST 19:13:28 INFO - Directory to install application into. [default: 19:13:28 INFO - "/builds/slave/test"] 19:13:28 INFO - --app=APP Application being installed. [default: firefox] 19:13:28 INFO - mkdir: /builds/slave/test/build/application 19:13:28 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'] 19:13:28 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 19:13:46 INFO - Reading from file tmpfile_stdout 19:13:46 INFO - Output received: 19:13:46 INFO - /builds/slave/test/build/application/firefox/firefox 19:13:46 INFO - Running post-action listener: _resource_record_post_action 19:13:46 INFO - ##### 19:13:46 INFO - ##### Finished install step (success) 19:13:46 INFO - ##### 19:13:46 INFO - ##### 19:13:46 INFO - ##### Running run-tests step. 19:13:46 INFO - ##### 19:13:46 INFO - Running pre-action listener: _resource_record_pre_action 19:13:46 INFO - Running main action method: run_tests 19:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:13:46 INFO - Python 2.7.3 19:13:46 INFO - Return code: 0 19:13:46 INFO - grabbing minidump binary from tooltool 19:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:13:46 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 0x2509570>, '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 0x250a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:13:46 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 19:13:46 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 19:13:46 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 19:13:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:13:46 INFO - Return code: 0 19:13:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:13:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:13:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:13:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:13:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 19:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 19:13:46 INFO - Using env: {'DISPLAY': ':0', 19:13:46 INFO - 'HOME': '/home/cltbld', 19:13:46 INFO - 'LANG': 'en_US.UTF-8', 19:13:46 INFO - 'LANGUAGE': 'en_US:en', 19:13:46 INFO - 'LOGNAME': 'cltbld', 19:13:46 INFO - 'MAIL': '/var/mail/cltbld', 19:13:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:13:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:46 INFO - 'MOZ_NO_REMOTE': '1', 19:13:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:46 INFO - 'NO_EM_RESTART': '1', 19:13:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:46 INFO - 'PWD': '/builds/slave/test', 19:13:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:13:46 INFO - 'SHELL': '/bin/bash', 19:13:46 INFO - 'SHLVL': '1', 19:13:46 INFO - 'TERM': 'linux', 19:13:46 INFO - 'TMOUT': '86400', 19:13:46 INFO - 'USER': 'cltbld', 19:13:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168', 19:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:46 INFO - '_': '/tools/buildbot/bin/python'} 19:13:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 19:13:46 INFO - mozversion application_buildid: 20160709163003 19:13:46 INFO - mozversion application_changeset: 2393f903d0a732960e73ae00489d0758d5f526f0 19:13:46 INFO - mozversion application_display_name: Nightly 19:13:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:13:46 INFO - mozversion application_name: Firefox 19:13:46 INFO - mozversion application_remotingname: firefox 19:13:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:13:46 INFO - mozversion application_vendor: Mozilla 19:13:46 INFO - mozversion application_version: 50.0a1 19:13:46 INFO - mozversion platform_buildid: 20160709163003 19:13:46 INFO - mozversion platform_changeset: 2393f903d0a732960e73ae00489d0758d5f526f0 19:13:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:13:46 INFO - mozversion platform_version: 50.0a1 19:13:46 INFO - using testdate: 1468116826 19:13:46 INFO - actual date: 1468116826 19:13:46 INFO - starting webserver on 'localhost:53929' 19:13:46 INFO - SUITE-START | Running 2 tests 19:13:46 INFO - TEST-START | dromaeo_css 19:13:46 INFO - operating with platform_type : linux_ 19:13:46 INFO - Initialising browser for dromaeo_css test... 19:13:46 INFO - TEST-INFO | started process 9601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYauDwn/profile http://localhost:53929/getInfo.html) 19:13:51 INFO - PROCESS | 9601 | __metrics Screen width/height:1600/1200 19:13:51 INFO - PROCESS | 9601 | colorDepth:24 19:13:51 INFO - PROCESS | 9601 | Browser inner width/height: 1024/697 19:13:51 INFO - PROCESS | 9601 | __metrics 19:13:52 ERROR - PROCESS | 9601 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 19:13:53 INFO - TEST-INFO | 9601: exit 0 19:13:53 INFO - Browser initialized. 19:13:53 INFO - Running cycle 1/1 for dromaeo_css test... 19:13:53 INFO - TEST-INFO | started process 9722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYauDwn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:14:04 INFO - PROCESS | 9722 | RSS: Main: 167989248 19:14:04 INFO - PROCESS | 9722 | 19:14:54 INFO - PROCESS | 9722 | 1468116894398 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] 19:17:02 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:53929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53929/tests/dromaeo/cssquery-ext.html) 19:17:03 INFO - PROCESS | 9722 | RSS: Main: 171646976 19:17:03 INFO - PROCESS | 9722 | 19:20:05 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:53929/tests/dromaeo/cssquery-ext.html (next: http://localhost:53929/tests/dromaeo/cssquery-jquery.html) 19:20:05 INFO - PROCESS | 9722 | RSS: Main: 168431616 19:20:05 INFO - PROCESS | 9722 | 19:23:07 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:53929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53929/tests/dromaeo/cssquery-mootools.html) 19:23:08 INFO - PROCESS | 9722 | RSS: Main: 171229184 19:23:08 INFO - PROCESS | 9722 | 19:26:10 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:53929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53929/tests/dromaeo/cssquery-prototype.html) 19:26:10 INFO - PROCESS | 9722 | RSS: Main: 167038976 19:26:10 INFO - PROCESS | 9722 | 19:29:13 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:53929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53929/tests/dromaeo/cssquery-yui.html) 19:29:13 INFO - PROCESS | 9722 | RSS: Main: 168787968 19:29:13 INFO - PROCESS | 9722 | 19:32:16 INFO - PROCESS | 9722 | Cycle 1(1): loaded http://localhost:53929/tests/dromaeo/cssquery-yui.html (next: http://localhost:53929/tests/dromaeo/cssquery-dojo.html) 19:32:16 INFO - PROCESS | 9722 | RSS: Main: 170205184 19:32:16 INFO - PROCESS | 9722 | 19:32:16 INFO - PROCESS | 9722 | __start_tp_report 19:32:16 INFO - PROCESS | 9722 | _x_x_mozilla_page_load 19:32:16 INFO - PROCESS | 9722 | _x_x_mozilla_page_load_details 19:32:16 INFO - PROCESS | 9722 | |i|pagename|runs| 19:32:16 INFO - PROCESS | 9722 | |0;dojo.html;3084.737797287232;3090.196548897286;3092.319689668272;3115.8442077896107;3127.218195451139;5410.648307859987;5464.480874316939;5490.725463726808;5506.449355064502;5521.889562208753;5444.564434845212;5475.397706252309;5516.806911758089;5527.668339899609;5582.302212223472;4936.5063493650705;4968.627352948525;5071.31537242473;5088.313077734496;5148.459411761767;164.11862665962286;5063.594912406998;5067.037262920052;5085.872853178682;5117;4958.528939750736;4974.328465657126;4975.303457515951;4979.7261150636705;5017.84946451607;4890.853274401774;4979.825706100269;4984.725840078794;5006.148954677714;5048.596112311043;4983.476734942851;4999.050180465736;5038.748062596856;5052.343195384613;5058.873528161788;5535.972320138414;5537.307836520435;5590.440955904377;5615.775368985276;5631.63394379364;5813.709314534299;5878.470937615635;5959.22530071088;5981.252343457068;6018.578699491038;5925.170476133345;5963.642181469082;5997.850053748648;6023.518118550505;6031.487323577501;5548.77804887804;5558.777648894039;5559.916601250984;5562.0266453370905;5564.554835613141;5946.70266486674;6002.6698531580305;6031.366706495754;6112.51099912006;6113.113598528189;5751.079827227707;5761.85595360111;5776.942230577724;5792.536597072224;5817.360090390053;5852.531797456193;5912.970435147797;5921.526277897758;5930.584859059911;5932.911006334908;5764.884702305931;5864.03243464832;5877.177195192677;5892.793752218652;5913.231279933581;5790.88418231633;5845.3277873045145;5912.940870591325;5914.556408269397;5919.112133180058;4509.751963641966;4517.954820451819;4518.4126063612175;4522.208613492626;4559.224931761609;3972.463717398172;4012.057166565855;4016.8995775105273;4030.2544029354076;4061.025353915039;5656.151577263443;5690.971545142248;5695.03184458643;5704.172894930211;5733.856653583611;5890.734916928748;6047.909281360783;6050.031994880886;6050.6672133032225;6055.666938318434;5488.945110548923;5685.289338832646;5708.971455142698;5722.341930677942;5753.712314384264;5063.1898896176435;5071.492850714899;5072.568831649277;5078.713073648345;5079.923801142986;5970.432808883149;6275.6548389839;6291.811245662638;6296.244450665858;6296.590721603081;6013.4888534474185;6051.727672254847;6052.485538729257;6063.151158837854;6117.908231376622;6150.630962142286;6171.753129874754;6225.595336303307;6235.781747638811;6278.811635650755;5746.597738158289;5807.419258074159;5962.642241465526;5965.503696742672;6035.39646035393;5995.2206213192;6036.426539478743;6054.606450580698;6095.542834287535;6097.817065488042;5823.94176058234;5835.44563266489;5847.1229315603;5878.853028674317;5892.410758924073;5643.661380317194;5873.177755114373;5874.060150375919;5875.177475153397;5879.382664820303;5784.652920824764;5804.912926306193;5842.853928651648;5864.266966629171;5873.060310350324;5885.3820348862755;5932.288125424977;5946.524278057658;5954.345022047658;5980.401959803985;5655.293088363955;5746.051901436216;5836.037053886062;5847.035239185487;5847.678377689098 19:32:16 INFO - PROCESS | 9722 | |1;ext.html;559.5954303002139;585.0405335250188;592.2034863109118;610.5970059760559;624.5378419969225;38899.80550097249;42966.78516607413;42971.570284297144;43117.137657246836;43338.783306083424;43744.78127609358;44127.3380899286;44306.33540496895;44443.77778111105;44487.77756111215;8858.11418858114;8963.910360896405;9018.549072546379;9020.323475739313;9022.774430639221;8936.374453788238;8950.104989501064;9012.8648070279;9018.68434604789;9049.909500904972;8970.551472426385;9004.8649270261;9027.774305642346;9105.772355691128;9108.089191080906;8956.104389561024;9036.096390360977;9040.638374465047;9055.456672599665;9058.773530661752;8858.955705221497;8954.328425368123;8976.820463590691;8986.05646407131;8987.236084932789;42249.78875105635;42539;42545.78727106375;42584;42682.78658606718;3427.0676541831726;3490.7381946354126;3537.133402316423;3940.133170702441;4160.791960401968;32611;32849.50725739116;32907.83546082254;33037.66962330394;33058.6694133058;3853.421986702017;4026.7382620129597;4074.8370065197655;4106.425100485934;4200.7521516591305;345579;346357;346870;347517.9999999975;347677;58308.7084564583;58929.70535147297;59286.70356648189;59332.70333648391;59379.109313360335;61581.38418615846;62120;62138.68930655318;62183;62582;14764.40942362315;14938.551843444715;14991.925040374728;15056.623584410258;15066.472673456376;10890.401027943539;10924.235303528836;10935.945320273348;10977.560897564008;10979.121670266359;17586.648267034587;17700.433437151798;17732.645347092985;17733.911330443265;18270.360537381395;6267.2165979252595;6397.392247736458;6401.303654531553;6552.672366381662;6701.430378417889;987.7530617345664;1025.5077562769911;1063.8616979792578;1075.3225467955137;1169.8479197704414;32492.02523924286;32636.347273054882;32881.835590822375;32961.83519082389;33283.500747488804;1076.2896488317829;1077.8652668416448;1097.8847221041676;1155.0528566575495;1208.3897631695938;16798.580035498966;17338.219780109674;17460.0332268878;17479.300827966992;17527.474175774747;517152;592654;602043;604497;856450;55626.443735562934;56296;56740.43259567351;56857;57021;1227.858796238426;1329.02316797154;1340.1021315718492;1342.7985802129758;1361.645972047255;30453.5259532338;32777;34495.482567762;34766.65233347735;35177.82411087928;52675.47324526706;53402;53829;53859.19211211757;54138.72930635479;506538;511055;511837;511853;516351;45040.77479612581;45767.313490297005;46684;46713.76643116763;46785;50535.49464505308;50989.235161471865;51939;52734.736326318125;52776.208356875446;43445;43863.78068109639;43940;44115;45236;42892.571074288855;43194.568054319054;43216.13567728565;43436.78281608572;43637;42208.788956055025;42804.57195428006;43300;43332;43387.78306108449;36536.26927461383;38034.969203259374;38069;38092.619073808906;38205.61794382021;28413.857930710215;28591.14226573206;28840.567391489563;28884;29090 19:32:16 INFO - PROCESS | 9722 | |2;jquery.html;379.3797141673363;384.76144790230063;385.7531180044771;403.8525938032619;406.55685303019703;17774.377896773614;19740.137680036405;19909.104090315934;20077.498062548442;20489.18043278271;17081.40215092472;17213.655726885485;17339.826601733977;17646.735298970525;17792.377266795665;5649.802256921009;5715.799947001856;5785.652860828342;5803.346046376783;5856.326522449909;5713.257276554042;5740.827775166731;5752.453516915886;5753.050746626823;5766.1639062335935;5617.662940223579;5650.943490565103;5755.079187330028;5761.164631128484;5787.016207244757;5511.53151982082;5711.771529138871;5724.771009159628;5756.769729210806;5776.768929242825;4880.389951256093;5059.494050594911;5072.847814565569;5174.2238664200295;5200.193969934666;13666.248356340397;13782.104163229358;14000.509982150576;22396.664050039264;23412.063517459283;2197.099189332382;2203.8126759225484;2286.4855407533337;2400.57989851777;2744.725527447259;10177.440240786755;10281.691549253459;10325.277230593862;10349.844752328721;10565.683029509128;1702.8893121947033;1920.807919208082;1923.5479662279354;1924.6246981838547;1962.2249211561352;70635.64682176607;78074.21925780726;79553;85312.57343713242;89405.55297223537;10581.84127238092;10829.187810914213;11013.83479247812;11196.712378076463;11237.157213209042;15237.923810380877;15249.313780879887;15275.541733748005;15304.770428443582;15313.23433828304;7223.169335526377;7237.493375463667;7692.538447693044;7864.764057078297;7868.803279918048;7159.176694680178;7178.964105179441;7299.781006569811;7336.559806411526;7409.333160015624;4569.908601827945;4604.125216208977;4613.123506533748;4623.468301145344;4708.199606066977;1935.2839449403812;1952.8730632508841;1971.1228503315888;1992.750906136733;1998.7201791749167;982;995.7198016542183;1037.8235699930879;1073.7047311989265;1075.714935542082;19269.903650481938;20178.192872284944;20243.696344554843;20245.08897099634;20521.281755138796;983.5475681186591;987.4618333008384;991.5141580625586;1050.054950544516;1076.2842709598185;10740.785184296426;11305.378204198849;11401.258918170292;11407.372594507382;11500.884991149982;498274;516180;516303;518373;522383;79951.60024199841;96365.51817240869;101814;103102;103488;995.915347195482;1043.4156872151468;1061.8407238914224;1063.8989296016866;1064.6433444795925;17807.198676059867;17943.192556334736;18540.536486587942;18591.90704046471;18818;42355.152896941276;43531.34702979394;44275;44356.778216108716;45554.31668524908;60024.39975600188;61593;61906;63441.68279158575;63512;8352.123027082313;8530.914690853013;8584.65661373538;8631.654733810577;8816.691415800417;8982.595783189641;9305.11601397866;9436.103570160823;9670.661526846527;10001.99980001994;8286.295664868554;8307.335413166811;8469.491830490191;8574.91425085766;8592.828143436971;8350.248477636798;8437.789055273668;8538.103499132501;8538.91461085406;8778.122187781171;8342.040665323566;8402.32781377476;8421.70524031656;8449.957750211455;8941.37410381267;11967.461464234304;13192.340382981005;13318.933405332911;13343.399547020214;13375.398107085399;12551.121421500773;12970.416331265304;13043.543475978295;13132.14641048367;13249.801252981406 19:32:16 INFO - PROCESS | 9722 | |3;mootools.html;1459.9124052556845;1471.9779203311953;1613.9919300403496;1790.5971156489784;1800.5498625343655;7807.297343239107;8267.255946964771;8604.91395086049;9152.313576481765;9171.816563668732;8415.99008119025;8567.57162141892;8651.04838467768;8731.083236260196;8753.562321883912;2243.091547923094;2313.0747700919683;2317.385892738426;2317.7682231776857;2321.2804030750435;2228.3092241405134;2249.876256805875;2317.177402022283;2318.3508617587104;2319.8840057997118;2271.6706077618737;2293.747687754346;2311.503026849227;2315.050829160045;2315.154968436517;2227.8774667393286;2236.8546044507216;2240.204727321802;2242.248846636379;2246.7416247131546;2215.3686199433246;2217.7006104176053;2218.3344996500987;2219.9223027194134;2235.944101397478;8786.472811631258;8904.688335908211;8910.465372077697;8918.375713700043;8967.596458159333;5040.899182016376;5131.563817075553;5165.690058596496;5181.5077567631015;5183.663061900965;3202.615686117681;3263.9347213055607;3413.6245013048792;3421.4525675891737;3437.364087643794;1102.08526922654;1104.6465131158034;1126.3692332293942;1135.6649788312468;1139.117184182257;12271.325077120755;12369.072319576067;12399.75200495994;12438.19151755142;12495.687607809787;4602.930956035662;4640.69835460694;4770.594499467515;4776.498467660846;4819.662623616383;10521.579136834442;10592.947035264775;10625.681229563126;10627.618409606855;10638.787224255471;5260.105782017066;5260.842174734687;5288.391834938954;5294.100002999499;5313.256144139824;4237.788110594458;4696.624270058387;4842.273658951115;4846.030793841246;4852.636052296092;3983.50206224222;4029.4157347184496;4113.424120623115;4150.813213405404;4158.106007208465;1248.8938440232682;1249.8937590304927;1260.8297879786294;1284.0048962054295;1300.63582196985;959.6065613098735;972.2416515118077;988.8615593816871;997.2919227348664;1001.484235618657;5791.478766910998;5914.349421563625;6271.62370257786;6292.276388215322;6407.615543067431;451.64545831522753;458.07697489558564;461.12156342168225;462.25115313192174;468.33730271665894;4007.3988901664984;4108.219438306712;4123.072308730511;4125.958740412558;4179.101493178981;10586.417747023834;11218;11219.382933938548;11270.380129092979;11282.717932051764;10338.12125969286;10789.946050269855;11097.889021109686;11116.833247501294;11165.050970667422;8260.132686067876;8335.458195217292;8358.247757701714;8401.36989725773;8419.494830310201;6110.358412366638;6338.144350512622;6388.201474815648;6449.935500644933;6532.542722009413;10221.795564088825;10254.077133058061;10265.794684106128;10273.743156420851;10358.171346292127;9728.805423891625;10196.082352588302;10263.12763415118;10401.427921464392;10476.895231047592;7078.362947334765;7567.545947243183;7864.646090925808;7916.287534121957;8018.358531317597;8549.358798090292;8618.267447267053;8628.22345988864;8667.91332086671;8671.523066231417;7550.131734850563;7801.1808760079375;7932.6430310635005;7951.960240198762;8094.919050809416;7598.354139898171;7664.386849051951;7811.765647030598;7970.681172753025;7997.7600671979935;7015.123109611299;7124.073870396815;7173.928260717326;7183.20984691694;7210.603416812126;5090.720010399464;5091.694498330112;5204.661696989683;5241.7379131042535;5331.1470164773455;5185.559227465707;5239.528442440199;5303.242313996777;5450.155225939986;5466.180072989084 19:32:16 INFO - PROCESS | 9722 | |4;prototype.html;322.68538175279093;323.11949936423247;329.16720696637503;330.88253669947153;334.1295924117675;5654.293213348332;5718.513926316263;5725.513331366834;5741.224934633823;5775.971120144393;5605.159226116085;5625.746841392137;5656;5658.547316214704;5669.829905102843;4174.853880114204;4198.391233271173;4331.5884990925815;4365.2142614329405;4370.4099946507295;4339.414179085815;4342.196693611692;4350.347447882811;4359.735676653767;4371.14762621289;4301.591348821873;4333.2416827055295;4346.065595896882;4350.36919646651;4353.651707863379;4251.319788833787;4294.377315289296;4301.526832048472;4312.504062032875;4318.52496225415;3758.9812050939845;3776.527934008249;3814.5613254475534;3824.349860523718;3844.7500912440883;5481.561475081984;5483.287172667568;5501;5501.229827824108;5506.64206826555;4892.804287828482;4943.258511223309;4986.90026199474;4990.850274491771;4997.350344455198;5796.2464879565805;5797.36229014808;5808.215890854723;5821.563382746311;5833.912491312633;4207.453031105967;4207.579242075768;4209.768462734548;4223.303154979425;4229.6827737919475;6004.909926351108;6024.939750602482;6032.728527216242;6066.636001839904;6088.512918966472;4274.871753847389;4309.095090031128;4317.395564620955;4319.308910574356;4329.28566786483;4369.235383807821;4372.540883207281;4381.5759878039125;4383.167198232326;4402.449693788277;4598.954010459853;4918.458969513351;4926.261060840831;4932.704037757674;4996.825111121093;5918.425484914076;5931.347551769302;5934.961381758175;5950.8809823803285;5952.464278214981;1455.3523681961638;1455.6535204935392;1458.0886945658963;1465.3113036872653;1466.618679143409;921.4102974096584;948.7485816258697;978.844962943719;988.8121256961155;998.605550807427;5630.774769009276;5651.717414129277;5663.621279062803;5664.85837854057;5684.317881854204;5999.310079340931;6028.909566356509;6032.371259759928;6033.456988871023;6040.697965101727;5491.176323551499;5534.6754363167565;5647.604667673223;5673.489385955201;5712.857178570486;3194.7444204463586;3228.8224147672104;3230.9030729077695;3241.367933252993;3244.740420766333;6071.939280607137;6166.352532984062;6177.96911015442;6204.084080482166;6204.844878877974;6099.268087829489;6105.633661980295;6116.418940200674;6139.754409823647;6164.630122192682;6051.668632900754;6166.383361663888;6227.16298691887;6255.624662520263;6264.5301602380005;5928.525717942468;5968.194293770285;5971.58198926071;5974;6000;5940.762369505344;5948.453402115395;6009.87980240384;6012.87974240504;6022.879542409215;6049.879002420015;6159.322474527888;6169.938300616936;6210.968945155245;6232.5325600581045;4162.895927601713;4167.62468385426;4183.811728472287;4188.5811418857875;4194.035371864427;5981.127318922696;6025.517958563217;6035.909461358171;6068.21113255274;6083.330833608388;5677.687727175045;5798.536117110705;5813.750043740616;5814.76740930358;5817.76728930838;5756.712164391847;5825.75708352279;5828.358880523054;5835.416458354131;5858.920083370513;5285.973570132125;5758.2514273144225;5780.248567686174;5784.595078344644;5824.126381042708;5897.941020589739;5907.3797251288;5929.9110513341475;5947.464728174312;5973.701314934149;5531.474509921551;5784.190213370048;5789.594728368974;5792.247007888947;5810.593258471867 19:32:16 INFO - PROCESS | 9722 | |5;yui.html;740.2264633458036;771.0824119298035;795.5187111797362;813.3818298093447;856.3662889461798;13919.512817051405;14375.353109110089;14423;14433.927830360859;14524.927375363135;12399.256044637306;12564.811527827067;12582.685432864182;12603.432845521951;12645.430955606997;645.8837409266354;783.4241832253289;784.6900474312644;809.5709274084716;811.6550466051934;793.4089103617813;794.0749027383092;803.9517628942282;806.9273765361116;810.2343285595115;846.0481957797477;847.2501835875233;851.6125163050827;851.82537579796;852.0925214646381;847.1189962439056;849.5752123938031;851.9488830670149;852.1776485691306;853.1340689200435;620.7703149834545;620.8758248350348;620.8975519039399;622.8007037747923;622.8691974685322;13166;13184.472621095145;13204.60386188416;13211.73576528464;13249.536266230636;15017.774733379008;15149.621259468491;15198.240087995557;15308.464203752927;15475.922620386826;10968.287061340987;11051.557937682483;11233.157513186461;11305.943470282678;11770.17608767378;3541.6635419635095;3657.579378371495;3753.3244016077097;3764.209516001643;3836.558795738498;72956.63521682411;76231.61884190599;76632;77860.22139778586;78362.99999999943;11488.425578721031;11626.476808543635;11779.646610601696;12188.085893558018;12336.876631233572;23006;23017.654735178985;23124.884375578014;23189.7681023191;23202.7679723204;8558.400911936105;8583.914160858312;8688.91311086881;8709.477431354138;8712.477251364939;4547.795349209294;4615.9076818463445;4660.39414876064;4664.836730714409;4703.835365762182;3478.4608385700258;3595.6404359563835;3598.8740394086603;3966;4143.8964025898995;713.878640631094;721.4228617106294;727.4144313827314;728.1735230513406;728.9635518224173;743.1194035068461;757.8257000889716;768.673313841615;778.7118766056595;780.6565111350988;9837.458939758239;10011.449370284705;10139.997318249238;10348.637797677196;10800.405977671146;739.6199368884148;740.8333125046821;749.089855825175;756.2928661701327;762.6949220311919;4737.478877323491;4958.553730164303;5001.399832020181;5003.3495645565845;5058.696478211319;76756;124030.79846007664;131513;134054.32972835074;134738;30916;31160.22099447532;91900;108277;109825.45087274513;58332;59251;78675.60662196652;84270.5786471076;97266;9446.763830904283;9520.155463650295;9535.713928582154;9545.761355966157;9550.587048477004;53234;54608;55987.160192597956;56815;58422.4157758417;74623.25376746163;84722.57638711768;86810;87681.56159219163;87802;11672.241304315192;12427.689307767378;12475.563355282522;12523.812142818048;12889.355532223164;14059.578212653636;14078.648033799236;14250.358733857209;14295.64260893486;14313.64215894611;13236.205827650372;13402.396892140072;13600.591982240549;13628.318584070956;13775.655608609864;12412.255264684149;12575.434105465092;12762.808557871454;12772;12982.221066736027;12814.231146131262;13004.349782510648;13113;13362.532311369445;13505.12216705911;10487.528061237415;10665.146788257076;10973.725656858323;11064.114870810477;11402.258853174517;10533.631322903662;10806.297590656583;11083;11088.501017454395;11135.88864111381 19:32:16 INFO - PROCESS | 9722 | __end_tp_report 19:32:16 INFO - PROCESS | 9722 | __start_cc_report 19:32:16 INFO - PROCESS | 9722 | _x_x_mozilla_cycle_collect,364 19:32:16 INFO - PROCESS | 9722 | __end_cc_report 19:32:16 INFO - PROCESS | 9722 | __startTimestamp1468117936742__endTimestamp 19:32:16 INFO - PROCESS | 9722 | 19:32:16 INFO - PROCESS | 9722 | ------- Summary: start ------- 19:32:16 INFO - PROCESS | 9722 | Number of tests: 6 19:32:16 INFO - PROCESS | 9722 | 19:32:16 INFO - PROCESS | 9722 | [#0] dojo.html Cycles:165 Average:5498.75 Median:5776.94 stddev:780.98 (13.5%) stddev-sans-first:760.06 19:32:16 INFO - PROCESS | 9722 | Values: 3084.7 3090.2 3092.3 3115.8 3127.2 5410.6 5464.5 5490.7 5506.4 5521.9 5444.6 5475.4 5516.8 5527.7 5582.3 4936.5 4968.6 5071.3 5088.3 5148.5 164.1 5063.6 5067.0 5085.9 5117.0 4958.5 4974.3 4975.3 4979.7 5017.8 4890.9 4979.8 4984.7 5006.1 5048.6 4983.5 4999.1 5038.7 5052.3 5058.9 5536.0 5537.3 5590.4 5615.8 5631.6 5813.7 5878.5 5959.2 5981.3 6018.6 5925.2 5963.6 5997.9 6023.5 6031.5 5548.8 5558.8 5559.9 5562.0 5564.6 5946.7 6002.7 6031.4 6112.5 6113.1 5751.1 5761.9 5776.9 5792.5 5817.4 5852.5 5913.0 5921.5 5930.6 5932.9 5764.9 5864.0 5877.2 5892.8 5913.2 5790.9 5845.3 5912.9 5914.6 5919.1 4509.8 4518.0 4518.4 4522.2 4559.2 3972.5 4012.1 4016.9 4030.3 4061.0 5656.2 5691.0 5695.0 5704.2 5733.9 5890.7 6047.9 6050.0 6050.7 6055.7 5488.9 5685.3 5709.0 5722.3 5753.7 5063.2 5071.5 5072.6 5078.7 5079.9 5970.4 6275.7 6291.8 6296.2 6296.6 6013.5 6051.7 6052.5 6063.2 6117.9 6150.6 6171.8 6225.6 6235.8 6278.8 5746.6 5807.4 5962.6 5965.5 6035.4 5995.2 6036.4 6054.6 6095.5 6097.8 5823.9 5835.4 5847.1 5878.9 5892.4 5643.7 5873.2 5874.1 5875.2 5879.4 5784.7 5804.9 5842.9 5864.3 5873.1 5885.4 5932.3 5946.5 5954.3 5980.4 5655.3 5746.1 5836.0 5847.0 5847.7 19:32:16 INFO - PROCESS | 9722 | 19:32:16 INFO - PROCESS | 9722 | [#1] ext.html Cycles:180 Average:65881.27 Median:43363.28 stddev:137631.43 (317.4%) stddev-sans-first:137930.14 19:32:16 INFO - PROCESS | 9722 | Values: 559.6 585.0 592.2 610.6 624.5 38899.8 42966.8 42971.6 43117.1 43338.8 43744.8 44127.3 44306.3 44443.8 44487.8 8858.1 8963.9 9018.5 9020.3 9022.8 8936.4 8950.1 9012.9 9018.7 9049.9 8970.6 9004.9 9027.8 9105.8 9108.1 8956.1 9036.1 9040.6 9055.5 9058.8 8859.0 8954.3 8976.8 8986.1 8987.2 42249.8 42539.0 42545.8 42584.0 42682.8 3427.1 3490.7 3537.1 3940.1 4160.8 32611.0 32849.5 32907.8 33037.7 33058.7 3853.4 4026.7 4074.8 4106.4 4200.8 345579.0 346357.0 346870.0 347518.0 347677.0 58308.7 58929.7 59286.7 59332.7 59379.1 61581.4 62120.0 62138.7 62183.0 62582.0 14764.4 14938.6 14991.9 15056.6 15066.5 10890.4 10924.2 10935.9 10977.6 10979.1 17586.6 17700.4 17732.6 17733.9 18270.4 6267.2 6397.4 6401.3 6552.7 6701.4 987.8 1025.5 1063.9 1075.3 1169.8 32492.0 32636.3 32881.8 32961.8 33283.5 1076.3 1077.9 1097.9 1155.1 1208.4 16798.6 17338.2 17460.0 17479.3 17527.5 517152.0 592654.0 602043.0 604497.0 856450.0 55626.4 56296.0 56740.4 56857.0 57021.0 1227.9 1329.0 1340.1 1342.8 1361.6 30453.5 32777.0 34495.5 34766.7 35177.8 52675.5 53402.0 53829.0 53859.2 54138.7 506538.0 511055.0 511837.0 511853.0 516351.0 45040.8 45767.3 46684.0 46713.8 46785.0 50535.5 50989.2 51939.0 52734.7 52776.2 43445.0 43863.8 43940.0 44115.0 45236.0 42892.6 43194.6 43216.1 43436.8 43637.0 42208.8 42804.6 43300.0 43332.0 43387.8 36536.3 38035.0 38069.0 38092.6 38205.6 28413.9 28591.1 28840.6 28884.0 29090.0 19:32:16 INFO - PROCESS | 9722 | 19:32:16 INFO - PROCESS | 9722 | [#2] jquery.html Cycles:180 Average:29596.43 Median:44315.89 stddev:84928.16 (191.6%) stddev-sans-first:85138.07 19:32:16 INFO - PROCESS | 9722 | Values: 379.4 384.8 385.8 403.9 406.6 17774.4 19740.1 19909.1 20077.5 20489.2 17081.4 17213.7 17339.8 17646.7 17792.4 5649.8 5715.8 5785.7 5803.3 5856.3 5713.3 5740.8 5752.5 5753.1 5766.2 5617.7 5650.9 5755.1 5761.2 5787.0 5511.5 5711.8 5724.8 5756.8 5776.8 4880.4 5059.5 5072.8 5174.2 5200.2 13666.2 13782.1 14000.5 22396.7 23412.1 2197.1 2203.8 2286.5 2400.6 2744.7 10177.4 10281.7 10325.3 10349.8 10565.7 1702.9 1920.8 1923.5 1924.6 1962.2 70635.6 78074.2 79553.0 85312.6 89405.6 10581.8 10829.2 11013.8 11196.7 11237.2 15237.9 15249.3 15275.5 15304.8 15313.2 7223.2 7237.5 7692.5 7864.8 7868.8 7159.2 7179.0 7299.8 7336.6 7409.3 4569.9 4604.1 4613.1 4623.5 4708.2 1935.3 1952.9 1971.1 1992.8 1998.7 982.0 995.7 1037.8 1073.7 1075.7 19269.9 20178.2 20243.7 20245.1 20521.3 983.5 987.5 991.5 1050.1 1076.3 10740.8 11305.4 11401.3 11407.4 11500.9 498274.0 516180.0 516303.0 518373.0 522383.0 79951.6 96365.5 101814.0 103102.0 103488.0 995.9 1043.4 1061.8 1063.9 1064.6 17807.2 17943.2 18540.5 18591.9 18818.0 42355.2 43531.3 44275.0 44356.8 45554.3 60024.4 61593.0 61906.0 63441.7 63512.0 8352.1 8530.9 8584.7 8631.7 8816.7 8982.6 9305.1 9436.1 9670.7 10002.0 8286.3 8307.3 8469.5 8574.9 8592.8 8350.2 8437.8 8538.1 8538.9 8778.1 8342.0 8402.3 8421.7 8450.0 8941.4 11967.5 13192.3 13318.9 13343.4 13375.4 12551.1 12970.4 13043.5 13132.1 13249.8 19:32:16 INFO - PROCESS | 9722 | 19:32:16 INFO - PROCESS | 9722 | [#3] mootools.html Cycles:180 Average:5842.45 Median:2551.47 stddev:3361.58 (131.8%) stddev-sans-first:3354.87 19:32:16 INFO - PROCESS | 9722 | Values: 1459.9 1472.0 1614.0 1790.6 1800.5 7807.3 8267.3 8604.9 9152.3 9171.8 8416.0 8567.6 8651.0 8731.1 8753.6 2243.1 2313.1 2317.4 2317.8 2321.3 2228.3 2249.9 2317.2 2318.4 2319.9 2271.7 2293.7 2311.5 2315.1 2315.2 2227.9 2236.9 2240.2 2242.2 2246.7 2215.4 2217.7 2218.3 2219.9 2235.9 8786.5 8904.7 8910.5 8918.4 8967.6 5040.9 5131.6 5165.7 5181.5 5183.7 3202.6 3263.9 3413.6 3421.5 3437.4 1102.1 1104.6 1126.4 1135.7 1139.1 12271.3 12369.1 12399.8 12438.2 12495.7 4602.9 4640.7 4770.6 4776.5 4819.7 10521.6 10592.9 10625.7 10627.6 10638.8 5260.1 5260.8 5288.4 5294.1 5313.3 4237.8 4696.6 4842.3 4846.0 4852.6 3983.5 4029.4 4113.4 4150.8 4158.1 1248.9 1249.9 1260.8 1284.0 1300.6 959.6 972.2 988.9 997.3 1001.5 5791.5 5914.3 6271.6 6292.3 6407.6 451.6 458.1 461.1 462.3 468.3 4007.4 4108.2 4123.1 4126.0 4179.1 10586.4 11218.0 11219.4 11270.4 11282.7 10338.1 10789.9 11097.9 11116.8 11165.1 8260.1 8335.5 8358.2 8401.4 8419.5 6110.4 6338.1 6388.2 6449.9 6532.5 10221.8 10254.1 10265.8 10273.7 10358.2 9728.8 10196.1 10263.1 10401.4 10476.9 7078.4 7567.5 7864.6 7916.3 8018.4 8549.4 8618.3 8628.2 8667.9 8671.5 7550.1 7801.2 7932.6 7952.0 8094.9 7598.4 7664.4 7811.8 7970.7 7997.8 7015.1 7124.1 7173.9 7183.2 7210.6 5090.7 5091.7 5204.7 5241.7 5331.1 5185.6 5239.5 5303.2 5450.2 5466.2 19:32:16 INFO - PROCESS | 9722 | 19:32:16 INFO - PROCESS | 9722 | [#4] prototype.html Cycles:180 Average:4931.75 Median:5675.59 stddev:1460.93 (25.7%) stddev-sans-first:1423.48 19:32:16 INFO - PROCESS | 9722 | Values: 322.7 323.1 329.2 330.9 334.1 5654.3 5718.5 5725.5 5741.2 5776.0 5605.2 5625.7 5656.0 5658.5 5669.8 4174.9 4198.4 4331.6 4365.2 4370.4 4339.4 4342.2 4350.3 4359.7 4371.1 4301.6 4333.2 4346.1 4350.4 4353.7 4251.3 4294.4 4301.5 4312.5 4318.5 3759.0 3776.5 3814.6 3824.3 3844.8 5481.6 5483.3 5501.0 5501.2 5506.6 4892.8 4943.3 4986.9 4990.9 4997.4 5796.2 5797.4 5808.2 5821.6 5833.9 4207.5 4207.6 4209.8 4223.3 4229.7 6004.9 6024.9 6032.7 6066.6 6088.5 4274.9 4309.1 4317.4 4319.3 4329.3 4369.2 4372.5 4381.6 4383.2 4402.4 4599.0 4918.5 4926.3 4932.7 4996.8 5918.4 5931.3 5935.0 5950.9 5952.5 1455.4 1455.7 1458.1 1465.3 1466.6 921.4 948.7 978.8 988.8 998.6 5630.8 5651.7 5663.6 5664.9 5684.3 5999.3 6028.9 6032.4 6033.5 6040.7 5491.2 5534.7 5647.6 5673.5 5712.9 3194.7 3228.8 3230.9 3241.4 3244.7 6071.9 6166.4 6178.0 6204.1 6204.8 6099.3 6105.6 6116.4 6139.8 6164.6 6051.7 6166.4 6227.2 6255.6 6264.5 5928.5 5968.2 5971.6 5974.0 6000.0 5940.8 5948.5 6009.9 6012.9 6022.9 6049.9 6159.3 6169.9 6211.0 6232.5 4162.9 4167.6 4183.8 4188.6 4194.0 5981.1 6025.5 6035.9 6068.2 6083.3 5677.7 5798.5 5813.8 5814.8 5817.8 5756.7 5825.8 5828.4 5835.4 5858.9 5286.0 5758.3 5780.2 5784.6 5824.1 5897.9 5907.4 5929.9 5947.5 5973.7 5531.5 5784.2 5789.6 5792.2 5810.6 19:32:16 INFO - PROCESS | 9722 | 19:32:16 INFO - PROCESS | 9722 | [#5] yui.html Cycles:180 Average:20237.36 Median:4054.95 stddev:29939.21 (738.3%) stddev-sans-first:29987.41 19:32:16 INFO - PROCESS | 9722 | Values: 740.2 771.1 795.5 813.4 856.4 13919.5 14375.4 14423.0 14433.9 14524.9 12399.3 12564.8 12582.7 12603.4 12645.4 645.9 783.4 784.7 809.6 811.7 793.4 794.1 804.0 806.9 810.2 846.0 847.3 851.6 851.8 852.1 847.1 849.6 851.9 852.2 853.1 620.8 620.9 620.9 622.8 622.9 13166.0 13184.5 13204.6 13211.7 13249.5 15017.8 15149.6 15198.2 15308.5 15475.9 10968.3 11051.6 11233.2 11305.9 11770.2 3541.7 3657.6 3753.3 3764.2 3836.6 72956.6 76231.6 76632.0 77860.2 78363.0 11488.4 11626.5 11779.6 12188.1 12336.9 23006.0 23017.7 23124.9 23189.8 23202.8 8558.4 8583.9 8688.9 8709.5 8712.5 4547.8 4615.9 4660.4 4664.8 4703.8 3478.5 3595.6 3598.9 3966.0 4143.9 713.9 721.4 727.4 728.2 729.0 743.1 757.8 768.7 778.7 780.7 9837.5 10011.4 10140.0 10348.6 10800.4 739.6 740.8 749.1 756.3 762.7 4737.5 4958.6 5001.4 5003.3 5058.7 76756.0 124030.8 131513.0 134054.3 134738.0 30916.0 31160.2 91900.0 108277.0 109825.5 58332.0 59251.0 78675.6 84270.6 97266.0 9446.8 9520.2 9535.7 9545.8 9550.6 53234.0 54608.0 55987.2 56815.0 58422.4 74623.3 84722.6 86810.0 87681.6 87802.0 11672.2 12427.7 12475.6 12523.8 12889.4 14059.6 14078.6 14250.4 14295.6 14313.6 13236.2 13402.4 13600.6 13628.3 13775.7 12412.3 12575.4 12762.8 12772.0 12982.2 12814.2 13004.3 13113.0 13362.5 13505.1 10487.5 10665.1 10973.7 11064.1 11402.3 10533.6 10806.3 11083.0 11088.5 11135.9 19:32:16 INFO - PROCESS | 9722 | -------- Summary: end -------- 19:32:16 INFO - PROCESS | 9722 | 19:32:17 INFO - TEST-INFO | 9722: exit 0 19:32:17 INFO - TEST-OK | dromaeo_css | took 1111075ms 19:32:17 INFO - TEST-START | kraken 19:32:17 INFO - operating with platform_type : linux_ 19:32:17 INFO - Initialising browser for kraken test... 19:32:17 INFO - TEST-INFO | started process 9974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmWr81L/profile http://localhost:53929/getInfo.html) 19:32:22 INFO - PROCESS | 9974 | __metrics Screen width/height:1600/1200 19:32:22 INFO - PROCESS | 9974 | colorDepth:24 19:32:22 INFO - PROCESS | 9974 | Browser inner width/height: 1024/697 19:32:22 INFO - PROCESS | 9974 | __metrics 19:32:22 ERROR - PROCESS | 9974 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 19:32:23 INFO - TEST-INFO | 9974: exit 0 19:32:23 INFO - Browser initialized. 19:32:23 INFO - Running cycle 1/1 for kraken test... 19:32:23 INFO - TEST-INFO | started process 10094 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmWr81L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:32:35 INFO - PROCESS | 10094 | RSS: Main: 168189952 19:32:35 INFO - PROCESS | 10094 | 19:32:37 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53929/tests/kraken/driver.html?testName=audio-beat-detection) 19:32:38 INFO - PROCESS | 10094 | RSS: Main: 173420544 19:32:38 INFO - PROCESS | 10094 | 19:32:41 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53929/tests/kraken/driver.html?testName=audio-dft) 19:32:42 INFO - PROCESS | 10094 | RSS: Main: 172453888 19:32:42 INFO - PROCESS | 10094 | 19:32:44 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53929/tests/kraken/driver.html?testName=audio-fft) 19:32:45 INFO - PROCESS | 10094 | RSS: Main: 167436288 19:32:45 INFO - PROCESS | 10094 | 19:32:47 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53929/tests/kraken/driver.html?testName=audio-oscillator) 19:32:48 INFO - PROCESS | 10094 | RSS: Main: 168054784 19:32:48 INFO - PROCESS | 10094 | 19:32:50 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:32:51 INFO - PROCESS | 10094 | RSS: Main: 168329216 19:32:51 INFO - PROCESS | 10094 | 19:32:54 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53929/tests/kraken/driver.html?testName=imaging-darkroom) 19:32:54 INFO - PROCESS | 10094 | RSS: Main: 168521728 19:32:54 INFO - PROCESS | 10094 | 19:32:58 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53929/tests/kraken/driver.html?testName=imaging-desaturate) 19:32:58 INFO - PROCESS | 10094 | RSS: Main: 168792064 19:32:58 INFO - PROCESS | 10094 | 19:33:01 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53929/tests/kraken/driver.html?testName=json-parse-financial) 19:33:02 INFO - PROCESS | 10094 | RSS: Main: 168652800 19:33:02 INFO - PROCESS | 10094 | 19:33:03 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:33:04 INFO - PROCESS | 10094 | RSS: Main: 168595456 19:33:04 INFO - PROCESS | 10094 | 19:33:06 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53929/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:33:07 INFO - PROCESS | 10094 | RSS: Main: 168644608 19:33:07 INFO - PROCESS | 10094 | 19:33:09 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:33:09 INFO - PROCESS | 10094 | RSS: Main: 169426944 19:33:09 INFO - PROCESS | 10094 | 19:33:12 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:33:12 INFO - PROCESS | 10094 | RSS: Main: 169492480 19:33:12 INFO - PROCESS | 10094 | 19:33:15 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:33:16 INFO - PROCESS | 10094 | RSS: Main: 169443328 19:33:16 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | Cycle 1(1): loaded http://localhost:53929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53929/tests/kraken/driver.html?testName=ai-astar) 19:33:18 INFO - PROCESS | 10094 | RSS: Main: 169791488 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | __start_tp_report 19:33:18 INFO - PROCESS | 10094 | _x_x_mozilla_page_load 19:33:18 INFO - PROCESS | 10094 | _x_x_mozilla_page_load_details 19:33:18 INFO - PROCESS | 10094 | |i|pagename|runs| 19:33:18 INFO - PROCESS | 10094 | |0;ai-astar;112;112;105;110;111;113;112;110;110;110 19:33:18 INFO - PROCESS | 10094 | |1;audio-beat-detection;150;117;146;170;118;150;145;120;181;119 19:33:18 INFO - PROCESS | 10094 | |2;audio-dft;164;164;162;163;162;164;176;162;162;161 19:33:18 INFO - PROCESS | 10094 | |3;audio-fft;75;75;74;151;79;76;75;77;161;77 19:33:18 INFO - PROCESS | 10094 | |4;audio-oscillator;86;83;162;84;84;84;150;84;85;163 19:33:18 INFO - PROCESS | 10094 | |5;imaging-gaussian-blur;118;118;117;117;117;119;117;118;117;117 19:33:18 INFO - PROCESS | 10094 | |6;imaging-darkroom;148;146;149;148;148;147;147;147;147;147 19:33:18 INFO - PROCESS | 10094 | |7;imaging-desaturate;95;96;96;96;95;95;97;95;95;95 19:33:18 INFO - PROCESS | 10094 | |8;json-parse-financial;55;54;54;54;56;54;53;55;54;54 19:33:18 INFO - PROCESS | 10094 | |9;json-stringify-tinderbox;63;63;63;63;63;63;64;62;65;64 19:33:18 INFO - PROCESS | 10094 | |10;stanford-crypto-aes;81;83;76;77;81;76;76;75;81;76 19:33:18 INFO - PROCESS | 10094 | |11;stanford-crypto-ccm;122;123;120;137;120;134;124;122;166;122 19:33:18 INFO - PROCESS | 10094 | |12;stanford-crypto-pbkdf2;165;165;174;164;166;171;165;166;165;162 19:33:18 INFO - PROCESS | 10094 | |13;stanford-crypto-sha256-iterative;64;65;67;65;64;66;65;64;64;63 19:33:18 INFO - PROCESS | 10094 | __end_tp_report 19:33:18 INFO - PROCESS | 10094 | __start_cc_report 19:33:18 INFO - PROCESS | 10094 | _x_x_mozilla_cycle_collect,870 19:33:18 INFO - PROCESS | 10094 | __end_cc_report 19:33:18 INFO - PROCESS | 10094 | __startTimestamp1468117998315__endTimestamp 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | ------- Summary: start ------- 19:33:18 INFO - PROCESS | 10094 | Number of tests: 14 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.22 (2.0%) stddev-sans-first:2.29 19:33:18 INFO - PROCESS | 10094 | Values: 112.0 112.0 105.0 110.0 111.0 113.0 112.0 110.0 110.0 110.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:148.00 stddev:22.78 (15.4%) stddev-sans-first:23.96 19:33:18 INFO - PROCESS | 10094 | Values: 150.0 117.0 146.0 170.0 118.0 150.0 145.0 120.0 181.0 119.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:4.35 (2.7%) stddev-sans-first:4.61 19:33:18 INFO - PROCESS | 10094 | Values: 164.0 164.0 162.0 163.0 162.0 164.0 176.0 162.0 162.0 161.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.50 stddev:33.84 (44.8%) stddev-sans-first:35.33 19:33:18 INFO - PROCESS | 10094 | Values: 75.0 75.0 74.0 151.0 79.0 76.0 75.0 77.0 161.0 77.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:84.00 stddev:35.94 (42.8%) stddev-sans-first:37.35 19:33:18 INFO - PROCESS | 10094 | Values: 86.0 83.0 162.0 84.0 84.0 84.0 150.0 84.0 85.0 163.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 19:33:18 INFO - PROCESS | 10094 | Values: 118.0 118.0 117.0 117.0 117.0 119.0 117.0 118.0 117.0 117.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 19:33:18 INFO - PROCESS | 10094 | Values: 148.0 146.0 149.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 19:33:18 INFO - PROCESS | 10094 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 97.0 95.0 95.0 95.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 19:33:18 INFO - PROCESS | 10094 | Values: 55.0 54.0 54.0 54.0 56.0 54.0 53.0 55.0 54.0 54.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 19:33:18 INFO - PROCESS | 10094 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 64.0 62.0 65.0 64.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:79.00 stddev:2.94 (3.7%) stddev-sans-first:2.93 19:33:18 INFO - PROCESS | 10094 | Values: 81.0 83.0 76.0 77.0 81.0 76.0 76.0 75.0 81.0 76.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:123.50 stddev:14.25 (11.5%) stddev-sans-first:14.89 19:33:18 INFO - PROCESS | 10094 | Values: 122.0 123.0 120.0 137.0 120.0 134.0 124.0 122.0 166.0 122.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:165.50 stddev:3.53 (2.1%) stddev-sans-first:3.71 19:33:18 INFO - PROCESS | 10094 | Values: 165.0 165.0 174.0 164.0 166.0 171.0 165.0 166.0 165.0 162.0 19:33:18 INFO - PROCESS | 10094 | 19:33:18 INFO - PROCESS | 10094 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 19:33:18 INFO - PROCESS | 10094 | Values: 64.0 65.0 67.0 65.0 64.0 66.0 65.0 64.0 64.0 63.0 19:33:18 INFO - PROCESS | 10094 | -------- Summary: end -------- 19:33:18 INFO - PROCESS | 10094 | 19:33:19 INFO - TEST-INFO | 10094: exit 0 19:33:19 INFO - TEST-OK | kraken | took 61776ms 19:33:19 INFO - SUITE-END | took 1172s 19:33:19 INFO - Completed test suite (00:19:33) 19:33:19 INFO - javascript benchmark 19:33:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7325.785054929505, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.737797287232, 3090.196548897286, 3092.319689668272, 3115.8442077896107, 3127.218195451139, 5410.648307859987, 5464.480874316939, 5490.725463726808, 5506.449355064502, 5521.889562208753, 5444.564434845212, 5475.397706252309, 5516.806911758089, 5527.668339899609, 5582.302212223472, 4936.5063493650705, 4968.627352948525, 5071.31537242473, 5088.313077734496, 5148.459411761767, 164.11862665962286, 5063.594912406998, 5067.037262920052, 5085.872853178682, 5117.0, 4958.528939750736, 4974.328465657126, 4975.303457515951, 4979.7261150636705, 5017.84946451607, 4890.853274401774, 4979.825706100269, 4984.725840078794, 5006.148954677714, 5048.596112311043, 4983.476734942851, 4999.050180465736, 5038.748062596856, 5052.343195384613, 5058.873528161788, 5535.972320138414, 5537.307836520435, 5590.440955904377, 5615.775368985276, 5631.63394379364, 5813.709314534299, 5878.470937615635, 5959.22530071088, 5981.252343457068, 6018.578699491038, 5925.170476133345, 5963.642181469082, 5997.850053748648, 6023.518118550505, 6031.487323577501, 5548.77804887804, 5558.777648894039, 5559.916601250984, 5562.0266453370905, 5564.554835613141, 5946.70266486674, 6002.6698531580305, 6031.366706495754, 6112.51099912006, 6113.113598528189, 5751.079827227707, 5761.85595360111, 5776.942230577724, 5792.536597072224, 5817.360090390053, 5852.531797456193, 5912.970435147797, 5921.526277897758, 5930.584859059911, 5932.911006334908, 5764.884702305931, 5864.03243464832, 5877.177195192677, 5892.793752218652, 5913.231279933581, 5790.88418231633, 5845.3277873045145, 5912.940870591325, 5914.556408269397, 5919.112133180058, 4509.751963641966, 4517.954820451819, 4518.4126063612175, 4522.208613492626, 4559.224931761609, 3972.463717398172, 4012.057166565855, 4016.8995775105273, 4030.2544029354076, 4061.025353915039, 5656.151577263443, 5690.971545142248, 5695.03184458643, 5704.172894930211, 5733.856653583611, 5890.734916928748, 6047.909281360783, 6050.031994880886, 6050.6672133032225, 6055.666938318434, 5488.945110548923, 5685.289338832646, 5708.971455142698, 5722.341930677942, 5753.712314384264, 5063.1898896176435, 5071.492850714899, 5072.568831649277, 5078.713073648345, 5079.923801142986, 5970.432808883149, 6275.6548389839, 6291.811245662638, 6296.244450665858, 6296.590721603081, 6013.4888534474185, 6051.727672254847, 6052.485538729257, 6063.151158837854, 6117.908231376622, 6150.630962142286, 6171.753129874754, 6225.595336303307, 6235.781747638811, 6278.811635650755, 5746.597738158289, 5807.419258074159, 5962.642241465526, 5965.503696742672, 6035.39646035393, 5995.2206213192, 6036.426539478743, 6054.606450580698, 6095.542834287535, 6097.817065488042, 5823.94176058234, 5835.44563266489, 5847.1229315603, 5878.853028674317, 5892.410758924073, 5643.661380317194, 5873.177755114373, 5874.060150375919, 5875.177475153397, 5879.382664820303, 5784.652920824764, 5804.912926306193, 5842.853928651648, 5864.266966629171, 5873.060310350324, 5885.3820348862755, 5932.288125424977, 5946.524278057658, 5954.345022047658, 5980.401959803985, 5655.293088363955, 5746.051901436216, 5836.037053886062, 5847.035239185487, 5847.678377689098], "value": 5445.506833000424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.5954303002139, 585.0405335250188, 592.2034863109118, 610.5970059760559, 624.5378419969225, 38899.80550097249, 42966.78516607413, 42971.570284297144, 43117.137657246836, 43338.783306083424, 43744.78127609358, 44127.3380899286, 44306.33540496895, 44443.77778111105, 44487.77756111215, 8858.11418858114, 8963.910360896405, 9018.549072546379, 9020.323475739313, 9022.774430639221, 8936.374453788238, 8950.104989501064, 9012.8648070279, 9018.68434604789, 9049.909500904972, 8970.551472426385, 9004.8649270261, 9027.774305642346, 9105.772355691128, 9108.089191080906, 8956.104389561024, 9036.096390360977, 9040.638374465047, 9055.456672599665, 9058.773530661752, 8858.955705221497, 8954.328425368123, 8976.820463590691, 8986.05646407131, 8987.236084932789, 42249.78875105635, 42539.0, 42545.78727106375, 42584.0, 42682.78658606718, 3427.0676541831726, 3490.7381946354126, 3537.133402316423, 3940.133170702441, 4160.791960401968, 32611.0, 32849.50725739116, 32907.83546082254, 33037.66962330394, 33058.6694133058, 3853.421986702017, 4026.7382620129597, 4074.8370065197655, 4106.425100485934, 4200.7521516591305, 345579.0, 346357.0, 346870.0, 347517.9999999975, 347677.0, 58308.7084564583, 58929.70535147297, 59286.70356648189, 59332.70333648391, 59379.109313360335, 61581.38418615846, 62120.0, 62138.68930655318, 62183.0, 62582.0, 14764.40942362315, 14938.551843444715, 14991.925040374728, 15056.623584410258, 15066.472673456376, 10890.401027943539, 10924.235303528836, 10935.945320273348, 10977.560897564008, 10979.121670266359, 17586.648267034587, 17700.433437151798, 17732.645347092985, 17733.911330443265, 18270.360537381395, 6267.2165979252595, 6397.392247736458, 6401.303654531553, 6552.672366381662, 6701.430378417889, 987.7530617345664, 1025.5077562769911, 1063.8616979792578, 1075.3225467955137, 1169.8479197704414, 32492.02523924286, 32636.347273054882, 32881.835590822375, 32961.83519082389, 33283.500747488804, 1076.2896488317829, 1077.8652668416448, 1097.8847221041676, 1155.0528566575495, 1208.3897631695938, 16798.580035498966, 17338.219780109674, 17460.0332268878, 17479.300827966992, 17527.474175774747, 517152.0, 592654.0, 602043.0, 604497.0, 856450.0, 55626.443735562934, 56296.0, 56740.43259567351, 56857.0, 57021.0, 1227.858796238426, 1329.02316797154, 1340.1021315718492, 1342.7985802129758, 1361.645972047255, 30453.5259532338, 32777.0, 34495.482567762, 34766.65233347735, 35177.82411087928, 52675.47324526706, 53402.0, 53829.0, 53859.19211211757, 54138.72930635479, 506538.0, 511055.0, 511837.0, 511853.0, 516351.0, 45040.77479612581, 45767.313490297005, 46684.0, 46713.76643116763, 46785.0, 50535.49464505308, 50989.235161471865, 51939.0, 52734.736326318125, 52776.208356875446, 43445.0, 43863.78068109639, 43940.0, 44115.0, 45236.0, 42892.571074288855, 43194.568054319054, 43216.13567728565, 43436.78281608572, 43637.0, 42208.788956055025, 42804.57195428006, 43300.0, 43332.0, 43387.78306108449, 36536.26927461383, 38034.969203259374, 38069.0, 38092.619073808906, 38205.61794382021, 28413.857930710215, 28591.14226573206, 28840.567391489563, 28884.0, 29090.0], "value": 20629.963217562363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3797141673363, 384.76144790230063, 385.7531180044771, 403.8525938032619, 406.55685303019703, 17774.377896773614, 19740.137680036405, 19909.104090315934, 20077.498062548442, 20489.18043278271, 17081.40215092472, 17213.655726885485, 17339.826601733977, 17646.735298970525, 17792.377266795665, 5649.802256921009, 5715.799947001856, 5785.652860828342, 5803.346046376783, 5856.326522449909, 5713.257276554042, 5740.827775166731, 5752.453516915886, 5753.050746626823, 5766.1639062335935, 5617.662940223579, 5650.943490565103, 5755.079187330028, 5761.164631128484, 5787.016207244757, 5511.53151982082, 5711.771529138871, 5724.771009159628, 5756.769729210806, 5776.768929242825, 4880.389951256093, 5059.494050594911, 5072.847814565569, 5174.2238664200295, 5200.193969934666, 13666.248356340397, 13782.104163229358, 14000.509982150576, 22396.664050039264, 23412.063517459283, 2197.099189332382, 2203.8126759225484, 2286.4855407533337, 2400.57989851777, 2744.725527447259, 10177.440240786755, 10281.691549253459, 10325.277230593862, 10349.844752328721, 10565.683029509128, 1702.8893121947033, 1920.807919208082, 1923.5479662279354, 1924.6246981838547, 1962.2249211561352, 70635.64682176607, 78074.21925780726, 79553.0, 85312.57343713242, 89405.55297223537, 10581.84127238092, 10829.187810914213, 11013.83479247812, 11196.712378076463, 11237.157213209042, 15237.923810380877, 15249.313780879887, 15275.541733748005, 15304.770428443582, 15313.23433828304, 7223.169335526377, 7237.493375463667, 7692.538447693044, 7864.764057078297, 7868.803279918048, 7159.176694680178, 7178.964105179441, 7299.781006569811, 7336.559806411526, 7409.333160015624, 4569.908601827945, 4604.125216208977, 4613.123506533748, 4623.468301145344, 4708.199606066977, 1935.2839449403812, 1952.8730632508841, 1971.1228503315888, 1992.750906136733, 1998.7201791749167, 982.0, 995.7198016542183, 1037.8235699930879, 1073.7047311989265, 1075.714935542082, 19269.903650481938, 20178.192872284944, 20243.696344554843, 20245.08897099634, 20521.281755138796, 983.5475681186591, 987.4618333008384, 991.5141580625586, 1050.054950544516, 1076.2842709598185, 10740.785184296426, 11305.378204198849, 11401.258918170292, 11407.372594507382, 11500.884991149982, 498274.0, 516180.0, 516303.0, 518373.0, 522383.0, 79951.60024199841, 96365.51817240869, 101814.0, 103102.0, 103488.0, 995.915347195482, 1043.4156872151468, 1061.8407238914224, 1063.8989296016866, 1064.6433444795925, 17807.198676059867, 17943.192556334736, 18540.536486587942, 18591.90704046471, 18818.0, 42355.152896941276, 43531.34702979394, 44275.0, 44356.778216108716, 45554.31668524908, 60024.39975600188, 61593.0, 61906.0, 63441.68279158575, 63512.0, 8352.123027082313, 8530.914690853013, 8584.65661373538, 8631.654733810577, 8816.691415800417, 8982.595783189641, 9305.11601397866, 9436.103570160823, 9670.661526846527, 10001.99980001994, 8286.295664868554, 8307.335413166811, 8469.491830490191, 8574.91425085766, 8592.828143436971, 8350.248477636798, 8437.789055273668, 8538.103499132501, 8538.91461085406, 8778.122187781171, 8342.040665323566, 8402.32781377476, 8421.70524031656, 8449.957750211455, 8941.37410381267, 11967.461464234304, 13192.340382981005, 13318.933405332911, 13343.399547020214, 13375.398107085399, 12551.121421500773, 12970.416331265304, 13043.543475978295, 13132.14641048367, 13249.801252981406], "value": 8984.432787913096, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.9124052556845, 1471.9779203311953, 1613.9919300403496, 1790.5971156489784, 1800.5498625343655, 7807.297343239107, 8267.255946964771, 8604.91395086049, 9152.313576481765, 9171.816563668732, 8415.99008119025, 8567.57162141892, 8651.04838467768, 8731.083236260196, 8753.562321883912, 2243.091547923094, 2313.0747700919683, 2317.385892738426, 2317.7682231776857, 2321.2804030750435, 2228.3092241405134, 2249.876256805875, 2317.177402022283, 2318.3508617587104, 2319.8840057997118, 2271.6706077618737, 2293.747687754346, 2311.503026849227, 2315.050829160045, 2315.154968436517, 2227.8774667393286, 2236.8546044507216, 2240.204727321802, 2242.248846636379, 2246.7416247131546, 2215.3686199433246, 2217.7006104176053, 2218.3344996500987, 2219.9223027194134, 2235.944101397478, 8786.472811631258, 8904.688335908211, 8910.465372077697, 8918.375713700043, 8967.596458159333, 5040.899182016376, 5131.563817075553, 5165.690058596496, 5181.5077567631015, 5183.663061900965, 3202.615686117681, 3263.9347213055607, 3413.6245013048792, 3421.4525675891737, 3437.364087643794, 1102.08526922654, 1104.6465131158034, 1126.3692332293942, 1135.6649788312468, 1139.117184182257, 12271.325077120755, 12369.072319576067, 12399.75200495994, 12438.19151755142, 12495.687607809787, 4602.930956035662, 4640.69835460694, 4770.594499467515, 4776.498467660846, 4819.662623616383, 10521.579136834442, 10592.947035264775, 10625.681229563126, 10627.618409606855, 10638.787224255471, 5260.105782017066, 5260.842174734687, 5288.391834938954, 5294.100002999499, 5313.256144139824, 4237.788110594458, 4696.624270058387, 4842.273658951115, 4846.030793841246, 4852.636052296092, 3983.50206224222, 4029.4157347184496, 4113.424120623115, 4150.813213405404, 4158.106007208465, 1248.8938440232682, 1249.8937590304927, 1260.8297879786294, 1284.0048962054295, 1300.63582196985, 959.6065613098735, 972.2416515118077, 988.8615593816871, 997.2919227348664, 1001.484235618657, 5791.478766910998, 5914.349421563625, 6271.62370257786, 6292.276388215322, 6407.615543067431, 451.64545831522753, 458.07697489558564, 461.12156342168225, 462.25115313192174, 468.33730271665894, 4007.3988901664984, 4108.219438306712, 4123.072308730511, 4125.958740412558, 4179.101493178981, 10586.417747023834, 11218.0, 11219.382933938548, 11270.380129092979, 11282.717932051764, 10338.12125969286, 10789.946050269855, 11097.889021109686, 11116.833247501294, 11165.050970667422, 8260.132686067876, 8335.458195217292, 8358.247757701714, 8401.36989725773, 8419.494830310201, 6110.358412366638, 6338.144350512622, 6388.201474815648, 6449.935500644933, 6532.542722009413, 10221.795564088825, 10254.077133058061, 10265.794684106128, 10273.743156420851, 10358.171346292127, 9728.805423891625, 10196.082352588302, 10263.12763415118, 10401.427921464392, 10476.895231047592, 7078.362947334765, 7567.545947243183, 7864.646090925808, 7916.287534121957, 8018.358531317597, 8549.358798090292, 8618.267447267053, 8628.22345988864, 8667.91332086671, 8671.523066231417, 7550.131734850563, 7801.1808760079375, 7932.6430310635005, 7951.960240198762, 8094.919050809416, 7598.354139898171, 7664.386849051951, 7811.765647030598, 7970.681172753025, 7997.7600671979935, 7015.123109611299, 7124.073870396815, 7173.928260717326, 7183.20984691694, 7210.603416812126, 5090.720010399464, 5091.694498330112, 5204.661696989683, 5241.7379131042535, 5331.1470164773455, 5185.559227465707, 5239.528442440199, 5303.242313996777, 5450.155225939986, 5466.180072989084], "value": 4580.771077787084, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.68538175279093, 323.11949936423247, 329.16720696637503, 330.88253669947153, 334.1295924117675, 5654.293213348332, 5718.513926316263, 5725.513331366834, 5741.224934633823, 5775.971120144393, 5605.159226116085, 5625.746841392137, 5656.0, 5658.547316214704, 5669.829905102843, 4174.853880114204, 4198.391233271173, 4331.5884990925815, 4365.2142614329405, 4370.4099946507295, 4339.414179085815, 4342.196693611692, 4350.347447882811, 4359.735676653767, 4371.14762621289, 4301.591348821873, 4333.2416827055295, 4346.065595896882, 4350.36919646651, 4353.651707863379, 4251.319788833787, 4294.377315289296, 4301.526832048472, 4312.504062032875, 4318.52496225415, 3758.9812050939845, 3776.527934008249, 3814.5613254475534, 3824.349860523718, 3844.7500912440883, 5481.561475081984, 5483.287172667568, 5501.0, 5501.229827824108, 5506.64206826555, 4892.804287828482, 4943.258511223309, 4986.90026199474, 4990.850274491771, 4997.350344455198, 5796.2464879565805, 5797.36229014808, 5808.215890854723, 5821.563382746311, 5833.912491312633, 4207.453031105967, 4207.579242075768, 4209.768462734548, 4223.303154979425, 4229.6827737919475, 6004.909926351108, 6024.939750602482, 6032.728527216242, 6066.636001839904, 6088.512918966472, 4274.871753847389, 4309.095090031128, 4317.395564620955, 4319.308910574356, 4329.28566786483, 4369.235383807821, 4372.540883207281, 4381.5759878039125, 4383.167198232326, 4402.449693788277, 4598.954010459853, 4918.458969513351, 4926.261060840831, 4932.704037757674, 4996.825111121093, 5918.425484914076, 5931.347551769302, 5934.961381758175, 5950.8809823803285, 5952.464278214981, 1455.3523681961638, 1455.6535204935392, 1458.0886945658963, 1465.3113036872653, 1466.618679143409, 921.4102974096584, 948.7485816258697, 978.844962943719, 988.8121256961155, 998.605550807427, 5630.774769009276, 5651.717414129277, 5663.621279062803, 5664.85837854057, 5684.317881854204, 5999.310079340931, 6028.909566356509, 6032.371259759928, 6033.456988871023, 6040.697965101727, 5491.176323551499, 5534.6754363167565, 5647.604667673223, 5673.489385955201, 5712.857178570486, 3194.7444204463586, 3228.8224147672104, 3230.9030729077695, 3241.367933252993, 3244.740420766333, 6071.939280607137, 6166.352532984062, 6177.96911015442, 6204.084080482166, 6204.844878877974, 6099.268087829489, 6105.633661980295, 6116.418940200674, 6139.754409823647, 6164.630122192682, 6051.668632900754, 6166.383361663888, 6227.16298691887, 6255.624662520263, 6264.5301602380005, 5928.525717942468, 5968.194293770285, 5971.58198926071, 5974.0, 6000.0, 5940.762369505344, 5948.453402115395, 6009.87980240384, 6012.87974240504, 6022.879542409215, 6049.879002420015, 6159.322474527888, 6169.938300616936, 6210.968945155245, 6232.5325600581045, 4162.895927601713, 4167.62468385426, 4183.811728472287, 4188.5811418857875, 4194.035371864427, 5981.127318922696, 6025.517958563217, 6035.909461358171, 6068.21113255274, 6083.330833608388, 5677.687727175045, 5798.536117110705, 5813.750043740616, 5814.76740930358, 5817.76728930838, 5756.712164391847, 5825.75708352279, 5828.358880523054, 5835.416458354131, 5858.920083370513, 5285.973570132125, 5758.2514273144225, 5780.248567686174, 5784.595078344644, 5824.126381042708, 5897.941020589739, 5907.3797251288, 5929.9110513341475, 5947.464728174312, 5973.701314934149, 5531.474509921551, 5784.190213370048, 5789.594728368974, 5792.247007888947, 5810.593258471867], "value": 4455.627378717655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.2264633458036, 771.0824119298035, 795.5187111797362, 813.3818298093447, 856.3662889461798, 13919.512817051405, 14375.353109110089, 14423.0, 14433.927830360859, 14524.927375363135, 12399.256044637306, 12564.811527827067, 12582.685432864182, 12603.432845521951, 12645.430955606997, 645.8837409266354, 783.4241832253289, 784.6900474312644, 809.5709274084716, 811.6550466051934, 793.4089103617813, 794.0749027383092, 803.9517628942282, 806.9273765361116, 810.2343285595115, 846.0481957797477, 847.2501835875233, 851.6125163050827, 851.82537579796, 852.0925214646381, 847.1189962439056, 849.5752123938031, 851.9488830670149, 852.1776485691306, 853.1340689200435, 620.7703149834545, 620.8758248350348, 620.8975519039399, 622.8007037747923, 622.8691974685322, 13166.0, 13184.472621095145, 13204.60386188416, 13211.73576528464, 13249.536266230636, 15017.774733379008, 15149.621259468491, 15198.240087995557, 15308.464203752927, 15475.922620386826, 10968.287061340987, 11051.557937682483, 11233.157513186461, 11305.943470282678, 11770.17608767378, 3541.6635419635095, 3657.579378371495, 3753.3244016077097, 3764.209516001643, 3836.558795738498, 72956.63521682411, 76231.61884190599, 76632.0, 77860.22139778586, 78362.99999999943, 11488.425578721031, 11626.476808543635, 11779.646610601696, 12188.085893558018, 12336.876631233572, 23006.0, 23017.654735178985, 23124.884375578014, 23189.7681023191, 23202.7679723204, 8558.400911936105, 8583.914160858312, 8688.91311086881, 8709.477431354138, 8712.477251364939, 4547.795349209294, 4615.9076818463445, 4660.39414876064, 4664.836730714409, 4703.835365762182, 3478.4608385700258, 3595.6404359563835, 3598.8740394086603, 3966.0, 4143.8964025898995, 713.878640631094, 721.4228617106294, 727.4144313827314, 728.1735230513406, 728.9635518224173, 743.1194035068461, 757.8257000889716, 768.673313841615, 778.7118766056595, 780.6565111350988, 9837.458939758239, 10011.449370284705, 10139.997318249238, 10348.637797677196, 10800.405977671146, 739.6199368884148, 740.8333125046821, 749.089855825175, 756.2928661701327, 762.6949220311919, 4737.478877323491, 4958.553730164303, 5001.399832020181, 5003.3495645565845, 5058.696478211319, 76756.0, 124030.79846007664, 131513.0, 134054.32972835074, 134738.0, 30916.0, 31160.22099447532, 91900.0, 108277.0, 109825.45087274513, 58332.0, 59251.0, 78675.60662196652, 84270.5786471076, 97266.0, 9446.763830904283, 9520.155463650295, 9535.713928582154, 9545.761355966157, 9550.587048477004, 53234.0, 54608.0, 55987.160192597956, 56815.0, 58422.4157758417, 74623.25376746163, 84722.57638711768, 86810.0, 87681.56159219163, 87802.0, 11672.241304315192, 12427.689307767378, 12475.563355282522, 12523.812142818048, 12889.355532223164, 14059.578212653636, 14078.648033799236, 14250.358733857209, 14295.64260893486, 14313.64215894611, 13236.205827650372, 13402.396892140072, 13600.591982240549, 13628.318584070956, 13775.655608609864, 12412.255264684149, 12575.434105465092, 12762.808557871454, 12772.0, 12982.221066736027, 12814.231146131262, 13004.349782510648, 13113.0, 13362.532311369445, 13505.12216705911, 10487.528061237415, 10665.146788257076, 10973.725656858323, 11064.114870810477, 11402.258853174517, 10533.631322903662, 10806.297590656583, 11083.0, 11088.501017454395, 11135.88864111381], "value": 7502.509509816469, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 105.0, 110.0, 111.0, 113.0, 112.0, 110.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 146.0, 170.0, 118.0, 150.0, 145.0, 120.0, 181.0, 119.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 163.0, 162.0, 164.0, 176.0, 162.0, 162.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 151.0, 79.0, 76.0, 75.0, 77.0, 161.0, 77.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 162.0, 84.0, 84.0, 84.0, 150.0, 84.0, 85.0, 163.0], "value": 106.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 117.0, 118.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 149.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 56.0, 54.0, 53.0, 55.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 62.0, 65.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 76.0, 77.0, 81.0, 76.0, 76.0, 75.0, 81.0, 76.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 120.0, 137.0, 120.0, 134.0, 124.0, 122.0, 166.0, 122.0], "value": 129.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 174.0, 164.0, 166.0, 171.0, 165.0, 166.0, 165.0, 162.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 67.0, 65.0, 64.0, 66.0, 65.0, 64.0, 64.0, 63.0], "value": 64.7, "unit": "score"}]}]} 19:33:19 INFO - Return code: 0 19:33:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:33:19 ERROR - # TBPL SUCCESS # 19:33:19 INFO - Running post-action listener: _resource_record_post_action 19:33:19 INFO - ##### 19:33:19 INFO - ##### Finished run-tests step (success) 19:33:19 INFO - ##### 19:33:19 INFO - Running post-run listener: _resource_record_post_run 19:33:19 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 563990528; Read time: 20; Write time: 857184 19:33:19 INFO - TinderboxPrint: CPU usage
13.4% 19:33:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 19:33:19 INFO - TinderboxPrint: I/O write bytes / time
563,990,528 / 857,184 19:33:19 INFO - TinderboxPrint: CPU idle
8,227.2 (86.6%) 19:33:19 INFO - TinderboxPrint: CPU user
1,212.5 (12.8%) 19:33:19 INFO - TinderboxPrint: Swap in / out
0 / 0 19:33:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 267784192; Read time: 0; Write time: 425056 19:33:19 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 296206336; Read time: 0; Write time: 432128 19:33:20 INFO - Running post-run listener: _upload_blobber_files 19:33:20 INFO - Blob upload gear active. 19:33:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:33:20 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 19:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:33:20 INFO - (blobuploader) - INFO - Open directory for files ... 19:33:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:33:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:33:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:24 INFO - (blobuploader) - INFO - Done attempting. 19:33:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:33:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:33:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:24 INFO - (blobuploader) - INFO - Done attempting. 19:33:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:33:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:33:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:25 INFO - (blobuploader) - INFO - Done attempting. 19:33:25 INFO - (blobuploader) - INFO - Iteration through files over. 19:33:25 INFO - Return code: 0 19:33:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:33:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:33:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73d22223dcd69d58a4e1d25f8994816151ed5bb6dd772b4fdedd1fb5bed7fb414f35fdafbfcb2cf140eeb7c79e5702ea8f357b4b65f8a0fd4bb2d52e10626564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cd180d81325d1d23026978c0724348ddfdee821fa352dffffd907691506a4ed7b68a289ca9603eae0d7aa4ef19a1434386b7dba1c12fecd337c8b5be93521ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4ffc91ae641b771ae31100c4318c0df64c1b51826eb644f3d03caeed41f61c658224a9a7e2b9007446738ad14b6657fb35eae2c3fabeb6f082b56a762f46f89"} 19:33:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:33:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:33:25 INFO - Contents: 19:33:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73d22223dcd69d58a4e1d25f8994816151ed5bb6dd772b4fdedd1fb5bed7fb414f35fdafbfcb2cf140eeb7c79e5702ea8f357b4b65f8a0fd4bb2d52e10626564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cd180d81325d1d23026978c0724348ddfdee821fa352dffffd907691506a4ed7b68a289ca9603eae0d7aa4ef19a1434386b7dba1c12fecd337c8b5be93521ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4ffc91ae641b771ae31100c4318c0df64c1b51826eb644f3d03caeed41f61c658224a9a7e2b9007446738ad14b6657fb35eae2c3fabeb6f082b56a762f46f89"} 19:33:25 INFO - Running post-run listener: copy_logs_to_upload_dir 19:33:25 INFO - Copying logs to upload dir... 19:33:25 INFO - mkdir: /builds/slave/test/build/upload/logs 19:33:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.893042 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-09 19:33:24.486908) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 19:33:24.491024) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73d22223dcd69d58a4e1d25f8994816151ed5bb6dd772b4fdedd1fb5bed7fb414f35fdafbfcb2cf140eeb7c79e5702ea8f357b4b65f8a0fd4bb2d52e10626564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cd180d81325d1d23026978c0724348ddfdee821fa352dffffd907691506a4ed7b68a289ca9603eae0d7aa4ef19a1434386b7dba1c12fecd337c8b5be93521ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4ffc91ae641b771ae31100c4318c0df64c1b51826eb644f3d03caeed41f61c658224a9a7e2b9007446738ad14b6657fb35eae2c3fabeb6f082b56a762f46f89"} build_url:https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/E9CZ37GfSFa0u5kqu7agFw/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/Mozilla-Inbound/sha512/73d22223dcd69d58a4e1d25f8994816151ed5bb6dd772b4fdedd1fb5bed7fb414f35fdafbfcb2cf140eeb7c79e5702ea8f357b4b65f8a0fd4bb2d52e10626564", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8cd180d81325d1d23026978c0724348ddfdee821fa352dffffd907691506a4ed7b68a289ca9603eae0d7aa4ef19a1434386b7dba1c12fecd337c8b5be93521ef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4ffc91ae641b771ae31100c4318c0df64c1b51826eb644f3d03caeed41f61c658224a9a7e2b9007446738ad14b6657fb35eae2c3fabeb6f082b56a762f46f89"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 19:33:24.516584) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 19:33:24.516921) ========= 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=5bd038846534b2fdfa68eeae000001e2-1468116615.159228-745757168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 19:33:24.601491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 19:33:24.601815) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 19:33:24.602116) ========= ========= Total master_lag: 0.17 =========