builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1467982869.51 results: success (0) buildid: 20160708030216 builduid: 45601d08de994270872094a59096e962 revision: 45682df2d2d45e5a8385fd842579e661a4b60bc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:09.507040) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:09.507512) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:09.507795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:09.529623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:09.530018) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 06:01:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.3M=0s 2016-07-08 06:01:09 (38.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115331 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:09.659698) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:09.660131) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017409 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:09.710609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 06:01:09.710978) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45682df2d2d45e5a8385fd842579e661a4b60bc5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 45682df2d2d45e5a8385fd842579e661a4b60bc5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 06:01:10,009 truncating revision to first 12 chars 2016-07-08 06:01:10,009 Setting DEBUG logging. 2016-07-08 06:01:10,009 attempt 1/10 2016-07-08 06:01:10,009 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45682df2d2d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 06:01:11,345 unpacking tar archive at: mozilla-central-45682df2d2d4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.729125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 06:01:11.453830) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:11.454190) ========= script_repo_revision: 45682df2d2d45e5a8385fd842579e661a4b60bc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:11.454629) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:11.454900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 06:01:11.464205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-08 06:01:11.464623) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:01:11 INFO - MultiFileLogger online at 20160708 06:01:11 in /builds/slave/test 06:01:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:01:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:01:11 INFO - {'append_to_log': False, 06:01:11 INFO - 'base_work_dir': '/builds/slave/test', 06:01:11 INFO - 'blob_upload_branch': 'Firefox', 06:01:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:01:11 INFO - 'branch': 'Firefox', 06:01:11 INFO - 'buildbot_json_path': 'buildprops.json', 06:01:11 INFO - 'config_files': ('talos/linux_config.py',), 06:01:11 INFO - 'default_actions': ('clobber', 06:01:11 INFO - 'read-buildbot-config', 06:01:11 INFO - 'download-and-extract', 06:01:11 INFO - 'populate-webroot', 06:01:11 INFO - 'create-virtualenv', 06:01:11 INFO - 'install', 06:01:11 INFO - 'run-tests'), 06:01:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:01:11 INFO - 'download_minidump_stackwalk': True, 06:01:11 INFO - 'download_symbols': 'ondemand', 06:01:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:01:11 INFO - 'tooltool.py': '/tools/tooltool.py', 06:01:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:01:11 INFO - '/tools/misc-python/virtualenv.py')}, 06:01:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:01:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:01:11 INFO - 'installer_path': 'installer.exe', 06:01:11 INFO - 'log_level': 'info', 06:01:11 INFO - 'log_name': 'talos', 06:01:11 INFO - 'log_to_console': True, 06:01:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:01:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:01:11 INFO - 'opt_config_files': (), 06:01:11 INFO - 'pip_index': False, 06:01:11 INFO - 'sps_profile': False, 06:01:11 INFO - 'sps_profile_interval': 0, 06:01:11 INFO - 'suite': 'dromaeojs', 06:01:11 INFO - 'system_bits': '32', 06:01:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:01:11 INFO - 'title': 'talos-linux64-ix-049', 06:01:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:01:11 INFO - 'use_talos_json': True, 06:01:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:01:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:01:11 INFO - 'work_dir': 'build'} 06:01:11 INFO - ##### 06:01:11 INFO - ##### Running clobber step. 06:01:11 INFO - ##### 06:01:11 INFO - Running pre-action listener: _resource_record_pre_action 06:01:11 INFO - Running main action method: clobber 06:01:11 INFO - rmtree: /builds/slave/test/build 06:01:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:01:12 INFO - Running post-action listener: _resource_record_post_action 06:01:12 INFO - ##### 06:01:12 INFO - ##### Finished clobber step (success) 06:01:12 INFO - ##### 06:01:12 INFO - ##### 06:01:12 INFO - ##### Running read-buildbot-config step. 06:01:12 INFO - ##### 06:01:12 INFO - Running pre-action listener: _resource_record_pre_action 06:01:12 INFO - Running main action method: read_buildbot_config 06:01:12 INFO - Using buildbot properties: 06:01:12 INFO - { 06:01:12 INFO - "project": "", 06:01:12 INFO - "product": "firefox", 06:01:12 INFO - "script_repo_revision": "production", 06:01:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:01:12 INFO - "repository": "", 06:01:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:01:12 INFO - "buildid": "20160708030216", 06:01:12 INFO - "stage_platform": "linux64-pgo", 06:01:12 INFO - "basedir": "/builds/slave/test", 06:01:12 INFO - "nightly_build": "True", 06:01:12 INFO - "buildnumber": 375, 06:01:12 INFO - "slavename": "talos-linux64-ix-049", 06:01:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:01:12 INFO - "platform": "ubuntu64_hw", 06:01:12 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:01:12 INFO - "branch": "mozilla-central", 06:01:12 INFO - "repo_path": "mozilla-central", 06:01:12 INFO - "revision": "45682df2d2d45e5a8385fd842579e661a4b60bc5", 06:01:12 INFO - "pgo_build": "True", 06:01:12 INFO - "builduid": "45601d08de994270872094a59096e962", 06:01:12 INFO - "slavebuilddir": "test" 06:01:12 INFO - } 06:01:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:01:12 INFO - Running post-action listener: _resource_record_post_action 06:01:12 INFO - ##### 06:01:12 INFO - ##### Finished read-buildbot-config step (success) 06:01:12 INFO - ##### 06:01:12 INFO - ##### 06:01:12 INFO - ##### Running download-and-extract step. 06:01:12 INFO - ##### 06:01:12 INFO - Running pre-action listener: _resource_record_pre_action 06:01:12 INFO - Running main action method: download_and_extract 06:01:12 INFO - mkdir: /builds/slave/test/build/tests 06:01: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')]} 06:01:12 INFO - https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:01:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/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 06:01:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/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 06:01:13 INFO - Downloaded 1361 bytes. 06:01:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:01:13 INFO - Using the following test package requirements: 06:01:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:01:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:01:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:13 INFO - u'jsshell-linux-x86_64.zip'], 06:01:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:01:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:01:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:01:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:01:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:01:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:01:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:01:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:01:13 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')]} 06:01:13 INFO - https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:01:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/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 06:01:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/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 06:01:15 INFO - Downloaded 24303499 bytes. 06:01:15 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'] 06:01:15 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 06:01:16 INFO - Return code: 0 06:01:16 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 06:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:16 INFO - https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:01:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:01:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/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 06:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/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 06:01:17 INFO - Downloaded 24303499 bytes. 06:01:17 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'] 06:01:17 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 06:01:18 INFO - Return code: 0 06:01:18 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')]} 06:01:18 INFO - https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:01:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:01:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/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 06:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/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 06:01:20 INFO - Downloaded 14403333 bytes. 06:01:20 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'] 06:01:20 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 06:01:20 INFO - Return code: 0 06:01: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')]} 06:01:20 INFO - https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:01:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/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 06:01:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dKZFsTF8QQeVJh_cibp5dA/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 06:01:21 INFO - Downloaded 60459947 bytes. 06:01:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:21 INFO - mkdir: /builds/slave/test/properties 06:01:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:01:21 INFO - Writing to file /builds/slave/test/properties/build_url 06:01:21 INFO - Contents: 06:01:21 INFO - build_url:https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:01:22 INFO - Running post-action listener: _resource_record_post_action 06:01:22 INFO - Running post-action listener: set_extra_try_arguments 06:01:22 INFO - ##### 06:01:22 INFO - ##### Finished download-and-extract step (success) 06:01:22 INFO - ##### 06:01:22 INFO - ##### 06:01:22 INFO - ##### Running populate-webroot step. 06:01:22 INFO - ##### 06:01:22 INFO - Running pre-action listener: _resource_record_pre_action 06:01:22 INFO - Running main action method: populate_webroot 06:01:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:01:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:01:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:01:22 INFO - '--tppagecycles', 06:01:22 INFO - '7'], 06:01:22 INFO - 'tests': ['tsvgm']}}, 06:01:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:01:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:01:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:01:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:01:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:22 INFO - 'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:01:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:22 INFO - 'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['damp', 'tps']}, 06:01:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:22 INFO - 'tests': ['damp', 'tps']}, 06:01:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['dromaeo_dom']}, 06:01:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:01:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['basic_compositor_video']}, 06:01:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:01:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['a11yr', 06:01:22 INFO - 'ts_paint', 06:01:22 INFO - 'tpaint', 06:01:22 INFO - 'sessionrestore', 06:01:22 INFO - 'sessionrestore_no_auto_restore', 06:01:22 INFO - 'tabpaint']}, 06:01:22 INFO - 'other-e10s': {'tests': ['a11yr', 06:01:22 INFO - 'ts_paint', 06:01:22 INFO - 'tpaint', 06:01:22 INFO - 'sessionrestore', 06:01:22 INFO - 'sessionrestore_no_auto_restore', 06:01:22 INFO - 'tabpaint']}, 06:01:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:01:22 INFO - 'ts_paint', 06:01:22 INFO - 'tpaint', 06:01:22 INFO - 'sessionrestore', 06:01:22 INFO - 'sessionrestore_no_auto_restore', 06:01:22 INFO - 'tabpaint']}, 06:01:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:01:22 INFO - 'ts_paint', 06:01:22 INFO - 'tpaint', 06:01:22 INFO - 'sessionrestore', 06:01:22 INFO - 'sessionrestore_no_auto_restore', 06:01:22 INFO - 'tabpaint']}, 06:01:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['a11yr', 06:01:22 INFO - 'ts_paint', 06:01:22 INFO - 'tpaint', 06:01:22 INFO - 'sessionrestore', 06:01:22 INFO - 'sessionrestore_no_auto_restore', 06:01:22 INFO - 'tabpaint']}, 06:01:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['a11yr', 06:01:22 INFO - 'ts_paint', 06:01:22 INFO - 'tpaint', 06:01:22 INFO - 'sessionrestore', 06:01:22 INFO - 'sessionrestore_no_auto_restore', 06:01:22 INFO - 'tabpaint']}, 06:01:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['tsvgx', 06:01:22 INFO - 'tsvgr_opacity', 06:01:22 INFO - 'tart', 06:01:22 INFO - 'tscrollx', 06:01:22 INFO - 'cart']}, 06:01:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:01:22 INFO - 'tsvgr_opacity', 06:01:22 INFO - 'tart', 06:01:22 INFO - 'tscrollx', 06:01:22 INFO - 'cart']}, 06:01:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:22 INFO - 'talos_options': ['--disable-e10s'], 06:01:22 INFO - 'tests': ['tp5o']}, 06:01:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:22 INFO - 'tests': ['tp5o']}, 06:01:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:22 INFO - 'talos_options': ['--disable-e10s', 06:01:22 INFO - '--xperf_path', 06:01:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:22 INFO - 'tests': ['tp5n']}, 06:01:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:01:22 INFO - 'talos_options': ['--xperf_path', 06:01:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:01:22 INFO - 'tests': ['tp5n']}}, 06:01:22 INFO - 'talos.zip': {'path': '', 06:01:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:01:22 INFO - Running post-action listener: _resource_record_post_action 06:01:22 INFO - ##### 06:01:22 INFO - ##### Finished populate-webroot step (success) 06:01:22 INFO - ##### 06:01:22 INFO - ##### 06:01:22 INFO - ##### Running create-virtualenv step. 06:01:22 INFO - ##### 06:01:22 INFO - Running pre-action listener: _resource_record_pre_action 06:01:22 INFO - Running main action method: create_virtualenv 06:01:22 INFO - Creating virtualenv /builds/slave/test/build/venv 06:01:22 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 06:01:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:01:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:01:22 INFO - Using real prefix '/usr' 06:01:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:01:23 INFO - Installing distribute.............................................................................................................................................................................................done. 06:01:25 INFO - Installing pip.................done. 06:01:25 INFO - Return code: 0 06:01:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:01:25 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')]} 06:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:25 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')]} 06:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:25 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 0x1ca4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f633b0>, '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 0x1f642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f64740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', '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 06:01:25 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 06:01:25 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 06:01:25 INFO - Using env: {'DISPLAY': ':0', 06:01:25 INFO - 'HOME': '/home/cltbld', 06:01:25 INFO - 'LANG': 'en_US.UTF-8', 06:01:25 INFO - 'LANGUAGE': 'en_US:en', 06:01:25 INFO - 'LOGNAME': 'cltbld', 06:01:25 INFO - 'MAIL': '/var/mail/cltbld', 06:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:25 INFO - 'MOZ_NO_REMOTE': '1', 06:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:25 INFO - 'NO_EM_RESTART': '1', 06:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:25 INFO - 'PWD': '/builds/slave/test', 06:01:25 INFO - 'SHELL': '/bin/bash', 06:01:25 INFO - 'SHLVL': '1', 06:01:25 INFO - 'TERM': 'linux', 06:01:25 INFO - 'TMOUT': '86400', 06:01:25 INFO - 'USER': 'cltbld', 06:01:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', 06:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:25 INFO - '_': '/tools/buildbot/bin/python'} 06:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:25 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 06:01:25 INFO - Cleaning up... 06:01:25 INFO - Return code: 0 06:01:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:01:25 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')]} 06:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:25 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')]} 06:01:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:25 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 0x1ca4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f633b0>, '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 0x1f642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f64740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', '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 06:01:25 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 06:01:25 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 06:01:25 INFO - Using env: {'DISPLAY': ':0', 06:01:25 INFO - 'HOME': '/home/cltbld', 06:01:25 INFO - 'LANG': 'en_US.UTF-8', 06:01:25 INFO - 'LANGUAGE': 'en_US:en', 06:01:25 INFO - 'LOGNAME': 'cltbld', 06:01:25 INFO - 'MAIL': '/var/mail/cltbld', 06:01:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:25 INFO - 'MOZ_NO_REMOTE': '1', 06:01:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:25 INFO - 'NO_EM_RESTART': '1', 06:01:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:25 INFO - 'PWD': '/builds/slave/test', 06:01:25 INFO - 'SHELL': '/bin/bash', 06:01:25 INFO - 'SHLVL': '1', 06:01:25 INFO - 'TERM': 'linux', 06:01:25 INFO - 'TMOUT': '86400', 06:01:25 INFO - 'USER': 'cltbld', 06:01:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', 06:01:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:25 INFO - '_': '/tools/buildbot/bin/python'} 06:01:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:25 INFO - Downloading/unpacking psutil>=3.1.1 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01: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 06:01:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:01:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:27 INFO - Installing collected packages: psutil 06:01:27 INFO - Running setup.py install for psutil 06:01:27 INFO - building 'psutil._psutil_linux' extension 06:01:27 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 06:01:28 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 06:01:28 INFO - building 'psutil._psutil_posix' extension 06:01:28 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 06:01:28 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 06:01:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:01:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:01:28 INFO - Successfully installed psutil 06:01:28 INFO - Cleaning up... 06:01:28 INFO - Return code: 0 06:01:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:01: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')]} 06:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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')]} 06:01:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f633b0>, '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 0x1f642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f64740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', '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 06:01: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:01: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 mozsystemmonitor==0.3 06:01:28 INFO - Using env: {'DISPLAY': ':0', 06:01:28 INFO - 'HOME': '/home/cltbld', 06:01:28 INFO - 'LANG': 'en_US.UTF-8', 06:01:28 INFO - 'LANGUAGE': 'en_US:en', 06:01:28 INFO - 'LOGNAME': 'cltbld', 06:01:28 INFO - 'MAIL': '/var/mail/cltbld', 06:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:28 INFO - 'MOZ_NO_REMOTE': '1', 06:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:28 INFO - 'NO_EM_RESTART': '1', 06:01:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:28 INFO - 'PWD': '/builds/slave/test', 06:01:28 INFO - 'SHELL': '/bin/bash', 06:01:28 INFO - 'SHLVL': '1', 06:01:28 INFO - 'TERM': 'linux', 06:01:28 INFO - 'TMOUT': '86400', 06:01:28 INFO - 'USER': 'cltbld', 06:01:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', 06:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:28 INFO - '_': '/tools/buildbot/bin/python'} 06:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:01:28 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 06:01:28 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 06:01:28 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 06:01:28 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 06:01:28 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 06:01:28 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 06:01:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:01:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:01:30 INFO - Installing collected packages: mozsystemmonitor 06:01:30 INFO - Running setup.py install for mozsystemmonitor 06:01:30 INFO - Successfully installed mozsystemmonitor 06:01:30 INFO - Cleaning up... 06:01:30 INFO - Return code: 0 06:01:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:30 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 0x1ca4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f633b0>, '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 0x1f642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f64740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', '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 06:01:30 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 06:01:30 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 06:01:30 INFO - Using env: {'DISPLAY': ':0', 06:01:30 INFO - 'HOME': '/home/cltbld', 06:01:30 INFO - 'LANG': 'en_US.UTF-8', 06:01:30 INFO - 'LANGUAGE': 'en_US:en', 06:01:30 INFO - 'LOGNAME': 'cltbld', 06:01:30 INFO - 'MAIL': '/var/mail/cltbld', 06:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:30 INFO - 'MOZ_NO_REMOTE': '1', 06:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:30 INFO - 'NO_EM_RESTART': '1', 06:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:30 INFO - 'PWD': '/builds/slave/test', 06:01:30 INFO - 'SHELL': '/bin/bash', 06:01:30 INFO - 'SHLVL': '1', 06:01:30 INFO - 'TERM': 'linux', 06:01:30 INFO - 'TMOUT': '86400', 06:01:30 INFO - 'USER': 'cltbld', 06:01:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', 06:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:30 INFO - '_': '/tools/buildbot/bin/python'} 06:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:30 INFO - Downloading/unpacking jsonschema==2.5.1 06:01:30 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 06:01:30 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 06:01:30 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 06:01:30 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 06:01:30 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 06:01:30 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 06:01:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:01:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:01:32 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 06:01:32 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 06:01:32 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 06:01:32 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 06:01:32 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 06:01:32 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 06:01:32 INFO - Downloading functools32-3.2.3-2.tar.gz 06:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:01:33 INFO - warning: no files found matching '*.txt' 06:01:33 INFO - no previously-included directories found matching 'build' 06:01:33 INFO - no previously-included directories found matching 'dist' 06:01:33 INFO - no previously-included directories found matching '.git*' 06:01:33 INFO - Installing collected packages: jsonschema, functools32 06:01:33 INFO - Running setup.py install for functools32 06:01:33 INFO - warning: no files found matching '*.txt' 06:01:33 INFO - no previously-included directories found matching 'build' 06:01:33 INFO - no previously-included directories found matching 'dist' 06:01:33 INFO - no previously-included directories found matching '.git*' 06:01:33 INFO - Successfully installed jsonschema functools32 06:01:33 INFO - Cleaning up... 06:01:33 INFO - Return code: 0 06:01:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:01:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:33 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 0x1ca4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f633b0>, '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 0x1f642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f64740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', '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 06:01:33 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 06:01:33 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 06:01:33 INFO - Using env: {'DISPLAY': ':0', 06:01:33 INFO - 'HOME': '/home/cltbld', 06:01:33 INFO - 'LANG': 'en_US.UTF-8', 06:01:33 INFO - 'LANGUAGE': 'en_US:en', 06:01:33 INFO - 'LOGNAME': 'cltbld', 06:01:33 INFO - 'MAIL': '/var/mail/cltbld', 06:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:33 INFO - 'MOZ_NO_REMOTE': '1', 06:01:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:33 INFO - 'NO_EM_RESTART': '1', 06:01:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:33 INFO - 'PWD': '/builds/slave/test', 06:01:33 INFO - 'SHELL': '/bin/bash', 06:01:33 INFO - 'SHLVL': '1', 06:01:33 INFO - 'TERM': 'linux', 06:01:33 INFO - 'TMOUT': '86400', 06:01:33 INFO - 'USER': 'cltbld', 06:01:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', 06:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:33 INFO - '_': '/tools/buildbot/bin/python'} 06:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:33 INFO - Downloading/unpacking blobuploader==1.2.4 06:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:01:35 INFO - Downloading blobuploader-1.2.4.tar.gz 06:01:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:01:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:01:35 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 06:01:35 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 06:01:35 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 06:01:35 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 06:01:35 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 06:01:35 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 06:01:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:01:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:01:35 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 06:01:35 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 06:01:35 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 06:01:35 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 06:01:35 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 06:01:35 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 06:01:36 INFO - Downloading docopt-0.6.1.tar.gz 06:01:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:01:36 INFO - Installing collected packages: blobuploader, requests, docopt 06:01:36 INFO - Running setup.py install for blobuploader 06:01:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:01:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:01:36 INFO - Running setup.py install for requests 06:01:36 INFO - Running setup.py install for docopt 06:01:36 INFO - Successfully installed blobuploader requests docopt 06:01:36 INFO - Cleaning up... 06:01:36 INFO - Return code: 0 06:01:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:36 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')]} 06:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:36 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')]} 06:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:36 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 0x1ca4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f633b0>, '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 0x1f642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f64740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', '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 06:01:36 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 06:01:36 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 06:01:36 INFO - Using env: {'DISPLAY': ':0', 06:01:36 INFO - 'HOME': '/home/cltbld', 06:01:36 INFO - 'LANG': 'en_US.UTF-8', 06:01:36 INFO - 'LANGUAGE': 'en_US:en', 06:01:36 INFO - 'LOGNAME': 'cltbld', 06:01:36 INFO - 'MAIL': '/var/mail/cltbld', 06:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:36 INFO - 'MOZ_NO_REMOTE': '1', 06:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:36 INFO - 'NO_EM_RESTART': '1', 06:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:36 INFO - 'PWD': '/builds/slave/test', 06:01:36 INFO - 'SHELL': '/bin/bash', 06:01:36 INFO - 'SHLVL': '1', 06:01:36 INFO - 'TERM': 'linux', 06:01:36 INFO - 'TMOUT': '86400', 06:01:36 INFO - 'USER': 'cltbld', 06:01:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', 06:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:36 INFO - '_': '/tools/buildbot/bin/python'} 06:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:36 INFO - Running setup.py (path:/tmp/pip-rDvOK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:37 INFO - Running setup.py (path:/tmp/pip-Q0AN4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:37 INFO - Running setup.py (path:/tmp/pip-YT4yoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:37 INFO - Running setup.py (path:/tmp/pip-WwMCdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:37 INFO - Running setup.py (path:/tmp/pip-oixpQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:37 INFO - Running setup.py (path:/tmp/pip-0uBgOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:37 INFO - Running setup.py (path:/tmp/pip-ffGVIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:37 INFO - Running setup.py (path:/tmp/pip-OMNzXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:37 INFO - Running setup.py (path:/tmp/pip-fGYtUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:37 INFO - Running setup.py (path:/tmp/pip-7KgFkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:37 INFO - Running setup.py (path:/tmp/pip-PnAYUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:37 INFO - Running setup.py (path:/tmp/pip-v2xJQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:37 INFO - Running setup.py (path:/tmp/pip-t8pMmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:37 INFO - Running setup.py (path:/tmp/pip-uJcWr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:37 INFO - Running setup.py (path:/tmp/pip-Ga5TPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:38 INFO - Running setup.py (path:/tmp/pip-jB3iyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:38 INFO - Running setup.py (path:/tmp/pip-bB2JS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:01:38 INFO - Running setup.py install for manifestparser 06:01:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:01:38 INFO - Running setup.py install for mozcrash 06:01:38 INFO - Running setup.py install for mozdebug 06:01:38 INFO - Running setup.py install for mozdevice 06:01:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:01:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:01:38 INFO - Running setup.py install for mozfile 06:01:38 INFO - Running setup.py install for mozhttpd 06:01:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:01:38 INFO - Running setup.py install for mozinfo 06:01:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:01:38 INFO - Running setup.py install for mozInstall 06:01:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:01:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:01:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:01:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:01:38 INFO - Running setup.py install for mozleak 06:01:39 INFO - Running setup.py install for mozlog 06:01:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:01:39 INFO - Running setup.py install for moznetwork 06:01:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:01:39 INFO - Running setup.py install for mozprocess 06:01:39 INFO - Running setup.py install for mozprofile 06:01:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:01:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:01:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:01:39 INFO - Running setup.py install for mozrunner 06:01:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:01:39 INFO - Running setup.py install for mozscreenshot 06:01:39 INFO - Running setup.py install for moztest 06:01:39 INFO - Running setup.py install for mozversion 06:01:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:01:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:01:39 INFO - Cleaning up... 06:01:39 INFO - Return code: 0 06:01:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:39 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 0x1ca4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f633b0>, '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 0x1f642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f64740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', '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 06:01:39 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 06:01:39 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 06:01:39 INFO - Using env: {'DISPLAY': ':0', 06:01:39 INFO - 'HOME': '/home/cltbld', 06:01:39 INFO - 'LANG': 'en_US.UTF-8', 06:01:39 INFO - 'LANGUAGE': 'en_US:en', 06:01:39 INFO - 'LOGNAME': 'cltbld', 06:01:39 INFO - 'MAIL': '/var/mail/cltbld', 06:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:39 INFO - 'MOZ_NO_REMOTE': '1', 06:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:39 INFO - 'NO_EM_RESTART': '1', 06:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:39 INFO - 'PWD': '/builds/slave/test', 06:01:39 INFO - 'SHELL': '/bin/bash', 06:01:39 INFO - 'SHLVL': '1', 06:01:39 INFO - 'TERM': 'linux', 06:01:39 INFO - 'TMOUT': '86400', 06:01:39 INFO - 'USER': 'cltbld', 06:01:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', 06:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:39 INFO - '_': '/tools/buildbot/bin/python'} 06:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:01:40 INFO - Running setup.py (path:/tmp/pip-YeXDVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:01:40 INFO - Running setup.py (path:/tmp/pip-gI50lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:01:40 INFO - Running setup.py (path:/tmp/pip-W8ItL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:01:40 INFO - Running setup.py (path:/tmp/pip-3UXL0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:01:40 INFO - Running setup.py (path:/tmp/pip-j9Ayo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:01:40 INFO - Running setup.py (path:/tmp/pip-qBCVDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:01:40 INFO - Running setup.py (path:/tmp/pip-Ay5vev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:01:40 INFO - Running setup.py (path:/tmp/pip-UMRMEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:01:40 INFO - Running setup.py (path:/tmp/pip-P8iTY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:01:40 INFO - Running setup.py (path:/tmp/pip-psIIiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:01:40 INFO - Running setup.py (path:/tmp/pip-5irBBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:01:40 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)) 06:01:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:01:40 INFO - Running setup.py (path:/tmp/pip-5zWE5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:01:41 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)) 06:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:01:41 INFO - Running setup.py (path:/tmp/pip-4ZRahP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:01:41 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)) 06:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:01:41 INFO - Running setup.py (path:/tmp/pip-l1BVXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:01:41 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)) 06:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:41 INFO - Running setup.py (path:/tmp/pip-CZzrV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:01:41 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)) 06:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:01:41 INFO - Running setup.py (path:/tmp/pip-eNNZ33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:01:41 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)) 06:01:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:01:41 INFO - Running setup.py (path:/tmp/pip-IkYiWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:01:41 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)) 06:01:41 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)) 06:01:41 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)) 06:01:41 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)) 06:01:41 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)) 06:01:41 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)) 06:01:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:01:41 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 06:01:41 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 06:01:41 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 06:01:41 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 06:01:41 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 06:01:41 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 06:01:43 INFO - Downloading blessings-1.6.tar.gz 06:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:01:43 INFO - Installing collected packages: blessings 06:01:43 INFO - Running setup.py install for blessings 06:01:43 INFO - Successfully installed blessings 06:01:43 INFO - Cleaning up... 06:01:43 INFO - Return code: 0 06:01:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:01:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:43 INFO - Reading from file tmpfile_stdout 06:01:43 INFO - Current package versions: 06:01:43 INFO - argparse == 1.2.1 06:01:43 INFO - blessings == 1.6 06:01:43 INFO - blobuploader == 1.2.4 06:01:43 INFO - docopt == 0.6.1 06:01:43 INFO - functools32 == 3.2.3-2 06:01:43 INFO - jsonschema == 2.5.1 06:01:43 INFO - manifestparser == 1.1 06:01:43 INFO - mozInstall == 1.12 06:01:43 INFO - mozcrash == 0.17 06:01:43 INFO - mozdebug == 0.1 06:01:43 INFO - mozdevice == 0.48 06:01:43 INFO - mozfile == 1.2 06:01:43 INFO - mozhttpd == 0.7 06:01:43 INFO - mozinfo == 0.9 06:01:43 INFO - mozleak == 0.1 06:01:43 INFO - mozlog == 3.2 06:01:43 INFO - moznetwork == 0.27 06:01:43 INFO - mozprocess == 0.23 06:01:43 INFO - mozprofile == 0.28 06:01:43 INFO - mozrunner == 6.12 06:01:43 INFO - mozscreenshot == 0.1 06:01:43 INFO - mozsystemmonitor == 0.3 06:01:43 INFO - moztest == 0.7 06:01:43 INFO - mozversion == 1.4 06:01:43 INFO - psutil == 3.1.1 06:01:43 INFO - requests == 1.2.3 06:01:43 INFO - wsgiref == 0.1.2 06:01:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:43 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 0x1ca4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f633b0>, '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 0x1f642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f64740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', '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 06:01:43 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 06:01:43 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 06:01:43 INFO - Using env: {'DISPLAY': ':0', 06:01:43 INFO - 'HOME': '/home/cltbld', 06:01:43 INFO - 'LANG': 'en_US.UTF-8', 06:01:43 INFO - 'LANGUAGE': 'en_US:en', 06:01:43 INFO - 'LOGNAME': 'cltbld', 06:01:43 INFO - 'MAIL': '/var/mail/cltbld', 06:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:43 INFO - 'MOZ_NO_REMOTE': '1', 06:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:43 INFO - 'NO_EM_RESTART': '1', 06:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:43 INFO - 'PWD': '/builds/slave/test', 06:01:43 INFO - 'SHELL': '/bin/bash', 06:01:43 INFO - 'SHLVL': '1', 06:01:43 INFO - 'TERM': 'linux', 06:01:43 INFO - 'TMOUT': '86400', 06:01:43 INFO - 'USER': 'cltbld', 06:01:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', 06:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:43 INFO - '_': '/tools/buildbot/bin/python'} 06:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:43 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)) 06:01:43 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)) 06:01:43 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)) 06:01:43 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)) 06:01:44 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)) 06:01:44 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)) 06:01:44 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)) 06:01:44 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)) 06:01:44 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)) 06:01:44 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)) 06:01:44 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)) 06:01:44 INFO - Cleaning up... 06:01:44 INFO - Return code: 0 06:01:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:01:44 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')]} 06:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:44 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')]} 06:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:01:44 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 0x1ca4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f65180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f633b0>, '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 0x1f642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f64740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', '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 06:01:44 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 06:01:44 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 06:01:44 INFO - Using env: {'DISPLAY': ':0', 06:01:44 INFO - 'HOME': '/home/cltbld', 06:01:44 INFO - 'LANG': 'en_US.UTF-8', 06:01:44 INFO - 'LANGUAGE': 'en_US:en', 06:01:44 INFO - 'LOGNAME': 'cltbld', 06:01:44 INFO - 'MAIL': '/var/mail/cltbld', 06:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:44 INFO - 'MOZ_NO_REMOTE': '1', 06:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:44 INFO - 'NO_EM_RESTART': '1', 06:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:01:44 INFO - 'PWD': '/builds/slave/test', 06:01:44 INFO - 'SHELL': '/bin/bash', 06:01:44 INFO - 'SHLVL': '1', 06:01:44 INFO - 'TERM': 'linux', 06:01:44 INFO - 'TMOUT': '86400', 06:01:44 INFO - 'USER': 'cltbld', 06:01:44 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', 06:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:44 INFO - '_': '/tools/buildbot/bin/python'} 06:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:01:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:01:44 INFO - Cleaning up... 06:01:44 INFO - Return code: 0 06:01:44 INFO - Running post-action listener: _resource_record_post_action 06:01:44 INFO - Running post-action listener: _start_resource_monitoring 06:01:44 INFO - Starting resource monitoring. 06:01:44 INFO - ##### 06:01:44 INFO - ##### Finished create-virtualenv step (success) 06:01:44 INFO - ##### 06:01:44 INFO - ##### 06:01:44 INFO - ##### Running install step. 06:01:44 INFO - ##### 06:01:44 INFO - Running pre-action listener: _resource_record_pre_action 06:01:44 INFO - Running main action method: install 06:01:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:01:44 INFO - Reading from file tmpfile_stdout 06:01:44 INFO - Detecting whether we're running mozinstall >=1.0... 06:01:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:01:44 INFO - Reading from file tmpfile_stdout 06:01:44 INFO - Output received: 06:01:44 INFO - Usage: mozinstall [options] installer 06:01:44 INFO - Options: 06:01:44 INFO - -h, --help show this help message and exit 06:01:44 INFO - -d DEST, --destination=DEST 06:01:44 INFO - Directory to install application into. [default: 06:01:44 INFO - "/builds/slave/test"] 06:01:44 INFO - --app=APP Application being installed. [default: firefox] 06:01:44 INFO - mkdir: /builds/slave/test/build/application 06:01:44 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'] 06:01:44 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 06:02:01 INFO - Reading from file tmpfile_stdout 06:02:01 INFO - Output received: 06:02:01 INFO - /builds/slave/test/build/application/firefox/firefox 06:02:01 INFO - Running post-action listener: _resource_record_post_action 06:02:01 INFO - ##### 06:02:01 INFO - ##### Finished install step (success) 06:02:01 INFO - ##### 06:02:01 INFO - ##### 06:02:01 INFO - ##### Running run-tests step. 06:02:01 INFO - ##### 06:02:01 INFO - Running pre-action listener: _resource_record_pre_action 06:02:01 INFO - Running main action method: run_tests 06:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:02:01 INFO - Python 2.7.3 06:02:01 INFO - Return code: 0 06:02:01 INFO - grabbing minidump binary from tooltool 06:02: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')]} 06:02:01 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 0x1f633b0>, '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 0x1f642b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f64740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:02:01 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 06:02:01 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 06:02:01 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 06:02:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:02:01 INFO - Return code: 0 06:02:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:02:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:02:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:02:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:02:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:02:01 INFO - Using env: {'DISPLAY': ':0', 06:02:01 INFO - 'HOME': '/home/cltbld', 06:02:01 INFO - 'LANG': 'en_US.UTF-8', 06:02:01 INFO - 'LANGUAGE': 'en_US:en', 06:02:01 INFO - 'LOGNAME': 'cltbld', 06:02:01 INFO - 'MAIL': '/var/mail/cltbld', 06:02:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:02:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:01 INFO - 'MOZ_NO_REMOTE': '1', 06:02:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:01 INFO - 'NO_EM_RESTART': '1', 06:02:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:01 INFO - 'PWD': '/builds/slave/test', 06:02:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:02:01 INFO - 'SHELL': '/bin/bash', 06:02:01 INFO - 'SHLVL': '1', 06:02:01 INFO - 'TERM': 'linux', 06:02:01 INFO - 'TMOUT': '86400', 06:02:01 INFO - 'USER': 'cltbld', 06:02:01 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888', 06:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:01 INFO - '_': '/tools/buildbot/bin/python'} 06:02:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:02:01 INFO - mozversion application_buildid: 20160708030216 06:02:01 INFO - mozversion application_changeset: 45682df2d2d45e5a8385fd842579e661a4b60bc5 06:02:01 INFO - mozversion application_display_name: Nightly 06:02:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:02:01 INFO - mozversion application_name: Firefox 06:02:01 INFO - mozversion application_remotingname: firefox 06:02:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:02:01 INFO - mozversion application_vendor: Mozilla 06:02:01 INFO - mozversion application_version: 50.0a1 06:02:01 INFO - mozversion platform_buildid: 20160708030216 06:02:01 INFO - mozversion platform_changeset: 45682df2d2d45e5a8385fd842579e661a4b60bc5 06:02:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:02:01 INFO - mozversion platform_version: 50.0a1 06:02:01 INFO - using testdate: 1467982921 06:02:01 INFO - actual date: 1467982921 06:02:01 INFO - starting webserver on 'localhost:43152' 06:02:01 INFO - SUITE-START | Running 2 tests 06:02:01 INFO - TEST-START | dromaeo_css 06:02:01 INFO - operating with platform_type : linux_ 06:02:01 INFO - Initialising browser for dromaeo_css test... 06:02:01 INFO - TEST-INFO | started process 9401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQOnAT1/profile http://localhost:43152/getInfo.html) 06:02:06 INFO - PROCESS | 9401 | __metrics Screen width/height:1600/1200 06:02:06 INFO - PROCESS | 9401 | colorDepth:24 06:02:06 INFO - PROCESS | 9401 | Browser inner width/height: 1024/697 06:02:06 INFO - PROCESS | 9401 | __metrics 06:02:07 INFO - PROCESS | 9401 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:02:07 INFO - TEST-INFO | 9401: exit 0 06:02:07 INFO - Browser initialized. 06:02:07 INFO - Running cycle 1/1 for dromaeo_css test... 06:02:07 INFO - TEST-INFO | started process 9484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQOnAT1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:19 INFO - PROCESS | 9484 | RSS: Main: 156913664 06:02:19 INFO - PROCESS | 9484 | 06:03:11 INFO - PROCESS | 9484 | 1467982991225 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] 06:05:18 INFO - PROCESS | 9484 | Cycle 1(1): loaded http://localhost:43152/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43152/tests/dromaeo/cssquery-ext.html) 06:05:19 INFO - PROCESS | 9484 | RSS: Main: 247336960 06:05:19 INFO - PROCESS | 9484 | 06:08:22 INFO - PROCESS | 9484 | Cycle 1(1): loaded http://localhost:43152/tests/dromaeo/cssquery-ext.html (next: http://localhost:43152/tests/dromaeo/cssquery-jquery.html) 06:08:22 INFO - PROCESS | 9484 | RSS: Main: 245604352 06:08:22 INFO - PROCESS | 9484 | 06:11:25 INFO - PROCESS | 9484 | Cycle 1(1): loaded http://localhost:43152/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43152/tests/dromaeo/cssquery-mootools.html) 06:11:25 INFO - PROCESS | 9484 | RSS: Main: 253759488 06:11:25 INFO - PROCESS | 9484 | 06:14:27 INFO - PROCESS | 9484 | Cycle 1(1): loaded http://localhost:43152/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43152/tests/dromaeo/cssquery-prototype.html) 06:14:28 INFO - PROCESS | 9484 | RSS: Main: 242229248 06:14:28 INFO - PROCESS | 9484 | 06:17:31 INFO - PROCESS | 9484 | Cycle 1(1): loaded http://localhost:43152/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43152/tests/dromaeo/cssquery-yui.html) 06:17:31 INFO - PROCESS | 9484 | RSS: Main: 227332096 06:17:31 INFO - PROCESS | 9484 | 06:20:34 INFO - PROCESS | 9484 | Cycle 1(1): loaded http://localhost:43152/tests/dromaeo/cssquery-yui.html (next: http://localhost:43152/tests/dromaeo/cssquery-dojo.html) 06:20:34 INFO - PROCESS | 9484 | RSS: Main: 281202688 06:20:34 INFO - PROCESS | 9484 | 06:20:34 INFO - PROCESS | 9484 | __start_tp_report 06:20:34 INFO - PROCESS | 9484 | _x_x_mozilla_page_load 06:20:34 INFO - PROCESS | 9484 | _x_x_mozilla_page_load_details 06:20:34 INFO - PROCESS | 9484 | |i|pagename|runs| 06:20:34 INFO - PROCESS | 9484 | |0;dojo.html;2988.775841811864;3036;3040.893568725095;3054.4501989641885;3082.38352329534;5308.946910530894;5353.785848566057;5396.514313711765;5448.863778405537;5495.505404513593;5341.1988201769755;5364.275822763926;5373.623846330758;5410.8917821643545;5441.945580544193;4825.927611085836;4919.089968355847;4933.136701077315;4965.677230979993;5105.668131571455;5000.874978125539;5021.071101846152;5038.294638750578;5083.61872859537;5085.79656813727;4827.903441931159;4852.053849499349;4865.805367785284;4888.046830867982;4929.8028078876805;4854.805807767685;4855;4880.072786170616;4882.731449770261;4980.850574482772;4840.636952228597;4863.537963893425;4873.02539492103;4885.7312847793355;4922.950770492321;5171.095058364809;5306.283651707009;5383.327084114486;5402.297701298806;5415.675059496442;5805.941940580625;5809.82570522885;5810.88378232433;5846.21076154718;5859.2382990211;5857.619254748471;5857.794977175821;5887;5901.144334071579;5921.200637913869;5298.205269209611;5372.731363431852;5386.542143917772;5410.702411367373;5487.286652735199;6014.548908831855;6021.367756385516;6023.969880150571;6025.0962355646125;6026.367231440723;5377.650452720561;5703.828885133453;5756.280464941882;5764.394738552392;5765.971170144123;5693.60144789869;5731.541476681856;5738.340090889601;5746.396628354046;5748.827535173951;5639.238702775073;5649.774009039675;5659.207710920475;5666.348369937427;5705.087186050295;5564.8330550083565;5669.34802497718;5713.4000929902595;5723.59934804568;5745.971270143623;4423.690341676116;4447.688661793643;4450.554944505524;4489.259272220047;4492.191405547033;3902.512185976753;3915.138669492707;3920.098377373163;3921.4117882317883;3961.4057891316534;5322.893542129135;5374.91937620936;5434.239206511092;5535.308086489189;5553.333599968029;5814.738336774855;5821.970890145522;5822.679752613647;5844.649321040752;5931.258592675916;5491.039068163055;5501.229827824108;5501.312335958005;5507.972460137674;5513.531349835229;4782.0914026334885;4878.487758785276;4884.853454396374;4926.482719314492;4980.900381992412;6006.369331220247;6015.939840601625;6016.368281330398;6020.127081573148;6060.696965151725;5798.5651076168615;5816;5816.127580862904;5816.5055970243;5818.069108942549;5872.354041055566;5936.762529498945;5978.97010514962;5981.0131328330335;6006.759729610942;5696.601237913306;5702.315722113373;5710.65736055838;5715.714214289352;5724.570657200643;5752.71236438168;5813.244278243801;5815.476607105381;5823.097419899922;5823.330317013429;5525.889482210253;5652.293463317085;5691.971540142438;5705.714714264187;5750.367459579526;5666.490015898589;5729;5730.455606717355;5730.971345143247;5742.511886489695;5384.70384128861;5646.237757902795;5674.77300907959;5683.687397193194;5684.573656975661;5644.463775941444;5648.039833228443;5672.14917762339;5741.25363702716;5792.681402522733;5613.859653508532;5615.241942337895;5616.606837521498;5617.634853734494;5619.494245517923 06:20:34 INFO - PROCESS | 9484 | |1;ext.html;616.5406771954894;630.3066626710616;630.7634637011121;636.1285039495889;640.8910485217513;42627.78686106569;43788.905277368;43816.78091609538;43951.56048439519;47472.76263618677;45359.09281814362;45755.54244457554;45765.08469830601;45849;45958.310625340644;8896.688615898429;9041.502717350542;9045.547722613876;9048.276137908984;9064.728058158233;8885.200331970122;8973.641054357851;8977;8980.955095224515;8983.505907175102;9004.144606262395;9025.909740902573;9037.322200834931;9045;9056.13966673165;8949.910500895005;8975.102489751005;8993.415427997224;8999.23506501948;9016.504092274923;8915.063918288552;8999.280057595377;9000.369974101815;9001.279897608176;9015.954920225357;43300.78349608263;43466;43767;43786;43866.342004869955;3357.143928298293;3970.0471886746973;4015.959840401617;4187.958120418818;4312.202242585132;33925.32149356999;33958.83020584906;34135;34870.12824679378;36018.27963440717;4206.095689426788;4229.794508565075;4260.4248426462655;4273.636740877029;4275.166342563201;256373;256980;257764;257886.99999999814;257900;59738.402615974155;60772.39227607667;60778.696106519186;60786;60859.08711369333;54756;63187.36812631907;66376.33623663799;67465;67966.32033679698;17406.303747850197;17654.11729413524;17677.292908283525;17703.911480442515;17716.734248986275;13464.528741494001;13583.728325433436;13589.592312230649;13597.388117534734;13602.659933501543;15667.059976401453;17039.744403833953;17380.82619173792;17471.213795379237;18093.09534523295;5968.432998865101;6011.27864656244;6025.849353766191;6037.6679282639;6109.865750702728;924.0620769918538;992.4491906991544;1038.5378506564657;1088.5101704233127;1131.3099009604134;31832.204194895312;32407;32686;32811.83594082062;33083.50374744381;1094.8521949536869;1127.537709539085;1145.3414286785132;1208.7703336366062;1239.8078297863844;17377.178251618363;17475.213615387085;17601.207945642476;17620.647587048188;17833.732494012602;581816;582856;583173;583989;588097;61114;61300;61417.69291153516;61509.692451537456;61555;1205.9698507537382;1291.9354032298347;1326.8208791813174;1370.6230786533783;1404;30399.848000759855;33825.49261761125;34360;34380.48429273513;34809;52000.47999519957;52045.73977130242;52392;52532.737336313076;52627;447334;448516;448663;449012.2648160345;452651;36586;37061.258774823815;41246.175076498905;42014.159716806105;42235.7888210557;49476.752616236685;50205;50813;51798;51865.740671297914;42809;43240.56759432366;43600;44015.55984440115;44680.77659611681;43159.78420107879;43356;43495.130097398505;43572.34641480317;43588.78205608952;41641.375379369936;42728.5727142737;43085.7845710782;43201;43271.56728432675;36464.81767591145;37819.81090094532;38129.428058579695;38850;39344;28074.719252807212;28708.014963387588;28981.7101828979;29006.56490152607;29127.417451650424 06:20:34 INFO - PROCESS | 9484 | |2;jquery.html;383.2609780069439;386.89940615439997;398.8743545783078;402.3943964333678;414.8154071438211;13679.278468010856;18913.338033168842;20256.39230823074;20650.380488585368;20697.586048279027;14397.827345887346;18217.089145542705;18585.814141858576;19490.610187796272;19891;5797.768089276424;5967.970160149193;5974.044152935531;6009.549283803733;6010.519158467334;5872.76508939644;5936.257967754031;5942.168096466498;5943.257092863392;5953.315368732587;4167.166566686659;5863.618864773797;6379.07503412005;6663.800085997428;6676.732930682767;6439.871202575922;6714.496412769062;6715;6772.187337519505;6777;5852.122181672783;5886.676232807194;5908.586398952075;5917.497012753921;5918.733656985446;22826.429339266484;22996.195133170426;23590.64614030791;23604.29187124389;23837.523249535087;2188.8577242479187;2323.163661082009;2406.8074554035634;2435.585950388438;2562.359410147463;10432.236920986332;10436.37381757097;10579.153667706565;10837.783244335069;10919.945400273027;1914.7606549181353;1927.8939658318786;1996.9301074462323;2000.6498862699116;2050.302897015022;77129.22870771277;80926.19073809245;81002;81701.18298817055;82683.17316826814;11012.559497620166;11119.27724697892;11201.543799306039;11227.607033753779;11379.772404551863;15604.609884752972;15730.213489325488;15750.842491574938;15769;15819.604509887346;8499.532525711022;8699.304055675531;8798.824023519623;8873.112688731075;8875.556222188865;7915.089764677021;7996.68054770968;8124.878126828103;8507.787305317417;8608.053114157437;4449.377087207794;4594.402727645452;4868.221084626513;4952.158133117378;5022.6233032522705;1925.9037048147536;1982.1278637399787;2039.1027947702962;2043.335915827362;2089.613421517024;918.7197904639149;937.8042995181062;956.3305686019814;1013.9138173255209;1014.9238807089498;11716.589919352953;12339.321337326353;12807.295598741972;18249.270029198684;20250.594988100154;456.5069724697319;462.05740289809086;464.12512414099666;472.95034021427944;480.92545655423464;6780.118584584071;6845.992396641937;6913.3777959983845;6972.372486476242;6990.545614535039;509996;547991;556794;570364;570422;100590;102583;105195;105322;105702;494.7798229787782;500.07486150621787;501.13554119144914;502.7988804478238;504.6114491841262;11382.317060976036;11905.166638335233;11946.223495473114;12008.159428839897;12112.878871211527;42489.5751042498;45741;46022.309665355715;46198.53801461942;47025.76487117542;62512;63363;63384;63456.36543634505;64591;8908.777280568038;8928.261935298606;8986.86519702192;9119.589618467318;9278.675246366345;10472.581096756045;13059.085863989809;13501.459941602227;13706.38321275525;14183.29083545798;11728.648140555797;11801.586944456903;12083.456244469196;12097.57658481949;12188.75622487563;5463.863403414946;9785.657501987396;11169.994700476997;11815.350155741517;11837.704057398634;12226.510939562319;12346.13577049598;12422.503099875903;12525.436355363849;12615.684607884876;8497.490150590984;8601.967763868375;8725.476471411735;8928.86606700913;9157.816843663222;10824.837627435752;12111.333876636518;12122.696932576404;12163.939180304042;12289.078319125923 06:20:34 INFO - PROCESS | 9484 | |3;mootools.html;1326.648438163886;1333.1934179821208;1363.2570249214177;1407.3315175291737;1515.378694735159;8770.166834150754;9102.908970910297;9155.542222888862;9438.292128090387;9455.054494550559;9194.770130746734;9398.718038458841;9399.577019034143;9413.152816246537;9413.623455061806;2421.685180926477;2451.2156110044793;2452.1907770435714;2453.6196889482158;2454.325060608338;2386.183087817032;2438.2441443152593;2463.7536246375307;2465.617829236471;2472.431340791619;2354.8704821234824;2369.609014512612;2378.120095564635;2385.797207237378;2409.144753612469;2350.1421980976993;2357.528494301138;2367.2661474942824;2375.95248095038;2386.737458879522;2228.4317499037643;2275.84069115162;2277.3168049585056;2285.6800047993293;2286.1312701173447;7776.300132988058;8841.911580884173;9217.631294748202;9258.72223833286;9260.768480787967;4847.5394837490385;5048.671836330664;5057.595392368638;5065.39215294167;5072.442031376546;3238.3685181389637;3271.8691252349877;3297.752668549844;3316.436205845012;3336.132605522582;1065.3341661461586;1085.403028334413;1094.7810437912449;1108.534415545473;1120.9047230985377;13014.739705205937;13023.413946372437;13076.738465230643;13120;13127.343632818416;4600.838970636079;4629.953700463019;4801.447833499193;4843.128236917319;4855.223164293696;10892.618758343579;10910.781784364268;10918.617848375268;10920.18098642589;10961.725956850983;5361.142217245222;5368.248445217672;5409.323834520685;5410.1343784995;5412.188171774265;4918.065567542156;4971.37857767779;4975.975120124376;4991.376077990251;5015.799368025311;4023.8591649292134;4024.2555127301544;4075.918481630351;4113.300738874398;4138.79306034697;1253.8746125387388;1254.974900502003;1259.4080782032431;1268.0109514578644;1271.6121582917299;879.5821984557284;972.2902281334665;978.8645171600908;985.2512090811035;995.5320999130397;6138.907916381258;6152.107944348045;6272.184615999982;6272.498200143978;6433.74265029403;429.54682809636137;436.76851268827573;440.31970605414074;450.9301058335963;451.032535211975;4131.462909821704;4273.081287523135;4280.6789490788315;4298.4841818981295;4319.568043195655;10368.377897326185;11111.888881111247;11485.885141148648;11553;11636.243644163102;10268.897311026943;10604.469776511298;11753.529858805723;11856.466459009192;11866.347350895783;7563.205863384375;8036.839263214703;8285.54429506383;8316.085230624627;8554.57227138653;6049.697515124314;6071.362506936708;6240;6244.2819075806865;6338.809835704937;10264.127549158107;10484;10568.313059651098;10601.946990265;10826.89173108259;11003.779924401628;11075.280106793032;11139.944300278446;11368.886311137114;11374.090072794323;8020.839583208186;8090.676372945016;8160.673573057011;8172.959135204286;8178.059523154675;8787.868181977403;8995.595198216226;9000.459972401677;9000.459972401677;9051.728448146567;7957.721479748181;8097.2307630774985;8121.8375632488205;8152.551609661288;8234.300084492885;7975.7607271781935;7977.401694873024;8066.354691624539;8086.272235498834;8119.675212991414;7573.545587264782;7660;7676.731314403969;7704.807379815549;7707.768766937001;5296;5397.379301380234;5440.156775699773;5469.562435005269;5510.283663123768;5281.894362112659;5327.866803329948;5416.268803711606;5514;5557.277553917965 06:20:34 INFO - PROCESS | 9484 | |4;prototype.html;325.5231086458339;328.986720899629;337.87329751343236;338.82719812895414;343.5053522926985;5286.788528458862;5303.787848486061;5333.89332213356;5335.359756829176;5350.438203988583;5302;5323.361196656397;5325.600579956509;5331.147016477365;5342.931413717262;3997.120633460634;3999.4600728901664;4165.895852603679;4181.477315335583;4224.239636865363;4162.354835000565;4169.478815148106;4175.958240417587;4195.391668208108;4218.915621687564;3976.403539469074;4138.737685006072;4149.585041495841;4153.813078411479;4167.187398457302;4049.676025917934;4149.792510374469;4150.232207041707;4158.147579746144;4168.91662166758;3679.1721862580707;3683.318586061587;3690.3172913010912;3696.5194524711615;3700.611435799256;5107.284980102789;5146.408163061258;5151.562117220041;5172.844814655567;5225.320708307933;4478.57453541913;4669.509701481329;4710.811567537295;4721.276733992103;4729.125111854318;5383.327084114486;5394.838154855361;5406.972965135149;5420.051490989061;5488.725563721798;3935.291647503448;3942.5860284669984;3961.1681546875193;3974;4046.4825690366115;5676.268738034898;5684.204211410406;5706.28671416073;5706.743196556165;5730.799422020209;4090.529589097292;4174.540800511942;4176.352665336878;4182.351735481006;4184.121334519785;4175.665946724254;4181.874543763692;4190.5180904195795;4219.3249080147025;4225.535191128974;4743.739094349844;4746.121967435966;4749.216379297377;4777.283407488835;4792.9281060784115;5480.616356854982;5533.695646739468;5542.2795036644975;5542.584306177053;5553.9725150847225;1439.0048114568972;1447.9710405791825;1448.8551144885637;1462.824461064679;1466.281522054207;948.1750876737283;969.1955676788249;1009.7374682582434;1031.4275577054807;1045.8431235314763;5257.973710131425;5284.471552844685;5285.233641122016;5304.310439642899;5318.680879147186;5554.722263886871;5606;5606.6916319602815;5611.9719401403545;5637.379888212294;5042.596592272609;5254.185601231815;5263.578913686896;5301.920471192935;5326.627136100513;2965.2438628150117;2967.2581854536365;2978.3447641518833;2978.74680652147;2993;5555.72221388937;5753.913691294634;5767.88464230713;5769.682667453247;5813.88372232553;5808.477237048686;5847.6783776891825;5849.766009359663;5856.4143585641095;5862.618929769551;5889.322727886262;5896.380880007623;5905.527557795452;5920.993431116634;5938.703064846654;5554;5645.943540564542;5655.321361436654;5665.263515742927;5759.222504961776;5559.91581641576;5590.385057643574;5602.915956260741;5609;5639.3232812062815;5627.774889004394;5852.912206316823;5947.91078133837;5976.940230597638;6010.729517171825;3981.5421226559315;4013.458183145238;4025.6376926076796;4039;4053.817578208929;5664.37691853904;5685.886282274414;5691.77232910679;5702.173184888085;5739.971300143639;5395.973020134874;5598.412166722598;5621.8594535136945;5629.4652008059165;5632.408597097409;5511.208857121372;5544.556435485232;5557.1664250361155;5562.72186390687;5581.832545023656;5273.868153296198;5359.839204823861;5423.4034256231;5478.986387518322;5486.177073439016;5519.475649813261;5573.219749235192;5576.10782274834;5579.330480342385;5596.244506991667;5462.453754624506;5463.235147079333;5469.945300546943;5482.780688772564;5498.642588231752 06:20:34 INFO - PROCESS | 9484 | |5;yui.html;736.5580651609032;736.6684991753713;758.787539488943;775.7633921653893;849.1296421168304;14611.780823287645;15890.364385424598;15902.52292431226;15925.04449733017;15939.36242550298;13809;13813.444512765145;13939.860601393983;14565.271736413164;15335.616609584766;819.4427789103422;836;839.1566475691922;839.9916000839975;840.8276303357827;682.3756263019332;800.6677228950008;801.0427539090789;804.4650307545476;838.0320729557341;873.6112429968666;875.4353442029887;875.9824803503926;878.056089703568;881;700.502643123383;870.7039606533746;871.2376670413388;871.2420194430822;872.6509396241522;602.6534742523023;616.4913945994527;617.555360140698;634.3592971099177;635.2630948100182;15369.231538423033;15478.45825396117;15487.380504779796;15534.456294029767;15637.296321665552;13871.861281387159;14231.288435578283;14250.92874535631;14401.71196576073;14676.70646587073;13306.933465332708;13358.265295408748;13484.797728034087;13527;13541.729165416735;4598.218302888517;4605.37827393301;4643.535646435364;4802.378244647925;4826.251930950708;77014.22985770127;77862;78459;79357.60321198415;79995.6000220001;11311.714637195288;11529.942350288195;11699.181057325906;11957.291822581346;12224.449899754532;20865.895670521855;20964.580708385747;21006.579868402547;21015.264465743625;21020.894895525424;8619.353548483889;8736.475811451333;8884.200421962054;8956.552172391484;9083.591238394289;4799.616030717534;4930.654854160246;4954.5788607968725;4957.529034741694;5147.433782283946;3518.225990282134;3606.945895811565;3609.4405367167606;3609.819509024591;3614.3494171049465;622.8878801815627;626.6021076616381;627.7896904537031;635.2757856044113;640.5068097564942;611.1840692675239;652.3281020548842;691.6472598974559;703.3669697272496;720.772956518695;9532.285078619132;9708.514574271258;9723.562439690231;9752.21982241419;9962;584.186304848049;627.7206643043802;658.404144249455;662.3277373465936;668.628910954425;4430.335449682573;4554.931676024862;4787.652476972866;4794.448638406628;4818.566329030404;108073;109105;110962;111208.44395778132;115391;94944.52527737318;97832;98228.50885745525;98676;100470.49764751129;82687;83363.5831820837;85258.57370713231;85334;85557.57221213978;8664.306855451674;8787.121287871161;8796.384253102222;8806.559672016501;9005.729828105168;51398;51400.74299628627;51715.224271635205;52833.71662833686;53669.194962076384;69513.65243173752;72515;73546;74655;75092.62453687696;10377.377357358582;10506.054455099078;10585.629502967358;10649.148068154684;10925.180611454014;12479.500819967463;12491.500339986662;12874.485020599446;12923.612291631267;12984.610461686165;11841.526338946345;12110.939445302716;12374.443150058089;12391.504339826306;12408.441620126936;11691.181617287048;11799.410029498662;11865.762684746083;11891.76216475683;11910.702232444259;11625.302481851117;11728.589499367823;11873.109516786102;12204.633860984184;12353.505859765508;10014.467448241458;10060.899391006289;10062.748431289276;10227.94886025565;10699.938040892974;9930.404175749478;9947.452890091114;9971.102600765966;9997.250206234416;10069.496525173858 06:20:34 INFO - PROCESS | 9484 | __end_tp_report 06:20:34 INFO - PROCESS | 9484 | __start_cc_report 06:20:34 INFO - PROCESS | 9484 | _x_x_mozilla_cycle_collect,779 06:20:34 INFO - PROCESS | 9484 | __end_cc_report 06:20:34 INFO - PROCESS | 9484 | __startTimestamp1467984034559__endTimestamp 06:20:34 INFO - PROCESS | 9484 | 06:20:34 INFO - PROCESS | 9484 | ------- Summary: start ------- 06:20:34 INFO - PROCESS | 9484 | Number of tests: 6 06:20:34 INFO - PROCESS | 9484 | 06:20:34 INFO - PROCESS | 9484 | [#0] dojo.html Cycles:165 Average:5374.87 Median:5617.63 stddev:628.30 (11.2%) stddev-sans-first:601.70 06:20:34 INFO - PROCESS | 9484 | Values: 2988.8 3036.0 3040.9 3054.5 3082.4 5308.9 5353.8 5396.5 5448.9 5495.5 5341.2 5364.3 5373.6 5410.9 5441.9 4825.9 4919.1 4933.1 4965.7 5105.7 5000.9 5021.1 5038.3 5083.6 5085.8 4827.9 4852.1 4865.8 4888.0 4929.8 4854.8 4855.0 4880.1 4882.7 4980.9 4840.6 4863.5 4873.0 4885.7 4923.0 5171.1 5306.3 5383.3 5402.3 5415.7 5805.9 5809.8 5810.9 5846.2 5859.2 5857.6 5857.8 5887.0 5901.1 5921.2 5298.2 5372.7 5386.5 5410.7 5487.3 6014.5 6021.4 6024.0 6025.1 6026.4 5377.7 5703.8 5756.3 5764.4 5766.0 5693.6 5731.5 5738.3 5746.4 5748.8 5639.2 5649.8 5659.2 5666.3 5705.1 5564.8 5669.3 5713.4 5723.6 5746.0 4423.7 4447.7 4450.6 4489.3 4492.2 3902.5 3915.1 3920.1 3921.4 3961.4 5322.9 5374.9 5434.2 5535.3 5553.3 5814.7 5822.0 5822.7 5844.6 5931.3 5491.0 5501.2 5501.3 5508.0 5513.5 4782.1 4878.5 4884.9 4926.5 4980.9 6006.4 6015.9 6016.4 6020.1 6060.7 5798.6 5816.0 5816.1 5816.5 5818.1 5872.4 5936.8 5979.0 5981.0 6006.8 5696.6 5702.3 5710.7 5715.7 5724.6 5752.7 5813.2 5815.5 5823.1 5823.3 5525.9 5652.3 5692.0 5705.7 5750.4 5666.5 5729.0 5730.5 5731.0 5742.5 5384.7 5646.2 5674.8 5683.7 5684.6 5644.5 5648.0 5672.1 5741.3 5792.7 5613.9 5615.2 5616.6 5617.6 5619.5 06:20:34 INFO - PROCESS | 9484 | 06:20:34 INFO - PROCESS | 9484 | [#1] ext.html Cycles:180 Average:60555.30 Median:43533.74 stddev:119869.24 (275.3%) stddev-sans-first:120121.03 06:20:34 INFO - PROCESS | 9484 | Values: 616.5 630.3 630.8 636.1 640.9 42627.8 43788.9 43816.8 43951.6 47472.8 45359.1 45755.5 45765.1 45849.0 45958.3 8896.7 9041.5 9045.5 9048.3 9064.7 8885.2 8973.6 8977.0 8981.0 8983.5 9004.1 9025.9 9037.3 9045.0 9056.1 8949.9 8975.1 8993.4 8999.2 9016.5 8915.1 8999.3 9000.4 9001.3 9016.0 43300.8 43466.0 43767.0 43786.0 43866.3 3357.1 3970.0 4016.0 4188.0 4312.2 33925.3 33958.8 34135.0 34870.1 36018.3 4206.1 4229.8 4260.4 4273.6 4275.2 256373.0 256980.0 257764.0 257887.0 257900.0 59738.4 60772.4 60778.7 60786.0 60859.1 54756.0 63187.4 66376.3 67465.0 67966.3 17406.3 17654.1 17677.3 17703.9 17716.7 13464.5 13583.7 13589.6 13597.4 13602.7 15667.1 17039.7 17380.8 17471.2 18093.1 5968.4 6011.3 6025.8 6037.7 6109.9 924.1 992.4 1038.5 1088.5 1131.3 31832.2 32407.0 32686.0 32811.8 33083.5 1094.9 1127.5 1145.3 1208.8 1239.8 17377.2 17475.2 17601.2 17620.6 17833.7 581816.0 582856.0 583173.0 583989.0 588097.0 61114.0 61300.0 61417.7 61509.7 61555.0 1206.0 1291.9 1326.8 1370.6 1404.0 30399.8 33825.5 34360.0 34380.5 34809.0 52000.5 52045.7 52392.0 52532.7 52627.0 447334.0 448516.0 448663.0 449012.3 452651.0 36586.0 37061.3 41246.2 42014.2 42235.8 49476.8 50205.0 50813.0 51798.0 51865.7 42809.0 43240.6 43600.0 44015.6 44680.8 43159.8 43356.0 43495.1 43572.3 43588.8 41641.4 42728.6 43085.8 43201.0 43271.6 36464.8 37819.8 38129.4 38850.0 39344.0 28074.7 28708.0 28981.7 29006.6 29127.4 06:20:34 INFO - PROCESS | 9484 | 06:20:34 INFO - PROCESS | 9484 | [#2] jquery.html Cycles:180 Average:30955.21 Median:23328.37 stddev:91011.16 (390.1%) stddev-sans-first:91237.51 06:20:34 INFO - PROCESS | 9484 | Values: 383.3 386.9 398.9 402.4 414.8 13679.3 18913.3 20256.4 20650.4 20697.6 14397.8 18217.1 18585.8 19490.6 19891.0 5797.8 5968.0 5974.0 6009.5 6010.5 5872.8 5936.3 5942.2 5943.3 5953.3 4167.2 5863.6 6379.1 6663.8 6676.7 6439.9 6714.5 6715.0 6772.2 6777.0 5852.1 5886.7 5908.6 5917.5 5918.7 22826.4 22996.2 23590.6 23604.3 23837.5 2188.9 2323.2 2406.8 2435.6 2562.4 10432.2 10436.4 10579.2 10837.8 10919.9 1914.8 1927.9 1996.9 2000.6 2050.3 77129.2 80926.2 81002.0 81701.2 82683.2 11012.6 11119.3 11201.5 11227.6 11379.8 15604.6 15730.2 15750.8 15769.0 15819.6 8499.5 8699.3 8798.8 8873.1 8875.6 7915.1 7996.7 8124.9 8507.8 8608.1 4449.4 4594.4 4868.2 4952.2 5022.6 1925.9 1982.1 2039.1 2043.3 2089.6 918.7 937.8 956.3 1013.9 1014.9 11716.6 12339.3 12807.3 18249.3 20250.6 456.5 462.1 464.1 473.0 480.9 6780.1 6846.0 6913.4 6972.4 6990.5 509996.0 547991.0 556794.0 570364.0 570422.0 100590.0 102583.0 105195.0 105322.0 105702.0 494.8 500.1 501.1 502.8 504.6 11382.3 11905.2 11946.2 12008.2 12112.9 42489.6 45741.0 46022.3 46198.5 47025.8 62512.0 63363.0 63384.0 63456.4 64591.0 8908.8 8928.3 8986.9 9119.6 9278.7 10472.6 13059.1 13501.5 13706.4 14183.3 11728.6 11801.6 12083.5 12097.6 12188.8 5463.9 9785.7 11170.0 11815.4 11837.7 12226.5 12346.1 12422.5 12525.4 12615.7 8497.5 8602.0 8725.5 8928.9 9157.8 10824.8 12111.3 12122.7 12163.9 12289.1 06:20:34 INFO - PROCESS | 9484 | 06:20:34 INFO - PROCESS | 9484 | [#3] mootools.html Cycles:180 Average:6022.89 Median:4615.40 stddev:3528.58 (76.5%) stddev-sans-first:3520.83 06:20:34 INFO - PROCESS | 9484 | Values: 1326.6 1333.2 1363.3 1407.3 1515.4 8770.2 9102.9 9155.5 9438.3 9455.1 9194.8 9398.7 9399.6 9413.2 9413.6 2421.7 2451.2 2452.2 2453.6 2454.3 2386.2 2438.2 2463.8 2465.6 2472.4 2354.9 2369.6 2378.1 2385.8 2409.1 2350.1 2357.5 2367.3 2376.0 2386.7 2228.4 2275.8 2277.3 2285.7 2286.1 7776.3 8841.9 9217.6 9258.7 9260.8 4847.5 5048.7 5057.6 5065.4 5072.4 3238.4 3271.9 3297.8 3316.4 3336.1 1065.3 1085.4 1094.8 1108.5 1120.9 13014.7 13023.4 13076.7 13120.0 13127.3 4600.8 4630.0 4801.4 4843.1 4855.2 10892.6 10910.8 10918.6 10920.2 10961.7 5361.1 5368.2 5409.3 5410.1 5412.2 4918.1 4971.4 4976.0 4991.4 5015.8 4023.9 4024.3 4075.9 4113.3 4138.8 1253.9 1255.0 1259.4 1268.0 1271.6 879.6 972.3 978.9 985.3 995.5 6138.9 6152.1 6272.2 6272.5 6433.7 429.5 436.8 440.3 450.9 451.0 4131.5 4273.1 4280.7 4298.5 4319.6 10368.4 11111.9 11485.9 11553.0 11636.2 10268.9 10604.5 11753.5 11856.5 11866.3 7563.2 8036.8 8285.5 8316.1 8554.6 6049.7 6071.4 6240.0 6244.3 6338.8 10264.1 10484.0 10568.3 10601.9 10826.9 11003.8 11075.3 11139.9 11368.9 11374.1 8020.8 8090.7 8160.7 8173.0 8178.1 8787.9 8995.6 9000.5 9000.5 9051.7 7957.7 8097.2 8121.8 8152.6 8234.3 7975.8 7977.4 8066.4 8086.3 8119.7 7573.5 7660.0 7676.7 7704.8 7707.8 5296.0 5397.4 5440.2 5469.6 5510.3 5281.9 5327.9 5416.3 5514.0 5557.3 06:20:34 INFO - PROCESS | 9484 | 06:20:34 INFO - PROCESS | 9484 | [#4] prototype.html Cycles:180 Average:4674.26 Median:5321.02 stddev:1358.84 (25.5%) stddev-sans-first:1322.87 06:20:34 INFO - PROCESS | 9484 | Values: 325.5 329.0 337.9 338.8 343.5 5286.8 5303.8 5333.9 5335.4 5350.4 5302.0 5323.4 5325.6 5331.1 5342.9 3997.1 3999.5 4165.9 4181.5 4224.2 4162.4 4169.5 4176.0 4195.4 4218.9 3976.4 4138.7 4149.6 4153.8 4167.2 4049.7 4149.8 4150.2 4158.1 4168.9 3679.2 3683.3 3690.3 3696.5 3700.6 5107.3 5146.4 5151.6 5172.8 5225.3 4478.6 4669.5 4710.8 4721.3 4729.1 5383.3 5394.8 5407.0 5420.1 5488.7 3935.3 3942.6 3961.2 3974.0 4046.5 5676.3 5684.2 5706.3 5706.7 5730.8 4090.5 4174.5 4176.4 4182.4 4184.1 4175.7 4181.9 4190.5 4219.3 4225.5 4743.7 4746.1 4749.2 4777.3 4792.9 5480.6 5533.7 5542.3 5542.6 5554.0 1439.0 1448.0 1448.9 1462.8 1466.3 948.2 969.2 1009.7 1031.4 1045.8 5258.0 5284.5 5285.2 5304.3 5318.7 5554.7 5606.0 5606.7 5612.0 5637.4 5042.6 5254.2 5263.6 5301.9 5326.6 2965.2 2967.3 2978.3 2978.7 2993.0 5555.7 5753.9 5767.9 5769.7 5813.9 5808.5 5847.7 5849.8 5856.4 5862.6 5889.3 5896.4 5905.5 5921.0 5938.7 5554.0 5645.9 5655.3 5665.3 5759.2 5559.9 5590.4 5602.9 5609.0 5639.3 5627.8 5852.9 5947.9 5976.9 6010.7 3981.5 4013.5 4025.6 4039.0 4053.8 5664.4 5685.9 5691.8 5702.2 5740.0 5396.0 5598.4 5621.9 5629.5 5632.4 5511.2 5544.6 5557.2 5562.7 5581.8 5273.9 5359.8 5423.4 5479.0 5486.2 5519.5 5573.2 5576.1 5579.3 5596.2 5462.5 5463.2 5469.9 5482.8 5498.6 06:20:34 INFO - PROCESS | 9484 | 06:20:34 INFO - PROCESS | 9484 | [#5] yui.html Cycles:180 Average:20408.07 Median:28177.76 stddev:29524.53 (104.8%) stddev-sans-first:29570.40 06:20:34 INFO - PROCESS | 9484 | Values: 736.6 736.7 758.8 775.8 849.1 14611.8 15890.4 15902.5 15925.0 15939.4 13809.0 13813.4 13939.9 14565.3 15335.6 819.4 836.0 839.2 840.0 840.8 682.4 800.7 801.0 804.5 838.0 873.6 875.4 876.0 878.1 881.0 700.5 870.7 871.2 871.2 872.7 602.7 616.5 617.6 634.4 635.3 15369.2 15478.5 15487.4 15534.5 15637.3 13871.9 14231.3 14250.9 14401.7 14676.7 13306.9 13358.3 13484.8 13527.0 13541.7 4598.2 4605.4 4643.5 4802.4 4826.3 77014.2 77862.0 78459.0 79357.6 79995.6 11311.7 11529.9 11699.2 11957.3 12224.4 20865.9 20964.6 21006.6 21015.3 21020.9 8619.4 8736.5 8884.2 8956.6 9083.6 4799.6 4930.7 4954.6 4957.5 5147.4 3518.2 3606.9 3609.4 3609.8 3614.3 622.9 626.6 627.8 635.3 640.5 611.2 652.3 691.6 703.4 720.8 9532.3 9708.5 9723.6 9752.2 9962.0 584.2 627.7 658.4 662.3 668.6 4430.3 4554.9 4787.7 4794.4 4818.6 108073.0 109105.0 110962.0 111208.4 115391.0 94944.5 97832.0 98228.5 98676.0 100470.5 82687.0 83363.6 85258.6 85334.0 85557.6 8664.3 8787.1 8796.4 8806.6 9005.7 51398.0 51400.7 51715.2 52833.7 53669.2 69513.7 72515.0 73546.0 74655.0 75092.6 10377.4 10506.1 10585.6 10649.1 10925.2 12479.5 12491.5 12874.5 12923.6 12984.6 11841.5 12110.9 12374.4 12391.5 12408.4 11691.2 11799.4 11865.8 11891.8 11910.7 11625.3 11728.6 11873.1 12204.6 12353.5 10014.5 10060.9 10062.7 10227.9 10699.9 9930.4 9947.5 9971.1 9997.3 10069.5 06:20:34 INFO - PROCESS | 9484 | -------- Summary: end -------- 06:20:34 INFO - PROCESS | 9484 | 06:20:35 INFO - TEST-INFO | 9484: exit 0 06:20:35 INFO - TEST-OK | dromaeo_css | took 1113339ms 06:20:35 INFO - TEST-START | kraken 06:20:35 INFO - operating with platform_type : linux_ 06:20:35 INFO - Initialising browser for kraken test... 06:20:35 INFO - TEST-INFO | started process 9680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpye0qug/profile http://localhost:43152/getInfo.html) 06:20:39 INFO - PROCESS | 9680 | __metrics Screen width/height:1600/1200 06:20:39 INFO - PROCESS | 9680 | colorDepth:24 06:20:39 INFO - PROCESS | 9680 | Browser inner width/height: 1024/697 06:20:39 INFO - PROCESS | 9680 | __metrics 06:20:40 INFO - PROCESS | 9680 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:41 INFO - TEST-INFO | 9680: exit 0 06:20:41 INFO - Browser initialized. 06:20:41 INFO - Running cycle 1/1 for kraken test... 06:20:41 INFO - TEST-INFO | started process 9762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpye0qug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:53 INFO - PROCESS | 9762 | RSS: Main: 157315072 06:20:53 INFO - PROCESS | 9762 | 06:20:55 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43152/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:56 INFO - PROCESS | 9762 | RSS: Main: 214859776 06:20:56 INFO - PROCESS | 9762 | 06:20:58 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43152/tests/kraken/driver.html?testName=audio-dft) 06:20:59 INFO - PROCESS | 9762 | RSS: Main: 204193792 06:20:59 INFO - PROCESS | 9762 | 06:21:02 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43152/tests/kraken/driver.html?testName=audio-fft) 06:21:03 INFO - PROCESS | 9762 | RSS: Main: 269021184 06:21:03 INFO - PROCESS | 9762 | 06:21:05 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43152/tests/kraken/driver.html?testName=audio-oscillator) 06:21:06 INFO - PROCESS | 9762 | RSS: Main: 179970048 06:21:06 INFO - PROCESS | 9762 | 06:21:08 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43152/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:21:08 INFO - PROCESS | 9762 | RSS: Main: 184791040 06:21:08 INFO - PROCESS | 9762 | 06:21:11 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43152/tests/kraken/driver.html?testName=imaging-darkroom) 06:21:12 INFO - PROCESS | 9762 | RSS: Main: 219021312 06:21:12 INFO - PROCESS | 9762 | 06:21:15 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43152/tests/kraken/driver.html?testName=imaging-desaturate) 06:21:16 INFO - PROCESS | 9762 | RSS: Main: 220798976 06:21:16 INFO - PROCESS | 9762 | 06:21:19 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43152/tests/kraken/driver.html?testName=json-parse-financial) 06:21:19 INFO - PROCESS | 9762 | RSS: Main: 220626944 06:21:19 INFO - PROCESS | 9762 | 06:21:21 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43152/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:21:21 INFO - PROCESS | 9762 | RSS: Main: 208384000 06:21:21 INFO - PROCESS | 9762 | 06:21:23 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43152/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:21:24 INFO - PROCESS | 9762 | RSS: Main: 212471808 06:21:24 INFO - PROCESS | 9762 | 06:21:26 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43152/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:21:27 INFO - PROCESS | 9762 | RSS: Main: 209911808 06:21:27 INFO - PROCESS | 9762 | 06:21:29 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43152/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:21:30 INFO - PROCESS | 9762 | RSS: Main: 223834112 06:21:30 INFO - PROCESS | 9762 | 06:21:32 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43152/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:21:33 INFO - PROCESS | 9762 | RSS: Main: 224296960 06:21:33 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | Cycle 1(1): loaded http://localhost:43152/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43152/tests/kraken/driver.html?testName=ai-astar) 06:21:35 INFO - PROCESS | 9762 | RSS: Main: 267067392 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | __start_tp_report 06:21:35 INFO - PROCESS | 9762 | _x_x_mozilla_page_load 06:21:35 INFO - PROCESS | 9762 | _x_x_mozilla_page_load_details 06:21:35 INFO - PROCESS | 9762 | |i|pagename|runs| 06:21:35 INFO - PROCESS | 9762 | |0;ai-astar;104;113;110;111;112;109;110;110;110;111 06:21:35 INFO - PROCESS | 9762 | |1;audio-beat-detection;142;116;121;175;119;118;145;118;156;124 06:21:35 INFO - PROCESS | 9762 | |2;audio-dft;160;160;160;160;160;161;161;161;161;160 06:21:35 INFO - PROCESS | 9762 | |3;audio-fft;75;74;75;106;76;76;75;75;100;75 06:21:35 INFO - PROCESS | 9762 | |4;audio-oscillator;84;84;113;84;83;84;124;83;83;125 06:21:35 INFO - PROCESS | 9762 | |5;imaging-gaussian-blur;117;117;116;117;116;116;116;117;116;117 06:21:35 INFO - PROCESS | 9762 | |6;imaging-darkroom;145;145;145;145;145;146;145;145;145;146 06:21:35 INFO - PROCESS | 9762 | |7;imaging-desaturate;95;95;95;95;95;94;96;95;95;95 06:21:35 INFO - PROCESS | 9762 | |8;json-parse-financial;53;53;53;52;53;54;55;53;53;52 06:21:35 INFO - PROCESS | 9762 | |9;json-stringify-tinderbox;62;61;61;62;63;61;62;66;61;62 06:21:35 INFO - PROCESS | 9762 | |10;stanford-crypto-aes;79;76;75;77;75;74;75;76;74;78 06:21:35 INFO - PROCESS | 9762 | |11;stanford-crypto-ccm;122;126;118;132;121;120;126;120;158;121 06:21:35 INFO - PROCESS | 9762 | |12;stanford-crypto-pbkdf2;162;160;165;159;163;159;158;158;157;159 06:21:35 INFO - PROCESS | 9762 | |13;stanford-crypto-sha256-iterative;64;65;62;64;63;66;62;62;67;62 06:21:35 INFO - PROCESS | 9762 | __end_tp_report 06:21:35 INFO - PROCESS | 9762 | __start_cc_report 06:21:35 INFO - PROCESS | 9762 | _x_x_mozilla_cycle_collect,1686 06:21:35 INFO - PROCESS | 9762 | __end_cc_report 06:21:35 INFO - PROCESS | 9762 | __startTimestamp1467984095368__endTimestamp 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | ------- Summary: start ------- 06:21:35 INFO - PROCESS | 9762 | Number of tests: 14 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:2.40 (2.2%) stddev-sans-first:1.22 06:21:35 INFO - PROCESS | 9762 | Values: 104.0 113.0 110.0 111.0 112.0 109.0 110.0 110.0 110.0 111.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:133.00 stddev:20.21 (15.2%) stddev-sans-first:21.20 06:21:35 INFO - PROCESS | 9762 | Values: 142.0 116.0 121.0 175.0 119.0 118.0 145.0 118.0 156.0 124.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:21:35 INFO - PROCESS | 9762 | Values: 160.0 160.0 160.0 160.0 160.0 161.0 161.0 161.0 161.0 160.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:11.85 (15.8%) stddev-sans-first:12.39 06:21:35 INFO - PROCESS | 9762 | Values: 75.0 74.0 75.0 106.0 76.0 76.0 75.0 75.0 100.0 75.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:83.50 stddev:18.20 (21.8%) stddev-sans-first:18.88 06:21:35 INFO - PROCESS | 9762 | Values: 84.0 84.0 113.0 84.0 83.0 84.0 124.0 83.0 83.0 125.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:21:35 INFO - PROCESS | 9762 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 117.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:21:35 INFO - PROCESS | 9762 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 06:21:35 INFO - PROCESS | 9762 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 06:21:35 INFO - PROCESS | 9762 | Values: 53.0 53.0 53.0 52.0 53.0 54.0 55.0 53.0 53.0 52.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.52 (2.5%) stddev-sans-first:1.62 06:21:35 INFO - PROCESS | 9762 | Values: 62.0 61.0 61.0 62.0 63.0 61.0 62.0 66.0 61.0 62.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:1.66 (2.2%) stddev-sans-first:1.33 06:21:35 INFO - PROCESS | 9762 | Values: 79.0 76.0 75.0 77.0 75.0 74.0 75.0 76.0 74.0 78.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:124.00 stddev:11.83 (9.5%) stddev-sans-first:12.44 06:21:35 INFO - PROCESS | 9762 | Values: 122.0 126.0 118.0 132.0 121.0 120.0 126.0 120.0 158.0 121.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:159.50 stddev:2.54 (1.6%) stddev-sans-first:2.59 06:21:35 INFO - PROCESS | 9762 | Values: 162.0 160.0 165.0 159.0 163.0 159.0 158.0 158.0 157.0 159.0 06:21:35 INFO - PROCESS | 9762 | 06:21:35 INFO - PROCESS | 9762 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.83 (2.9%) stddev-sans-first:1.94 06:21:35 INFO - PROCESS | 9762 | Values: 64.0 65.0 62.0 64.0 63.0 66.0 62.0 62.0 67.0 62.0 06:21:35 INFO - PROCESS | 9762 | -------- Summary: end -------- 06:21:35 INFO - PROCESS | 9762 | 06:21:36 INFO - TEST-INFO | 9762: exit 0 06:21:36 INFO - TEST-OK | kraken | took 61116ms 06:21:36 INFO - SUITE-END | took 1174s 06:21:36 INFO - Completed test suite (00:19:34) 06:21:36 INFO - javascript benchmark 06:21:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2988.775841811864, 3036.0, 3040.893568725095, 3054.4501989641885, 3082.38352329534, 5308.946910530894, 5353.785848566057, 5396.514313711765, 5448.863778405537, 5495.505404513593, 5341.1988201769755, 5364.275822763926, 5373.623846330758, 5410.8917821643545, 5441.945580544193, 4825.927611085836, 4919.089968355847, 4933.136701077315, 4965.677230979993, 5105.668131571455, 5000.874978125539, 5021.071101846152, 5038.294638750578, 5083.61872859537, 5085.79656813727, 4827.903441931159, 4852.053849499349, 4865.805367785284, 4888.046830867982, 4929.8028078876805, 4854.805807767685, 4855.0, 4880.072786170616, 4882.731449770261, 4980.850574482772, 4840.636952228597, 4863.537963893425, 4873.02539492103, 4885.7312847793355, 4922.950770492321, 5171.095058364809, 5306.283651707009, 5383.327084114486, 5402.297701298806, 5415.675059496442, 5805.941940580625, 5809.82570522885, 5810.88378232433, 5846.21076154718, 5859.2382990211, 5857.619254748471, 5857.794977175821, 5887.0, 5901.144334071579, 5921.200637913869, 5298.205269209611, 5372.731363431852, 5386.542143917772, 5410.702411367373, 5487.286652735199, 6014.548908831855, 6021.367756385516, 6023.969880150571, 6025.0962355646125, 6026.367231440723, 5377.650452720561, 5703.828885133453, 5756.280464941882, 5764.394738552392, 5765.971170144123, 5693.60144789869, 5731.541476681856, 5738.340090889601, 5746.396628354046, 5748.827535173951, 5639.238702775073, 5649.774009039675, 5659.207710920475, 5666.348369937427, 5705.087186050295, 5564.8330550083565, 5669.34802497718, 5713.4000929902595, 5723.59934804568, 5745.971270143623, 4423.690341676116, 4447.688661793643, 4450.554944505524, 4489.259272220047, 4492.191405547033, 3902.512185976753, 3915.138669492707, 3920.098377373163, 3921.4117882317883, 3961.4057891316534, 5322.893542129135, 5374.91937620936, 5434.239206511092, 5535.308086489189, 5553.333599968029, 5814.738336774855, 5821.970890145522, 5822.679752613647, 5844.649321040752, 5931.258592675916, 5491.039068163055, 5501.229827824108, 5501.312335958005, 5507.972460137674, 5513.531349835229, 4782.0914026334885, 4878.487758785276, 4884.853454396374, 4926.482719314492, 4980.900381992412, 6006.369331220247, 6015.939840601625, 6016.368281330398, 6020.127081573148, 6060.696965151725, 5798.5651076168615, 5816.0, 5816.127580862904, 5816.5055970243, 5818.069108942549, 5872.354041055566, 5936.762529498945, 5978.97010514962, 5981.0131328330335, 6006.759729610942, 5696.601237913306, 5702.315722113373, 5710.65736055838, 5715.714214289352, 5724.570657200643, 5752.71236438168, 5813.244278243801, 5815.476607105381, 5823.097419899922, 5823.330317013429, 5525.889482210253, 5652.293463317085, 5691.971540142438, 5705.714714264187, 5750.367459579526, 5666.490015898589, 5729.0, 5730.455606717355, 5730.971345143247, 5742.511886489695, 5384.70384128861, 5646.237757902795, 5674.77300907959, 5683.687397193194, 5684.573656975661, 5644.463775941444, 5648.039833228443, 5672.14917762339, 5741.25363702716, 5792.681402522733, 5613.859653508532, 5615.241942337895, 5616.606837521498, 5617.634853734494, 5619.494245517923], "value": 5330.7859532144685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.5406771954894, 630.3066626710616, 630.7634637011121, 636.1285039495889, 640.8910485217513, 42627.78686106569, 43788.905277368, 43816.78091609538, 43951.56048439519, 47472.76263618677, 45359.09281814362, 45755.54244457554, 45765.08469830601, 45849.0, 45958.310625340644, 8896.688615898429, 9041.502717350542, 9045.547722613876, 9048.276137908984, 9064.728058158233, 8885.200331970122, 8973.641054357851, 8977.0, 8980.955095224515, 8983.505907175102, 9004.144606262395, 9025.909740902573, 9037.322200834931, 9045.0, 9056.13966673165, 8949.910500895005, 8975.102489751005, 8993.415427997224, 8999.23506501948, 9016.504092274923, 8915.063918288552, 8999.280057595377, 9000.369974101815, 9001.279897608176, 9015.954920225357, 43300.78349608263, 43466.0, 43767.0, 43786.0, 43866.342004869955, 3357.143928298293, 3970.0471886746973, 4015.959840401617, 4187.958120418818, 4312.202242585132, 33925.32149356999, 33958.83020584906, 34135.0, 34870.12824679378, 36018.27963440717, 4206.095689426788, 4229.794508565075, 4260.4248426462655, 4273.636740877029, 4275.166342563201, 256373.0, 256980.0, 257764.0, 257886.99999999814, 257900.0, 59738.402615974155, 60772.39227607667, 60778.696106519186, 60786.0, 60859.08711369333, 54756.0, 63187.36812631907, 66376.33623663799, 67465.0, 67966.32033679698, 17406.303747850197, 17654.11729413524, 17677.292908283525, 17703.911480442515, 17716.734248986275, 13464.528741494001, 13583.728325433436, 13589.592312230649, 13597.388117534734, 13602.659933501543, 15667.059976401453, 17039.744403833953, 17380.82619173792, 17471.213795379237, 18093.09534523295, 5968.432998865101, 6011.27864656244, 6025.849353766191, 6037.6679282639, 6109.865750702728, 924.0620769918538, 992.4491906991544, 1038.5378506564657, 1088.5101704233127, 1131.3099009604134, 31832.204194895312, 32407.0, 32686.0, 32811.83594082062, 33083.50374744381, 1094.8521949536869, 1127.537709539085, 1145.3414286785132, 1208.7703336366062, 1239.8078297863844, 17377.178251618363, 17475.213615387085, 17601.207945642476, 17620.647587048188, 17833.732494012602, 581816.0, 582856.0, 583173.0, 583989.0, 588097.0, 61114.0, 61300.0, 61417.69291153516, 61509.692451537456, 61555.0, 1205.9698507537382, 1291.9354032298347, 1326.8208791813174, 1370.6230786533783, 1404.0, 30399.848000759855, 33825.49261761125, 34360.0, 34380.48429273513, 34809.0, 52000.47999519957, 52045.73977130242, 52392.0, 52532.737336313076, 52627.0, 447334.0, 448516.0, 448663.0, 449012.2648160345, 452651.0, 36586.0, 37061.258774823815, 41246.175076498905, 42014.159716806105, 42235.7888210557, 49476.752616236685, 50205.0, 50813.0, 51798.0, 51865.740671297914, 42809.0, 43240.56759432366, 43600.0, 44015.55984440115, 44680.77659611681, 43159.78420107879, 43356.0, 43495.130097398505, 43572.34641480317, 43588.78205608952, 41641.375379369936, 42728.5727142737, 43085.7845710782, 43201.0, 43271.56728432675, 36464.81767591145, 37819.81090094532, 38129.428058579695, 38850.0, 39344.0, 28074.719252807212, 28708.014963387588, 28981.7101828979, 29006.56490152607, 29127.417451650424], "value": 20657.59845247271, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.2609780069439, 386.89940615439997, 398.8743545783078, 402.3943964333678, 414.8154071438211, 13679.278468010856, 18913.338033168842, 20256.39230823074, 20650.380488585368, 20697.586048279027, 14397.827345887346, 18217.089145542705, 18585.814141858576, 19490.610187796272, 19891.0, 5797.768089276424, 5967.970160149193, 5974.044152935531, 6009.549283803733, 6010.519158467334, 5872.76508939644, 5936.257967754031, 5942.168096466498, 5943.257092863392, 5953.315368732587, 4167.166566686659, 5863.618864773797, 6379.07503412005, 6663.800085997428, 6676.732930682767, 6439.871202575922, 6714.496412769062, 6715.0, 6772.187337519505, 6777.0, 5852.122181672783, 5886.676232807194, 5908.586398952075, 5917.497012753921, 5918.733656985446, 22826.429339266484, 22996.195133170426, 23590.64614030791, 23604.29187124389, 23837.523249535087, 2188.8577242479187, 2323.163661082009, 2406.8074554035634, 2435.585950388438, 2562.359410147463, 10432.236920986332, 10436.37381757097, 10579.153667706565, 10837.783244335069, 10919.945400273027, 1914.7606549181353, 1927.8939658318786, 1996.9301074462323, 2000.6498862699116, 2050.302897015022, 77129.22870771277, 80926.19073809245, 81002.0, 81701.18298817055, 82683.17316826814, 11012.559497620166, 11119.27724697892, 11201.543799306039, 11227.607033753779, 11379.772404551863, 15604.609884752972, 15730.213489325488, 15750.842491574938, 15769.0, 15819.604509887346, 8499.532525711022, 8699.304055675531, 8798.824023519623, 8873.112688731075, 8875.556222188865, 7915.089764677021, 7996.68054770968, 8124.878126828103, 8507.787305317417, 8608.053114157437, 4449.377087207794, 4594.402727645452, 4868.221084626513, 4952.158133117378, 5022.6233032522705, 1925.9037048147536, 1982.1278637399787, 2039.1027947702962, 2043.335915827362, 2089.613421517024, 918.7197904639149, 937.8042995181062, 956.3305686019814, 1013.9138173255209, 1014.9238807089498, 11716.589919352953, 12339.321337326353, 12807.295598741972, 18249.270029198684, 20250.594988100154, 456.5069724697319, 462.05740289809086, 464.12512414099666, 472.95034021427944, 480.92545655423464, 6780.118584584071, 6845.992396641937, 6913.3777959983845, 6972.372486476242, 6990.545614535039, 509996.0, 547991.0, 556794.0, 570364.0, 570422.0, 100590.0, 102583.0, 105195.0, 105322.0, 105702.0, 494.7798229787782, 500.07486150621787, 501.13554119144914, 502.7988804478238, 504.6114491841262, 11382.317060976036, 11905.166638335233, 11946.223495473114, 12008.159428839897, 12112.878871211527, 42489.5751042498, 45741.0, 46022.309665355715, 46198.53801461942, 47025.76487117542, 62512.0, 63363.0, 63384.0, 63456.36543634505, 64591.0, 8908.777280568038, 8928.261935298606, 8986.86519702192, 9119.589618467318, 9278.675246366345, 10472.581096756045, 13059.085863989809, 13501.459941602227, 13706.38321275525, 14183.29083545798, 11728.648140555797, 11801.586944456903, 12083.456244469196, 12097.57658481949, 12188.75622487563, 5463.863403414946, 9785.657501987396, 11169.994700476997, 11815.350155741517, 11837.704057398634, 12226.510939562319, 12346.13577049598, 12422.503099875903, 12525.436355363849, 12615.684607884876, 8497.490150590984, 8601.967763868375, 8725.476471411735, 8928.86606700913, 9157.816843663222, 10824.837627435752, 12111.333876636518, 12122.696932576404, 12163.939180304042, 12289.078319125923], "value": 8823.740334293587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.648438163886, 1333.1934179821208, 1363.2570249214177, 1407.3315175291737, 1515.378694735159, 8770.166834150754, 9102.908970910297, 9155.542222888862, 9438.292128090387, 9455.054494550559, 9194.770130746734, 9398.718038458841, 9399.577019034143, 9413.152816246537, 9413.623455061806, 2421.685180926477, 2451.2156110044793, 2452.1907770435714, 2453.6196889482158, 2454.325060608338, 2386.183087817032, 2438.2441443152593, 2463.7536246375307, 2465.617829236471, 2472.431340791619, 2354.8704821234824, 2369.609014512612, 2378.120095564635, 2385.797207237378, 2409.144753612469, 2350.1421980976993, 2357.528494301138, 2367.2661474942824, 2375.95248095038, 2386.737458879522, 2228.4317499037643, 2275.84069115162, 2277.3168049585056, 2285.6800047993293, 2286.1312701173447, 7776.300132988058, 8841.911580884173, 9217.631294748202, 9258.72223833286, 9260.768480787967, 4847.5394837490385, 5048.671836330664, 5057.595392368638, 5065.39215294167, 5072.442031376546, 3238.3685181389637, 3271.8691252349877, 3297.752668549844, 3316.436205845012, 3336.132605522582, 1065.3341661461586, 1085.403028334413, 1094.7810437912449, 1108.534415545473, 1120.9047230985377, 13014.739705205937, 13023.413946372437, 13076.738465230643, 13120.0, 13127.343632818416, 4600.838970636079, 4629.953700463019, 4801.447833499193, 4843.128236917319, 4855.223164293696, 10892.618758343579, 10910.781784364268, 10918.617848375268, 10920.18098642589, 10961.725956850983, 5361.142217245222, 5368.248445217672, 5409.323834520685, 5410.1343784995, 5412.188171774265, 4918.065567542156, 4971.37857767779, 4975.975120124376, 4991.376077990251, 5015.799368025311, 4023.8591649292134, 4024.2555127301544, 4075.918481630351, 4113.300738874398, 4138.79306034697, 1253.8746125387388, 1254.974900502003, 1259.4080782032431, 1268.0109514578644, 1271.6121582917299, 879.5821984557284, 972.2902281334665, 978.8645171600908, 985.2512090811035, 995.5320999130397, 6138.907916381258, 6152.107944348045, 6272.184615999982, 6272.498200143978, 6433.74265029403, 429.54682809636137, 436.76851268827573, 440.31970605414074, 450.9301058335963, 451.032535211975, 4131.462909821704, 4273.081287523135, 4280.6789490788315, 4298.4841818981295, 4319.568043195655, 10368.377897326185, 11111.888881111247, 11485.885141148648, 11553.0, 11636.243644163102, 10268.897311026943, 10604.469776511298, 11753.529858805723, 11856.466459009192, 11866.347350895783, 7563.205863384375, 8036.839263214703, 8285.54429506383, 8316.085230624627, 8554.57227138653, 6049.697515124314, 6071.362506936708, 6240.0, 6244.2819075806865, 6338.809835704937, 10264.127549158107, 10484.0, 10568.313059651098, 10601.946990265, 10826.89173108259, 11003.779924401628, 11075.280106793032, 11139.944300278446, 11368.886311137114, 11374.090072794323, 8020.839583208186, 8090.676372945016, 8160.673573057011, 8172.959135204286, 8178.059523154675, 8787.868181977403, 8995.595198216226, 9000.459972401677, 9000.459972401677, 9051.728448146567, 7957.721479748181, 8097.2307630774985, 8121.8375632488205, 8152.551609661288, 8234.300084492885, 7975.7607271781935, 7977.401694873024, 8066.354691624539, 8086.272235498834, 8119.675212991414, 7573.545587264782, 7660.0, 7676.731314403969, 7704.807379815549, 7707.768766937001, 5296.0, 5397.379301380234, 5440.156775699773, 5469.562435005269, 5510.283663123768, 5281.894362112659, 5327.866803329948, 5416.268803711606, 5514.0, 5557.277553917965], "value": 4671.367712141459, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.5231086458339, 328.986720899629, 337.87329751343236, 338.82719812895414, 343.5053522926985, 5286.788528458862, 5303.787848486061, 5333.89332213356, 5335.359756829176, 5350.438203988583, 5302.0, 5323.361196656397, 5325.600579956509, 5331.147016477365, 5342.931413717262, 3997.120633460634, 3999.4600728901664, 4165.895852603679, 4181.477315335583, 4224.239636865363, 4162.354835000565, 4169.478815148106, 4175.958240417587, 4195.391668208108, 4218.915621687564, 3976.403539469074, 4138.737685006072, 4149.585041495841, 4153.813078411479, 4167.187398457302, 4049.676025917934, 4149.792510374469, 4150.232207041707, 4158.147579746144, 4168.91662166758, 3679.1721862580707, 3683.318586061587, 3690.3172913010912, 3696.5194524711615, 3700.611435799256, 5107.284980102789, 5146.408163061258, 5151.562117220041, 5172.844814655567, 5225.320708307933, 4478.57453541913, 4669.509701481329, 4710.811567537295, 4721.276733992103, 4729.125111854318, 5383.327084114486, 5394.838154855361, 5406.972965135149, 5420.051490989061, 5488.725563721798, 3935.291647503448, 3942.5860284669984, 3961.1681546875193, 3974.0, 4046.4825690366115, 5676.268738034898, 5684.204211410406, 5706.28671416073, 5706.743196556165, 5730.799422020209, 4090.529589097292, 4174.540800511942, 4176.352665336878, 4182.351735481006, 4184.121334519785, 4175.665946724254, 4181.874543763692, 4190.5180904195795, 4219.3249080147025, 4225.535191128974, 4743.739094349844, 4746.121967435966, 4749.216379297377, 4777.283407488835, 4792.9281060784115, 5480.616356854982, 5533.695646739468, 5542.2795036644975, 5542.584306177053, 5553.9725150847225, 1439.0048114568972, 1447.9710405791825, 1448.8551144885637, 1462.824461064679, 1466.281522054207, 948.1750876737283, 969.1955676788249, 1009.7374682582434, 1031.4275577054807, 1045.8431235314763, 5257.973710131425, 5284.471552844685, 5285.233641122016, 5304.310439642899, 5318.680879147186, 5554.722263886871, 5606.0, 5606.6916319602815, 5611.9719401403545, 5637.379888212294, 5042.596592272609, 5254.185601231815, 5263.578913686896, 5301.920471192935, 5326.627136100513, 2965.2438628150117, 2967.2581854536365, 2978.3447641518833, 2978.74680652147, 2993.0, 5555.72221388937, 5753.913691294634, 5767.88464230713, 5769.682667453247, 5813.88372232553, 5808.477237048686, 5847.6783776891825, 5849.766009359663, 5856.4143585641095, 5862.618929769551, 5889.322727886262, 5896.380880007623, 5905.527557795452, 5920.993431116634, 5938.703064846654, 5554.0, 5645.943540564542, 5655.321361436654, 5665.263515742927, 5759.222504961776, 5559.91581641576, 5590.385057643574, 5602.915956260741, 5609.0, 5639.3232812062815, 5627.774889004394, 5852.912206316823, 5947.91078133837, 5976.940230597638, 6010.729517171825, 3981.5421226559315, 4013.458183145238, 4025.6376926076796, 4039.0, 4053.817578208929, 5664.37691853904, 5685.886282274414, 5691.77232910679, 5702.173184888085, 5739.971300143639, 5395.973020134874, 5598.412166722598, 5621.8594535136945, 5629.4652008059165, 5632.408597097409, 5511.208857121372, 5544.556435485232, 5557.1664250361155, 5562.72186390687, 5581.832545023656, 5273.868153296198, 5359.839204823861, 5423.4034256231, 5478.986387518322, 5486.177073439016, 5519.475649813261, 5573.219749235192, 5576.10782274834, 5579.330480342385, 5596.244506991667, 5462.453754624506, 5463.235147079333, 5469.945300546943, 5482.780688772564, 5498.642588231752], "value": 4246.1726560255565, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.5580651609032, 736.6684991753713, 758.787539488943, 775.7633921653893, 849.1296421168304, 14611.780823287645, 15890.364385424598, 15902.52292431226, 15925.04449733017, 15939.36242550298, 13809.0, 13813.444512765145, 13939.860601393983, 14565.271736413164, 15335.616609584766, 819.4427789103422, 836.0, 839.1566475691922, 839.9916000839975, 840.8276303357827, 682.3756263019332, 800.6677228950008, 801.0427539090789, 804.4650307545476, 838.0320729557341, 873.6112429968666, 875.4353442029887, 875.9824803503926, 878.056089703568, 881.0, 700.502643123383, 870.7039606533746, 871.2376670413388, 871.2420194430822, 872.6509396241522, 602.6534742523023, 616.4913945994527, 617.555360140698, 634.3592971099177, 635.2630948100182, 15369.231538423033, 15478.45825396117, 15487.380504779796, 15534.456294029767, 15637.296321665552, 13871.861281387159, 14231.288435578283, 14250.92874535631, 14401.71196576073, 14676.70646587073, 13306.933465332708, 13358.265295408748, 13484.797728034087, 13527.0, 13541.729165416735, 4598.218302888517, 4605.37827393301, 4643.535646435364, 4802.378244647925, 4826.251930950708, 77014.22985770127, 77862.0, 78459.0, 79357.60321198415, 79995.6000220001, 11311.714637195288, 11529.942350288195, 11699.181057325906, 11957.291822581346, 12224.449899754532, 20865.895670521855, 20964.580708385747, 21006.579868402547, 21015.264465743625, 21020.894895525424, 8619.353548483889, 8736.475811451333, 8884.200421962054, 8956.552172391484, 9083.591238394289, 4799.616030717534, 4930.654854160246, 4954.5788607968725, 4957.529034741694, 5147.433782283946, 3518.225990282134, 3606.945895811565, 3609.4405367167606, 3609.819509024591, 3614.3494171049465, 622.8878801815627, 626.6021076616381, 627.7896904537031, 635.2757856044113, 640.5068097564942, 611.1840692675239, 652.3281020548842, 691.6472598974559, 703.3669697272496, 720.772956518695, 9532.285078619132, 9708.514574271258, 9723.562439690231, 9752.21982241419, 9962.0, 584.186304848049, 627.7206643043802, 658.404144249455, 662.3277373465936, 668.628910954425, 4430.335449682573, 4554.931676024862, 4787.652476972866, 4794.448638406628, 4818.566329030404, 108073.0, 109105.0, 110962.0, 111208.44395778132, 115391.0, 94944.52527737318, 97832.0, 98228.50885745525, 98676.0, 100470.49764751129, 82687.0, 83363.5831820837, 85258.57370713231, 85334.0, 85557.57221213978, 8664.306855451674, 8787.121287871161, 8796.384253102222, 8806.559672016501, 9005.729828105168, 51398.0, 51400.74299628627, 51715.224271635205, 52833.71662833686, 53669.194962076384, 69513.65243173752, 72515.0, 73546.0, 74655.0, 75092.62453687696, 10377.377357358582, 10506.054455099078, 10585.629502967358, 10649.148068154684, 10925.180611454014, 12479.500819967463, 12491.500339986662, 12874.485020599446, 12923.612291631267, 12984.610461686165, 11841.526338946345, 12110.939445302716, 12374.443150058089, 12391.504339826306, 12408.441620126936, 11691.181617287048, 11799.410029498662, 11865.762684746083, 11891.76216475683, 11910.702232444259, 11625.302481851117, 11728.589499367823, 11873.109516786102, 12204.633860984184, 12353.505859765508, 10014.467448241458, 10060.899391006289, 10062.748431289276, 10227.94886025565, 10699.938040892974, 9930.404175749478, 9947.452890091114, 9971.102600765966, 9997.250206234416, 10069.496525173858], "value": 7407.619966278849, "unit": "score"}], "name": "dromaeo_css", "value": 7229.610330016403, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 110.0, 111.0, 112.0, 109.0, 110.0, 110.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 121.0, 175.0, 119.0, 118.0, 145.0, 118.0, 156.0, 124.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 106.0, 76.0, 76.0, 75.0, 75.0, 100.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 84.0, 83.0, 84.0, 124.0, 83.0, 83.0, 125.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 52.0, 53.0, 54.0, 55.0, 53.0, 53.0, 52.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 62.0, 63.0, 61.0, 62.0, 66.0, 61.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 75.0, 77.0, 75.0, 74.0, 75.0, 76.0, 74.0, 78.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 126.0, 118.0, 132.0, 121.0, 120.0, 126.0, 120.0, 158.0, 121.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 165.0, 159.0, 163.0, 159.0, 158.0, 158.0, 157.0, 159.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 62.0, 64.0, 63.0, 66.0, 62.0, 62.0, 67.0, 62.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1477.1000000000004, "alertThreshold": 2.0}]} 06:21:36 INFO - Return code: 0 06:21:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:21:36 INFO - # TBPL SUCCESS # 06:21:36 INFO - Running post-action listener: _resource_record_post_action 06:21:36 INFO - ##### 06:21:36 INFO - ##### Finished run-tests step (success) 06:21:36 INFO - ##### 06:21:36 INFO - Running post-run listener: _resource_record_post_run 06:21:36 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 556363776; Read time: 0; Write time: 429572 06:21:36 INFO - TinderboxPrint: CPU usage
13.0% 06:21:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:21:36 INFO - TinderboxPrint: I/O write bytes / time
556,363,776 / 429,572 06:21:36 INFO - TinderboxPrint: CPU idle
8,279.3 (87.0%) 06:21:36 INFO - TinderboxPrint: CPU user
1,192.8 (12.5%) 06:21:36 INFO - TinderboxPrint: Swap in / out
0 / 0 06:21:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 262975488; Read time: 0; Write time: 228940 06:21:36 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 289447936; Read time: 0; Write time: 200092 06:21:37 INFO - Running post-run listener: _upload_blobber_files 06:21:37 INFO - Blob upload gear active. 06:21:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:21:37 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 06:21:37 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:21:37 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:21:37 INFO - (blobuploader) - INFO - Open directory for files ... 06:21:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:21:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:21:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:38 INFO - (blobuploader) - INFO - Done attempting. 06:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:39 INFO - (blobuploader) - INFO - Done attempting. 06:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:21:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:42 INFO - (blobuploader) - INFO - Done attempting. 06:21:42 INFO - (blobuploader) - INFO - Iteration through files over. 06:21:42 INFO - Return code: 0 06:21:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:21:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:21:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae6963186bbb981ffca6202a89ce05c5430c1fe3298e8c83fb0b0e22ceb41946e69bbdf7b9dd0c5743524ad8af843811b0e73f8e5ab9d15fa98f6deb5ec58f2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03c10437dab88303a1d1cb3dc045edefbb1a3bb142c4a7cd2556c79dce15b51781e6a98f08f3e23899c9699b42fd4edd0cf0e86e6332793baec3e17d72a693c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ce965dce6b7f9f100a81737b31a9d27a6c843d553c687eec99db473f057f56e988d48c7f7697955b11380898c91c83937c0b15af980b01f290bbdadaac35b8"} 06:21:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:21:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:21:42 INFO - Contents: 06:21:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae6963186bbb981ffca6202a89ce05c5430c1fe3298e8c83fb0b0e22ceb41946e69bbdf7b9dd0c5743524ad8af843811b0e73f8e5ab9d15fa98f6deb5ec58f2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03c10437dab88303a1d1cb3dc045edefbb1a3bb142c4a7cd2556c79dce15b51781e6a98f08f3e23899c9699b42fd4edd0cf0e86e6332793baec3e17d72a693c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ce965dce6b7f9f100a81737b31a9d27a6c843d553c687eec99db473f057f56e988d48c7f7697955b11380898c91c83937c0b15af980b01f290bbdadaac35b8"} 06:21:42 INFO - Running post-run listener: copy_logs_to_upload_dir 06:21:42 INFO - Copying logs to upload dir... 06:21:42 INFO - mkdir: /builds/slave/test/build/upload/logs 06:21:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.235637 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-08 06:21:42.710363) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 06:21:42.713973) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae6963186bbb981ffca6202a89ce05c5430c1fe3298e8c83fb0b0e22ceb41946e69bbdf7b9dd0c5743524ad8af843811b0e73f8e5ab9d15fa98f6deb5ec58f2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03c10437dab88303a1d1cb3dc045edefbb1a3bb142c4a7cd2556c79dce15b51781e6a98f08f3e23899c9699b42fd4edd0cf0e86e6332793baec3e17d72a693c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ce965dce6b7f9f100a81737b31a9d27a6c843d553c687eec99db473f057f56e988d48c7f7697955b11380898c91c83937c0b15af980b01f290bbdadaac35b8"} build_url:https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/dKZFsTF8QQeVJh_cibp5dA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae6963186bbb981ffca6202a89ce05c5430c1fe3298e8c83fb0b0e22ceb41946e69bbdf7b9dd0c5743524ad8af843811b0e73f8e5ab9d15fa98f6deb5ec58f2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03c10437dab88303a1d1cb3dc045edefbb1a3bb142c4a7cd2556c79dce15b51781e6a98f08f3e23899c9699b42fd4edd0cf0e86e6332793baec3e17d72a693c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90ce965dce6b7f9f100a81737b31a9d27a6c843d553c687eec99db473f057f56e988d48c7f7697955b11380898c91c83937c0b15af980b01f290bbdadaac35b8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 06:21:42.739694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:21:42.740057) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1467982868.808237-2072339888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 06:21:42.823939) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 06:21:42.824347) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 06:21:42.824758) ========= ========= Total master_lag: 0.17 =========