builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1473394209.5 results: success (0) buildid: 20160908182520 builduid: 1f8ebc2ccc6540459145dee497460121 revision: 6cd56350a8953b0161a40064f0b332fbc93c6cb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:09.497487) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:09.498545) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:09.499029) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:09.592885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:09.593171) ========= 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=5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-08 21:10: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.2M=0s 2016-09-08 21:10:09 (69.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:09.749815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:09.750102) ========= 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=5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015976 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:09.804152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:09.804518) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6cd56350a8953b0161a40064f0b332fbc93c6cb1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6cd56350a8953b0161a40064f0b332fbc93c6cb1 --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=5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-08 21:10:09,910 truncating revision to first 12 chars 2016-09-08 21:10:09,910 Setting DEBUG logging. 2016-09-08 21:10:09,910 attempt 1/10 2016-09-08 21:10:09,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6cd56350a895?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-08 21:10:10,424 unpacking tar archive at: mozilla-aurora-6cd56350a895/testing/mozharness/ program finished with exit code 0 elapsedTime=0.894255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:10.713261) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:10.713683) ========= script_repo_revision: 6cd56350a8953b0161a40064f0b332fbc93c6cb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:10.714066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:10.714338) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 21:10:10.724863) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-09-08 21:10:10.725171) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:10:10 INFO - MultiFileLogger online at 20160908 21:10:10 in /builds/slave/test 21:10:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:10:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:10:10 INFO - {'append_to_log': False, 21:10:10 INFO - 'base_work_dir': '/builds/slave/test', 21:10:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:10:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:10:10 INFO - 'branch': 'Mozilla-Aurora', 21:10:10 INFO - 'buildbot_json_path': 'buildprops.json', 21:10:10 INFO - 'config_files': ('talos/linux_config.py',), 21:10:10 INFO - 'default_actions': ('clobber', 21:10:10 INFO - 'read-buildbot-config', 21:10:10 INFO - 'download-and-extract', 21:10:10 INFO - 'populate-webroot', 21:10:10 INFO - 'create-virtualenv', 21:10:10 INFO - 'install', 21:10:10 INFO - 'run-tests'), 21:10:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:10:10 INFO - 'download_minidump_stackwalk': True, 21:10:10 INFO - 'download_symbols': 'ondemand', 21:10:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:10:10 INFO - 'tooltool.py': '/tools/tooltool.py', 21:10:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:10:10 INFO - '/tools/misc-python/virtualenv.py')}, 21:10:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:10:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:10:10 INFO - 'installer_path': 'installer.exe', 21:10:10 INFO - 'log_level': 'info', 21:10:10 INFO - 'log_name': 'talos', 21:10:10 INFO - 'log_to_console': True, 21:10:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:10:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:10:10 INFO - 'opt_config_files': (), 21:10:10 INFO - 'pip_index': False, 21:10:10 INFO - 'sps_profile': False, 21:10:10 INFO - 'sps_profile_interval': 0, 21:10:10 INFO - 'suite': 'dromaeojs-e10s', 21:10:10 INFO - 'system_bits': '32', 21:10:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:10:10 INFO - 'title': 'talos-linux64-ix-011', 21:10:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:10:10 INFO - 'use_talos_json': True, 21:10:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:10:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:10:10 INFO - 'work_dir': 'build'} 21:10:10 INFO - [mozharness: 2016-09-09 04:10:10.921991Z] Running clobber step. 21:10:10 INFO - Running pre-action listener: _resource_record_pre_action 21:10:10 INFO - Running main action method: clobber 21:10:10 INFO - rmtree: /builds/slave/test/build 21:10:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:10:11 INFO - Running post-action listener: _resource_record_post_action 21:10:11 INFO - [mozharness: 2016-09-09 04:10:11.878910Z] Finished clobber step (success) 21:10:11 INFO - [mozharness: 2016-09-09 04:10:11.879009Z] Running read-buildbot-config step. 21:10:11 INFO - Running pre-action listener: _resource_record_pre_action 21:10:11 INFO - Running main action method: read_buildbot_config 21:10:11 INFO - Using buildbot properties: 21:10:11 INFO - { 21:10:11 INFO - "project": "", 21:10:11 INFO - "product": "firefox", 21:10:11 INFO - "script_repo_revision": "production", 21:10:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 21:10:11 INFO - "repository": "", 21:10:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 21:10:11 INFO - "buildid": "20160908182520", 21:10:11 INFO - "pgo_build": "True", 21:10:11 INFO - "basedir": "/builds/slave/test", 21:10:11 INFO - "buildnumber": 541, 21:10:11 INFO - "slavename": "talos-linux64-ix-011", 21:10:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:10:11 INFO - "platform": "ubuntu64_hw", 21:10:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:10:11 INFO - "branch": "mozilla-aurora", 21:10:11 INFO - "repo_path": "releases/mozilla-aurora", 21:10:11 INFO - "revision": "6cd56350a8953b0161a40064f0b332fbc93c6cb1", 21:10:11 INFO - "stage_platform": "linux64-pgo", 21:10:11 INFO - "builduid": "1f8ebc2ccc6540459145dee497460121", 21:10:11 INFO - "slavebuilddir": "test" 21:10:11 INFO - } 21:10:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 21:10:11 INFO - Running post-action listener: _resource_record_post_action 21:10:11 INFO - [mozharness: 2016-09-09 04:10:11.881452Z] Finished read-buildbot-config step (success) 21:10:11 INFO - [mozharness: 2016-09-09 04:10:11.881542Z] Running download-and-extract step. 21:10:11 INFO - Running pre-action listener: _resource_record_pre_action 21:10:11 INFO - Running main action method: download_and_extract 21:10:11 INFO - mkdir: /builds/slave/test/build/tests 21:10:11 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')]} 21:10:11 INFO - https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:10:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:10:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:10:11 INFO - retry: Failed, sleeping 30 seconds before retrying 21:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 21:10:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:10:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:10:41 INFO - retry: Failed, sleeping 60 seconds before retrying 21:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 21:11:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:11:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:11:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 21:11:42 INFO - Caught exception: HTTP Error 404: Not Found 21:11:42 INFO - Caught exception: HTTP Error 404: Not Found 21:11:42 INFO - Caught exception: HTTP Error 404: Not Found 21:11:42 INFO - trying https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:11:42 INFO - Downloading https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:11:42 INFO - Downloaded 1361 bytes. 21:11:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 21:11:42 INFO - Using the following test package requirements: 21:11:42 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 21:11:42 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:11:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:11:42 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:11:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:11:42 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:11:42 INFO - u'jsshell-linux-x86_64.zip'], 21:11:42 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:11:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:11:42 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 21:11:42 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:11:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:11:42 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:11:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:11:42 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:11:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:11:42 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 21:11:42 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:11:42 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:11:42 INFO - https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:11:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:11:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:11:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:11:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:11:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:11:42 INFO - retry: Failed, sleeping 30 seconds before retrying 21:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 21:12:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:12:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:12:12 INFO - retry: Failed, sleeping 60 seconds before retrying 21:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 21:13:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:13:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:13:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 21:13:12 INFO - Caught exception: HTTP Error 404: Not Found 21:13:12 INFO - Caught exception: HTTP Error 404: Not Found 21:13:12 INFO - Caught exception: HTTP Error 404: Not Found 21:13:12 INFO - trying https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:13:12 INFO - Downloading https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:13:13 INFO - Downloaded 21770334 bytes. 21:13:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:13:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:13:14 INFO - Return code: 0 21:13:14 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:13:14 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')]} 21:13:14 INFO - https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:13:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:13:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:13:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:13:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:13:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:13:14 INFO - retry: Failed, sleeping 30 seconds before retrying 21:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 21:13:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:13:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:13:45 INFO - retry: Failed, sleeping 60 seconds before retrying 21:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 21:14:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:14:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:14:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 21:14:45 INFO - Caught exception: HTTP Error 404: Not Found 21:14:45 INFO - Caught exception: HTTP Error 404: Not Found 21:14:45 INFO - Caught exception: HTTP Error 404: Not Found 21:14:45 INFO - trying https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:14:45 INFO - Downloading https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 21:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:14:46 INFO - Downloaded 21770334 bytes. 21:14:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:14:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:14:47 INFO - Return code: 0 21:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:47 INFO - https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:14:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:14:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:14:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:14:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:14:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:14:47 INFO - retry: Failed, sleeping 30 seconds before retrying 21:15:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 21:15:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:15:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:15:17 INFO - retry: Failed, sleeping 60 seconds before retrying 21:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 21:16:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:16:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:16:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 21:16:17 INFO - Caught exception: HTTP Error 404: Not Found 21:16:17 INFO - Caught exception: HTTP Error 404: Not Found 21:16:17 INFO - Caught exception: HTTP Error 404: Not Found 21:16:17 INFO - trying https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:16:17 INFO - Downloading https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 21:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:16:19 INFO - Downloaded 14413740 bytes. 21:16:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:16:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:16:19 INFO - Return code: 0 21:16:19 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')]} 21:16:19 INFO - https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:16:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:16:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:16:19 INFO - retry: Failed, sleeping 30 seconds before retrying 21:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 21:16:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:16:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:16:49 INFO - retry: Failed, sleeping 60 seconds before retrying 21:17:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 21:17:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:17:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:17:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 21:17:49 INFO - Caught exception: HTTP Error 404: Not Found 21:17:49 INFO - Caught exception: HTTP Error 404: Not Found 21:17:49 INFO - Caught exception: HTTP Error 404: Not Found 21:17:49 INFO - trying https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:17:49 INFO - Downloading https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:17:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:17:51 INFO - Downloaded 63914766 bytes. 21:17:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:17:51 INFO - mkdir: /builds/slave/test/properties 21:17:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:17:51 INFO - Writing to file /builds/slave/test/properties/build_url 21:17:51 INFO - Contents: 21:17:51 INFO - build_url:https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 21:17:51 INFO - Running post-action listener: _resource_record_post_action 21:17:51 INFO - Running post-action listener: set_extra_try_arguments 21:17:51 INFO - [mozharness: 2016-09-09 04:17:51.961727Z] Finished download-and-extract step (success) 21:17:51 INFO - [mozharness: 2016-09-09 04:17:51.961959Z] Running populate-webroot step. 21:17:51 INFO - Running pre-action listener: _resource_record_pre_action 21:17:51 INFO - Running main action method: populate_webroot 21:17:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:17:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:17:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:17:51 INFO - '--tppagecycles', 21:17:51 INFO - '7'], 21:17:51 INFO - 'tests': ['tsvgm']}}, 21:17:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:17:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:17:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:17:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:17:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:51 INFO - 'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:17:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:17:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:51 INFO - 'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['damp', 'tps']}, 21:17:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:51 INFO - 'tests': ['damp', 'tps']}, 21:17:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['dromaeo_dom']}, 21:17:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:17:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['basic_compositor_video']}, 21:17:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:17:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['a11yr', 21:17:51 INFO - 'ts_paint', 21:17:51 INFO - 'tpaint', 21:17:51 INFO - 'sessionrestore', 21:17:51 INFO - 'sessionrestore_no_auto_restore', 21:17:51 INFO - 'tabpaint']}, 21:17:51 INFO - 'other-e10s': {'tests': ['a11yr', 21:17:51 INFO - 'ts_paint', 21:17:51 INFO - 'tpaint', 21:17:51 INFO - 'sessionrestore', 21:17:51 INFO - 'sessionrestore_no_auto_restore', 21:17:51 INFO - 'tabpaint']}, 21:17:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:17:51 INFO - 'ts_paint', 21:17:51 INFO - 'tpaint', 21:17:51 INFO - 'sessionrestore', 21:17:51 INFO - 'sessionrestore_no_auto_restore', 21:17:51 INFO - 'tabpaint']}, 21:17:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:17:51 INFO - 'ts_paint', 21:17:51 INFO - 'tpaint', 21:17:51 INFO - 'sessionrestore', 21:17:51 INFO - 'sessionrestore_no_auto_restore', 21:17:51 INFO - 'tabpaint']}, 21:17:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['a11yr', 21:17:51 INFO - 'ts_paint', 21:17:51 INFO - 'tpaint', 21:17:51 INFO - 'sessionrestore', 21:17:51 INFO - 'sessionrestore_no_auto_restore', 21:17:51 INFO - 'tabpaint']}, 21:17:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['a11yr', 21:17:51 INFO - 'ts_paint', 21:17:51 INFO - 'tpaint', 21:17:51 INFO - 'sessionrestore', 21:17:51 INFO - 'sessionrestore_no_auto_restore', 21:17:51 INFO - 'tabpaint']}, 21:17:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['tsvgx', 21:17:51 INFO - 'tsvgr_opacity', 21:17:51 INFO - 'tart', 21:17:51 INFO - 'tscrollx', 21:17:51 INFO - 'cart']}, 21:17:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:17:51 INFO - 'tsvgr_opacity', 21:17:51 INFO - 'tart', 21:17:51 INFO - 'tscrollx', 21:17:51 INFO - 'cart']}, 21:17:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:51 INFO - 'talos_options': ['--disable-e10s'], 21:17:51 INFO - 'tests': ['tp5o']}, 21:17:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:51 INFO - 'tests': ['tp5o']}, 21:17:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:51 INFO - 'talos_options': ['--disable-e10s', 21:17:51 INFO - '--xperf_path', 21:17:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:17:51 INFO - 'tests': ['tp5n']}, 21:17:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:17:51 INFO - 'talos_options': ['--xperf_path', 21:17:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:17:51 INFO - 'tests': ['tp5n']}}, 21:17:51 INFO - 'talos.zip': {'path': '', 21:17:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:17:51 INFO - Running post-action listener: _resource_record_post_action 21:17:51 INFO - [mozharness: 2016-09-09 04:17:51.982523Z] Finished populate-webroot step (success) 21:17:51 INFO - [mozharness: 2016-09-09 04:17:51.982613Z] Running create-virtualenv step. 21:17:51 INFO - Running pre-action listener: _resource_record_pre_action 21:17:51 INFO - Running main action method: create_virtualenv 21:17:51 INFO - Creating virtualenv /builds/slave/test/build/venv 21:17:51 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 21:17:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:17:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:17:52 INFO - Using real prefix '/usr' 21:17:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:17:52 INFO - Installing distribute.............................................................................................................................................................................................done. 21:17:54 INFO - Installing pip.................done. 21:17:54 INFO - Return code: 0 21:17:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2712400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, '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': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', '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 21:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:17:54 INFO - Using env: {'DISPLAY': ':0', 21:17:54 INFO - 'HOME': '/home/cltbld', 21:17:54 INFO - 'LANG': 'en_US.UTF-8', 21:17:54 INFO - 'LANGUAGE': 'en_US:en', 21:17:54 INFO - 'LOGNAME': 'cltbld', 21:17:54 INFO - 'MAIL': '/var/mail/cltbld', 21:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:54 INFO - 'MOZ_NO_REMOTE': '1', 21:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:54 INFO - 'NO_EM_RESTART': '1', 21:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:54 INFO - 'PWD': '/builds/slave/test', 21:17:54 INFO - 'SHELL': '/bin/bash', 21:17:54 INFO - 'SHLVL': '1', 21:17:54 INFO - 'TERM': 'linux', 21:17:54 INFO - 'TMOUT': '86400', 21:17:54 INFO - 'USER': 'cltbld', 21:17:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:54 INFO - '_': '/tools/buildbot/bin/python'} 21:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:54 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 21:17:54 INFO - Cleaning up... 21:17:54 INFO - Return code: 0 21:17:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2712400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, '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': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', '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 21:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:17:54 INFO - Using env: {'DISPLAY': ':0', 21:17:54 INFO - 'HOME': '/home/cltbld', 21:17:54 INFO - 'LANG': 'en_US.UTF-8', 21:17:54 INFO - 'LANGUAGE': 'en_US:en', 21:17:54 INFO - 'LOGNAME': 'cltbld', 21:17:54 INFO - 'MAIL': '/var/mail/cltbld', 21:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:54 INFO - 'MOZ_NO_REMOTE': '1', 21:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:54 INFO - 'NO_EM_RESTART': '1', 21:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:54 INFO - 'PWD': '/builds/slave/test', 21:17:54 INFO - 'SHELL': '/bin/bash', 21:17:54 INFO - 'SHLVL': '1', 21:17:54 INFO - 'TERM': 'linux', 21:17:54 INFO - 'TMOUT': '86400', 21:17:54 INFO - 'USER': 'cltbld', 21:17:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:54 INFO - '_': '/tools/buildbot/bin/python'} 21:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:54 INFO - Downloading/unpacking psutil>=3.1.1 21:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:17:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:17:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:17:56 INFO - Installing collected packages: psutil 21:17:56 INFO - Running setup.py install for psutil 21:17:57 INFO - building 'psutil._psutil_linux' extension 21:17:57 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 21:17:57 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 21:17:57 INFO - building 'psutil._psutil_posix' extension 21:17:57 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 21:17:57 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 21:17:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:17:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:17:57 INFO - Successfully installed psutil 21:17:57 INFO - Cleaning up... 21:17:57 INFO - Return code: 0 21:17:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:17:57 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')]} 21:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:57 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')]} 21:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:57 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 0x24e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2712400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, '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': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', '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 21:17:57 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 21:17:57 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 21:17:57 INFO - Using env: {'DISPLAY': ':0', 21:17:57 INFO - 'HOME': '/home/cltbld', 21:17:57 INFO - 'LANG': 'en_US.UTF-8', 21:17:57 INFO - 'LANGUAGE': 'en_US:en', 21:17:57 INFO - 'LOGNAME': 'cltbld', 21:17:57 INFO - 'MAIL': '/var/mail/cltbld', 21:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:57 INFO - 'MOZ_NO_REMOTE': '1', 21:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:57 INFO - 'NO_EM_RESTART': '1', 21:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:57 INFO - 'PWD': '/builds/slave/test', 21:17:57 INFO - 'SHELL': '/bin/bash', 21:17:57 INFO - 'SHLVL': '1', 21:17:57 INFO - 'TERM': 'linux', 21:17:57 INFO - 'TMOUT': '86400', 21:17:57 INFO - 'USER': 'cltbld', 21:17:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:57 INFO - '_': '/tools/buildbot/bin/python'} 21:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:17:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:17:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:17:59 INFO - Installing collected packages: mozsystemmonitor 21:17:59 INFO - Running setup.py install for mozsystemmonitor 21:17:59 INFO - Successfully installed mozsystemmonitor 21:17:59 INFO - Cleaning up... 21:17:59 INFO - Return code: 0 21:17:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:17:59 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 0x24e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2712400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, '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': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', '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 21:17:59 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 21:17:59 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 21:17:59 INFO - Using env: {'DISPLAY': ':0', 21:17:59 INFO - 'HOME': '/home/cltbld', 21:17:59 INFO - 'LANG': 'en_US.UTF-8', 21:17:59 INFO - 'LANGUAGE': 'en_US:en', 21:17:59 INFO - 'LOGNAME': 'cltbld', 21:17:59 INFO - 'MAIL': '/var/mail/cltbld', 21:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:17:59 INFO - 'MOZ_NO_REMOTE': '1', 21:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:17:59 INFO - 'NO_EM_RESTART': '1', 21:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:17:59 INFO - 'PWD': '/builds/slave/test', 21:17:59 INFO - 'SHELL': '/bin/bash', 21:17:59 INFO - 'SHLVL': '1', 21:17:59 INFO - 'TERM': 'linux', 21:17:59 INFO - 'TMOUT': '86400', 21:17:59 INFO - 'USER': 'cltbld', 21:17:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:17:59 INFO - '_': '/tools/buildbot/bin/python'} 21:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:00 INFO - Downloading/unpacking jsonschema==2.5.1 21:18:00 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 21:18:00 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 21:18:00 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 21:18:00 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 21:18:00 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 21:18:00 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 21:18:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:18:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:18:02 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 21:18:02 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 21:18:02 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 21:18:02 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 21:18:02 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 21:18:02 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 21:18:02 INFO - Downloading functools32-3.2.3-2.tar.gz 21:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:18:02 INFO - warning: no files found matching '*.txt' 21:18:02 INFO - no previously-included directories found matching 'build' 21:18:02 INFO - no previously-included directories found matching 'dist' 21:18:02 INFO - no previously-included directories found matching '.git*' 21:18:02 INFO - Installing collected packages: jsonschema, functools32 21:18:02 INFO - Running setup.py install for functools32 21:18:02 INFO - warning: no files found matching '*.txt' 21:18:02 INFO - no previously-included directories found matching 'build' 21:18:02 INFO - no previously-included directories found matching 'dist' 21:18:02 INFO - no previously-included directories found matching '.git*' 21:18:02 INFO - Successfully installed jsonschema functools32 21:18:02 INFO - Cleaning up... 21:18:02 INFO - Return code: 0 21:18:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2712400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, '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': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', '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 21:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:18:02 INFO - Using env: {'DISPLAY': ':0', 21:18:02 INFO - 'HOME': '/home/cltbld', 21:18:02 INFO - 'LANG': 'en_US.UTF-8', 21:18:02 INFO - 'LANGUAGE': 'en_US:en', 21:18:02 INFO - 'LOGNAME': 'cltbld', 21:18:02 INFO - 'MAIL': '/var/mail/cltbld', 21:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:02 INFO - 'MOZ_NO_REMOTE': '1', 21:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:02 INFO - 'NO_EM_RESTART': '1', 21:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:02 INFO - 'PWD': '/builds/slave/test', 21:18:02 INFO - 'SHELL': '/bin/bash', 21:18:02 INFO - 'SHLVL': '1', 21:18:02 INFO - 'TERM': 'linux', 21:18:02 INFO - 'TMOUT': '86400', 21:18:02 INFO - 'USER': 'cltbld', 21:18:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:02 INFO - '_': '/tools/buildbot/bin/python'} 21:18:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:18:02 INFO - Cleaning up... 21:18:02 INFO - Return code: 0 21:18:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2712400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, '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': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', '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 21:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:18:02 INFO - Using env: {'DISPLAY': ':0', 21:18:02 INFO - 'HOME': '/home/cltbld', 21:18:02 INFO - 'LANG': 'en_US.UTF-8', 21:18:02 INFO - 'LANGUAGE': 'en_US:en', 21:18:02 INFO - 'LOGNAME': 'cltbld', 21:18:02 INFO - 'MAIL': '/var/mail/cltbld', 21:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:02 INFO - 'MOZ_NO_REMOTE': '1', 21:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:02 INFO - 'NO_EM_RESTART': '1', 21:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:02 INFO - 'PWD': '/builds/slave/test', 21:18:02 INFO - 'SHELL': '/bin/bash', 21:18:02 INFO - 'SHLVL': '1', 21:18:02 INFO - 'TERM': 'linux', 21:18:02 INFO - 'TMOUT': '86400', 21:18:02 INFO - 'USER': 'cltbld', 21:18:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:02 INFO - '_': '/tools/buildbot/bin/python'} 21:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:03 INFO - Downloading/unpacking blobuploader==1.2.4 21:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:04 INFO - Downloading blobuploader-1.2.4.tar.gz 21:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:18:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:18:04 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 21:18:04 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 21:18:04 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 21:18:04 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 21:18:04 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 21:18:04 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 21:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:18:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:18:05 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 21:18:05 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 21:18:05 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 21:18:05 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 21:18:05 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 21:18:05 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 21:18:05 INFO - Downloading docopt-0.6.1.tar.gz 21:18:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:18:05 INFO - Installing collected packages: blobuploader, requests, docopt 21:18:05 INFO - Running setup.py install for blobuploader 21:18:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:18:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:18:05 INFO - Running setup.py install for requests 21:18:06 INFO - Running setup.py install for docopt 21:18:06 INFO - Successfully installed blobuploader requests docopt 21:18:06 INFO - Cleaning up... 21:18:06 INFO - Return code: 0 21:18:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18:06 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')]} 21:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:06 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')]} 21:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:06 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 0x24e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2712400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, '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': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', '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 21:18:06 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 21:18:06 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 21:18:06 INFO - Using env: {'DISPLAY': ':0', 21:18:06 INFO - 'HOME': '/home/cltbld', 21:18:06 INFO - 'LANG': 'en_US.UTF-8', 21:18:06 INFO - 'LANGUAGE': 'en_US:en', 21:18:06 INFO - 'LOGNAME': 'cltbld', 21:18:06 INFO - 'MAIL': '/var/mail/cltbld', 21:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:06 INFO - 'MOZ_NO_REMOTE': '1', 21:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:06 INFO - 'NO_EM_RESTART': '1', 21:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:06 INFO - 'PWD': '/builds/slave/test', 21:18:06 INFO - 'SHELL': '/bin/bash', 21:18:06 INFO - 'SHLVL': '1', 21:18:06 INFO - 'TERM': 'linux', 21:18:06 INFO - 'TMOUT': '86400', 21:18:06 INFO - 'USER': 'cltbld', 21:18:06 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:06 INFO - '_': '/tools/buildbot/bin/python'} 21:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:18:06 INFO - Running setup.py (path:/tmp/pip-7ORhdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:18:06 INFO - Running setup.py (path:/tmp/pip-Zzpfoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:18:06 INFO - Running setup.py (path:/tmp/pip-9OYr7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:18:06 INFO - Running setup.py (path:/tmp/pip-5eOYWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:18:06 INFO - Running setup.py (path:/tmp/pip-8htwZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:18:06 INFO - Running setup.py (path:/tmp/pip-FC_4wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:18:06 INFO - Running setup.py (path:/tmp/pip-YZiYBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:18:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:18:06 INFO - Running setup.py (path:/tmp/pip-Auu9UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:18:07 INFO - Running setup.py (path:/tmp/pip-IoXc3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:18:07 INFO - Running setup.py (path:/tmp/pip-A1m901-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:18:07 INFO - Running setup.py (path:/tmp/pip-qPUy2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:18:07 INFO - Running setup.py (path:/tmp/pip-Egqmgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:18:07 INFO - Running setup.py (path:/tmp/pip-_6VA92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:18:07 INFO - Running setup.py (path:/tmp/pip-rzQUbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:07 INFO - Running setup.py (path:/tmp/pip-XPgNAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:18:07 INFO - Running setup.py (path:/tmp/pip-qDajWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:18:07 INFO - Running setup.py (path:/tmp/pip-T2peZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:18:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:18:07 INFO - Running setup.py install for manifestparser 21:18:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:18:07 INFO - Running setup.py install for mozcrash 21:18:07 INFO - Running setup.py install for mozdebug 21:18:07 INFO - Running setup.py install for mozdevice 21:18:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:18:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:18:08 INFO - Running setup.py install for mozfile 21:18:08 INFO - Running setup.py install for mozhttpd 21:18:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:18:08 INFO - Running setup.py install for mozinfo 21:18:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:18:08 INFO - Running setup.py install for mozInstall 21:18:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:18:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:18:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:18:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:18:08 INFO - Running setup.py install for mozleak 21:18:08 INFO - Running setup.py install for mozlog 21:18:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:18:08 INFO - Running setup.py install for moznetwork 21:18:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:18:08 INFO - Running setup.py install for mozprocess 21:18:08 INFO - Running setup.py install for mozprofile 21:18:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:18:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:18:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:18:09 INFO - Running setup.py install for mozrunner 21:18:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:18:09 INFO - Running setup.py install for mozscreenshot 21:18:09 INFO - Running setup.py install for moztest 21:18:09 INFO - Running setup.py install for mozversion 21:18:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:18:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:18:09 INFO - Cleaning up... 21:18:09 INFO - Return code: 0 21:18:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:09 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 0x24e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2712400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, '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': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', '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 21:18:09 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 21:18:09 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 21:18:09 INFO - Using env: {'DISPLAY': ':0', 21:18:09 INFO - 'HOME': '/home/cltbld', 21:18:09 INFO - 'LANG': 'en_US.UTF-8', 21:18:09 INFO - 'LANGUAGE': 'en_US:en', 21:18:09 INFO - 'LOGNAME': 'cltbld', 21:18:09 INFO - 'MAIL': '/var/mail/cltbld', 21:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:09 INFO - 'MOZ_NO_REMOTE': '1', 21:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:09 INFO - 'NO_EM_RESTART': '1', 21:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:09 INFO - 'PWD': '/builds/slave/test', 21:18:09 INFO - 'SHELL': '/bin/bash', 21:18:09 INFO - 'SHLVL': '1', 21:18:09 INFO - 'TERM': 'linux', 21:18:09 INFO - 'TMOUT': '86400', 21:18:09 INFO - 'USER': 'cltbld', 21:18:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:09 INFO - '_': '/tools/buildbot/bin/python'} 21:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:18:09 INFO - Running setup.py (path:/tmp/pip-ETGE1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:18:09 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)) 21:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:18:09 INFO - Running setup.py (path:/tmp/pip-hLpoG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:18:09 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)) 21:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:18:09 INFO - Running setup.py (path:/tmp/pip-q6AA_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:18:09 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)) 21:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:18:09 INFO - Running setup.py (path:/tmp/pip-GA5zSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:18:09 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)) 21:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:18:09 INFO - Running setup.py (path:/tmp/pip-_pWdad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:18:10 INFO - Running setup.py (path:/tmp/pip-FpfEV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:18:10 INFO - Running setup.py (path:/tmp/pip-Jvg7xW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:18:10 INFO - Running setup.py (path:/tmp/pip-mJxa1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:18:10 INFO - Running setup.py (path:/tmp/pip-Qm770j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:18:10 INFO - Running setup.py (path:/tmp/pip-JkUalO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:18:10 INFO - Running setup.py (path:/tmp/pip-_OIOfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:18:10 INFO - Running setup.py (path:/tmp/pip-maZSHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:18:10 INFO - Running setup.py (path:/tmp/pip-Z4ODq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:18:10 INFO - Running setup.py (path:/tmp/pip-NdWl8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:10 INFO - Running setup.py (path:/tmp/pip-dbSsxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:18:10 INFO - Running setup.py (path:/tmp/pip-c1xNVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:18:10 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)) 21:18:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:18:10 INFO - Running setup.py (path:/tmp/pip-DVCybY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:18:10 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)) 21:18:10 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)) 21:18:10 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)) 21:18:10 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)) 21:18:10 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)) 21:18:10 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)) 21:18:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:18:12 INFO - Downloading blessings-1.6.tar.gz 21:18:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:18:12 INFO - Installing collected packages: blessings 21:18:12 INFO - Running setup.py install for blessings 21:18:13 INFO - Successfully installed blessings 21:18:13 INFO - Cleaning up... 21:18:13 INFO - Return code: 0 21:18:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:18:13 INFO - Reading from file tmpfile_stdout 21:18:13 INFO - Current package versions: 21:18:13 INFO - argparse == 1.2.1 21:18:13 INFO - blessings == 1.6 21:18:13 INFO - blobuploader == 1.2.4 21:18:13 INFO - docopt == 0.6.1 21:18:13 INFO - functools32 == 3.2.3-2 21:18:13 INFO - jsonschema == 2.5.1 21:18:13 INFO - manifestparser == 1.1 21:18:13 INFO - mozInstall == 1.12 21:18:13 INFO - mozcrash == 0.17 21:18:13 INFO - mozdebug == 0.1 21:18:13 INFO - mozdevice == 0.48 21:18:13 INFO - mozfile == 1.2 21:18:13 INFO - mozhttpd == 0.7 21:18:13 INFO - mozinfo == 0.9 21:18:13 INFO - mozleak == 0.1 21:18:13 INFO - mozlog == 3.3 21:18:13 INFO - moznetwork == 0.27 21:18:13 INFO - mozprocess == 0.23 21:18:13 INFO - mozprofile == 0.28 21:18:13 INFO - mozrunner == 6.12 21:18:13 INFO - mozscreenshot == 0.1 21:18:13 INFO - mozsystemmonitor == 0.3 21:18:13 INFO - moztest == 0.7 21:18:13 INFO - mozversion == 1.4 21:18:13 INFO - psutil == 3.1.1 21:18:13 INFO - requests == 1.2.3 21:18:13 INFO - wsgiref == 0.1.2 21:18:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:18: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')]} 21:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18: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')]} 21:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:13 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 0x24e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2712400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, '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': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', '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 21:18:13 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 21:18:13 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 21:18:13 INFO - Using env: {'DISPLAY': ':0', 21:18:13 INFO - 'HOME': '/home/cltbld', 21:18:13 INFO - 'LANG': 'en_US.UTF-8', 21:18:13 INFO - 'LANGUAGE': 'en_US:en', 21:18:13 INFO - 'LOGNAME': 'cltbld', 21:18:13 INFO - 'MAIL': '/var/mail/cltbld', 21:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:13 INFO - 'MOZ_NO_REMOTE': '1', 21:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:13 INFO - 'NO_EM_RESTART': '1', 21:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:13 INFO - 'PWD': '/builds/slave/test', 21:18:13 INFO - 'SHELL': '/bin/bash', 21:18:13 INFO - 'SHLVL': '1', 21:18:13 INFO - 'TERM': 'linux', 21:18:13 INFO - 'TMOUT': '86400', 21:18:13 INFO - 'USER': 'cltbld', 21:18:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:13 INFO - '_': '/tools/buildbot/bin/python'} 21:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:13 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)) 21:18:13 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)) 21:18:13 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)) 21:18:13 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)) 21:18:13 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)) 21:18:13 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)) 21:18:13 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)) 21:18:13 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)) 21:18:13 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)) 21:18:13 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)) 21:18:13 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)) 21:18:13 INFO - Cleaning up... 21:18:13 INFO - Return code: 0 21:18:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:18: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')]} 21:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18: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')]} 21:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:18:13 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 0x24e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2712400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, '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': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', '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 21:18:13 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 21:18:13 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 21:18:13 INFO - Using env: {'DISPLAY': ':0', 21:18:13 INFO - 'HOME': '/home/cltbld', 21:18:13 INFO - 'LANG': 'en_US.UTF-8', 21:18:13 INFO - 'LANGUAGE': 'en_US:en', 21:18:13 INFO - 'LOGNAME': 'cltbld', 21:18:13 INFO - 'MAIL': '/var/mail/cltbld', 21:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:13 INFO - 'MOZ_NO_REMOTE': '1', 21:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:13 INFO - 'NO_EM_RESTART': '1', 21:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:13 INFO - 'PWD': '/builds/slave/test', 21:18:13 INFO - 'SHELL': '/bin/bash', 21:18:13 INFO - 'SHLVL': '1', 21:18:13 INFO - 'TERM': 'linux', 21:18:13 INFO - 'TMOUT': '86400', 21:18:13 INFO - 'USER': 'cltbld', 21:18:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:13 INFO - '_': '/tools/buildbot/bin/python'} 21:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:18:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:18:13 INFO - Cleaning up... 21:18:13 INFO - Return code: 0 21:18:13 INFO - Running post-action listener: _resource_record_post_action 21:18:13 INFO - Running post-action listener: _start_resource_monitoring 21:18:13 INFO - Starting resource monitoring. 21:18:13 INFO - [mozharness: 2016-09-09 04:18:13.755883Z] Finished create-virtualenv step (success) 21:18:13 INFO - [mozharness: 2016-09-09 04:18:13.756320Z] Running install step. 21:18:13 INFO - Running pre-action listener: _resource_record_pre_action 21:18:13 INFO - Running main action method: install 21:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:18:13 INFO - Reading from file tmpfile_stdout 21:18:13 INFO - Detecting whether we're running mozinstall >=1.0... 21:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:18:14 INFO - Reading from file tmpfile_stdout 21:18:14 INFO - Output received: 21:18:14 INFO - Usage: mozinstall [options] installer 21:18:14 INFO - Options: 21:18:14 INFO - -h, --help show this help message and exit 21:18:14 INFO - -d DEST, --destination=DEST 21:18:14 INFO - Directory to install application into. [default: 21:18:14 INFO - "/builds/slave/test"] 21:18:14 INFO - --app=APP Application being installed. [default: firefox] 21:18:14 INFO - mkdir: /builds/slave/test/build/application 21:18:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:18:30 INFO - Reading from file tmpfile_stdout 21:18:30 INFO - Output received: 21:18:30 INFO - /builds/slave/test/build/application/firefox/firefox 21:18:30 INFO - Running post-action listener: _resource_record_post_action 21:18:30 INFO - [mozharness: 2016-09-09 04:18:30.425516Z] Finished install step (success) 21:18:30 INFO - [mozharness: 2016-09-09 04:18:30.425793Z] Running run-tests step. 21:18:30 INFO - Running pre-action listener: _resource_record_pre_action 21:18:30 INFO - Running main action method: run_tests 21:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:18:30 INFO - Python 2.7.3 21:18:30 INFO - Return code: 0 21:18:30 INFO - grabbing minidump binary from tooltool 21:18: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')]} 21:18:30 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 0x27a1570>, '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 0x27a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a2900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:18:30 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 21:18:30 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 21:18:30 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 21:18:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:18:30 INFO - Return code: 0 21:18:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:18:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:18:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:18:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:18:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:18:30 INFO - Using env: {'DISPLAY': ':0', 21:18:30 INFO - 'HOME': '/home/cltbld', 21:18:30 INFO - 'LANG': 'en_US.UTF-8', 21:18:30 INFO - 'LANGUAGE': 'en_US:en', 21:18:30 INFO - 'LOGNAME': 'cltbld', 21:18:30 INFO - 'MAIL': '/var/mail/cltbld', 21:18:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:18:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:18:30 INFO - 'MOZ_NO_REMOTE': '1', 21:18:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:18:30 INFO - 'NO_EM_RESTART': '1', 21:18:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:18:30 INFO - 'PWD': '/builds/slave/test', 21:18:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:18:30 INFO - 'SHELL': '/bin/bash', 21:18:30 INFO - 'SHLVL': '1', 21:18:30 INFO - 'TERM': 'linux', 21:18:30 INFO - 'TMOUT': '86400', 21:18:30 INFO - 'USER': 'cltbld', 21:18:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860', 21:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:18:30 INFO - '_': '/tools/buildbot/bin/python'} 21:18:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:18:30 INFO - mozversion application_buildid: 20160908182520 21:18:30 INFO - mozversion application_changeset: 6cd56350a8953b0161a40064f0b332fbc93c6cb1 21:18:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:18:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:18:30 INFO - mozversion application_name: Firefox 21:18:30 INFO - mozversion application_remotingname: firefox-dev 21:18:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:18:30 INFO - mozversion application_vendor: Mozilla 21:18:30 INFO - mozversion application_version: 50.0a2 21:18:30 INFO - mozversion platform_buildid: 20160908182520 21:18:30 INFO - mozversion platform_changeset: 6cd56350a8953b0161a40064f0b332fbc93c6cb1 21:18:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:18:30 INFO - mozversion platform_version: 50.0a2 21:18:30 INFO - using testdate: 1473394710 21:18:30 INFO - actual date: 1473394710 21:18:30 INFO - starting webserver on 'localhost:53540' 21:18:30 INFO - SUITE-START | Running 2 tests 21:18:30 INFO - TEST-START | dromaeo_css 21:18:30 INFO - operating with platform_type : linux_ 21:18:30 INFO - Initialising browser for dromaeo_css test... 21:18:30 INFO - TEST-INFO | started process 10860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZsDzSF/profile http://localhost:53540/getInfo.html) 21:18:36 INFO - PROCESS | 10860 | __metrics Screen width/height:1600/1200 21:18:36 INFO - PROCESS | 10860 | colorDepth:24 21:18:36 INFO - PROCESS | 10860 | Browser inner width/height: 1024/697 21:18:36 INFO - PROCESS | 10860 | __metrics 21:18:37 ERROR - PROCESS | 10860 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:18:37 INFO - TEST-INFO | 10860: exit 0 21:18:37 INFO - Browser initialized. 21:18:37 INFO - Running cycle 1/1 for dromaeo_css test... 21:18:37 INFO - TEST-INFO | started process 10989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZsDzSF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:18:49 INFO - PROCESS | 10989 | RSS: Main: 153497600 21:18:49 INFO - PROCESS | 10989 | 21:19:39 INFO - PROCESS | 10989 | 1473394779339 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] 21:21:47 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:53540/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53540/tests/dromaeo/cssquery-ext.html) 21:21:48 INFO - PROCESS | 10989 | RSS: Main: 160215040 21:21:48 INFO - PROCESS | 10989 | 21:24:50 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:53540/tests/dromaeo/cssquery-ext.html (next: http://localhost:53540/tests/dromaeo/cssquery-jquery.html) 21:24:51 INFO - PROCESS | 10989 | RSS: Main: 156184576 21:24:51 INFO - PROCESS | 10989 | 21:27:53 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:53540/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53540/tests/dromaeo/cssquery-mootools.html) 21:27:53 INFO - PROCESS | 10989 | RSS: Main: 156323840 21:27:53 INFO - PROCESS | 10989 | 21:30:55 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:53540/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53540/tests/dromaeo/cssquery-prototype.html) 21:30:56 INFO - PROCESS | 10989 | RSS: Main: 155430912 21:30:56 INFO - PROCESS | 10989 | 21:33:58 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:53540/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53540/tests/dromaeo/cssquery-yui.html) 21:33:59 INFO - PROCESS | 10989 | RSS: Main: 157470720 21:33:59 INFO - PROCESS | 10989 | 21:37:01 INFO - PROCESS | 10989 | Cycle 1(1): loaded http://localhost:53540/tests/dromaeo/cssquery-yui.html (next: http://localhost:53540/tests/dromaeo/cssquery-dojo.html) 21:37:01 INFO - PROCESS | 10989 | RSS: Main: 158494720 21:37:01 INFO - PROCESS | 10989 | 21:37:01 INFO - PROCESS | 10989 | __start_tp_report 21:37:01 INFO - PROCESS | 10989 | _x_x_mozilla_page_load 21:37:01 INFO - PROCESS | 10989 | _x_x_mozilla_page_load_details 21:37:01 INFO - PROCESS | 10989 | |i|pagename|runs| 21:37:01 INFO - PROCESS | 10989 | |0;dojo.html;3210.7591930605204;3247.545343651888;3248.0255923223026;3250.398676244894;3275.492298693703;5594.440555944404;5688.857778555533;5694.202811606378;5701.657900525971;5702.714864256791;5710.1434784782305;5712.600117991742;5749.396313387087;5751.223584816049;5768.826935191941;5170.276161337425;5255.789768409278;5267.947320526803;5326.866828329284;5338.786448542073;5116.539511443969;5124.333836601237;5164.974175129119;5171.198464238049;5237.423883372826;5224.399194092671;5234.502722241381;5284.101702710529;5324.068288049576;5345.946540534604;5308.124159513675;5333.493318134771;5333.946660533384;5337.919931201035;5346.064438723208;5010.498950104997;5010.649254552182;5215.243789650517;5230.006298803215;5304.310439642861;5511.338639363302;5557.38868724444;5563.054280772238;5587.217789509472;5627.465390787909;5952.642841429528;5954.5534084943365;5989.31122920861;6023.849403764897;6028.97507423739;5854.824355269348;5992.400759923973;6040.426159514839;6064.514838812928;6075.513958883279;5592.804251851207;5696.743646535916;5698.572607054529;5709;5723.370429252779;6214.906776398358;6216.937830621727;6231.189945307081;6232.283287422005;6255.093011513305;5691.231683722727;5882.617629854046;5940.108983652401;5950.226470558886;5976.970115149396;5971.223740913653;6078.513718902477;6080.57435979486;6107.4197951194565;6108.786192483241;5985;6036.486898613579;6039.5470339723815;6044.667543285162;6062.545309101835;5767.9134812977;5793.884122317614;5996.010658241428;6046.183765191643;6047.576669633171;4510.774461276923;4534.59188673021;4550.112728018071;4555.453345598483;4583.816647334069;4048.2713111640187;4063.4311196432523;4064.146529228836;4066.532348779869;4077.388391741203;5594.552435805126;5684.715764211773;5692.402297758758;5705.62913410627;5719.628224165416;6074.51403887688;6147.231596050494;6164.660943648142;6170.043643235305;6171.660558669317;5810.82567522975;5848.2689663792025;5855.677937713466;5886.058230683156;5893.499052580493;5128.9230661540105;5161.329027226437;5233.4243233244315;5278.049951008778;5283.630145889751;6131.315499379051;6310.242770867525;6314.336994615591;6317.557770955989;6321.810345689637;6063.454289114001;6073.787417440369;6074.42292982166;6079.240094988127;6090.847728806815;6101.6644084574;6186.226721659793;6267.96866015667;6274.937250627435;6283.71723272463;5930.644161350333;6039.48664363534;6041.75832966694;6046.57673962836;6074.088886667036;6113.5414843886;6117.082437634391;6129.693515324305;6130.846728831815;6142.2629284484365;5835.358110607915;5836.620619659709;5959.523238140851;5995.820125396245;6010.819675409744;5922.378150294157;6014.36849130835;6024.849378765391;6035.698215089315;6066.241719785027;5955.344912059757;5987.64074155552;6000.339962604197;6004.489618382487;6006.669633170218;5894.970525147347;5913.497352724895;6002.0996850472775;6045.667488288186;6045.727942242522;5748.109043098327;5844.970775146097;5849.3858144894175;5853.385394533512;5899.292084949833 21:37:01 INFO - PROCESS | 10989 | |1;ext.html;589.4547543522241;638.2628064585406;645.8643684826186;666.7266420767486;692.7471472912389;44999;45753.31370029444;46014.53985460144;46197.76901115494;46340.3048954266;47194.76402617982;47720.52279477204;47741.76129119349;48113.278300825514;48125;9041.141091596288;9177.265818734519;9177.816443671123;9192.402493837879;9217.446953182796;9141.908580914205;9154.130357616015;9214.76963075925;9216.30877684173;9272.953635231814;9257;9270.119338662817;9334;9362.344635875492;9378.390404623711;9177.908220917772;9226.077392260788;9265.583048762788;9271.397359171633;9299.72100836976;9205.447673139633;9210;9213.355065145442;9263.166315031613;9269.629214831399;43887.78056109731;44057.339139912925;44190.11619767587;44241.77879110584;44291.77854110709;4094.9385759213637;4187.874363769091;4389.561043895616;4420.381146639473;4626.884327891796;34790.30419391598;35071.1232219194;35149.648503514894;35247;35322.823385883166;4754.286856971447;4831.178699621073;4850.878728031827;4867.902641947177;4935.925961110586;362724;363939;365227;365282;367479;64347.35652643508;64878.35121648723;65146;65222.673886631215;65284.673576631816;39337.60662393396;39828.20343593112;40011.59988400079;66727.33272667308;66967.66516167388;18712.906435467736;18816.341428049953;18888.90555547241;18901.43295701131;18908.905455472635;14207;14215.715685686228;14297.999140060305;14310.713785724227;14373.85626143746;21466.677999830015;21487.140514379564;21520.139194432046;21634.24280150187;21789.34631961044;7564.357029652431;7608.695652173851;7751.534907905431;7779.649915753805;8048.436609437284;1018.9286749927583;1035.5495359518634;1130.6890605083668;1155.4569352404355;1165.5454372794618;34438.48342274868;34455.65544344574;34772.130696732784;34955.650443495746;35354;1132.247055707945;1143.9313641181557;1155.9711007224719;1190.4761904761876;1191.434068817305;17991.370302039366;18262.634747305245;18301.816981830278;18545.629087418176;18736;595465;598115;598734;601042;606557;65534.672326638065;65624;65848.67075664687;66000.33999659942;66147.33852661411;1424.900256982022;1432.0834665813888;1463.3561233057421;1470.1105830972322;1478.2091581004327;32004;33717.15707107244;34201.31597368088;34259.14352141217;34467;50975.49024509708;51015.74492127515;51149.488505114474;57700.42299577119;57827;494402;495491;498232;498436;499333;31983.36033279275;32054.679453206103;32371.838140809145;32955;33994;53786.46213537971;54087.45912540982;54222;54453;55201;45002;45558;45613.54386456093;47226.29160562663;47347.28979065248;44684.32973505335;45314.32028519509;46301.76849115733;46703.29945050895;46939.295910562054;38205.42691859569;43296;43961.858073773146;44465.777671111435;44800.32799508075;38978.22043559056;39812.2037559253;39878.60121398749;40124.398134027426;41333.79333103315;30092.849535752182;30204.395912082076;30514.389712206077;30844.691553084183;31007 21:37:01 INFO - PROCESS | 10989 | |2;jquery.html;401.7991004497749;405.7502891095426;414.36188270064105;423.32268370607034;434.27042568484933;19450.610987780237;20553.691694624573;20810.855402952868;20863.791362086373;21295.36113916583;19856.801431985677;20010;20066.49833754157;20301.593968120666;20515.897420512876;5957.970210148943;6133.815985520441;6184.07238914162;6185.948388773919;6188.504919606443;5480.671159730409;5678.43215678433;5695.829125126253;6068.939310606882;6113.113598528211;5674.659520428767;5792;5793.536517078624;5810.709464526778;5910.67491287979;5857.794977175799;5908.645481271137;6217.782377616762;6364.459020983222;6372.681365931685;6113.419225173601;6122.112293717386;6136.662483563402;6154.8769024619705;6160.630362178239;14949.70100597982;14986.925065374713;15088.849111508855;19810.00949952511;23810.047598096055;2583.7287084856193;2689.704132545438;2774.140016594862;2900.8259504429802;2910.9126726198247;10587;10656.680299590947;10683.519241634145;10867.67396978084;11185.328880267129;2033.5119571302928;2036.1384812312072;2046.9897650511653;2091.5084955035554;2168.9891550542147;83040.58479707623;84005.57997210036;84497;85357;87929.56035219847;11093.168012399103;11187.664370068911;11201.71995700114;11261.155413344031;11414.201005929672;16093.678126437406;16111.113888735998;16124.596885077732;16131.354745810037;16166.919165404333;8288.419810613199;8370.497770133812;8428.4942903426;8612.913870861337;8649.308055355556;7396.223396543393;7451.366633836076;7503;7550.962245188739;7665.770026899202;4788.281757736298;4808.951910480921;4854.199057155601;4932.136876046749;5021.472745361758;1917.3481016454193;1998.150785916009;2000.7499062617173;2030.2285131649878;2046.1610739596993;988.3476905242505;1009.4498498318434;1047.6537649120844;1072.5602502973743;1097.8517900083546;20607;20790.58418831645;21120.894395527925;21150.259740908994;21161.470963225736;1027.5581499954942;1100.510272928539;1106.9280496767685;1121.3328069798456;1181.3443538835857;11597.710057248636;11709.355985420883;11818.881811181778;11819.822702659467;11863.288202707865;503887;506073;507256;508454;514596;88159.55920220487;91876.54061729649;93229.53385233166;93507.53246233726;95154;1046.7069220618087;1079.9190060745475;1089.9455027248605;1090.7709381030072;1099.9010089092021;17905.910470447565;18088.819111808712;18517.90741046286;18535.07324633736;18645.720314195027;42089.78955105205;43406.78296608497;43806.34290485582;43864;43977.12045759131;60869.47826304378;61494.385056148865;61775.38224617696;61997;63100;8942.329325300498;9028.954855225682;9033;9067.319951003568;9186.954065229898;11345.432728363714;13948.302584870513;14038.438462461796;14257.857421426068;14331.35508902081;11937;12137.575184868487;12261.75476490483;12403.875961240634;12434.37828108609;11808.822867657163;12059.095567832272;12188.939055304667;12287.69280767988;12533.623991280276;12198.634040978784;12364;12490.750184996068;12676.23942563449;12704.745905081661;8802.163794439519;8868.822623547621;8911.420757650732;8970.596323165342;9368.718938431857;9528.475933823429;12143.210691305037;12166.209196402206;12166.878331216574;12172.2696638202 21:37:01 INFO - PROCESS | 10989 | |3;mootools.html;1528.182422404014;1551.7206902757507;1695.3133980737798;1822.0616382562982;1859.3956963986707;8429.283510901565;8924.375293729441;8956.10438956104;9603.855942160873;9661;8912.688055918044;9274.026227246142;9288.489133097677;9311.674091406801;9335.43987360759;2345.8475199112045;2406.4826062396583;2406.783389494945;2410.9035638574437;2414.7343792182933;2357.57563638545;2373.8931748071377;2377.3818807110188;2396.808255339569;2404;2383.7139543254834;2392.521495700858;2398.70016247969;2414.33605758417;2425.757424257578;2293.334932869466;2308.0652335803943;2308.803751681109;2312.6068568343253;2350.21267875262;2268.2854900706225;2279.076973825603;2292.2435596253363;2309.445733024079;2311.0755697721047;9543.761405964837;9632.084951929555;9659.565319560566;9676.419414835133;9723.902760972442;5425.131978883399;5530.723463826793;5537.252470916415;5545.417731138213;5545.473180047929;3435.5018522314376;3520.823958802075;3540.522029526007;3543.061088811467;3574.2136729919375;1221.6335099470123;1236.6661001529537;1238.2941723217768;1252.2674235572201;1256.0265794009624;12840.61478155657;12845.614631561068;12850.35748212595;12899.03257255719;12922.224666520038;4684.476929390821;4743.83396581118;4805.990741944231;4878.292647566083;4880.243562247857;10841.620543280947;10852.457377131112;10935.945320273348;10946.507407166537;10961.451927403758;5492.038893193675;5513.117901135799;5514.6139770216505;5563.415841336601;5564.10974244119;4545.318202269686;5113.565346945476;5188.584913206934;5306.151015837448;5325.4674532547215;4296.2481565725875;4360.345948107746;4396.560343965642;4407.316865885793;4423.712458690175;1370.2463644995212;1373.3957058894055;1376.2705765944065;1382.7718426459521;1398.1960372785688;934.6495064350869;1038.408107378802;1049.3494033699155;1055.4933631856752;1064.7551063255494;6387.457066149336;6629.1382120325015;6673;6723.5293529452465;6849.417799487;1025.4616326428536;1031.783325501638;1057.9735506612396;1089.487940667885;1107.4241394474827;4454.665900057508;4470.932936005963;4497.302918047708;4574.382458368144;4575.359449677047;11111.611093611846;11724.765504690029;11892.524299027942;11978.64064078079;12062.215955962834;11470.827937580943;11861.703457413461;11879.940600296943;11901.642950711492;11933.820992685116;8741.562921853882;8772.122787721177;8794.384393092421;8822.25010874083;8871.778205544784;6600.9009864851105;6682.63245521501;6722.764703235363;6830.7609233676585;6835.008923706134;10655.25413221067;10869.076128529163;11029.172812039289;11093;11104.833427498756;11019.779604407706;11074.889251107386;11194;11229.21395502307;11270.661880143281;7616.314531691953;8226.753197404087;8345.123762004901;8428.241458268785;8625.439346442712;9275.39709918853;9295.163435290857;9372.718818435458;9416.435013899189;9419.105185007413;8167.305779008851;8325.25072743456;8325.458845175044;8329.083800781787;8373.958130209554;8182.099969003286;8197.590120493833;8200.179982001751;8220.917790822254;8305.875411868949;7227.205007449072;7295.963520182365;7302.780916572511;7306.2693730626515;7324;5657.179708942263;5684.744186511534;5722.370539240764;5730.828075157752;5924.170616113662;5609.868250064949;5745.885082298247;5763.337216220189;5829.09649004405;5882.264716910387 21:37:01 INFO - PROCESS | 10989 | |4;prototype.html;348.91974845785467;348.9406800843857;348.9755717099803;351.195761705694;351.7889266440135;5810.215620891178;5877.941220587798;5905.379935106816;5909.970450147749;5926.436988486098;5763.5389168866495;5784.855378615537;5810.18657387965;5829.183914252008;5855.765769369231;4140.544540100586;4535.387722657432;4543.477500087482;4550.340200670901;4595.195840727876;4541.704789188709;4561.0649816787645;4566.858285428643;4581.244094724367;4592.402987611606;4476.529964353728;4505.594496495315;4556.521565235652;4561.6806823522365;4571.428571428572;4526.275795872644;4531.501534831183;4540.591346778806;4542.659300552472;4552.521985191574;4022.6178513041214;4026.6778657707605;4027.8590249341423;4052.3921411788174;4054.331035379159;5581.972090139523;5637.492625663669;5646.378898321182;5672;5728.052462162885;5208.609354298443;5224.387806096952;5227.712475813829;5228;5230.581553475713;6066.545009124334;6080.270367555878;6101.60339577926;6134.815955521297;6146.631202127886;4281.336392859112;4424.557544245549;4436.578525040116;4465.419495465569;4474.9776251118865;6301.180846489973;6321.431071203614;6359.014352775327;6367.745290188387;6411.326810684857;4539.614132798749;4581.381513495636;4584.266517357207;4595.40259766235;4595.931061034087;4510.323451482304;4546.363509108727;4551.203539380595;4638.234691275969;4658;5179.601507592929;5187.455317191716;5188.273641690166;5245.396779370421;5262.289590905179;6056.485878530368;6089.391060893964;6098.207233059763;6098.573099883054;6176.227971503562;1484.2356186563927;1551.5965848879148;1565.882558808094;1570;1582.8021497312836;978.2711879649706;990.2177279948904;993.2153598657125;1032.5198782565992;1062.8937106289309;5830.212921255661;5859.44335288147;5872.677002764804;5886.705664716747;5961.880762384728;6171.84570385744;6205.379462053758;6207.503399728011;6240;6293.3391993840905;5735.065346848611;5832.62087964281;5861.296644402699;5906.2912450505355;5916.881662366729;3265.853036613358;3307.8676852926096;3309.8179600122226;3323.9169020774675;3325.48454989477;6290.874182516324;6502.674866256668;6526.4452521536205;6555.115059467006;6604.537682362285;6405.718856228773;6472.514561407913;6504.837379065561;6513.837154071091;6546.541742078104;6345.460635846005;6533.379328963741;6646;6646.4713115983595;6671.266160722316;6326.398992095744;6332.430081292521;6339.239291284891;6387.489000879826;6448.96816509375;6146.5390095742105;6297.992321228581;6330.3669633036325;6347;6353.809385718436;6531.3468653134305;6571.5399922005;6582.670866456562;6605.405513503808;6627.7348906045145;4415.315626077963;4438.778061096997;4478.462584489882;4480.708753930984;4485.865424037284;6199;6344.30212676596;6357.90463143044;6422.563928298338;6480.416762491398;6239.812805615838;6272.6236425814595;6273.1844860167885;6281.3404592518955;6281.560290779602;6072.696365181635;6222.346653601307;6236.875262494816;6253.218347706536;6253.530985176039;5985.760569577168;6079.422454866781;6141.631502109888;6145.385461453998;6154.876902462015;6189.535784816247;6204.658743769136;6223.7325404163175;6267.686615669107;6277.403646653561;5883.882322353615;6037.879242415215;6066.636001839904;6071.848203794941;6138.263408391022 21:37:01 INFO - PROCESS | 10989 | |5;yui.html;829.2702421868754;868.409481552544;902.9413088149271;912.7216199059284;946.4368700623127;16621.83378166218;17966;18025.459236222934;18043.729344059833;18072.4578262652;16484.34062637493;16637.33450661972;16720.2475888585;17016;17289.39487117948;885.8095509465463;887.9822403551925;890.3322508118911;908.6819613135383;913.1507697841005;908.7500937242278;910.1262787723794;915.2083447817623;917.2936838634248;918.1231923513029;965.1313817564178;966.1884017425361;967.0377973915963;968.2254196642693;971.3589031239384;950.1970834644715;953.1374106433689;953.7329547726648;956.4261443134134;956.5647630328184;704.5596502186133;705.2559549675091;705.4039336760429;706.4666177036305;706.5266271598042;14687.55937321882;14741.631459213499;14786.778198327034;14842.480513181987;14908.552743417715;15037.849621503754;15073.698526029419;15300.158491282975;15619.453319133889;16602.418915338025;12338.938305308506;12700.555480558229;12726.554570590077;12801.039922005793;13221.272829994443;4082.6529744971713;4122.793860306972;4129.174165166979;4198.5591512891015;4271;94005;94499.52750236273;94729.99999999932;96607;96693.51653241689;11094.22340436178;12797.680057998625;13147.802782958262;13365.532206372925;13689.31553422325;25666;26223.082192123184;26585.20244392671;26938.191854244404;26999.865000674872;9548.140667339834;9927.106560409598;9994.950025249827;10151.847722284025;10288.537015834305;5147;5196.090684130262;5210.21846722987;5283.550898173698;5299.205119232146;3817.904552386157;3904;3910.8631197907935;3914.451976723261;3935.4687117239378;694.861027794433;695.7217113154778;699.3461113858457;703.3423748794893;706.3184027413467;725.0755287009106;754.901862757838;788.9467560806273;789.3172405868996;806.4838503357738;8943.5975381108;9343.439393636403;10268.33255838383;10347.327423717585;10405.375677459377;702.2415790945767;722.3931897206267;726.2954933714394;726.7892311229684;731.8316787138988;4588.128255631486;4891.437484689306;4892.158085026805;4907.950920490749;4936.506349365035;112331;133999.33000334937;134937.32531337478;139074;142800;65848.67075664591;100952.49523752334;108417;111309.44345278222;111502.44248778705;59415.70292148511;103705;104765;105820;106630.99999999844;9561.235101192027;9703.563339649592;9787.119159275699;9808.85286720714;9884.703458896245;40846.59153408547;41132.383014254214;48672;49975.00099996105;50471.49528504815;77565.2243477558;77708.92597823673;78338;81398.18601813907;82975;14074.155550666992;14163.858361416254;14289.71420571562;14878;15069.924650376677;14358.56924292273;14657.267136643339;14995.850041499445;15277.541673749362;15481.690366192839;13702.314884255547;13890.58328250154;14013;14744.483943061941;15333.539993800205;12746.426410811351;12986.610401687965;13051.21692698441;13128.934355328161;13324.133931294435;13524.526641567498;13553.704156662432;13910.234937078558;14219.146851188962;14370.568882933529;11207.551697931991;11476.655700329004;11811.586594469152;11839;12203.69490762738;11074.501647425725;11253.15601329887;11315.490802913724;11319.755885614017;11354.091672666002 21:37:01 INFO - PROCESS | 10989 | __end_tp_report 21:37:01 INFO - PROCESS | 10989 | __start_cc_report 21:37:01 INFO - PROCESS | 10989 | _x_x_mozilla_cycle_collect,330 21:37:01 INFO - PROCESS | 10989 | __end_cc_report 21:37:01 INFO - PROCESS | 10989 | __startTimestamp1473395821980__endTimestamp 21:37:01 INFO - PROCESS | 10989 | 21:37:01 INFO - PROCESS | 10989 | ------- Summary: start ------- 21:37:01 INFO - PROCESS | 10989 | Number of tests: 6 21:37:01 INFO - PROCESS | 10989 | 21:37:01 INFO - PROCESS | 10989 | [#0] dojo.html Cycles:165 Average:5644.22 Median:5855.68 stddev:647.42 (11.1%) stddev-sans-first:620.62 21:37:01 INFO - PROCESS | 10989 | Values: 3210.8 3247.5 3248.0 3250.4 3275.5 5594.4 5688.9 5694.2 5701.7 5702.7 5710.1 5712.6 5749.4 5751.2 5768.8 5170.3 5255.8 5267.9 5326.9 5338.8 5116.5 5124.3 5165.0 5171.2 5237.4 5224.4 5234.5 5284.1 5324.1 5345.9 5308.1 5333.5 5333.9 5337.9 5346.1 5010.5 5010.6 5215.2 5230.0 5304.3 5511.3 5557.4 5563.1 5587.2 5627.5 5952.6 5954.6 5989.3 6023.8 6029.0 5854.8 5992.4 6040.4 6064.5 6075.5 5592.8 5696.7 5698.6 5709.0 5723.4 6214.9 6216.9 6231.2 6232.3 6255.1 5691.2 5882.6 5940.1 5950.2 5977.0 5971.2 6078.5 6080.6 6107.4 6108.8 5985.0 6036.5 6039.5 6044.7 6062.5 5767.9 5793.9 5996.0 6046.2 6047.6 4510.8 4534.6 4550.1 4555.5 4583.8 4048.3 4063.4 4064.1 4066.5 4077.4 5594.6 5684.7 5692.4 5705.6 5719.6 6074.5 6147.2 6164.7 6170.0 6171.7 5810.8 5848.3 5855.7 5886.1 5893.5 5128.9 5161.3 5233.4 5278.0 5283.6 6131.3 6310.2 6314.3 6317.6 6321.8 6063.5 6073.8 6074.4 6079.2 6090.8 6101.7 6186.2 6268.0 6274.9 6283.7 5930.6 6039.5 6041.8 6046.6 6074.1 6113.5 6117.1 6129.7 6130.8 6142.3 5835.4 5836.6 5959.5 5995.8 6010.8 5922.4 6014.4 6024.8 6035.7 6066.2 5955.3 5987.6 6000.3 6004.5 6006.7 5895.0 5913.5 6002.1 6045.7 6045.7 5748.1 5845.0 5849.4 5853.4 5899.3 21:37:01 INFO - PROCESS | 10989 | 21:37:01 INFO - PROCESS | 10989 | [#1] ext.html Cycles:180 Average:65884.11 Median:45436.16 stddev:131890.95 (290.3%) stddev-sans-first:132169.83 21:37:02 INFO - PROCESS | 10989 | Values: 589.5 638.3 645.9 666.7 692.7 44999.0 45753.3 46014.5 46197.8 46340.3 47194.8 47720.5 47741.8 48113.3 48125.0 9041.1 9177.3 9177.8 9192.4 9217.4 9141.9 9154.1 9214.8 9216.3 9273.0 9257.0 9270.1 9334.0 9362.3 9378.4 9177.9 9226.1 9265.6 9271.4 9299.7 9205.4 9210.0 9213.4 9263.2 9269.6 43887.8 44057.3 44190.1 44241.8 44291.8 4094.9 4187.9 4389.6 4420.4 4626.9 34790.3 35071.1 35149.6 35247.0 35322.8 4754.3 4831.2 4850.9 4867.9 4935.9 362724.0 363939.0 365227.0 365282.0 367479.0 64347.4 64878.4 65146.0 65222.7 65284.7 39337.6 39828.2 40011.6 66727.3 66967.7 18712.9 18816.3 18888.9 18901.4 18908.9 14207.0 14215.7 14298.0 14310.7 14373.9 21466.7 21487.1 21520.1 21634.2 21789.3 7564.4 7608.7 7751.5 7779.6 8048.4 1018.9 1035.5 1130.7 1155.5 1165.5 34438.5 34455.7 34772.1 34955.7 35354.0 1132.2 1143.9 1156.0 1190.5 1191.4 17991.4 18262.6 18301.8 18545.6 18736.0 595465.0 598115.0 598734.0 601042.0 606557.0 65534.7 65624.0 65848.7 66000.3 66147.3 1424.9 1432.1 1463.4 1470.1 1478.2 32004.0 33717.2 34201.3 34259.1 34467.0 50975.5 51015.7 51149.5 57700.4 57827.0 494402.0 495491.0 498232.0 498436.0 499333.0 31983.4 32054.7 32371.8 32955.0 33994.0 53786.5 54087.5 54222.0 54453.0 55201.0 45002.0 45558.0 45613.5 47226.3 47347.3 44684.3 45314.3 46301.8 46703.3 46939.3 38205.4 43296.0 43961.9 44465.8 44800.3 38978.2 39812.2 39878.6 40124.4 41333.8 30092.8 30204.4 30514.4 30844.7 31007.0 21:37:02 INFO - PROCESS | 10989 | 21:37:02 INFO - PROCESS | 10989 | [#2] jquery.html Cycles:180 Average:29997.26 Median:11732.18 stddev:83745.70 (713.8%) stddev-sans-first:83951.14 21:37:02 INFO - PROCESS | 10989 | Values: 401.8 405.8 414.4 423.3 434.3 19450.6 20553.7 20810.9 20863.8 21295.4 19856.8 20010.0 20066.5 20301.6 20515.9 5958.0 6133.8 6184.1 6185.9 6188.5 5480.7 5678.4 5695.8 6068.9 6113.1 5674.7 5792.0 5793.5 5810.7 5910.7 5857.8 5908.6 6217.8 6364.5 6372.7 6113.4 6122.1 6136.7 6154.9 6160.6 14949.7 14986.9 15088.8 19810.0 23810.0 2583.7 2689.7 2774.1 2900.8 2910.9 10587.0 10656.7 10683.5 10867.7 11185.3 2033.5 2036.1 2047.0 2091.5 2169.0 83040.6 84005.6 84497.0 85357.0 87929.6 11093.2 11187.7 11201.7 11261.2 11414.2 16093.7 16111.1 16124.6 16131.4 16166.9 8288.4 8370.5 8428.5 8612.9 8649.3 7396.2 7451.4 7503.0 7551.0 7665.8 4788.3 4809.0 4854.2 4932.1 5021.5 1917.3 1998.2 2000.7 2030.2 2046.2 988.3 1009.4 1047.7 1072.6 1097.9 20607.0 20790.6 21120.9 21150.3 21161.5 1027.6 1100.5 1106.9 1121.3 1181.3 11597.7 11709.4 11818.9 11819.8 11863.3 503887.0 506073.0 507256.0 508454.0 514596.0 88159.6 91876.5 93229.5 93507.5 95154.0 1046.7 1079.9 1089.9 1090.8 1099.9 17905.9 18088.8 18517.9 18535.1 18645.7 42089.8 43406.8 43806.3 43864.0 43977.1 60869.5 61494.4 61775.4 61997.0 63100.0 8942.3 9029.0 9033.0 9067.3 9187.0 11345.4 13948.3 14038.4 14257.9 14331.4 11937.0 12137.6 12261.8 12403.9 12434.4 11808.8 12059.1 12188.9 12287.7 12533.6 12198.6 12364.0 12490.8 12676.2 12704.7 8802.2 8868.8 8911.4 8970.6 9368.7 9528.5 12143.2 12166.2 12166.9 12172.3 21:37:02 INFO - PROCESS | 10989 | 21:37:02 INFO - PROCESS | 10989 | [#3] mootools.html Cycles:180 Average:6225.06 Median:4484.12 stddev:3547.04 (79.1%) stddev-sans-first:3539.43 21:37:02 INFO - PROCESS | 10989 | Values: 1528.2 1551.7 1695.3 1822.1 1859.4 8429.3 8924.4 8956.1 9603.9 9661.0 8912.7 9274.0 9288.5 9311.7 9335.4 2345.8 2406.5 2406.8 2410.9 2414.7 2357.6 2373.9 2377.4 2396.8 2404.0 2383.7 2392.5 2398.7 2414.3 2425.8 2293.3 2308.1 2308.8 2312.6 2350.2 2268.3 2279.1 2292.2 2309.4 2311.1 9543.8 9632.1 9659.6 9676.4 9723.9 5425.1 5530.7 5537.3 5545.4 5545.5 3435.5 3520.8 3540.5 3543.1 3574.2 1221.6 1236.7 1238.3 1252.3 1256.0 12840.6 12845.6 12850.4 12899.0 12922.2 4684.5 4743.8 4806.0 4878.3 4880.2 10841.6 10852.5 10935.9 10946.5 10961.5 5492.0 5513.1 5514.6 5563.4 5564.1 4545.3 5113.6 5188.6 5306.2 5325.5 4296.2 4360.3 4396.6 4407.3 4423.7 1370.2 1373.4 1376.3 1382.8 1398.2 934.6 1038.4 1049.3 1055.5 1064.8 6387.5 6629.1 6673.0 6723.5 6849.4 1025.5 1031.8 1058.0 1089.5 1107.4 4454.7 4470.9 4497.3 4574.4 4575.4 11111.6 11724.8 11892.5 11978.6 12062.2 11470.8 11861.7 11879.9 11901.6 11933.8 8741.6 8772.1 8794.4 8822.3 8871.8 6600.9 6682.6 6722.8 6830.8 6835.0 10655.3 10869.1 11029.2 11093.0 11104.8 11019.8 11074.9 11194.0 11229.2 11270.7 7616.3 8226.8 8345.1 8428.2 8625.4 9275.4 9295.2 9372.7 9416.4 9419.1 8167.3 8325.3 8325.5 8329.1 8374.0 8182.1 8197.6 8200.2 8220.9 8305.9 7227.2 7296.0 7302.8 7306.3 7324.0 5657.2 5684.7 5722.4 5730.8 5924.2 5609.9 5745.9 5763.3 5829.1 5882.3 21:37:02 INFO - PROCESS | 10989 | 21:37:02 INFO - PROCESS | 10989 | [#4] prototype.html Cycles:180 Average:5186.67 Median:5885.29 stddev:1540.02 (26.2%) stddev-sans-first:1500.92 21:37:02 INFO - PROCESS | 10989 | Values: 348.9 348.9 349.0 351.2 351.8 5810.2 5877.9 5905.4 5910.0 5926.4 5763.5 5784.9 5810.2 5829.2 5855.8 4140.5 4535.4 4543.5 4550.3 4595.2 4541.7 4561.1 4566.9 4581.2 4592.4 4476.5 4505.6 4556.5 4561.7 4571.4 4526.3 4531.5 4540.6 4542.7 4552.5 4022.6 4026.7 4027.9 4052.4 4054.3 5582.0 5637.5 5646.4 5672.0 5728.1 5208.6 5224.4 5227.7 5228.0 5230.6 6066.5 6080.3 6101.6 6134.8 6146.6 4281.3 4424.6 4436.6 4465.4 4475.0 6301.2 6321.4 6359.0 6367.7 6411.3 4539.6 4581.4 4584.3 4595.4 4595.9 4510.3 4546.4 4551.2 4638.2 4658.0 5179.6 5187.5 5188.3 5245.4 5262.3 6056.5 6089.4 6098.2 6098.6 6176.2 1484.2 1551.6 1565.9 1570.0 1582.8 978.3 990.2 993.2 1032.5 1062.9 5830.2 5859.4 5872.7 5886.7 5961.9 6171.8 6205.4 6207.5 6240.0 6293.3 5735.1 5832.6 5861.3 5906.3 5916.9 3265.9 3307.9 3309.8 3323.9 3325.5 6290.9 6502.7 6526.4 6555.1 6604.5 6405.7 6472.5 6504.8 6513.8 6546.5 6345.5 6533.4 6646.0 6646.5 6671.3 6326.4 6332.4 6339.2 6387.5 6449.0 6146.5 6298.0 6330.4 6347.0 6353.8 6531.3 6571.5 6582.7 6605.4 6627.7 4415.3 4438.8 4478.5 4480.7 4485.9 6199.0 6344.3 6357.9 6422.6 6480.4 6239.8 6272.6 6273.2 6281.3 6281.6 6072.7 6222.3 6236.9 6253.2 6253.5 5985.8 6079.4 6141.6 6145.4 6154.9 6189.5 6204.7 6223.7 6267.7 6277.4 5883.9 6037.9 6066.6 6071.8 6138.3 21:37:02 INFO - PROCESS | 10989 | 21:37:02 INFO - PROCESS | 10989 | [#5] yui.html Cycles:180 Average:22648.49 Median:3912.66 stddev:33568.85 (858.0%) stddev-sans-first:33623.04 21:37:02 INFO - PROCESS | 10989 | Values: 829.3 868.4 902.9 912.7 946.4 16621.8 17966.0 18025.5 18043.7 18072.5 16484.3 16637.3 16720.2 17016.0 17289.4 885.8 888.0 890.3 908.7 913.2 908.8 910.1 915.2 917.3 918.1 965.1 966.2 967.0 968.2 971.4 950.2 953.1 953.7 956.4 956.6 704.6 705.3 705.4 706.5 706.5 14687.6 14741.6 14786.8 14842.5 14908.6 15037.8 15073.7 15300.2 15619.5 16602.4 12338.9 12700.6 12726.6 12801.0 13221.3 4082.7 4122.8 4129.2 4198.6 4271.0 94005.0 94499.5 94730.0 96607.0 96693.5 11094.2 12797.7 13147.8 13365.5 13689.3 25666.0 26223.1 26585.2 26938.2 26999.9 9548.1 9927.1 9995.0 10151.8 10288.5 5147.0 5196.1 5210.2 5283.6 5299.2 3817.9 3904.0 3910.9 3914.5 3935.5 694.9 695.7 699.3 703.3 706.3 725.1 754.9 788.9 789.3 806.5 8943.6 9343.4 10268.3 10347.3 10405.4 702.2 722.4 726.3 726.8 731.8 4588.1 4891.4 4892.2 4908.0 4936.5 112331.0 133999.3 134937.3 139074.0 142800.0 65848.7 100952.5 108417.0 111309.4 111502.4 59415.7 103705.0 104765.0 105820.0 106631.0 9561.2 9703.6 9787.1 9808.9 9884.7 40846.6 41132.4 48672.0 49975.0 50471.5 77565.2 77708.9 78338.0 81398.2 82975.0 14074.2 14163.9 14289.7 14878.0 15069.9 14358.6 14657.3 14995.9 15277.5 15481.7 13702.3 13890.6 14013.0 14744.5 15333.5 12746.4 12986.6 13051.2 13128.9 13324.1 13524.5 13553.7 13910.2 14219.1 14370.6 11207.6 11476.7 11811.6 11839.0 12203.7 11074.5 11253.2 11315.5 11319.8 11354.1 21:37:02 INFO - PROCESS | 10989 | -------- Summary: end -------- 21:37:02 INFO - PROCESS | 10989 | 21:37:02 INFO - TEST-INFO | 10989: exit 0 21:37:02 INFO - TEST-OK | dromaeo_css | took 1112099ms 21:37:02 INFO - TEST-START | kraken 21:37:02 INFO - operating with platform_type : linux_ 21:37:02 INFO - Initialising browser for kraken test... 21:37:02 INFO - TEST-INFO | started process 11256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpisfdof/profile http://localhost:53540/getInfo.html) 21:37:07 INFO - PROCESS | 11256 | __metrics Screen width/height:1600/1200 21:37:07 INFO - PROCESS | 11256 | colorDepth:24 21:37:07 INFO - PROCESS | 11256 | Browser inner width/height: 1024/697 21:37:07 INFO - PROCESS | 11256 | __metrics 21:37:08 ERROR - PROCESS | 11256 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:37:09 INFO - TEST-INFO | 11256: exit 0 21:37:09 INFO - Browser initialized. 21:37:09 INFO - Running cycle 1/1 for kraken test... 21:37:09 INFO - TEST-INFO | started process 11385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpisfdof/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:37:21 INFO - PROCESS | 11385 | RSS: Main: 153657344 21:37:21 INFO - PROCESS | 11385 | 21:37:23 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53540/tests/kraken/driver.html?testName=audio-beat-detection) 21:37:24 INFO - PROCESS | 11385 | RSS: Main: 158756864 21:37:24 INFO - PROCESS | 11385 | 21:37:27 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53540/tests/kraken/driver.html?testName=audio-dft) 21:37:27 INFO - PROCESS | 11385 | RSS: Main: 157134848 21:37:27 INFO - PROCESS | 11385 | 21:37:30 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53540/tests/kraken/driver.html?testName=audio-fft) 21:37:31 INFO - PROCESS | 11385 | RSS: Main: 158633984 21:37:31 INFO - PROCESS | 11385 | 21:37:33 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53540/tests/kraken/driver.html?testName=audio-oscillator) 21:37:33 INFO - PROCESS | 11385 | RSS: Main: 158134272 21:37:33 INFO - PROCESS | 11385 | 21:37:36 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53540/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:37:36 INFO - PROCESS | 11385 | RSS: Main: 157712384 21:37:36 INFO - PROCESS | 11385 | 21:37:39 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53540/tests/kraken/driver.html?testName=imaging-darkroom) 21:37:40 INFO - PROCESS | 11385 | RSS: Main: 158072832 21:37:40 INFO - PROCESS | 11385 | 21:37:43 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53540/tests/kraken/driver.html?testName=imaging-desaturate) 21:37:44 INFO - PROCESS | 11385 | RSS: Main: 158273536 21:37:44 INFO - PROCESS | 11385 | 21:37:47 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53540/tests/kraken/driver.html?testName=json-parse-financial) 21:37:48 INFO - PROCESS | 11385 | RSS: Main: 158142464 21:37:48 INFO - PROCESS | 11385 | 21:37:49 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53540/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:37:50 INFO - PROCESS | 11385 | RSS: Main: 157069312 21:37:50 INFO - PROCESS | 11385 | 21:37:51 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53540/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:37:52 INFO - PROCESS | 11385 | RSS: Main: 158191616 21:37:52 INFO - PROCESS | 11385 | 21:37:54 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53540/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:37:55 INFO - PROCESS | 11385 | RSS: Main: 158523392 21:37:55 INFO - PROCESS | 11385 | 21:37:57 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:37:58 INFO - PROCESS | 11385 | RSS: Main: 158187520 21:37:58 INFO - PROCESS | 11385 | 21:38:01 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:38:01 INFO - PROCESS | 11385 | RSS: Main: 158674944 21:38:01 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | Cycle 1(1): loaded http://localhost:53540/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53540/tests/kraken/driver.html?testName=ai-astar) 21:38:03 INFO - PROCESS | 11385 | RSS: Main: 160325632 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | __start_tp_report 21:38:03 INFO - PROCESS | 11385 | _x_x_mozilla_page_load 21:38:03 INFO - PROCESS | 11385 | _x_x_mozilla_page_load_details 21:38:03 INFO - PROCESS | 11385 | |i|pagename|runs| 21:38:03 INFO - PROCESS | 11385 | |0;ai-astar;109;112;103;110;111;112;100;110;111;111 21:38:03 INFO - PROCESS | 11385 | |1;audio-beat-detection;157;117;139;170;117;144;141;119;165;116 21:38:03 INFO - PROCESS | 11385 | |2;audio-dft;163;161;163;160;162;160;160;160;162;159 21:38:03 INFO - PROCESS | 11385 | |3;audio-fft;75;75;74;177;76;76;74;75;163;77 21:38:03 INFO - PROCESS | 11385 | |4;audio-oscillator;83;83;140;85;83;84;136;83;83;143 21:38:03 INFO - PROCESS | 11385 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 21:38:03 INFO - PROCESS | 11385 | |6;imaging-darkroom;147;148;147;147;146;146;147;147;146;147 21:38:03 INFO - PROCESS | 11385 | |7;imaging-desaturate;95;95;96;99;95;95;95;95;95;95 21:38:03 INFO - PROCESS | 11385 | |8;json-parse-financial;55;51;50;50;51;52;53;51;54;51 21:38:03 INFO - PROCESS | 11385 | |9;json-stringify-tinderbox;60;61;60;60;63;59;60;61;61;61 21:38:03 INFO - PROCESS | 11385 | |10;stanford-crypto-aes;79;73;72;73;73;72;72;72;72;72 21:38:03 INFO - PROCESS | 11385 | |11;stanford-crypto-ccm;117;118;124;130;127;120;139;133;158;116 21:38:03 INFO - PROCESS | 11385 | |12;stanford-crypto-pbkdf2;155;150;150;152;151;148;153;153;151;156 21:38:03 INFO - PROCESS | 11385 | |13;stanford-crypto-sha256-iterative;64;65;62;62;62;61;61;62;60;62 21:38:03 INFO - PROCESS | 11385 | __end_tp_report 21:38:03 INFO - PROCESS | 11385 | __start_cc_report 21:38:03 INFO - PROCESS | 11385 | _x_x_mozilla_cycle_collect,923 21:38:03 INFO - PROCESS | 11385 | __end_cc_report 21:38:03 INFO - PROCESS | 11385 | __startTimestamp1473395883528__endTimestamp 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | ------- Summary: start ------- 21:38:03 INFO - PROCESS | 11385 | Number of tests: 14 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:4.07 (3.7%) stddev-sans-first:4.31 21:38:03 INFO - PROCESS | 11385 | Values: 109.0 112.0 103.0 110.0 111.0 112.0 100.0 110.0 111.0 111.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:142.50 stddev:20.78 (14.6%) stddev-sans-first:20.93 21:38:03 INFO - PROCESS | 11385 | Values: 157.0 117.0 139.0 170.0 117.0 144.0 141.0 119.0 165.0 116.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.41 (0.9%) stddev-sans-first:1.30 21:38:03 INFO - PROCESS | 11385 | Values: 163.0 161.0 163.0 160.0 162.0 160.0 160.0 160.0 162.0 159.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:40.10 (53.5%) stddev-sans-first:41.92 21:38:03 INFO - PROCESS | 11385 | Values: 75.0 75.0 74.0 177.0 76.0 76.0 74.0 75.0 163.0 77.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:83.00 stddev:27.22 (32.8%) stddev-sans-first:28.15 21:38:03 INFO - PROCESS | 11385 | Values: 83.0 83.0 140.0 85.0 83.0 84.0 136.0 83.0 83.0 143.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 21:38:03 INFO - PROCESS | 11385 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 21:38:03 INFO - PROCESS | 11385 | Values: 147.0 148.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.27 (1.3%) stddev-sans-first:1.33 21:38:03 INFO - PROCESS | 11385 | Values: 95.0 95.0 96.0 99.0 95.0 95.0 95.0 95.0 95.0 95.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:51.50 stddev:1.69 (3.3%) stddev-sans-first:1.33 21:38:03 INFO - PROCESS | 11385 | Values: 55.0 51.0 50.0 50.0 51.0 52.0 53.0 51.0 54.0 51.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:1.07 (1.8%) stddev-sans-first:1.12 21:38:03 INFO - PROCESS | 11385 | Values: 60.0 61.0 60.0 60.0 63.0 59.0 60.0 61.0 61.0 61.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:72.50 stddev:2.16 (3.0%) stddev-sans-first:0.50 21:38:03 INFO - PROCESS | 11385 | Values: 79.0 73.0 72.0 73.0 73.0 72.0 72.0 72.0 72.0 72.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:128.50 stddev:12.89 (10.0%) stddev-sans-first:13.02 21:38:03 INFO - PROCESS | 11385 | Values: 117.0 118.0 124.0 130.0 127.0 120.0 139.0 133.0 158.0 116.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:152.50 stddev:2.42 (1.6%) stddev-sans-first:2.30 21:38:03 INFO - PROCESS | 11385 | Values: 155.0 150.0 150.0 152.0 151.0 148.0 153.0 153.0 151.0 156.0 21:38:03 INFO - PROCESS | 11385 | 21:38:03 INFO - PROCESS | 11385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.45 (2.3%) stddev-sans-first:1.36 21:38:03 INFO - PROCESS | 11385 | Values: 64.0 65.0 62.0 62.0 62.0 61.0 61.0 62.0 60.0 62.0 21:38:03 INFO - PROCESS | 11385 | -------- Summary: end -------- 21:38:03 INFO - PROCESS | 11385 | 21:38:04 INFO - TEST-INFO | 11385: exit 0 21:38:04 INFO - TEST-OK | kraken | took 61688ms 21:38:04 INFO - SUITE-END | took 1173s 21:38:04 INFO - Completed test suite (00:19:34) 21:38:04 INFO - javascript benchmark 21:38:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7787.74356439405, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.7591930605204, 3247.545343651888, 3248.0255923223026, 3250.398676244894, 3275.492298693703, 5594.440555944404, 5688.857778555533, 5694.202811606378, 5701.657900525971, 5702.714864256791, 5710.1434784782305, 5712.600117991742, 5749.396313387087, 5751.223584816049, 5768.826935191941, 5170.276161337425, 5255.789768409278, 5267.947320526803, 5326.866828329284, 5338.786448542073, 5116.539511443969, 5124.333836601237, 5164.974175129119, 5171.198464238049, 5237.423883372826, 5224.399194092671, 5234.502722241381, 5284.101702710529, 5324.068288049576, 5345.946540534604, 5308.124159513675, 5333.493318134771, 5333.946660533384, 5337.919931201035, 5346.064438723208, 5010.498950104997, 5010.649254552182, 5215.243789650517, 5230.006298803215, 5304.310439642861, 5511.338639363302, 5557.38868724444, 5563.054280772238, 5587.217789509472, 5627.465390787909, 5952.642841429528, 5954.5534084943365, 5989.31122920861, 6023.849403764897, 6028.97507423739, 5854.824355269348, 5992.400759923973, 6040.426159514839, 6064.514838812928, 6075.513958883279, 5592.804251851207, 5696.743646535916, 5698.572607054529, 5709.0, 5723.370429252779, 6214.906776398358, 6216.937830621727, 6231.189945307081, 6232.283287422005, 6255.093011513305, 5691.231683722727, 5882.617629854046, 5940.108983652401, 5950.226470558886, 5976.970115149396, 5971.223740913653, 6078.513718902477, 6080.57435979486, 6107.4197951194565, 6108.786192483241, 5985.0, 6036.486898613579, 6039.5470339723815, 6044.667543285162, 6062.545309101835, 5767.9134812977, 5793.884122317614, 5996.010658241428, 6046.183765191643, 6047.576669633171, 4510.774461276923, 4534.59188673021, 4550.112728018071, 4555.453345598483, 4583.816647334069, 4048.2713111640187, 4063.4311196432523, 4064.146529228836, 4066.532348779869, 4077.388391741203, 5594.552435805126, 5684.715764211773, 5692.402297758758, 5705.62913410627, 5719.628224165416, 6074.51403887688, 6147.231596050494, 6164.660943648142, 6170.043643235305, 6171.660558669317, 5810.82567522975, 5848.2689663792025, 5855.677937713466, 5886.058230683156, 5893.499052580493, 5128.9230661540105, 5161.329027226437, 5233.4243233244315, 5278.049951008778, 5283.630145889751, 6131.315499379051, 6310.242770867525, 6314.336994615591, 6317.557770955989, 6321.810345689637, 6063.454289114001, 6073.787417440369, 6074.42292982166, 6079.240094988127, 6090.847728806815, 6101.6644084574, 6186.226721659793, 6267.96866015667, 6274.937250627435, 6283.71723272463, 5930.644161350333, 6039.48664363534, 6041.75832966694, 6046.57673962836, 6074.088886667036, 6113.5414843886, 6117.082437634391, 6129.693515324305, 6130.846728831815, 6142.2629284484365, 5835.358110607915, 5836.620619659709, 5959.523238140851, 5995.820125396245, 6010.819675409744, 5922.378150294157, 6014.36849130835, 6024.849378765391, 6035.698215089315, 6066.241719785027, 5955.344912059757, 5987.64074155552, 6000.339962604197, 6004.489618382487, 6006.669633170218, 5894.970525147347, 5913.497352724895, 6002.0996850472775, 6045.667488288186, 6045.727942242522, 5748.109043098327, 5844.970775146097, 5849.3858144894175, 5853.385394533512, 5899.292084949833], "value": 5599.476665949201, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.4547543522241, 638.2628064585406, 645.8643684826186, 666.7266420767486, 692.7471472912389, 44999.0, 45753.31370029444, 46014.53985460144, 46197.76901115494, 46340.3048954266, 47194.76402617982, 47720.52279477204, 47741.76129119349, 48113.278300825514, 48125.0, 9041.141091596288, 9177.265818734519, 9177.816443671123, 9192.402493837879, 9217.446953182796, 9141.908580914205, 9154.130357616015, 9214.76963075925, 9216.30877684173, 9272.953635231814, 9257.0, 9270.119338662817, 9334.0, 9362.344635875492, 9378.390404623711, 9177.908220917772, 9226.077392260788, 9265.583048762788, 9271.397359171633, 9299.72100836976, 9205.447673139633, 9210.0, 9213.355065145442, 9263.166315031613, 9269.629214831399, 43887.78056109731, 44057.339139912925, 44190.11619767587, 44241.77879110584, 44291.77854110709, 4094.9385759213637, 4187.874363769091, 4389.561043895616, 4420.381146639473, 4626.884327891796, 34790.30419391598, 35071.1232219194, 35149.648503514894, 35247.0, 35322.823385883166, 4754.286856971447, 4831.178699621073, 4850.878728031827, 4867.902641947177, 4935.925961110586, 362724.0, 363939.0, 365227.0, 365282.0, 367479.0, 64347.35652643508, 64878.35121648723, 65146.0, 65222.673886631215, 65284.673576631816, 39337.60662393396, 39828.20343593112, 40011.59988400079, 66727.33272667308, 66967.66516167388, 18712.906435467736, 18816.341428049953, 18888.90555547241, 18901.43295701131, 18908.905455472635, 14207.0, 14215.715685686228, 14297.999140060305, 14310.713785724227, 14373.85626143746, 21466.677999830015, 21487.140514379564, 21520.139194432046, 21634.24280150187, 21789.34631961044, 7564.357029652431, 7608.695652173851, 7751.534907905431, 7779.649915753805, 8048.436609437284, 1018.9286749927583, 1035.5495359518634, 1130.6890605083668, 1155.4569352404355, 1165.5454372794618, 34438.48342274868, 34455.65544344574, 34772.130696732784, 34955.650443495746, 35354.0, 1132.247055707945, 1143.9313641181557, 1155.9711007224719, 1190.4761904761876, 1191.434068817305, 17991.370302039366, 18262.634747305245, 18301.816981830278, 18545.629087418176, 18736.0, 595465.0, 598115.0, 598734.0, 601042.0, 606557.0, 65534.672326638065, 65624.0, 65848.67075664687, 66000.33999659942, 66147.33852661411, 1424.900256982022, 1432.0834665813888, 1463.3561233057421, 1470.1105830972322, 1478.2091581004327, 32004.0, 33717.15707107244, 34201.31597368088, 34259.14352141217, 34467.0, 50975.49024509708, 51015.74492127515, 51149.488505114474, 57700.42299577119, 57827.0, 494402.0, 495491.0, 498232.0, 498436.0, 499333.0, 31983.36033279275, 32054.679453206103, 32371.838140809145, 32955.0, 33994.0, 53786.46213537971, 54087.45912540982, 54222.0, 54453.0, 55201.0, 45002.0, 45558.0, 45613.54386456093, 47226.29160562663, 47347.28979065248, 44684.32973505335, 45314.32028519509, 46301.76849115733, 46703.29945050895, 46939.295910562054, 38205.42691859569, 43296.0, 43961.858073773146, 44465.777671111435, 44800.32799508075, 38978.22043559056, 39812.2037559253, 39878.60121398749, 40124.398134027426, 41333.79333103315, 30092.849535752182, 30204.395912082076, 30514.389712206077, 30844.691553084183, 31007.0], "value": 21750.08438332845, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.7991004497749, 405.7502891095426, 414.36188270064105, 423.32268370607034, 434.27042568484933, 19450.610987780237, 20553.691694624573, 20810.855402952868, 20863.791362086373, 21295.36113916583, 19856.801431985677, 20010.0, 20066.49833754157, 20301.593968120666, 20515.897420512876, 5957.970210148943, 6133.815985520441, 6184.07238914162, 6185.948388773919, 6188.504919606443, 5480.671159730409, 5678.43215678433, 5695.829125126253, 6068.939310606882, 6113.113598528211, 5674.659520428767, 5792.0, 5793.536517078624, 5810.709464526778, 5910.67491287979, 5857.794977175799, 5908.645481271137, 6217.782377616762, 6364.459020983222, 6372.681365931685, 6113.419225173601, 6122.112293717386, 6136.662483563402, 6154.8769024619705, 6160.630362178239, 14949.70100597982, 14986.925065374713, 15088.849111508855, 19810.00949952511, 23810.047598096055, 2583.7287084856193, 2689.704132545438, 2774.140016594862, 2900.8259504429802, 2910.9126726198247, 10587.0, 10656.680299590947, 10683.519241634145, 10867.67396978084, 11185.328880267129, 2033.5119571302928, 2036.1384812312072, 2046.9897650511653, 2091.5084955035554, 2168.9891550542147, 83040.58479707623, 84005.57997210036, 84497.0, 85357.0, 87929.56035219847, 11093.168012399103, 11187.664370068911, 11201.71995700114, 11261.155413344031, 11414.201005929672, 16093.678126437406, 16111.113888735998, 16124.596885077732, 16131.354745810037, 16166.919165404333, 8288.419810613199, 8370.497770133812, 8428.4942903426, 8612.913870861337, 8649.308055355556, 7396.223396543393, 7451.366633836076, 7503.0, 7550.962245188739, 7665.770026899202, 4788.281757736298, 4808.951910480921, 4854.199057155601, 4932.136876046749, 5021.472745361758, 1917.3481016454193, 1998.150785916009, 2000.7499062617173, 2030.2285131649878, 2046.1610739596993, 988.3476905242505, 1009.4498498318434, 1047.6537649120844, 1072.5602502973743, 1097.8517900083546, 20607.0, 20790.58418831645, 21120.894395527925, 21150.259740908994, 21161.470963225736, 1027.5581499954942, 1100.510272928539, 1106.9280496767685, 1121.3328069798456, 1181.3443538835857, 11597.710057248636, 11709.355985420883, 11818.881811181778, 11819.822702659467, 11863.288202707865, 503887.0, 506073.0, 507256.0, 508454.0, 514596.0, 88159.55920220487, 91876.54061729649, 93229.53385233166, 93507.53246233726, 95154.0, 1046.7069220618087, 1079.9190060745475, 1089.9455027248605, 1090.7709381030072, 1099.9010089092021, 17905.910470447565, 18088.819111808712, 18517.90741046286, 18535.07324633736, 18645.720314195027, 42089.78955105205, 43406.78296608497, 43806.34290485582, 43864.0, 43977.12045759131, 60869.47826304378, 61494.385056148865, 61775.38224617696, 61997.0, 63100.0, 8942.329325300498, 9028.954855225682, 9033.0, 9067.319951003568, 9186.954065229898, 11345.432728363714, 13948.302584870513, 14038.438462461796, 14257.857421426068, 14331.35508902081, 11937.0, 12137.575184868487, 12261.75476490483, 12403.875961240634, 12434.37828108609, 11808.822867657163, 12059.095567832272, 12188.939055304667, 12287.69280767988, 12533.623991280276, 12198.634040978784, 12364.0, 12490.750184996068, 12676.23942563449, 12704.745905081661, 8802.163794439519, 8868.822623547621, 8911.420757650732, 8970.596323165342, 9368.718938431857, 9528.475933823429, 12143.210691305037, 12166.209196402206, 12166.878331216574, 12172.2696638202], "value": 9613.45037314811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.182422404014, 1551.7206902757507, 1695.3133980737798, 1822.0616382562982, 1859.3956963986707, 8429.283510901565, 8924.375293729441, 8956.10438956104, 9603.855942160873, 9661.0, 8912.688055918044, 9274.026227246142, 9288.489133097677, 9311.674091406801, 9335.43987360759, 2345.8475199112045, 2406.4826062396583, 2406.783389494945, 2410.9035638574437, 2414.7343792182933, 2357.57563638545, 2373.8931748071377, 2377.3818807110188, 2396.808255339569, 2404.0, 2383.7139543254834, 2392.521495700858, 2398.70016247969, 2414.33605758417, 2425.757424257578, 2293.334932869466, 2308.0652335803943, 2308.803751681109, 2312.6068568343253, 2350.21267875262, 2268.2854900706225, 2279.076973825603, 2292.2435596253363, 2309.445733024079, 2311.0755697721047, 9543.761405964837, 9632.084951929555, 9659.565319560566, 9676.419414835133, 9723.902760972442, 5425.131978883399, 5530.723463826793, 5537.252470916415, 5545.417731138213, 5545.473180047929, 3435.5018522314376, 3520.823958802075, 3540.522029526007, 3543.061088811467, 3574.2136729919375, 1221.6335099470123, 1236.6661001529537, 1238.2941723217768, 1252.2674235572201, 1256.0265794009624, 12840.61478155657, 12845.614631561068, 12850.35748212595, 12899.03257255719, 12922.224666520038, 4684.476929390821, 4743.83396581118, 4805.990741944231, 4878.292647566083, 4880.243562247857, 10841.620543280947, 10852.457377131112, 10935.945320273348, 10946.507407166537, 10961.451927403758, 5492.038893193675, 5513.117901135799, 5514.6139770216505, 5563.415841336601, 5564.10974244119, 4545.318202269686, 5113.565346945476, 5188.584913206934, 5306.151015837448, 5325.4674532547215, 4296.2481565725875, 4360.345948107746, 4396.560343965642, 4407.316865885793, 4423.712458690175, 1370.2463644995212, 1373.3957058894055, 1376.2705765944065, 1382.7718426459521, 1398.1960372785688, 934.6495064350869, 1038.408107378802, 1049.3494033699155, 1055.4933631856752, 1064.7551063255494, 6387.457066149336, 6629.1382120325015, 6673.0, 6723.5293529452465, 6849.417799487, 1025.4616326428536, 1031.783325501638, 1057.9735506612396, 1089.487940667885, 1107.4241394474827, 4454.665900057508, 4470.932936005963, 4497.302918047708, 4574.382458368144, 4575.359449677047, 11111.611093611846, 11724.765504690029, 11892.524299027942, 11978.64064078079, 12062.215955962834, 11470.827937580943, 11861.703457413461, 11879.940600296943, 11901.642950711492, 11933.820992685116, 8741.562921853882, 8772.122787721177, 8794.384393092421, 8822.25010874083, 8871.778205544784, 6600.9009864851105, 6682.63245521501, 6722.764703235363, 6830.7609233676585, 6835.008923706134, 10655.25413221067, 10869.076128529163, 11029.172812039289, 11093.0, 11104.833427498756, 11019.779604407706, 11074.889251107386, 11194.0, 11229.21395502307, 11270.661880143281, 7616.314531691953, 8226.753197404087, 8345.123762004901, 8428.241458268785, 8625.439346442712, 9275.39709918853, 9295.163435290857, 9372.718818435458, 9416.435013899189, 9419.105185007413, 8167.305779008851, 8325.25072743456, 8325.458845175044, 8329.083800781787, 8373.958130209554, 8182.099969003286, 8197.590120493833, 8200.179982001751, 8220.917790822254, 8305.875411868949, 7227.205007449072, 7295.963520182365, 7302.780916572511, 7306.2693730626515, 7324.0, 5657.179708942263, 5684.744186511534, 5722.370539240764, 5730.828075157752, 5924.170616113662, 5609.868250064949, 5745.885082298247, 5763.337216220189, 5829.09649004405, 5882.264716910387], "value": 4968.85129850822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.91974845785467, 348.9406800843857, 348.9755717099803, 351.195761705694, 351.7889266440135, 5810.215620891178, 5877.941220587798, 5905.379935106816, 5909.970450147749, 5926.436988486098, 5763.5389168866495, 5784.855378615537, 5810.18657387965, 5829.183914252008, 5855.765769369231, 4140.544540100586, 4535.387722657432, 4543.477500087482, 4550.340200670901, 4595.195840727876, 4541.704789188709, 4561.0649816787645, 4566.858285428643, 4581.244094724367, 4592.402987611606, 4476.529964353728, 4505.594496495315, 4556.521565235652, 4561.6806823522365, 4571.428571428572, 4526.275795872644, 4531.501534831183, 4540.591346778806, 4542.659300552472, 4552.521985191574, 4022.6178513041214, 4026.6778657707605, 4027.8590249341423, 4052.3921411788174, 4054.331035379159, 5581.972090139523, 5637.492625663669, 5646.378898321182, 5672.0, 5728.052462162885, 5208.609354298443, 5224.387806096952, 5227.712475813829, 5228.0, 5230.581553475713, 6066.545009124334, 6080.270367555878, 6101.60339577926, 6134.815955521297, 6146.631202127886, 4281.336392859112, 4424.557544245549, 4436.578525040116, 4465.419495465569, 4474.9776251118865, 6301.180846489973, 6321.431071203614, 6359.014352775327, 6367.745290188387, 6411.326810684857, 4539.614132798749, 4581.381513495636, 4584.266517357207, 4595.40259766235, 4595.931061034087, 4510.323451482304, 4546.363509108727, 4551.203539380595, 4638.234691275969, 4658.0, 5179.601507592929, 5187.455317191716, 5188.273641690166, 5245.396779370421, 5262.289590905179, 6056.485878530368, 6089.391060893964, 6098.207233059763, 6098.573099883054, 6176.227971503562, 1484.2356186563927, 1551.5965848879148, 1565.882558808094, 1570.0, 1582.8021497312836, 978.2711879649706, 990.2177279948904, 993.2153598657125, 1032.5198782565992, 1062.8937106289309, 5830.212921255661, 5859.44335288147, 5872.677002764804, 5886.705664716747, 5961.880762384728, 6171.84570385744, 6205.379462053758, 6207.503399728011, 6240.0, 6293.3391993840905, 5735.065346848611, 5832.62087964281, 5861.296644402699, 5906.2912450505355, 5916.881662366729, 3265.853036613358, 3307.8676852926096, 3309.8179600122226, 3323.9169020774675, 3325.48454989477, 6290.874182516324, 6502.674866256668, 6526.4452521536205, 6555.115059467006, 6604.537682362285, 6405.718856228773, 6472.514561407913, 6504.837379065561, 6513.837154071091, 6546.541742078104, 6345.460635846005, 6533.379328963741, 6646.0, 6646.4713115983595, 6671.266160722316, 6326.398992095744, 6332.430081292521, 6339.239291284891, 6387.489000879826, 6448.96816509375, 6146.5390095742105, 6297.992321228581, 6330.3669633036325, 6347.0, 6353.809385718436, 6531.3468653134305, 6571.5399922005, 6582.670866456562, 6605.405513503808, 6627.7348906045145, 4415.315626077963, 4438.778061096997, 4478.462584489882, 4480.708753930984, 4485.865424037284, 6199.0, 6344.30212676596, 6357.90463143044, 6422.563928298338, 6480.416762491398, 6239.812805615838, 6272.6236425814595, 6273.1844860167885, 6281.3404592518955, 6281.560290779602, 6072.696365181635, 6222.346653601307, 6236.875262494816, 6253.218347706536, 6253.530985176039, 5985.760569577168, 6079.422454866781, 6141.631502109888, 6145.385461453998, 6154.876902462015, 6189.535784816247, 6204.658743769136, 6223.7325404163175, 6267.686615669107, 6277.403646653561, 5883.882322353615, 6037.879242415215, 6066.636001839904, 6071.848203794941, 6138.263408391022], "value": 4686.624073765201, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.2702421868754, 868.409481552544, 902.9413088149271, 912.7216199059284, 946.4368700623127, 16621.83378166218, 17966.0, 18025.459236222934, 18043.729344059833, 18072.4578262652, 16484.34062637493, 16637.33450661972, 16720.2475888585, 17016.0, 17289.39487117948, 885.8095509465463, 887.9822403551925, 890.3322508118911, 908.6819613135383, 913.1507697841005, 908.7500937242278, 910.1262787723794, 915.2083447817623, 917.2936838634248, 918.1231923513029, 965.1313817564178, 966.1884017425361, 967.0377973915963, 968.2254196642693, 971.3589031239384, 950.1970834644715, 953.1374106433689, 953.7329547726648, 956.4261443134134, 956.5647630328184, 704.5596502186133, 705.2559549675091, 705.4039336760429, 706.4666177036305, 706.5266271598042, 14687.55937321882, 14741.631459213499, 14786.778198327034, 14842.480513181987, 14908.552743417715, 15037.849621503754, 15073.698526029419, 15300.158491282975, 15619.453319133889, 16602.418915338025, 12338.938305308506, 12700.555480558229, 12726.554570590077, 12801.039922005793, 13221.272829994443, 4082.6529744971713, 4122.793860306972, 4129.174165166979, 4198.5591512891015, 4271.0, 94005.0, 94499.52750236273, 94729.99999999932, 96607.0, 96693.51653241689, 11094.22340436178, 12797.680057998625, 13147.802782958262, 13365.532206372925, 13689.31553422325, 25666.0, 26223.082192123184, 26585.20244392671, 26938.191854244404, 26999.865000674872, 9548.140667339834, 9927.106560409598, 9994.950025249827, 10151.847722284025, 10288.537015834305, 5147.0, 5196.090684130262, 5210.21846722987, 5283.550898173698, 5299.205119232146, 3817.904552386157, 3904.0, 3910.8631197907935, 3914.451976723261, 3935.4687117239378, 694.861027794433, 695.7217113154778, 699.3461113858457, 703.3423748794893, 706.3184027413467, 725.0755287009106, 754.901862757838, 788.9467560806273, 789.3172405868996, 806.4838503357738, 8943.5975381108, 9343.439393636403, 10268.33255838383, 10347.327423717585, 10405.375677459377, 702.2415790945767, 722.3931897206267, 726.2954933714394, 726.7892311229684, 731.8316787138988, 4588.128255631486, 4891.437484689306, 4892.158085026805, 4907.950920490749, 4936.506349365035, 112331.0, 133999.33000334937, 134937.32531337478, 139074.0, 142800.0, 65848.67075664591, 100952.49523752334, 108417.0, 111309.44345278222, 111502.44248778705, 59415.70292148511, 103705.0, 104765.0, 105820.0, 106630.99999999844, 9561.235101192027, 9703.563339649592, 9787.119159275699, 9808.85286720714, 9884.703458896245, 40846.59153408547, 41132.383014254214, 48672.0, 49975.00099996105, 50471.49528504815, 77565.2243477558, 77708.92597823673, 78338.0, 81398.18601813907, 82975.0, 14074.155550666992, 14163.858361416254, 14289.71420571562, 14878.0, 15069.924650376677, 14358.56924292273, 14657.267136643339, 14995.850041499445, 15277.541673749362, 15481.690366192839, 13702.314884255547, 13890.58328250154, 14013.0, 14744.483943061941, 15333.539993800205, 12746.426410811351, 12986.610401687965, 13051.21692698441, 13128.934355328161, 13324.133931294435, 13524.526641567498, 13553.704156662432, 13910.234937078558, 14219.146851188962, 14370.568882933529, 11207.551697931991, 11476.655700329004, 11811.586594469152, 11839.0, 12203.69490762738, 11074.501647425725, 11253.15601329887, 11315.490802913724, 11319.755885614017, 11354.091672666002], "value": 8181.347024876289, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1489.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 103.0, 110.0, 111.0, 112.0, 100.0, 110.0, 111.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 117.0, 139.0, 170.0, 117.0, 144.0, 141.0, 119.0, 165.0, 116.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 160.0, 162.0, 160.0, 160.0, 160.0, 162.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 177.0, 76.0, 76.0, 74.0, 75.0, 163.0, 77.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 140.0, 85.0, 83.0, 84.0, 136.0, 83.0, 83.0, 143.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 99.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 50.0, 50.0, 51.0, 52.0, 53.0, 51.0, 54.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 63.0, 59.0, 60.0, 61.0, 61.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 72.0, 73.0, 73.0, 72.0, 72.0, 72.0, 72.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 124.0, 130.0, 127.0, 120.0, 139.0, 133.0, 158.0, 116.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 150.0, 150.0, 152.0, 151.0, 148.0, 153.0, 153.0, 151.0, 156.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 60.0, 62.0], "value": 62.1, "unit": "score"}]}]} 21:38:04 INFO - Return code: 0 21:38:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:38:04 ERROR - # TBPL SUCCESS # 21:38:04 INFO - Running post-action listener: _resource_record_post_action 21:38:04 INFO - [mozharness: 2016-09-09 04:38:04.852821Z] Finished run-tests step (success) 21:38:04 INFO - Running post-run listener: _resource_record_post_run 21:38:04 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 294912; Write bytes: 325292032; Read time: 512; Write time: 480028 21:38:04 INFO - TinderboxPrint: CPU usage
13.2% 21:38:04 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 512 21:38:04 INFO - TinderboxPrint: I/O write bytes / time
325,292,032 / 480,028 21:38:04 INFO - TinderboxPrint: CPU idle
8,243.4 (86.7%) 21:38:04 INFO - TinderboxPrint: CPU user
1,197.4 (12.6%) 21:38:04 INFO - TinderboxPrint: Swap in / out
0 / 0 21:38:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 78745600; Read time: 368; Write time: 148136 21:38:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 286720; Write bytes: 245932032; Read time: 132; Write time: 331892 21:38:05 INFO - Running post-run listener: _upload_blobber_files 21:38:05 INFO - Blob upload gear active. 21:38:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:38:05 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 21:38:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:38:05 INFO - (blobuploader) - INFO - Open directory for files ... 21:38:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:38:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:38:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:06 INFO - (blobuploader) - INFO - Done attempting. 21:38:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:38:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:38:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:07 INFO - (blobuploader) - INFO - Done attempting. 21:38:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:38:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:38:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:38:10 INFO - (blobuploader) - INFO - Done attempting. 21:38:10 INFO - (blobuploader) - INFO - Iteration through files over. 21:38:10 INFO - Return code: 0 21:38:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:38:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:38:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e64a8a63107e73d7920f1ae56948f72171e454725ea2f65287b06b42467e48345e7ed8060024781eec0418323507639f181b6d9f619ac8c34276d8d8c8ede33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a4e6c90ee2ca8119ebaba762f948243d2c6bfeec2032829625d827c1613b5e954d6e3635b28bdd08976eca637695c340c1a47139303149fbf035caba8fd2a89", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68ac78049170ee8883e1d2107e026fb348e2977ad998caa22fef5bc84e8a8e7358b8acc613190f998d7877b1863daada3d4b4d1c68a15aed6ec028e2f33e3a39"} 21:38:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:38:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:38:10 INFO - Contents: 21:38:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e64a8a63107e73d7920f1ae56948f72171e454725ea2f65287b06b42467e48345e7ed8060024781eec0418323507639f181b6d9f619ac8c34276d8d8c8ede33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a4e6c90ee2ca8119ebaba762f948243d2c6bfeec2032829625d827c1613b5e954d6e3635b28bdd08976eca637695c340c1a47139303149fbf035caba8fd2a89", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68ac78049170ee8883e1d2107e026fb348e2977ad998caa22fef5bc84e8a8e7358b8acc613190f998d7877b1863daada3d4b4d1c68a15aed6ec028e2f33e3a39"} 21:38:10 INFO - Running post-run listener: copy_logs_to_upload_dir 21:38:10 INFO - Copying logs to upload dir... 21:38:10 INFO - mkdir: /builds/slave/test/build/upload/logs 21:38:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1680.144953 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-09-08 21:38:10.885739) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 21:38:10.889070) ========= 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=5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e64a8a63107e73d7920f1ae56948f72171e454725ea2f65287b06b42467e48345e7ed8060024781eec0418323507639f181b6d9f619ac8c34276d8d8c8ede33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a4e6c90ee2ca8119ebaba762f948243d2c6bfeec2032829625d827c1613b5e954d6e3635b28bdd08976eca637695c340c1a47139303149fbf035caba8fd2a89", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68ac78049170ee8883e1d2107e026fb348e2977ad998caa22fef5bc84e8a8e7358b8acc613190f998d7877b1863daada3d4b4d1c68a15aed6ec028e2f33e3a39"} build_url:https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/cgk5zWjVQcqOdGqLDz95ww/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e64a8a63107e73d7920f1ae56948f72171e454725ea2f65287b06b42467e48345e7ed8060024781eec0418323507639f181b6d9f619ac8c34276d8d8c8ede33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a4e6c90ee2ca8119ebaba762f948243d2c6bfeec2032829625d827c1613b5e954d6e3635b28bdd08976eca637695c340c1a47139303149fbf035caba8fd2a89", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68ac78049170ee8883e1d2107e026fb348e2977ad998caa22fef5bc84e8a8e7358b8acc613190f998d7877b1863daada3d4b4d1c68a15aed6ec028e2f33e3a39"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 21:38:10.914617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 21:38:10.914975) ========= 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=5cf47e208febbcd81da23b2e0000026f-1473392768.260896-826286860 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 21:38:10.996832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 21:38:10.997186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 21:38:10.997512) ========= ========= Total master_lag: 0.18 =========