builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1474436181.4 results: success (0) buildid: 20160920195135 builduid: cee59c3af5c14ff3a1146431012cc3cc revision: 91faf7ec36cd18a8ebdc0e2edac966e5bbb15da2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:21.404342) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:21.405386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:21.406132) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:21.421704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:21.422243) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-20 22:36:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.3M=0s 2016-09-20 22:36:21 (30.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080284 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:21.521486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:21.522257) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020579 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:21.576407) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:21.577240) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 91faf7ec36cd18a8ebdc0e2edac966e5bbb15da2 --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-beta --rev 91faf7ec36cd18a8ebdc0e2edac966e5bbb15da2 --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=56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-20 22:36:21,770 truncating revision to first 12 chars 2016-09-20 22:36:21,770 Setting DEBUG logging. 2016-09-20 22:36:21,770 attempt 1/10 2016-09-20 22:36:21,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/91faf7ec36cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-20 22:36:22,231 unpacking tar archive at: mozilla-beta-91faf7ec36cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.793827 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:22.386621) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:22.387026) ========= script_repo_revision: 91faf7ec36cd18a8ebdc0e2edac966e5bbb15da2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:22.387483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:22.387810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 22:36:22.396430) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 12 secs) (at 2016-09-20 22:36:22.396751) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:36:22 INFO - MultiFileLogger online at 20160920 22:36:22 in /builds/slave/test 22:36:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:36:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:36:22 INFO - {'append_to_log': False, 22:36:22 INFO - 'base_work_dir': '/builds/slave/test', 22:36:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:36:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:36:22 INFO - 'branch': 'Mozilla-Beta', 22:36:22 INFO - 'buildbot_json_path': 'buildprops.json', 22:36:22 INFO - 'config_files': ('talos/linux_config.py',), 22:36:22 INFO - 'default_actions': ('clobber', 22:36:22 INFO - 'read-buildbot-config', 22:36:22 INFO - 'download-and-extract', 22:36:22 INFO - 'populate-webroot', 22:36:22 INFO - 'create-virtualenv', 22:36:22 INFO - 'install', 22:36:22 INFO - 'run-tests'), 22:36:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:36:22 INFO - 'download_minidump_stackwalk': True, 22:36:22 INFO - 'download_symbols': 'ondemand', 22:36:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:36:22 INFO - 'tooltool.py': '/tools/tooltool.py', 22:36:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:36:22 INFO - '/tools/misc-python/virtualenv.py')}, 22:36:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:36:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:36:22 INFO - 'installer_path': 'installer.exe', 22:36:22 INFO - 'log_level': 'info', 22:36:22 INFO - 'log_name': 'talos', 22:36:22 INFO - 'log_to_console': True, 22:36:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:36:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:36:22 INFO - 'opt_config_files': (), 22:36:22 INFO - 'pip_index': False, 22:36:22 INFO - 'sps_profile': False, 22:36:22 INFO - 'sps_profile_interval': 0, 22:36:22 INFO - 'suite': 'dromaeojs-e10s', 22:36:22 INFO - 'system_bits': '32', 22:36:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:36:22 INFO - 'title': 'talos-linux64-ix-037', 22:36:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:36:22 INFO - 'use_talos_json': True, 22:36:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:36:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:36:22 INFO - 'work_dir': 'build'} 22:36:22 INFO - [mozharness: 2016-09-21 05:36:22.682544Z] Running clobber step. 22:36:22 INFO - Running pre-action listener: _resource_record_pre_action 22:36:22 INFO - Running main action method: clobber 22:36:22 INFO - rmtree: /builds/slave/test/build 22:36:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:36:23 INFO - Running post-action listener: _resource_record_post_action 22:36:23 INFO - [mozharness: 2016-09-21 05:36:23.676867Z] Finished clobber step (success) 22:36:23 INFO - [mozharness: 2016-09-21 05:36:23.676968Z] Running read-buildbot-config step. 22:36:23 INFO - Running pre-action listener: _resource_record_pre_action 22:36:23 INFO - Running main action method: read_buildbot_config 22:36:23 INFO - Using buildbot properties: 22:36:23 INFO - { 22:36:23 INFO - "project": "", 22:36:23 INFO - "product": "firefox", 22:36:23 INFO - "script_repo_revision": "production", 22:36:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 22:36:23 INFO - "repository": "", 22:36:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 22:36:23 INFO - "buildid": "20160920195135", 22:36:23 INFO - "pgo_build": "True", 22:36:23 INFO - "basedir": "/builds/slave/test", 22:36:23 INFO - "buildnumber": 124, 22:36:23 INFO - "slavename": "talos-linux64-ix-037", 22:36:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:36:23 INFO - "platform": "ubuntu64_hw", 22:36:23 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 22:36:23 INFO - "branch": "mozilla-beta", 22:36:23 INFO - "repo_path": "releases/mozilla-beta", 22:36:23 INFO - "revision": "91faf7ec36cd18a8ebdc0e2edac966e5bbb15da2", 22:36:23 INFO - "stage_platform": "linux64-pgo", 22:36:23 INFO - "builduid": "cee59c3af5c14ff3a1146431012cc3cc", 22:36:23 INFO - "slavebuilddir": "test" 22:36:23 INFO - } 22:36:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 22:36:23 INFO - Running post-action listener: _resource_record_post_action 22:36:23 INFO - [mozharness: 2016-09-21 05:36:23.679410Z] Finished read-buildbot-config step (success) 22:36:23 INFO - [mozharness: 2016-09-21 05:36:23.679499Z] Running download-and-extract step. 22:36:23 INFO - Running pre-action listener: _resource_record_pre_action 22:36:23 INFO - Running main action method: download_and_extract 22:36:23 INFO - mkdir: /builds/slave/test/build/tests 22:36:23 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')]} 22:36:23 INFO - https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:36:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:36:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:36:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:36:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:36:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:36:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:36:23 INFO - retry: Failed, sleeping 30 seconds before retrying 22:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 22:36:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:36:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:36:53 INFO - retry: Failed, sleeping 60 seconds before retrying 22:37:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 22:37:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:37:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:37:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 22:37:53 INFO - Caught exception: HTTP Error 404: Not Found 22:37:53 INFO - Caught exception: HTTP Error 404: Not Found 22:37:53 INFO - Caught exception: HTTP Error 404: Not Found 22:37:53 INFO - trying https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:37:53 INFO - Downloading https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:37:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:37:54 INFO - Downloaded 1327 bytes. 22:37:54 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:37:54 INFO - Using the following test package requirements: 22:37:54 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 22:37:54 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:37:54 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 22:37:54 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:37:54 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 22:37:54 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:37:54 INFO - u'jsshell-linux-x86_64.zip'], 22:37:54 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:37:54 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 22:37:54 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 22:37:54 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:37:54 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 22:37:54 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:37:54 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 22:37:54 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:37:54 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 22:37:54 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:37:54 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 22:37:54 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:37: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')]} 22:37:54 INFO - https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:37:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:37:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:37:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:37:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:37:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:37:54 INFO - retry: Failed, sleeping 30 seconds before retrying 22:38:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 22:38:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:38:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:38:24 INFO - retry: Failed, sleeping 60 seconds before retrying 22:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 22:39:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:39:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:39:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 22:39:24 INFO - Caught exception: HTTP Error 404: Not Found 22:39:24 INFO - Caught exception: HTTP Error 404: Not Found 22:39:24 INFO - Caught exception: HTTP Error 404: Not Found 22:39:24 INFO - trying https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:39:24 INFO - Downloading https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:39:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:39:25 INFO - Downloaded 21771366 bytes. 22:39:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:39:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:39:26 INFO - Return code: 0 22:39:26 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:39:26 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')]} 22:39:26 INFO - https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:39:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:39:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:39:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:39:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:39:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:39:26 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:39:26 INFO - retry: Failed, sleeping 30 seconds before retrying 22:39:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 22:39:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:39:56 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:39:56 INFO - retry: Failed, sleeping 60 seconds before retrying 22:40:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 22:40:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:40:56 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:40:56 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 22:40:56 INFO - Caught exception: HTTP Error 404: Not Found 22:40:56 INFO - Caught exception: HTTP Error 404: Not Found 22:40:56 INFO - Caught exception: HTTP Error 404: Not Found 22:40:56 INFO - trying https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:40:56 INFO - Downloading https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:40:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:40:57 INFO - Downloaded 21771366 bytes. 22:40:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:40:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:40:58 INFO - Return code: 0 22:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:58 INFO - https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:40:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:40:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:40:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:40:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:40:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:40:58 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:40:58 INFO - retry: Failed, sleeping 30 seconds before retrying 22:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 22:41:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:41:28 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:41:28 INFO - retry: Failed, sleeping 60 seconds before retrying 22:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 22:42:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:42:28 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:42:28 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 22:42:28 INFO - Caught exception: HTTP Error 404: Not Found 22:42:28 INFO - Caught exception: HTTP Error 404: Not Found 22:42:28 INFO - Caught exception: HTTP Error 404: Not Found 22:42:28 INFO - trying https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:42:28 INFO - Downloading https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:42:29 INFO - Downloaded 14413740 bytes. 22:42:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:42:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:42:29 INFO - Return code: 0 22:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:42:29 INFO - https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:42:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:42:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:42:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:42:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:42:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:42:29 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:42:29 INFO - retry: Failed, sleeping 30 seconds before retrying 22:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 22:42:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:42:59 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:42:59 INFO - retry: Failed, sleeping 60 seconds before retrying 22:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 22:44:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:44:00 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:44:00 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 22:44:00 INFO - Caught exception: HTTP Error 404: Not Found 22:44:00 INFO - Caught exception: HTTP Error 404: Not Found 22:44:00 INFO - Caught exception: HTTP Error 404: Not Found 22:44:00 INFO - trying https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:44:00 INFO - Downloading https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:44:01 INFO - Downloaded 56774055 bytes. 22:44:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:44:01 INFO - mkdir: /builds/slave/test/properties 22:44:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:44:01 INFO - Writing to file /builds/slave/test/properties/build_url 22:44:01 INFO - Contents: 22:44:01 INFO - build_url:https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:44:01 INFO - Running post-action listener: _resource_record_post_action 22:44:01 INFO - Running post-action listener: set_extra_try_arguments 22:44:01 INFO - [mozharness: 2016-09-21 05:44:01.845333Z] Finished download-and-extract step (success) 22:44:01 INFO - [mozharness: 2016-09-21 05:44:01.845607Z] Running populate-webroot step. 22:44:01 INFO - Running pre-action listener: _resource_record_pre_action 22:44:01 INFO - Running main action method: populate_webroot 22:44:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:44:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:44:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:44:01 INFO - '--tppagecycles', 22:44:01 INFO - '7'], 22:44:01 INFO - 'tests': ['tsvgm']}}, 22:44:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:44:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:44:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:44:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:44:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:44:01 INFO - 'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:44:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:44:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:44:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:44:01 INFO - 'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['damp', 'tps']}, 22:44:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:44:01 INFO - 'tests': ['damp', 'tps']}, 22:44:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['dromaeo_dom']}, 22:44:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:44:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['basic_compositor_video']}, 22:44:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:44:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['a11yr', 22:44:01 INFO - 'ts_paint', 22:44:01 INFO - 'tpaint', 22:44:01 INFO - 'sessionrestore', 22:44:01 INFO - 'sessionrestore_no_auto_restore', 22:44:01 INFO - 'tabpaint']}, 22:44:01 INFO - 'other-e10s': {'tests': ['a11yr', 22:44:01 INFO - 'ts_paint', 22:44:01 INFO - 'tpaint', 22:44:01 INFO - 'sessionrestore', 22:44:01 INFO - 'sessionrestore_no_auto_restore', 22:44:01 INFO - 'tabpaint']}, 22:44:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:44:01 INFO - 'ts_paint', 22:44:01 INFO - 'tpaint', 22:44:01 INFO - 'sessionrestore', 22:44:01 INFO - 'sessionrestore_no_auto_restore', 22:44:01 INFO - 'tabpaint']}, 22:44:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:44:01 INFO - 'ts_paint', 22:44:01 INFO - 'tpaint', 22:44:01 INFO - 'sessionrestore', 22:44:01 INFO - 'sessionrestore_no_auto_restore', 22:44:01 INFO - 'tabpaint']}, 22:44:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['a11yr', 22:44:01 INFO - 'ts_paint', 22:44:01 INFO - 'tpaint', 22:44:01 INFO - 'sessionrestore', 22:44:01 INFO - 'sessionrestore_no_auto_restore', 22:44:01 INFO - 'tabpaint']}, 22:44:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['a11yr', 22:44:01 INFO - 'ts_paint', 22:44:01 INFO - 'tpaint', 22:44:01 INFO - 'sessionrestore', 22:44:01 INFO - 'sessionrestore_no_auto_restore', 22:44:01 INFO - 'tabpaint']}, 22:44:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['tsvgx', 22:44:01 INFO - 'tsvgr_opacity', 22:44:01 INFO - 'tart', 22:44:01 INFO - 'tscrollx', 22:44:01 INFO - 'cart']}, 22:44:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:44:01 INFO - 'tsvgr_opacity', 22:44:01 INFO - 'tart', 22:44:01 INFO - 'tscrollx', 22:44:01 INFO - 'cart']}, 22:44:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:44:01 INFO - 'talos_options': ['--disable-e10s'], 22:44:01 INFO - 'tests': ['tp5o']}, 22:44:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:44:01 INFO - 'tests': ['tp5o']}, 22:44:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:44:01 INFO - 'talos_options': ['--disable-e10s', 22:44:01 INFO - '--xperf_path', 22:44:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:44:01 INFO - 'tests': ['tp5n']}, 22:44:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:44:01 INFO - 'talos_options': ['--xperf_path', 22:44:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:44:01 INFO - 'tests': ['tp5n']}}, 22:44:01 INFO - 'talos.zip': {'path': '', 22:44:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:44:01 INFO - Running post-action listener: _resource_record_post_action 22:44:01 INFO - [mozharness: 2016-09-21 05:44:01.861304Z] Finished populate-webroot step (success) 22:44:01 INFO - [mozharness: 2016-09-21 05:44:01.861412Z] Running create-virtualenv step. 22:44:01 INFO - Running pre-action listener: _resource_record_pre_action 22:44:01 INFO - Running main action method: create_virtualenv 22:44:01 INFO - Creating virtualenv /builds/slave/test/build/venv 22:44:01 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 22:44:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:44:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:44:01 INFO - Using real prefix '/usr' 22:44:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:44:02 INFO - Installing distribute.............................................................................................................................................................................................done. 22:44:04 INFO - Installing pip.................done. 22:44:04 INFO - Return code: 0 22:44:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:44:04 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')]} 22:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:04 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')]} 22:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:04 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 0x1014030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1243400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', '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 22:44:04 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 22:44:04 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 22:44:04 INFO - Using env: {'DISPLAY': ':0', 22:44:04 INFO - 'HOME': '/home/cltbld', 22:44:04 INFO - 'LANG': 'en_US.UTF-8', 22:44:04 INFO - 'LANGUAGE': 'en_US:en', 22:44:04 INFO - 'LOGNAME': 'cltbld', 22:44:04 INFO - 'MAIL': '/var/mail/cltbld', 22:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:04 INFO - 'MOZ_NO_REMOTE': '1', 22:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:04 INFO - 'NO_EM_RESTART': '1', 22:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:04 INFO - 'PWD': '/builds/slave/test', 22:44:04 INFO - 'SHELL': '/bin/bash', 22:44:04 INFO - 'SHLVL': '1', 22:44:04 INFO - 'TERM': 'linux', 22:44:04 INFO - 'TMOUT': '86400', 22:44:04 INFO - 'USER': 'cltbld', 22:44:04 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:04 INFO - '_': '/tools/buildbot/bin/python'} 22:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:04 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 22:44:04 INFO - Cleaning up... 22:44:04 INFO - Return code: 0 22:44:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:44:04 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')]} 22:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:04 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')]} 22:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:04 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 0x1014030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1243400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', '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 22:44:04 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 22:44:04 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 22:44:04 INFO - Using env: {'DISPLAY': ':0', 22:44:04 INFO - 'HOME': '/home/cltbld', 22:44:04 INFO - 'LANG': 'en_US.UTF-8', 22:44:04 INFO - 'LANGUAGE': 'en_US:en', 22:44:04 INFO - 'LOGNAME': 'cltbld', 22:44:04 INFO - 'MAIL': '/var/mail/cltbld', 22:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:04 INFO - 'MOZ_NO_REMOTE': '1', 22:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:04 INFO - 'NO_EM_RESTART': '1', 22:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:04 INFO - 'PWD': '/builds/slave/test', 22:44:04 INFO - 'SHELL': '/bin/bash', 22:44:04 INFO - 'SHLVL': '1', 22:44:04 INFO - 'TERM': 'linux', 22:44:04 INFO - 'TMOUT': '86400', 22:44:04 INFO - 'USER': 'cltbld', 22:44:04 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:04 INFO - '_': '/tools/buildbot/bin/python'} 22:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:04 INFO - Downloading/unpacking psutil>=3.1.1 22:44: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 22:44: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 22:44: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 22:44: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 22:44: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 22:44: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 22:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:44:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:44:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:44:06 INFO - Installing collected packages: psutil 22:44:06 INFO - Running setup.py install for psutil 22:44:06 INFO - building 'psutil._psutil_linux' extension 22:44:06 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 22:44:07 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 22:44:07 INFO - building 'psutil._psutil_posix' extension 22:44:07 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 22:44:07 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 22:44:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:44:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:44:07 INFO - Successfully installed psutil 22:44:07 INFO - Cleaning up... 22:44:07 INFO - Return code: 0 22:44:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:44:07 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')]} 22:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:07 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')]} 22:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:07 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 0x1014030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1243400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', '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 22:44:07 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 22:44:07 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 22:44:07 INFO - Using env: {'DISPLAY': ':0', 22:44:07 INFO - 'HOME': '/home/cltbld', 22:44:07 INFO - 'LANG': 'en_US.UTF-8', 22:44:07 INFO - 'LANGUAGE': 'en_US:en', 22:44:07 INFO - 'LOGNAME': 'cltbld', 22:44:07 INFO - 'MAIL': '/var/mail/cltbld', 22:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:07 INFO - 'MOZ_NO_REMOTE': '1', 22:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:07 INFO - 'NO_EM_RESTART': '1', 22:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:07 INFO - 'PWD': '/builds/slave/test', 22:44:07 INFO - 'SHELL': '/bin/bash', 22:44:07 INFO - 'SHLVL': '1', 22:44:07 INFO - 'TERM': 'linux', 22:44:07 INFO - 'TMOUT': '86400', 22:44:07 INFO - 'USER': 'cltbld', 22:44:07 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:07 INFO - '_': '/tools/buildbot/bin/python'} 22:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:44:07 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 22:44:07 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 22:44:07 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 22:44:07 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 22:44:07 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 22:44:07 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 22:44:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:44:09 INFO - Installing collected packages: mozsystemmonitor 22:44:09 INFO - Running setup.py install for mozsystemmonitor 22:44:09 INFO - Successfully installed mozsystemmonitor 22:44:09 INFO - Cleaning up... 22:44:09 INFO - Return code: 0 22:44:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:44: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')]} 22:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44: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')]} 22:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1014030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1243400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', '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 22:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:44:09 INFO - Using env: {'DISPLAY': ':0', 22:44:09 INFO - 'HOME': '/home/cltbld', 22:44:09 INFO - 'LANG': 'en_US.UTF-8', 22:44:09 INFO - 'LANGUAGE': 'en_US:en', 22:44:09 INFO - 'LOGNAME': 'cltbld', 22:44:09 INFO - 'MAIL': '/var/mail/cltbld', 22:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:09 INFO - 'MOZ_NO_REMOTE': '1', 22:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:09 INFO - 'NO_EM_RESTART': '1', 22:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:09 INFO - 'PWD': '/builds/slave/test', 22:44:09 INFO - 'SHELL': '/bin/bash', 22:44:09 INFO - 'SHLVL': '1', 22:44:09 INFO - 'TERM': 'linux', 22:44:09 INFO - 'TMOUT': '86400', 22:44:09 INFO - 'USER': 'cltbld', 22:44:09 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:09 INFO - '_': '/tools/buildbot/bin/python'} 22:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:09 INFO - Downloading/unpacking jsonschema==2.5.1 22:44:09 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 22:44:09 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 22:44:09 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 22:44:09 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 22:44:09 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 22:44:09 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 22:44:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:44:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:44:11 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 22:44:11 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 22:44:11 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 22:44:11 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 22:44:11 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 22:44:11 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 22:44:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:44:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:44:12 INFO - warning: no files found matching '*.txt' 22:44:12 INFO - no previously-included directories found matching 'build' 22:44:12 INFO - no previously-included directories found matching 'dist' 22:44:12 INFO - no previously-included directories found matching '.git*' 22:44:12 INFO - Installing collected packages: jsonschema, functools32 22:44:12 INFO - Running setup.py install for functools32 22:44:12 INFO - warning: no files found matching '*.txt' 22:44:12 INFO - no previously-included directories found matching 'build' 22:44:12 INFO - no previously-included directories found matching 'dist' 22:44:12 INFO - no previously-included directories found matching '.git*' 22:44:12 INFO - Successfully installed jsonschema functools32 22:44:12 INFO - Cleaning up... 22:44:12 INFO - Return code: 0 22:44:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1014030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1243400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', '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 22:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:44:12 INFO - Using env: {'DISPLAY': ':0', 22:44:12 INFO - 'HOME': '/home/cltbld', 22:44:12 INFO - 'LANG': 'en_US.UTF-8', 22:44:12 INFO - 'LANGUAGE': 'en_US:en', 22:44:12 INFO - 'LOGNAME': 'cltbld', 22:44:12 INFO - 'MAIL': '/var/mail/cltbld', 22:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:12 INFO - 'MOZ_NO_REMOTE': '1', 22:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:12 INFO - 'NO_EM_RESTART': '1', 22:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:12 INFO - 'PWD': '/builds/slave/test', 22:44:12 INFO - 'SHELL': '/bin/bash', 22:44:12 INFO - 'SHLVL': '1', 22:44:12 INFO - 'TERM': 'linux', 22:44:12 INFO - 'TMOUT': '86400', 22:44:12 INFO - 'USER': 'cltbld', 22:44:12 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:12 INFO - '_': '/tools/buildbot/bin/python'} 22:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:44:12 INFO - Cleaning up... 22:44:12 INFO - Return code: 0 22:44:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1014030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1243400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', '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 22:44:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:44:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:44:12 INFO - Using env: {'DISPLAY': ':0', 22:44:12 INFO - 'HOME': '/home/cltbld', 22:44:12 INFO - 'LANG': 'en_US.UTF-8', 22:44:12 INFO - 'LANGUAGE': 'en_US:en', 22:44:12 INFO - 'LOGNAME': 'cltbld', 22:44:12 INFO - 'MAIL': '/var/mail/cltbld', 22:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:12 INFO - 'MOZ_NO_REMOTE': '1', 22:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:12 INFO - 'NO_EM_RESTART': '1', 22:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:12 INFO - 'PWD': '/builds/slave/test', 22:44:12 INFO - 'SHELL': '/bin/bash', 22:44:12 INFO - 'SHLVL': '1', 22:44:12 INFO - 'TERM': 'linux', 22:44:12 INFO - 'TMOUT': '86400', 22:44:12 INFO - 'USER': 'cltbld', 22:44:12 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:12 INFO - '_': '/tools/buildbot/bin/python'} 22:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:12 INFO - Downloading/unpacking blobuploader==1.2.4 22:44:12 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 22:44:12 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 22:44:12 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 22:44:12 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 22:44:12 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 22:44:12 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 22:44:14 INFO - Downloading blobuploader-1.2.4.tar.gz 22:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:44:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:44:14 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 22:44:14 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 22:44:14 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 22:44:14 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 22:44:14 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 22:44:14 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 22:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:44:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:15 INFO - Downloading docopt-0.6.1.tar.gz 22:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:44:15 INFO - Installing collected packages: blobuploader, requests, docopt 22:44:15 INFO - Running setup.py install for blobuploader 22:44:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:44:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:44:15 INFO - Running setup.py install for requests 22:44:15 INFO - Running setup.py install for docopt 22:44:15 INFO - Successfully installed blobuploader requests docopt 22:44:15 INFO - Cleaning up... 22:44:15 INFO - Return code: 0 22:44:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:15 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 0x1014030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1243400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', '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 22:44:15 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 22:44:15 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 22:44:15 INFO - Using env: {'DISPLAY': ':0', 22:44:15 INFO - 'HOME': '/home/cltbld', 22:44:15 INFO - 'LANG': 'en_US.UTF-8', 22:44:15 INFO - 'LANGUAGE': 'en_US:en', 22:44:15 INFO - 'LOGNAME': 'cltbld', 22:44:15 INFO - 'MAIL': '/var/mail/cltbld', 22:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:15 INFO - 'MOZ_NO_REMOTE': '1', 22:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:15 INFO - 'NO_EM_RESTART': '1', 22:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:15 INFO - 'PWD': '/builds/slave/test', 22:44:15 INFO - 'SHELL': '/bin/bash', 22:44:15 INFO - 'SHLVL': '1', 22:44:15 INFO - 'TERM': 'linux', 22:44:15 INFO - 'TMOUT': '86400', 22:44:15 INFO - 'USER': 'cltbld', 22:44:15 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:15 INFO - '_': '/tools/buildbot/bin/python'} 22:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:44:16 INFO - Running setup.py (path:/tmp/pip-EqXmMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:44:16 INFO - Running setup.py (path:/tmp/pip-da7YT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:44:16 INFO - Running setup.py (path:/tmp/pip-XZVpvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:44:16 INFO - Running setup.py (path:/tmp/pip-Wlm6Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:44:16 INFO - Running setup.py (path:/tmp/pip-RDz8le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:44:16 INFO - Running setup.py (path:/tmp/pip-R05hDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:44:16 INFO - Running setup.py (path:/tmp/pip-PnT3nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:44:16 INFO - Running setup.py (path:/tmp/pip-F9Sy9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:44:16 INFO - Running setup.py (path:/tmp/pip-letabh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:44:16 INFO - Running setup.py (path:/tmp/pip-FqWKKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:44:16 INFO - Running setup.py (path:/tmp/pip-yFn7GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:44:16 INFO - Running setup.py (path:/tmp/pip-g9OuSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:44:17 INFO - Running setup.py (path:/tmp/pip-20DjTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:44:17 INFO - Running setup.py (path:/tmp/pip-avkd3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:44:17 INFO - Running setup.py (path:/tmp/pip-gA14nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:44:17 INFO - Running setup.py (path:/tmp/pip-tHQwi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:44:17 INFO - Running setup.py (path:/tmp/pip-LYqsR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:44:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:44:17 INFO - Running setup.py install for manifestparser 22:44:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:44:17 INFO - Running setup.py install for mozcrash 22:44:17 INFO - Running setup.py install for mozdebug 22:44:17 INFO - Running setup.py install for mozdevice 22:44:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:44:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:44:17 INFO - Running setup.py install for mozfile 22:44:17 INFO - Running setup.py install for mozhttpd 22:44:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:44:17 INFO - Running setup.py install for mozinfo 22:44:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Running setup.py install for mozInstall 22:44:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Running setup.py install for mozleak 22:44:18 INFO - Running setup.py install for mozlog 22:44:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Running setup.py install for moznetwork 22:44:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Running setup.py install for mozprocess 22:44:18 INFO - Running setup.py install for mozprofile 22:44:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Running setup.py install for mozrunner 22:44:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:44:18 INFO - Running setup.py install for mozscreenshot 22:44:18 INFO - Running setup.py install for moztest 22:44:19 INFO - Running setup.py install for mozversion 22:44:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:44:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:44:19 INFO - Cleaning up... 22:44:19 INFO - Return code: 0 22:44:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:44: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')]} 22:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44: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')]} 22:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:19 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 0x1014030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1243400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', '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 22:44:19 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 22:44:19 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 22:44:19 INFO - Using env: {'DISPLAY': ':0', 22:44:19 INFO - 'HOME': '/home/cltbld', 22:44:19 INFO - 'LANG': 'en_US.UTF-8', 22:44:19 INFO - 'LANGUAGE': 'en_US:en', 22:44:19 INFO - 'LOGNAME': 'cltbld', 22:44:19 INFO - 'MAIL': '/var/mail/cltbld', 22:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:19 INFO - 'MOZ_NO_REMOTE': '1', 22:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:19 INFO - 'NO_EM_RESTART': '1', 22:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:19 INFO - 'PWD': '/builds/slave/test', 22:44:19 INFO - 'SHELL': '/bin/bash', 22:44:19 INFO - 'SHLVL': '1', 22:44:19 INFO - 'TERM': 'linux', 22:44:19 INFO - 'TMOUT': '86400', 22:44:19 INFO - 'USER': 'cltbld', 22:44:19 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:19 INFO - '_': '/tools/buildbot/bin/python'} 22:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:44:19 INFO - Running setup.py (path:/tmp/pip-cknr_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:44:19 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)) 22:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:44:19 INFO - Running setup.py (path:/tmp/pip-lJRc83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:44:19 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)) 22:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:44:19 INFO - Running setup.py (path:/tmp/pip-upbtfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:44:19 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)) 22:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:44:19 INFO - Running setup.py (path:/tmp/pip-a3VzJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:44:19 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)) 22:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:44:19 INFO - Running setup.py (path:/tmp/pip-9pCcuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:44:19 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)) 22:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:44:19 INFO - Running setup.py (path:/tmp/pip-labY6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:44:19 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)) 22:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:44:19 INFO - Running setup.py (path:/tmp/pip-ofveXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:44:19 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)) 22:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:44:19 INFO - Running setup.py (path:/tmp/pip-DpgdAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:44:19 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)) 22:44:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:44:19 INFO - Running setup.py (path:/tmp/pip-ms4PGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:44:20 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)) 22:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:44:20 INFO - Running setup.py (path:/tmp/pip-pVW6CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:44:20 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)) 22:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:44:20 INFO - Running setup.py (path:/tmp/pip-DFmBKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:44:20 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)) 22:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:44:20 INFO - Running setup.py (path:/tmp/pip-vKMKv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:44:20 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)) 22:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:44:20 INFO - Running setup.py (path:/tmp/pip-ENlmUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:44:20 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)) 22:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:44:20 INFO - Running setup.py (path:/tmp/pip-Jg6W3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:44:20 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)) 22:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:44:20 INFO - Running setup.py (path:/tmp/pip-zePyUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:44:20 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)) 22:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:44:20 INFO - Running setup.py (path:/tmp/pip-odZcHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:44:20 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)) 22:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:44:20 INFO - Running setup.py (path:/tmp/pip-79WI1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:44:20 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)) 22:44:20 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)) 22:44:20 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)) 22:44:20 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)) 22:44:20 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)) 22:44:20 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)) 22:44:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:22 INFO - Downloading blessings-1.6.tar.gz 22:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:44:22 INFO - Installing collected packages: blessings 22:44:22 INFO - Running setup.py install for blessings 22:44:22 INFO - Successfully installed blessings 22:44:22 INFO - Cleaning up... 22:44:22 INFO - Return code: 0 22:44:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:44:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:44:22 INFO - Reading from file tmpfile_stdout 22:44:22 INFO - Current package versions: 22:44:22 INFO - argparse == 1.2.1 22:44:22 INFO - blessings == 1.6 22:44:22 INFO - blobuploader == 1.2.4 22:44:22 INFO - docopt == 0.6.1 22:44:22 INFO - functools32 == 3.2.3-2 22:44:22 INFO - jsonschema == 2.5.1 22:44:22 INFO - manifestparser == 1.1 22:44:22 INFO - mozInstall == 1.12 22:44:22 INFO - mozcrash == 0.17 22:44:22 INFO - mozdebug == 0.1 22:44:22 INFO - mozdevice == 0.48 22:44:22 INFO - mozfile == 1.2 22:44:22 INFO - mozhttpd == 0.7 22:44:22 INFO - mozinfo == 0.9 22:44:22 INFO - mozleak == 0.1 22:44:22 INFO - mozlog == 3.3 22:44:22 INFO - moznetwork == 0.27 22:44:22 INFO - mozprocess == 0.23 22:44:22 INFO - mozprofile == 0.28 22:44:22 INFO - mozrunner == 6.12 22:44:22 INFO - mozscreenshot == 0.1 22:44:22 INFO - mozsystemmonitor == 0.3 22:44:22 INFO - moztest == 0.7 22:44:22 INFO - mozversion == 1.4 22:44:22 INFO - psutil == 3.1.1 22:44:22 INFO - requests == 1.2.3 22:44:22 INFO - wsgiref == 0.1.2 22:44:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:44:22 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')]} 22:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:22 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')]} 22:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:22 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 0x1014030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1243400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', '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 22:44:22 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 22:44:22 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 22:44:22 INFO - Using env: {'DISPLAY': ':0', 22:44:22 INFO - 'HOME': '/home/cltbld', 22:44:22 INFO - 'LANG': 'en_US.UTF-8', 22:44:22 INFO - 'LANGUAGE': 'en_US:en', 22:44:22 INFO - 'LOGNAME': 'cltbld', 22:44:22 INFO - 'MAIL': '/var/mail/cltbld', 22:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:22 INFO - 'MOZ_NO_REMOTE': '1', 22:44:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:22 INFO - 'NO_EM_RESTART': '1', 22:44:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:22 INFO - 'PWD': '/builds/slave/test', 22:44:22 INFO - 'SHELL': '/bin/bash', 22:44:22 INFO - 'SHLVL': '1', 22:44:22 INFO - 'TERM': 'linux', 22:44:22 INFO - 'TMOUT': '86400', 22:44:22 INFO - 'USER': 'cltbld', 22:44:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:22 INFO - '_': '/tools/buildbot/bin/python'} 22:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:23 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)) 22:44:23 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)) 22:44:23 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)) 22:44:23 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)) 22:44:23 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)) 22:44:23 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)) 22:44:23 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)) 22:44:23 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)) 22:44:23 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)) 22:44:23 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)) 22:44:23 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)) 22:44:23 INFO - Cleaning up... 22:44:23 INFO - Return code: 0 22:44:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:44:23 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')]} 22:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:23 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')]} 22:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:23 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 0x1014030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1243400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', '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 22:44:23 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 22:44:23 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 22:44:23 INFO - Using env: {'DISPLAY': ':0', 22:44:23 INFO - 'HOME': '/home/cltbld', 22:44:23 INFO - 'LANG': 'en_US.UTF-8', 22:44:23 INFO - 'LANGUAGE': 'en_US:en', 22:44:23 INFO - 'LOGNAME': 'cltbld', 22:44:23 INFO - 'MAIL': '/var/mail/cltbld', 22:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:23 INFO - 'MOZ_NO_REMOTE': '1', 22:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:23 INFO - 'NO_EM_RESTART': '1', 22:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:23 INFO - 'PWD': '/builds/slave/test', 22:44:23 INFO - 'SHELL': '/bin/bash', 22:44:23 INFO - 'SHLVL': '1', 22:44:23 INFO - 'TERM': 'linux', 22:44:23 INFO - 'TMOUT': '86400', 22:44:23 INFO - 'USER': 'cltbld', 22:44:23 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:23 INFO - '_': '/tools/buildbot/bin/python'} 22:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:44:23 INFO - Cleaning up... 22:44:23 INFO - Return code: 0 22:44:23 INFO - Running post-action listener: _resource_record_post_action 22:44:23 INFO - Running post-action listener: _start_resource_monitoring 22:44:23 INFO - Starting resource monitoring. 22:44:23 INFO - [mozharness: 2016-09-21 05:44:23.428583Z] Finished create-virtualenv step (success) 22:44:23 INFO - [mozharness: 2016-09-21 05:44:23.429007Z] Running install step. 22:44:23 INFO - Running pre-action listener: _resource_record_pre_action 22:44:23 INFO - Running main action method: install 22:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:44:23 INFO - Reading from file tmpfile_stdout 22:44:23 INFO - Detecting whether we're running mozinstall >=1.0... 22:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:44:23 INFO - Reading from file tmpfile_stdout 22:44:23 INFO - Output received: 22:44:23 INFO - Usage: mozinstall [options] installer 22:44:23 INFO - Options: 22:44:23 INFO - -h, --help show this help message and exit 22:44:23 INFO - -d DEST, --destination=DEST 22:44:23 INFO - Directory to install application into. [default: 22:44:23 INFO - "/builds/slave/test"] 22:44:23 INFO - --app=APP Application being installed. [default: firefox] 22:44:23 INFO - mkdir: /builds/slave/test/build/application 22:44:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:44:37 INFO - Reading from file tmpfile_stdout 22:44:37 INFO - Output received: 22:44:37 INFO - /builds/slave/test/build/application/firefox/firefox 22:44:37 INFO - Running post-action listener: _resource_record_post_action 22:44:37 INFO - [mozharness: 2016-09-21 05:44:37.741462Z] Finished install step (success) 22:44:37 INFO - [mozharness: 2016-09-21 05:44:37.741736Z] Running run-tests step. 22:44:37 INFO - Running pre-action listener: _resource_record_pre_action 22:44:37 INFO - Running main action method: run_tests 22:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:44:37 INFO - Python 2.7.3 22:44:37 INFO - Return code: 0 22:44:37 INFO - grabbing minidump binary from tooltool 22:44:37 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')]} 22:44:37 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 0x12d2570>, '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 0x12d3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d3900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:44:37 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 22:44:37 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 22:44:37 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 22:44:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:44:37 INFO - Return code: 0 22:44:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:44:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:44:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:44:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:44:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 22:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 22:44:37 INFO - Using env: {'DISPLAY': ':0', 22:44:37 INFO - 'HOME': '/home/cltbld', 22:44:37 INFO - 'LANG': 'en_US.UTF-8', 22:44:37 INFO - 'LANGUAGE': 'en_US:en', 22:44:37 INFO - 'LOGNAME': 'cltbld', 22:44:37 INFO - 'MAIL': '/var/mail/cltbld', 22:44:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:44:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:37 INFO - 'MOZ_NO_REMOTE': '1', 22:44:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:37 INFO - 'NO_EM_RESTART': '1', 22:44:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:44:37 INFO - 'PWD': '/builds/slave/test', 22:44:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:44:37 INFO - 'SHELL': '/bin/bash', 22:44:37 INFO - 'SHLVL': '1', 22:44:37 INFO - 'TERM': 'linux', 22:44:37 INFO - 'TMOUT': '86400', 22:44:37 INFO - 'USER': 'cltbld', 22:44:37 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660', 22:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:37 INFO - '_': '/tools/buildbot/bin/python'} 22:44:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 22:44:38 INFO - mozversion application_buildid: 20160920195135 22:44:38 INFO - mozversion application_changeset: 91faf7ec36cd18a8ebdc0e2edac966e5bbb15da2 22:44:38 INFO - mozversion application_display_name: Firefox 22:44:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:44:38 INFO - mozversion application_name: Firefox 22:44:38 INFO - mozversion application_remotingname: firefox 22:44:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:44:38 INFO - mozversion application_vendor: Mozilla 22:44:38 INFO - mozversion application_version: 50.0 22:44:38 INFO - mozversion platform_buildid: 20160920195135 22:44:38 INFO - mozversion platform_changeset: 91faf7ec36cd18a8ebdc0e2edac966e5bbb15da2 22:44:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:44:38 INFO - mozversion platform_version: 50.0 22:44:38 INFO - using testdate: 1474436678 22:44:38 INFO - actual date: 1474436678 22:44:38 INFO - starting webserver on 'localhost:41731' 22:44:38 INFO - SUITE-START | Running 2 tests 22:44:38 INFO - TEST-START | dromaeo_css 22:44:38 INFO - operating with platform_type : linux_ 22:44:38 INFO - Initialising browser for dromaeo_css test... 22:44:38 INFO - TEST-INFO | started process 1109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptO6_bE/profile http://localhost:41731/getInfo.html) 22:44:42 INFO - PROCESS | 1109 | __metrics Screen width/height:1600/1200 22:44:42 INFO - PROCESS | 1109 | colorDepth:24 22:44:42 INFO - PROCESS | 1109 | Browser inner width/height: 1024/697 22:44:42 INFO - PROCESS | 1109 | __metrics 22:44:42 ERROR - PROCESS | 1109 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:44:43 INFO - TEST-INFO | 1109: exit 0 22:44:43 INFO - Browser initialized. 22:44:43 INFO - Running cycle 1/1 for dromaeo_css test... 22:44:43 INFO - TEST-INFO | started process 1311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptO6_bE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:44:55 INFO - PROCESS | 1311 | RSS: Main: 149786624 22:44:55 INFO - PROCESS | 1311 | 22:45:44 INFO - PROCESS | 1311 | 1474436744965 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] 22:47:53 INFO - PROCESS | 1311 | Cycle 1(1): loaded http://localhost:41731/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41731/tests/dromaeo/cssquery-ext.html) 22:47:54 INFO - PROCESS | 1311 | RSS: Main: 157642752 22:47:54 INFO - PROCESS | 1311 | 22:50:56 INFO - PROCESS | 1311 | Cycle 1(1): loaded http://localhost:41731/tests/dromaeo/cssquery-ext.html (next: http://localhost:41731/tests/dromaeo/cssquery-jquery.html) 22:50:57 INFO - PROCESS | 1311 | RSS: Main: 155090944 22:50:57 INFO - PROCESS | 1311 | 22:53:59 INFO - PROCESS | 1311 | Cycle 1(1): loaded http://localhost:41731/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41731/tests/dromaeo/cssquery-mootools.html) 22:53:59 INFO - PROCESS | 1311 | RSS: Main: 154423296 22:53:59 INFO - PROCESS | 1311 | 22:57:01 INFO - PROCESS | 1311 | Cycle 1(1): loaded http://localhost:41731/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41731/tests/dromaeo/cssquery-prototype.html) 22:57:01 INFO - PROCESS | 1311 | RSS: Main: 155803648 22:57:01 INFO - PROCESS | 1311 | 23:00:04 INFO - PROCESS | 1311 | Cycle 1(1): loaded http://localhost:41731/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41731/tests/dromaeo/cssquery-yui.html) 23:00:05 INFO - PROCESS | 1311 | RSS: Main: 157057024 23:00:05 INFO - PROCESS | 1311 | 23:03:07 INFO - PROCESS | 1311 | Cycle 1(1): loaded http://localhost:41731/tests/dromaeo/cssquery-yui.html (next: http://localhost:41731/tests/dromaeo/cssquery-dojo.html) 23:03:07 INFO - PROCESS | 1311 | RSS: Main: 156868608 23:03:07 INFO - PROCESS | 1311 | 23:03:07 INFO - PROCESS | 1311 | __start_tp_report 23:03:07 INFO - PROCESS | 1311 | _x_x_mozilla_page_load 23:03:07 INFO - PROCESS | 1311 | _x_x_mozilla_page_load_details 23:03:07 INFO - PROCESS | 1311 | |i|pagename|runs| 23:03:07 INFO - PROCESS | 1311 | |0;dojo.html;3280.097973057409;3300.6864347886944;3303.223742420531;3320.767546271759;3329.084501762015;5682;5741.827745167641;5755.021646320125;5769.538436925046;5791.768329266824;5711.228984087147;5743.4543718346695;5748.310202775662;5763.106718458635;5764.682942438164;5233.293505376773;5238.5023422774775;5239.397469291042;5240.816571420001;5304.177852432879;5083.517065878754;5097.184450487923;5135.794568217267;5149.459306772791;5234.241035049916;5224.895502089956;5247.2653828464045;5253.106971814801;5264.631475796696;5320.973395133019;5258.106121959257;5318.494742999447;5319.361676598814;5319.9734001330135;5343.198520221959;5049.5455409013;5060.165072762989;5088.338515992934;5202;5215.478452154792;5643.887122257532;5664.2636457260705;5686.943130568683;5691;5715.257016587859;6086.60437071589;6111.35830737775;6138.17134686816;6144.385561443864;6144.600600960924;5987.251593550806;6075.088736689488;6122.54080943931;6184.257889053342;6192.628442293477;5754.539636829044;5764.654120752768;5792.594518383715;5807.767689292423;5821;6291.591046581958;6301.054841773679;6306.400891915261;6327.683615819191;6338.112664227012;5856.443637854397;5973.820785376446;5989.401059894063;6069.787557435468;6088.695565221721;6130.785422510191;6146.907796383058;6156.384361563808;6161.537884658668;6166.260048794174;6099.303536277131;6103.755849766048;6105.938940610626;6137.508999280047;6138.846528836815;5930.584859059911;5931.822045338647;5955.225820643375;6069.544784141207;6145.661988590581;4620.53794620542;4621.214393553104;4625.861224163281;4641.466231383367;4642.582167604932;4123.711340206157;4131.752094874257;4132.235536425771;4152.045029643138;4160.54234034256;5771.740271687784;5821.388754180834;5831.737571809279;5831.88336233273;5853.970730146407;6181.567290289637;6205.410486003822;6213.565050446426;6225.159603453566;6228.096925945712;5871.5908182036;5920.467157955719;5920.79277225295;5950.9702451487465;5973.1338955852025;5181.974090129525;5250.422453530108;5327.840164795062;5341.519263266325;5342.465753424626;6452.22573291208;6466.094746735461;6467.223933128054;6468.870622587616;6471.417572418411;6180.258368995749;6184.319724830355;6228.906566401417;6233.875322493434;6235.127082208585;6193.628382297076;6253.718582663882;6293.307736149111;6315.052742088724;6437.742490300523;6003.0695242237525;6015.187949626745;6026.517878569616;6033.698315084316;6041.24484439445;6112.419320164578;6113.388661133851;6128.4790792783115;6130.2030736004035;6132.202813634199;5838.474537291664;5933.2880054393745;5943.91084133747;5968.4926781224085;6008.669523176267;6013;6061.6666083365835;6080;6084.269887613515;6113.51091912637;5922.3485416605;5939.10913362999;5953.464188223081;5954.3152537458745;5978.8206353809455;5841.824745257649;5925;5955.40445955401;5977.581569290108;6061.999770037894;5838.795642152504;5851.941480585139;5855.121731740273;5865.882682346414;5890.7349169288345 23:03:07 INFO - PROCESS | 1311 | |1;ext.html;583.2272239282951;637.6301744987908;659.482306389484;666.1306994372345;698.5145323999823;41473.79263103684;45822.770886145525;46078.76960615197;46141.07717845641;46209;46760.53239467604;46964.76517617416;47251;47254.527454725445;47342.52657473424;9125.269978401746;9200.907990920106;9235.215006724437;9254.398464099846;9269.582868770922;9245.399049061823;9267.95366023169;9302;9324.393914395576;9354.625814967394;9249.768755781126;9281.535923203814;9291.76770580734;9292.674756383529;9296.302777291696;9262.814743705121;9296.116868897443;9301.581428835718;9309.674161404353;9321.394109382869;9090.454572725657;9197.908020919773;9206.677766278148;9208.12522810332;9217.308701847389;43369.56630433687;43661.12677746459;43708;43750.78124609389;43827.78086109581;3527.3121741260466;3668.394714872043;3740.3454395480953;4235.131797981407;4370.519242883281;33635.15912102193;33973.830130849434;34077.48883766746;34153;36141.096472588135;4487.551244875519;4594.402727645418;4660.37084993525;4692.4603670577635;4713.26944323627;390069;391474.99999999715;391594;391770;393303.0334848336;37866.62133378686;38755;38810.80594597009;61664.69167654223;61957.07064394038;40765.38851917224;40889.59110408858;40975;40980.79509602492;41088.79455602703;15972.920135399248;16116.435924742578;16227.432039878548;16259.51221463358;16306.836931630769;14068.155910645393;14106.224157671222;14107.858921410654;14141.646458838406;14147.151170929777;9229.077092290718;9232.584533696;9240.122188392092;9275.860862087075;9293.210077143383;3580.427131658922;3582.408902531053;3599.9280014400088;3619.6199399063244;3627.05696518907;1070.3310430980637;1089.7057794395469;1101.2236373356764;1151.694800877768;1177.5466445418576;33493.665063349545;33747.65009399645;34135.14662133417;34179.82910085483;34396.82801585976;1157.4751951874384;1210.0414486580403;1224.6632176151452;1285.762134005212;1286.0547497589264;17601.7359739604;17611.119444027747;17796.288148473915;17990.640187196444;18113.818861811214;632300;632774;634147;635639;636323;62047.6897615509;62624.373756261855;62847.37152628507;62886;62964.685176573825;1452.1287227663317;1454.3746189138772;1462.341946124227;1486.167746062187;1489.5307977987115;32713.34573308568;32814.83592582022;33217.501737473474;33380.734604083125;33417;54503.18245226245;54581.45418545764;54619;54962.72518637381;55116;530839;532118;533574;533852;534428;30462;30693;31763.205919851265;31783.84108079445;32801.83599081989;50380.24429633485;51054.744726276134;51472.74263628658;51857;52627;43500.564994349654;43873.56126438823;44760.32859507045;44888.77555612331;46206.30690539712;43297.350539741296;43500;44044.11911761683;46644.06711865812;48489;38538;42548.36177457403;43542.346864797684;44307;45698;37966.43050354302;38900.221995560496;39033.609663903;39721.60278397179;39825.40261896132;29731.405371892008;29909.252268693457;30322.84838575881;30365.24086897757;30625.387492249585 23:03:07 INFO - PROCESS | 1311 | |2;jquery.html;428.5140382984425;430.32009425108333;438.460693347183;443.357360977578;450.2593234129856;19352.806471935295;20099.29652462164;20579.485512862186;20708.068136933838;20727.792722072776;19340.51648708783;20278.391648250537;20894.791052089473;20982.475438114056;21075.156993720233;5796.8260952171395;6033.064874944369;6044.123602077696;6054.061620448838;6063.242094738158;5709.857253568653;5940.61386009908;5968.31364393096;5987.760489580412;6056.697165141747;6022.578419510636;6025.517958563304;6043.244594425697;6077.665728384937;6079.148919151322;6116.143739876421;6211.844703882439;6221.937780622181;6254.7185376657935;6274.968625156868;5842.649441033552;5959.761609535613;5965.880682386328;5985.760569577212;5992.041273396279;15350.155741434217;15917.52247432579;23995.400114997265;24704.258872233862;24951;2373.572756903774;2399.8800059997106;2473.9257822265363;2480.6155045967726;2749.2714430675887;10901.454927253684;11351.262167959056;11371;11407.372594507298;11418.942905285503;1985.5036240939764;2042.7242322286597;2047.1504325704814;2050.661640829276;2110.145391116585;68916;76964.61517692432;79801.60099199525;80639;88578.11421885763;11649;12033.217840840492;12049.108214028745;12145.906868381888;12454.688632784071;17304.913475432793;17323.65352692939;17323.913380433016;17359.65280694379;17389.65220695604;8948.8657670135;8973.865392019125;9036.277097832157;9043.819123617623;9447.716568502956;8872.689455869013;8934.4192627479;8973.50645714492;9049.954750226338;9081.046490118442;5057.873553161126;5215.713135777492;5272.759077392169;5293.629445938747;5388.7305634718105;2112.36629011296;2128.872267663945;2150.8064274215394;2181.7454963396112;2200.3728937253127;963;1017.9032991865761;1026.1277913773233;1074.793070020637;1108.224243029866;20347.59304813925;20663.793362066488;20989.47526311824;21048;21159.25942592002;1042.99478502607;1087.2932593814085;1093.9288946218471;1110.8278216876397;1124.5108377855659;11330.150238732129;11505.654830355103;11662.94168529169;11710.180287379802;11818.527258909719;502075;509630;524629;559440;560309;95905.5204723972;98074;98160.50919745356;99327;100314.4984275074;1010.6361709784471;1016.1210552871861;1038.408107378802;1040.0275742181084;1040.54216144896;18135.093245337415;18207.635847282716;18505.444836654922;18536.25854965786;18940.905295473436;44263.778681106385;44418;44621.55378446174;44744.105117898114;46240.8439789008;62391.6880415595;62575;63031;63376.68311658412;63673.68163159154;9333.67332143399;9390.295727820305;9480.146786788946;9491.430514169171;9617.79777527809;11139;14104.647383815487;14214.147151170962;14299.499517516837;14406;12053.63839084829;12116.636500904988;12324.32216228116;12700.729927007225;12990.350482476028;11628.88371116278;11977.520899163936;12013.279203247834;12275;12356.443960022001;12325.691857703629;12507.687307817378;12515.186512876633;12522.622511523907;12563.685907852012;9110.362274640976;9201.631934722804;9246.630134794803;9473.57368918414;9526.523673816142;9410.38832475887;12089.093318001362;12206.511739530319;12215.389230538616;12308.938455308024 23:03:07 INFO - PROCESS | 1311 | |3;mootools.html;1555.6110972256936;1563.2105786577772;1749.8512626426752;1854.5734481069353;1881.9059047047645;8162.673493060285;8961.641534338618;9023.872015998;9738.074882886123;9742.659006934759;9051.547422628875;9319.813603727922;9325.720228393158;9406.71779846604;9425.81148377032;2517.043523461087;2557.3350928758473;2560.8463492190526;2565.6664633597607;2566.153169454076;2478.3804048987754;2531.784798292138;2544.8345857519294;2548.6941567011986;2549.4518678484123;2526.2673824590847;2531.7974562035083;2533.5946248600226;2534.961975570368;2543.9491210175784;2434.026389444228;2454.0797201049604;2477.1206221791276;2517.622356646499;2518.0431436054364;2444.132333021769;2461.064795377745;2461.101697880261;2463.987680061606;2512.899484020637;9534.237261019101;9577.23382129428;9584.5686944087;9587.472689002103;9597.616095356178;5654.123610840326;5839.970800146015;5878.088896221093;5878.882422351529;5892.175095486636;3581.3016461789703;3684.4841722158917;3748.737588368815;3757.7369584129124;3777.527809023872;1172.5192671004847;1187.7149484123747;1214.550853749072;1228.4533382644727;1237.7586370657725;13554.254516001616;13607.727845443036;13646.727065458734;13663.521776737767;13669.589912302647;4800.279958006327;4846.5638092571835;5197.922031169535;5201;5205.557527610195;11459.77080458386;11521.48153333102;11527.13546484017;11608.419579021183;11625;5849.6782676952325;5854.648721076749;5873.2658417697785;5895.145203945404;5899.882002359929;4548.4541854977615;5323.813666521653;5408.215808707715;5410.783568657288;5485.670859748428;4221.662267018631;4292.441982542249;4374.234508960919;4378.1900348435;4408.162449134654;1429.9142051476945;1448;1460.3428457194304;1468.12646475347;1473.2044695864113;977.8044391121804;1078.5254488025244;1092.6558134187705;1096.6216655254084;1104.9392283424488;6232.220972378453;6342.873142537123;6428.292887782341;6519.185101862267;6583.769568065095;492.22474602501205;513.1558586125802;519.2393144043918;530.729328042701;535.750875842735;4431.534688857688;4593.26507758757;4611.446626404853;4620.422447194101;4747.406574178228;11752.23610465317;11961;12055.095867809949;12114.091443141624;12246.44890979908;12145.392730363446;12163.331016793984;12196.756064878653;12197.451114699683;12219.694507637203;8505.702300419456;8847.20375166238;8932.374733768704;9153.496557689257;9159.175674189222;6787.93212067873;6848.794536163923;6856.24581296067;6865.141857267841;6914.9308506914285;10879.401632910265;10897.945510272715;11202.32786032808;11370.886291137314;11461.770764584828;11055.557777688802;11172.21794474379;11244.156688248251;11406.14453915943;11505.539778409106;7901.920980790119;8191.344692424473;8231.259186673227;8320.916790832256;8355.749327520183;9189.264858811413;9204.677836275698;9222.861657075015;9225.769355766159;9248.907510924804;7980.640871160927;8258.628361723617;8270.462419942685;8311.501309921425;8467.788305292417;7863.174366691644;7865.134835168242;7908.920910791048;7967.960160199162;7970.561619111005;7228.530145540523;7461.328480436787;7497.2877576630135;7517.924820751941;7521.548707077593;5768.769249229984;5824.970875145597;5938.851528711644;5949.970250148895;5962.522998160223;5387.946120538744;5407.675539467645;5430.484104010113;5547.472990065938;5620.718964051699 23:03:07 INFO - PROCESS | 1311 | |4;prototype.html;360.1123231235005;363.12486906555205;364.1388117103051;368.3756033523179;368.9797061161635;5525.1214587040395;5693.9715301423485;5735.225744524488;5761.740721667525;5767.019606666871;5725.541956643469;5737.7991770287945;5755.9424405756035;5756.8272951811405;5815.244018277628;4534.433195850519;4572.634189264851;4573.016801387701;4585.862424127282;4588.967482316469;4486.618637415807;4524.6380289576755;4547.704399214057;4551.931721024171;4612.46956599992;4510.300903359985;4510.571495707903;4519.706219095749;4520.954790452102;4521.32180172975;4528.139653465847;4528.43394575678;4531.864044078683;4551.68138230324;4584.7936842842155;3899.8300509847218;3971.463852379921;3972.761634301922;3994.962569089756;4012.7391719538427;5704.401037891044;5711.343195532525;5718.485336319751;5752.504348869283;5757.337906140764;5086.92369614456;5224.947750522484;5225.634205605609;5254.6847189168775;5257.13257312543;6027.7287522061615;6032.758689652409;6057.636541807506;6073.271207455089;6082.1789058477425;4422.270325396305;4440.311751678495;4444.155610434007;4447.666425018104;4455.443069616298;6217.316095229521;6344.555881088326;6364.204474440695;6369.585976911486;6383.265924418705;4490.012197316585;4497.955020449819;4517.683762136685;4525.954740452619;4526.932096018562;4598.747068911242;4601;4604.884877878013;4606.239970404846;4613.723176609415;5145.614078944094;5185.170372740344;5204.42751297357;5242.685438873604;5242.7378631068295;5908.586398952032;6066.878662426727;6074.574779765374;6087.604305720114;6141.570090093651;1606.3173151410838;1616.272677295222;1629.1202750514826;1629.8998176230996;1630.9755353669705;1000.9940010289612;1024.830902901013;1035.0374152038526;1035.637526865591;1039.449091981251;5274.208868669731;5285.920711189336;5313.893722125613;5333.386660534088;5333.786648534093;5493.642913210629;5524.591229236519;5538.252335934678;5564.026295398289;5568.916466253009;4949.628777841676;5254.185601231815;5294.682319060868;5313.760880760375;5313.946860531345;2939.544370622557;2943.4701753684544;2944.3080875994124;2953.616029916097;2957;5518.613697041169;5709.714514274269;5719.48524632785;5806.332271788799;5812.854678632983;5514.889702205934;5621.7836622533105;5631.029139801037;5665;5681.602287839812;5696.715164241854;5757.395473475309;5769.259601689164;5823.79616713413;5889.676067816225;5308.911673107081;5490.725463726878;5505.587080968863;5524.723763811874;5655.547556195576;5480.424555421623;5480.616356855141;5557.416471270459;5560.860978475571;5565.749541270571;5760.222369979999;5784.797532086357;5792.189093526994;5819.418058194146;5835.156819839608;4020.3567429211184;4134.958650413458;4181.749095054306;4182.749035057906;4193.72740771861;5505.862353441035;5547;5560.416156303691;6133.570650054632;6303.716332765129;6139.201903752483;6173.783917562864;6197.450637340665;6205.81382558524;6210.254769427697;6083.300420451527;6190.845228869134;6211;6218.31598524171;6287.371262873676;6113.786017489367;6125.9693701531205;6137.263528376623;6141.232345956755;6157.322694503511;6219.315875253809;6242.313345531897;6242.406971337716;6244.6261822399;6274.717637706223;5870.354261031198;6008.04738460011;6027.78902738402;6060.1212824139375;6102.115193297036 23:03:07 INFO - PROCESS | 1311 | |5;yui.html;752.5522314223037;771.6488997506139;817.7955511122219;842.0863363250872;880.9691660791874;16185.190740462975;17500.737488937677;17551.64896702067;17556.473305800813;17557.12214389282;15435.382584696627;15524.689506209868;15550.066995980249;15576.68846623067;15607.141607211628;712.8253577873428;840.7015509494103;848.1010129262986;869.7173418638936;872.3283072034529;860.2859626510013;866.1901122450497;866.1987661413199;867.5965675960678;867.6399294292861;917.0600134861787;917.7751450894507;917.8393781088316;918.8943271523793;920.9309301802358;911.5624500239921;913.5751875377948;914.6158613382395;914.9130832570962;919.7562645898843;676.6650507998572;678.5555461172939;681.7681988124061;681.924988251292;683.3235097253732;15782.526524204291;15834.445794397141;15841.0495370277;15852.365905363888;15855.44505942298;14439.205843678594;14573;14708.338124784303;14720;14730.042547234396;12906.870931290661;12962.48150073996;12969.41637626309;13215.86784132156;13321.200727956353;3962.7622342659533;4155.563665815076;4181.184668989548;4278.080212754273;4286.121345124242;76491.61754191249;84917.99999999939;85164;85177.14822851754;85551;10310.690679279634;10711.625093121704;10820.13438924884;11027;11122.666320010412;22738.31785046451;22869.771302287096;22959.655605165935;23023.654645180002;23254.069837206323;8953.955230223937;9140.08599140094;9267.860982085274;9290.442573445614;9382.155605995493;4583.816647334069;4607.295300738748;4709.929351059737;4770.403699537558;4837.588804951619;3823.9235215296094;3946.8223929923224;3953.090789118519;3953.7034722395933;3953.92092158161;681.0431343961742;683.5351960666695;690.0890824112124;692.8718187135396;698.8672152291049;655.9147310849559;674.4132604634;722.3859719238606;810.0805585660318;821.2321479416764;10509.159267258601;10983.725406864893;11048;11064.391458469701;12227.205231659913;634.6953462338104;664.2693037658537;722.7362012865372;740.6926125657899;766.6894907562446;4903.190973489405;4938.209886418156;5245.842624721265;5293.629445938747;5442;71930.64034679793;79694;114616;120461;128940.35529822292;106740;109779.45110274397;110846;111539.44230278797;115860.42069789597;83008.58495707483;83094.16345524316;83939.16060839314;96831;97890;10096.545655445376;10122.696319110144;10161.187105031431;10479.318844275098;10672;49440.752796235785;51260;53795.92408151893;58256;58293.70853145707;54750.72624636851;67200;76743.61628191824;78002.6099869497;80423.59788201256;12920.870791291967;13137.671558211121;13782.93108534451;13894.23581703016;14098.08362456478;15383.846161538242;15421.922890385476;15459.61350966235;15654.9217253913;15952.760708589149;13106.60680179596;13398.732025359634;15202.771958420853;15654;15669.921650391676;14297.428102875769;14543;15457.5362739118;15464.226788660748;15531;12080.890652425858;14445.92777036108;14656.340464679328;15097.169655669044;15782.526524204291;10574.101201397967;10611.469426528796;10944.726381840517;11174.66476005721;11624.150165506911;9965.800683986425;10823.350598964087;11098.722531936442;11695.649130526097;11898.821517677416 23:03:07 INFO - PROCESS | 1311 | __end_tp_report 23:03:07 INFO - PROCESS | 1311 | __start_cc_report 23:03:07 INFO - PROCESS | 1311 | _x_x_mozilla_cycle_collect,350 23:03:07 INFO - PROCESS | 1311 | __end_cc_report 23:03:07 INFO - PROCESS | 1311 | __startTimestamp1474437787775__endTimestamp 23:03:07 INFO - PROCESS | 1311 | 23:03:07 INFO - PROCESS | 1311 | ------- Summary: start ------- 23:03:07 INFO - PROCESS | 1311 | Number of tests: 6 23:03:07 INFO - PROCESS | 1311 | 23:03:07 INFO - PROCESS | 1311 | [#0] dojo.html Cycles:165 Average:5699.83 Median:5925.00 stddev:657.66 (11.1%) stddev-sans-first:631.69 23:03:07 INFO - PROCESS | 1311 | Values: 3280.1 3300.7 3303.2 3320.8 3329.1 5682.0 5741.8 5755.0 5769.5 5791.8 5711.2 5743.5 5748.3 5763.1 5764.7 5233.3 5238.5 5239.4 5240.8 5304.2 5083.5 5097.2 5135.8 5149.5 5234.2 5224.9 5247.3 5253.1 5264.6 5321.0 5258.1 5318.5 5319.4 5320.0 5343.2 5049.5 5060.2 5088.3 5202.0 5215.5 5643.9 5664.3 5686.9 5691.0 5715.3 6086.6 6111.4 6138.2 6144.4 6144.6 5987.3 6075.1 6122.5 6184.3 6192.6 5754.5 5764.7 5792.6 5807.8 5821.0 6291.6 6301.1 6306.4 6327.7 6338.1 5856.4 5973.8 5989.4 6069.8 6088.7 6130.8 6146.9 6156.4 6161.5 6166.3 6099.3 6103.8 6105.9 6137.5 6138.8 5930.6 5931.8 5955.2 6069.5 6145.7 4620.5 4621.2 4625.9 4641.5 4642.6 4123.7 4131.8 4132.2 4152.0 4160.5 5771.7 5821.4 5831.7 5831.9 5854.0 6181.6 6205.4 6213.6 6225.2 6228.1 5871.6 5920.5 5920.8 5951.0 5973.1 5182.0 5250.4 5327.8 5341.5 5342.5 6452.2 6466.1 6467.2 6468.9 6471.4 6180.3 6184.3 6228.9 6233.9 6235.1 6193.6 6253.7 6293.3 6315.1 6437.7 6003.1 6015.2 6026.5 6033.7 6041.2 6112.4 6113.4 6128.5 6130.2 6132.2 5838.5 5933.3 5943.9 5968.5 6008.7 6013.0 6061.7 6080.0 6084.3 6113.5 5922.3 5939.1 5953.5 5954.3 5978.8 5841.8 5925.0 5955.4 5977.6 6062.0 5838.8 5851.9 5855.1 5865.9 5890.7 23:03:07 INFO - PROCESS | 1311 | 23:03:07 INFO - PROCESS | 1311 | [#1] ext.html Cycles:180 Average:66881.25 Median:24015.82 stddev:141085.72 (587.5%) stddev-sans-first:141393.69 23:03:07 INFO - PROCESS | 1311 | Values: 583.2 637.6 659.5 666.1 698.5 41473.8 45822.8 46078.8 46141.1 46209.0 46760.5 46964.8 47251.0 47254.5 47342.5 9125.3 9200.9 9235.2 9254.4 9269.6 9245.4 9268.0 9302.0 9324.4 9354.6 9249.8 9281.5 9291.8 9292.7 9296.3 9262.8 9296.1 9301.6 9309.7 9321.4 9090.5 9197.9 9206.7 9208.1 9217.3 43369.6 43661.1 43708.0 43750.8 43827.8 3527.3 3668.4 3740.3 4235.1 4370.5 33635.2 33973.8 34077.5 34153.0 36141.1 4487.6 4594.4 4660.4 4692.5 4713.3 390069.0 391475.0 391594.0 391770.0 393303.0 37866.6 38755.0 38810.8 61664.7 61957.1 40765.4 40889.6 40975.0 40980.8 41088.8 15972.9 16116.4 16227.4 16259.5 16306.8 14068.2 14106.2 14107.9 14141.6 14147.2 9229.1 9232.6 9240.1 9275.9 9293.2 3580.4 3582.4 3599.9 3619.6 3627.1 1070.3 1089.7 1101.2 1151.7 1177.5 33493.7 33747.7 34135.1 34179.8 34396.8 1157.5 1210.0 1224.7 1285.8 1286.1 17601.7 17611.1 17796.3 17990.6 18113.8 632300.0 632774.0 634147.0 635639.0 636323.0 62047.7 62624.4 62847.4 62886.0 62964.7 1452.1 1454.4 1462.3 1486.2 1489.5 32713.3 32814.8 33217.5 33380.7 33417.0 54503.2 54581.5 54619.0 54962.7 55116.0 530839.0 532118.0 533574.0 533852.0 534428.0 30462.0 30693.0 31763.2 31783.8 32801.8 50380.2 51054.7 51472.7 51857.0 52627.0 43500.6 43873.6 44760.3 44888.8 46206.3 43297.4 43500.0 44044.1 46644.1 48489.0 38538.0 42548.4 43542.3 44307.0 45698.0 37966.4 38900.2 39033.6 39721.6 39825.4 29731.4 29909.3 30322.8 30365.2 30625.4 23:03:07 INFO - PROCESS | 1311 | 23:03:07 INFO - PROCESS | 1311 | [#2] jquery.html Cycles:180 Average:30961.29 Median:2286.97 stddev:87539.92 (3827.8%) stddev-sans-first:87755.47 23:03:07 INFO - PROCESS | 1311 | Values: 428.5 430.3 438.5 443.4 450.3 19352.8 20099.3 20579.5 20708.1 20727.8 19340.5 20278.4 20894.8 20982.5 21075.2 5796.8 6033.1 6044.1 6054.1 6063.2 5709.9 5940.6 5968.3 5987.8 6056.7 6022.6 6025.5 6043.2 6077.7 6079.1 6116.1 6211.8 6221.9 6254.7 6275.0 5842.6 5959.8 5965.9 5985.8 5992.0 15350.2 15917.5 23995.4 24704.3 24951.0 2373.6 2399.9 2473.9 2480.6 2749.3 10901.5 11351.3 11371.0 11407.4 11418.9 1985.5 2042.7 2047.2 2050.7 2110.1 68916.0 76964.6 79801.6 80639.0 88578.1 11649.0 12033.2 12049.1 12145.9 12454.7 17304.9 17323.7 17323.9 17359.7 17389.7 8948.9 8973.9 9036.3 9043.8 9447.7 8872.7 8934.4 8973.5 9050.0 9081.0 5057.9 5215.7 5272.8 5293.6 5388.7 2112.4 2128.9 2150.8 2181.7 2200.4 963.0 1017.9 1026.1 1074.8 1108.2 20347.6 20663.8 20989.5 21048.0 21159.3 1043.0 1087.3 1093.9 1110.8 1124.5 11330.2 11505.7 11662.9 11710.2 11818.5 502075.0 509630.0 524629.0 559440.0 560309.0 95905.5 98074.0 98160.5 99327.0 100314.5 1010.6 1016.1 1038.4 1040.0 1040.5 18135.1 18207.6 18505.4 18536.3 18940.9 44263.8 44418.0 44621.6 44744.1 46240.8 62391.7 62575.0 63031.0 63376.7 63673.7 9333.7 9390.3 9480.1 9491.4 9617.8 11139.0 14104.6 14214.1 14299.5 14406.0 12053.6 12116.6 12324.3 12700.7 12990.4 11628.9 11977.5 12013.3 12275.0 12356.4 12325.7 12507.7 12515.2 12522.6 12563.7 9110.4 9201.6 9246.6 9473.6 9526.5 9410.4 12089.1 12206.5 12215.4 12308.9 23:03:07 INFO - PROCESS | 1311 | 23:03:07 INFO - PROCESS | 1311 | [#3] mootools.html Cycles:180 Average:6322.48 Median:4823.42 stddev:3634.69 (75.4%) stddev-sans-first:3627.23 23:03:07 INFO - PROCESS | 1311 | Values: 1555.6 1563.2 1749.9 1854.6 1881.9 8162.7 8961.6 9023.9 9738.1 9742.7 9051.5 9319.8 9325.7 9406.7 9425.8 2517.0 2557.3 2560.8 2565.7 2566.2 2478.4 2531.8 2544.8 2548.7 2549.5 2526.3 2531.8 2533.6 2535.0 2543.9 2434.0 2454.1 2477.1 2517.6 2518.0 2444.1 2461.1 2461.1 2464.0 2512.9 9534.2 9577.2 9584.6 9587.5 9597.6 5654.1 5840.0 5878.1 5878.9 5892.2 3581.3 3684.5 3748.7 3757.7 3777.5 1172.5 1187.7 1214.6 1228.5 1237.8 13554.3 13607.7 13646.7 13663.5 13669.6 4800.3 4846.6 5197.9 5201.0 5205.6 11459.8 11521.5 11527.1 11608.4 11625.0 5849.7 5854.6 5873.3 5895.1 5899.9 4548.5 5323.8 5408.2 5410.8 5485.7 4221.7 4292.4 4374.2 4378.2 4408.2 1429.9 1448.0 1460.3 1468.1 1473.2 977.8 1078.5 1092.7 1096.6 1104.9 6232.2 6342.9 6428.3 6519.2 6583.8 492.2 513.2 519.2 530.7 535.8 4431.5 4593.3 4611.4 4620.4 4747.4 11752.2 11961.0 12055.1 12114.1 12246.4 12145.4 12163.3 12196.8 12197.5 12219.7 8505.7 8847.2 8932.4 9153.5 9159.2 6787.9 6848.8 6856.2 6865.1 6914.9 10879.4 10897.9 11202.3 11370.9 11461.8 11055.6 11172.2 11244.2 11406.1 11505.5 7901.9 8191.3 8231.3 8320.9 8355.7 9189.3 9204.7 9222.9 9225.8 9248.9 7980.6 8258.6 8270.5 8311.5 8467.8 7863.2 7865.1 7908.9 7968.0 7970.6 7228.5 7461.3 7497.3 7517.9 7521.5 5768.8 5825.0 5938.9 5950.0 5962.5 5387.9 5407.7 5430.5 5547.5 5620.7 23:03:07 INFO - PROCESS | 1311 | 23:03:07 INFO - PROCESS | 1311 | [#4] prototype.html Cycles:180 Average:4957.27 Median:5505.72 stddev:1423.42 (25.9%) stddev-sans-first:1384.96 23:03:07 INFO - PROCESS | 1311 | Values: 360.1 363.1 364.1 368.4 369.0 5525.1 5694.0 5735.2 5761.7 5767.0 5725.5 5737.8 5755.9 5756.8 5815.2 4534.4 4572.6 4573.0 4585.9 4589.0 4486.6 4524.6 4547.7 4551.9 4612.5 4510.3 4510.6 4519.7 4521.0 4521.3 4528.1 4528.4 4531.9 4551.7 4584.8 3899.8 3971.5 3972.8 3995.0 4012.7 5704.4 5711.3 5718.5 5752.5 5757.3 5086.9 5224.9 5225.6 5254.7 5257.1 6027.7 6032.8 6057.6 6073.3 6082.2 4422.3 4440.3 4444.2 4447.7 4455.4 6217.3 6344.6 6364.2 6369.6 6383.3 4490.0 4498.0 4517.7 4526.0 4526.9 4598.7 4601.0 4604.9 4606.2 4613.7 5145.6 5185.2 5204.4 5242.7 5242.7 5908.6 6066.9 6074.6 6087.6 6141.6 1606.3 1616.3 1629.1 1629.9 1631.0 1001.0 1024.8 1035.0 1035.6 1039.4 5274.2 5285.9 5313.9 5333.4 5333.8 5493.6 5524.6 5538.3 5564.0 5568.9 4949.6 5254.2 5294.7 5313.8 5313.9 2939.5 2943.5 2944.3 2953.6 2957.0 5518.6 5709.7 5719.5 5806.3 5812.9 5514.9 5621.8 5631.0 5665.0 5681.6 5696.7 5757.4 5769.3 5823.8 5889.7 5308.9 5490.7 5505.6 5524.7 5655.5 5480.4 5480.6 5557.4 5560.9 5565.7 5760.2 5784.8 5792.2 5819.4 5835.2 4020.4 4135.0 4181.7 4182.7 4193.7 5505.9 5547.0 5560.4 6133.6 6303.7 6139.2 6173.8 6197.5 6205.8 6210.3 6083.3 6190.8 6211.0 6218.3 6287.4 6113.8 6126.0 6137.3 6141.2 6157.3 6219.3 6242.3 6242.4 6244.6 6274.7 5870.4 6008.0 6027.8 6060.1 6102.1 23:03:07 INFO - PROCESS | 1311 | 23:03:07 INFO - PROCESS | 1311 | [#5] yui.html Cycles:180 Average:21481.84 Median:3953.81 stddev:30586.63 (773.6%) stddev-sans-first:30632.83 23:03:07 INFO - PROCESS | 1311 | Values: 752.6 771.6 817.8 842.1 881.0 16185.2 17500.7 17551.6 17556.5 17557.1 15435.4 15524.7 15550.1 15576.7 15607.1 712.8 840.7 848.1 869.7 872.3 860.3 866.2 866.2 867.6 867.6 917.1 917.8 917.8 918.9 920.9 911.6 913.6 914.6 914.9 919.8 676.7 678.6 681.8 681.9 683.3 15782.5 15834.4 15841.0 15852.4 15855.4 14439.2 14573.0 14708.3 14720.0 14730.0 12906.9 12962.5 12969.4 13215.9 13321.2 3962.8 4155.6 4181.2 4278.1 4286.1 76491.6 84918.0 85164.0 85177.1 85551.0 10310.7 10711.6 10820.1 11027.0 11122.7 22738.3 22869.8 22959.7 23023.7 23254.1 8954.0 9140.1 9267.9 9290.4 9382.2 4583.8 4607.3 4709.9 4770.4 4837.6 3823.9 3946.8 3953.1 3953.7 3953.9 681.0 683.5 690.1 692.9 698.9 655.9 674.4 722.4 810.1 821.2 10509.2 10983.7 11048.0 11064.4 12227.2 634.7 664.3 722.7 740.7 766.7 4903.2 4938.2 5245.8 5293.6 5442.0 71930.6 79694.0 114616.0 120461.0 128940.4 106740.0 109779.5 110846.0 111539.4 115860.4 83008.6 83094.2 83939.2 96831.0 97890.0 10096.5 10122.7 10161.2 10479.3 10672.0 49440.8 51260.0 53795.9 58256.0 58293.7 54750.7 67200.0 76743.6 78002.6 80423.6 12920.9 13137.7 13782.9 13894.2 14098.1 15383.8 15421.9 15459.6 15654.9 15952.8 13106.6 13398.7 15202.8 15654.0 15669.9 14297.4 14543.0 15457.5 15464.2 15531.0 12080.9 14445.9 14656.3 15097.2 15782.5 10574.1 10611.5 10944.7 11174.7 11624.2 9965.8 10823.4 11098.7 11695.6 11898.8 23:03:07 INFO - PROCESS | 1311 | -------- Summary: end -------- 23:03:07 INFO - PROCESS | 1311 | 23:03:08 INFO - TEST-INFO | 1311: exit 0 23:03:08 INFO - TEST-OK | dromaeo_css | took 1110419ms 23:03:08 INFO - TEST-START | kraken 23:03:08 INFO - operating with platform_type : linux_ 23:03:08 INFO - Initialising browser for kraken test... 23:03:08 INFO - TEST-INFO | started process 1552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIIlvZI/profile http://localhost:41731/getInfo.html) 23:03:12 INFO - PROCESS | 1552 | __metrics Screen width/height:1600/1200 23:03:12 INFO - PROCESS | 1552 | colorDepth:24 23:03:12 INFO - PROCESS | 1552 | Browser inner width/height: 1024/697 23:03:12 INFO - PROCESS | 1552 | __metrics 23:03:13 ERROR - PROCESS | 1552 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 23:03:13 INFO - TEST-INFO | 1552: exit 0 23:03:13 INFO - Browser initialized. 23:03:13 INFO - Running cycle 1/1 for kraken test... 23:03:13 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIIlvZI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:03:25 INFO - PROCESS | 1677 | RSS: Main: 150290432 23:03:25 INFO - PROCESS | 1677 | 23:03:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41731/tests/kraken/driver.html?testName=audio-beat-detection) 23:03:29 INFO - PROCESS | 1677 | RSS: Main: 156827648 23:03:29 INFO - PROCESS | 1677 | 23:03:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41731/tests/kraken/driver.html?testName=audio-dft) 23:03:32 INFO - PROCESS | 1677 | RSS: Main: 155287552 23:03:32 INFO - PROCESS | 1677 | 23:03:35 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41731/tests/kraken/driver.html?testName=audio-fft) 23:03:35 INFO - PROCESS | 1677 | RSS: Main: 156172288 23:03:35 INFO - PROCESS | 1677 | 23:03:37 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41731/tests/kraken/driver.html?testName=audio-oscillator) 23:03:38 INFO - PROCESS | 1677 | RSS: Main: 156057600 23:03:38 INFO - PROCESS | 1677 | 23:03:40 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41731/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:03:41 INFO - PROCESS | 1677 | RSS: Main: 155754496 23:03:41 INFO - PROCESS | 1677 | 23:03:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41731/tests/kraken/driver.html?testName=imaging-darkroom) 23:03:44 INFO - PROCESS | 1677 | RSS: Main: 155455488 23:03:44 INFO - PROCESS | 1677 | 23:03:48 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41731/tests/kraken/driver.html?testName=imaging-desaturate) 23:03:48 INFO - PROCESS | 1677 | RSS: Main: 156028928 23:03:48 INFO - PROCESS | 1677 | 23:03:51 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41731/tests/kraken/driver.html?testName=json-parse-financial) 23:03:52 INFO - PROCESS | 1677 | RSS: Main: 156430336 23:03:52 INFO - PROCESS | 1677 | 23:03:53 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41731/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:03:54 INFO - PROCESS | 1677 | RSS: Main: 156491776 23:03:54 INFO - PROCESS | 1677 | 23:03:56 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41731/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:03:56 INFO - PROCESS | 1677 | RSS: Main: 156504064 23:03:56 INFO - PROCESS | 1677 | 23:03:58 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41731/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:03:59 INFO - PROCESS | 1677 | RSS: Main: 156364800 23:03:59 INFO - PROCESS | 1677 | 23:04:02 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:04:02 INFO - PROCESS | 1677 | RSS: Main: 156426240 23:04:02 INFO - PROCESS | 1677 | 23:04:05 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:04:06 INFO - PROCESS | 1677 | RSS: Main: 156610560 23:04:06 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:41731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41731/tests/kraken/driver.html?testName=ai-astar) 23:04:07 INFO - PROCESS | 1677 | RSS: Main: 158629888 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | __start_tp_report 23:04:07 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 23:04:07 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 23:04:07 INFO - PROCESS | 1677 | |i|pagename|runs| 23:04:07 INFO - PROCESS | 1677 | |0;ai-astar;103;113;106;110;111;113;112;111;110;110 23:04:07 INFO - PROCESS | 1677 | |1;audio-beat-detection;148;119;138;165;117;147;148;117;180;118 23:04:07 INFO - PROCESS | 1677 | |2;audio-dft;162;162;168;162;162;160;164;162;161;162 23:04:07 INFO - PROCESS | 1677 | |3;audio-fft;75;75;77;172;75;75;78;75;162;74 23:04:07 INFO - PROCESS | 1677 | |4;audio-oscillator;83;83;145;83;84;83;143;84;84;136 23:04:07 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;117;119;117;117;117;118;117;117;117;117 23:04:07 INFO - PROCESS | 1677 | |6;imaging-darkroom;147;147;147;147;148;146;146;147;148;147 23:04:07 INFO - PROCESS | 1677 | |7;imaging-desaturate;95;95;95;98;95;96;95;95;96;95 23:04:07 INFO - PROCESS | 1677 | |8;json-parse-financial;57;56;55;54;56;57;54;57;56;54 23:04:07 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;58;60;60;60;60;59;59;60;59;60 23:04:07 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;75;82;73;73;72;71;82;75;73;71 23:04:07 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;127;119;133;125;126;118;118;124;151;117 23:04:07 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;154;149;150;146;148;152;150;149;151;151 23:04:07 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;63;61;61;63;61;62;61;60;61;60 23:04:07 INFO - PROCESS | 1677 | __end_tp_report 23:04:07 INFO - PROCESS | 1677 | __start_cc_report 23:04:07 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,892 23:04:07 INFO - PROCESS | 1677 | __end_cc_report 23:04:07 INFO - PROCESS | 1677 | __startTimestamp1474437847900__endTimestamp 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | ------- Summary: start ------- 23:04:07 INFO - PROCESS | 1677 | Number of tests: 14 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.14 (2.8%) stddev-sans-first:2.12 23:04:07 INFO - PROCESS | 1677 | Values: 103.0 113.0 106.0 110.0 111.0 113.0 112.0 111.0 110.0 110.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:147.50 stddev:22.08 (15.0%) stddev-sans-first:23.22 23:04:07 INFO - PROCESS | 1677 | Values: 148.0 119.0 138.0 165.0 117.0 147.0 148.0 117.0 180.0 118.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.17 (1.3%) stddev-sans-first:2.30 23:04:07 INFO - PROCESS | 1677 | Values: 162.0 162.0 168.0 162.0 162.0 160.0 164.0 162.0 161.0 162.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:38.67 (51.6%) stddev-sans-first:40.41 23:04:07 INFO - PROCESS | 1677 | Values: 75.0 75.0 77.0 172.0 75.0 75.0 78.0 75.0 162.0 74.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:83.00 stddev:28.06 (33.8%) stddev-sans-first:29.02 23:04:07 INFO - PROCESS | 1677 | Values: 83.0 83.0 145.0 83.0 84.0 83.0 143.0 84.0 84.0 136.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 23:04:07 INFO - PROCESS | 1677 | Values: 117.0 119.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:04:07 INFO - PROCESS | 1677 | Values: 147.0 147.0 147.0 147.0 148.0 146.0 146.0 147.0 148.0 147.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 23:04:07 INFO - PROCESS | 1677 | Values: 95.0 95.0 95.0 98.0 95.0 96.0 95.0 95.0 96.0 95.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.26 (2.3%) stddev-sans-first:1.24 23:04:07 INFO - PROCESS | 1677 | Values: 57.0 56.0 55.0 54.0 56.0 57.0 54.0 57.0 56.0 54.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.71 (1.2%) stddev-sans-first:0.50 23:04:07 INFO - PROCESS | 1677 | Values: 58.0 60.0 60.0 60.0 60.0 59.0 59.0 60.0 59.0 60.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.00 stddev:4.08 (5.5%) stddev-sans-first:4.33 23:04:07 INFO - PROCESS | 1677 | Values: 75.0 82.0 73.0 73.0 72.0 71.0 82.0 75.0 73.0 71.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:125.50 stddev:10.21 (8.1%) stddev-sans-first:10.82 23:04:07 INFO - PROCESS | 1677 | Values: 127.0 119.0 133.0 125.0 126.0 118.0 118.0 124.0 151.0 117.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:150.50 stddev:2.21 (1.5%) stddev-sans-first:1.81 23:04:07 INFO - PROCESS | 1677 | Values: 154.0 149.0 150.0 146.0 148.0 152.0 150.0 149.0 151.0 151.0 23:04:07 INFO - PROCESS | 1677 | 23:04:07 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:1.06 (1.7%) stddev-sans-first:0.93 23:04:07 INFO - PROCESS | 1677 | Values: 63.0 61.0 61.0 63.0 61.0 62.0 61.0 60.0 61.0 60.0 23:04:07 INFO - PROCESS | 1677 | -------- Summary: end -------- 23:04:07 INFO - PROCESS | 1677 | 23:04:08 INFO - TEST-INFO | 1677: exit 0 23:04:08 INFO - TEST-OK | kraken | took 60400ms 23:04:08 INFO - SUITE-END | took 1170s 23:04:09 INFO - Completed test suite (00:19:31) 23:04:09 INFO - javascript benchmark 23:04:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7658.509139694486, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3280.097973057409, 3300.6864347886944, 3303.223742420531, 3320.767546271759, 3329.084501762015, 5682.0, 5741.827745167641, 5755.021646320125, 5769.538436925046, 5791.768329266824, 5711.228984087147, 5743.4543718346695, 5748.310202775662, 5763.106718458635, 5764.682942438164, 5233.293505376773, 5238.5023422774775, 5239.397469291042, 5240.816571420001, 5304.177852432879, 5083.517065878754, 5097.184450487923, 5135.794568217267, 5149.459306772791, 5234.241035049916, 5224.895502089956, 5247.2653828464045, 5253.106971814801, 5264.631475796696, 5320.973395133019, 5258.106121959257, 5318.494742999447, 5319.361676598814, 5319.9734001330135, 5343.198520221959, 5049.5455409013, 5060.165072762989, 5088.338515992934, 5202.0, 5215.478452154792, 5643.887122257532, 5664.2636457260705, 5686.943130568683, 5691.0, 5715.257016587859, 6086.60437071589, 6111.35830737775, 6138.17134686816, 6144.385561443864, 6144.600600960924, 5987.251593550806, 6075.088736689488, 6122.54080943931, 6184.257889053342, 6192.628442293477, 5754.539636829044, 5764.654120752768, 5792.594518383715, 5807.767689292423, 5821.0, 6291.591046581958, 6301.054841773679, 6306.400891915261, 6327.683615819191, 6338.112664227012, 5856.443637854397, 5973.820785376446, 5989.401059894063, 6069.787557435468, 6088.695565221721, 6130.785422510191, 6146.907796383058, 6156.384361563808, 6161.537884658668, 6166.260048794174, 6099.303536277131, 6103.755849766048, 6105.938940610626, 6137.508999280047, 6138.846528836815, 5930.584859059911, 5931.822045338647, 5955.225820643375, 6069.544784141207, 6145.661988590581, 4620.53794620542, 4621.214393553104, 4625.861224163281, 4641.466231383367, 4642.582167604932, 4123.711340206157, 4131.752094874257, 4132.235536425771, 4152.045029643138, 4160.54234034256, 5771.740271687784, 5821.388754180834, 5831.737571809279, 5831.88336233273, 5853.970730146407, 6181.567290289637, 6205.410486003822, 6213.565050446426, 6225.159603453566, 6228.096925945712, 5871.5908182036, 5920.467157955719, 5920.79277225295, 5950.9702451487465, 5973.1338955852025, 5181.974090129525, 5250.422453530108, 5327.840164795062, 5341.519263266325, 5342.465753424626, 6452.22573291208, 6466.094746735461, 6467.223933128054, 6468.870622587616, 6471.417572418411, 6180.258368995749, 6184.319724830355, 6228.906566401417, 6233.875322493434, 6235.127082208585, 6193.628382297076, 6253.718582663882, 6293.307736149111, 6315.052742088724, 6437.742490300523, 6003.0695242237525, 6015.187949626745, 6026.517878569616, 6033.698315084316, 6041.24484439445, 6112.419320164578, 6113.388661133851, 6128.4790792783115, 6130.2030736004035, 6132.202813634199, 5838.474537291664, 5933.2880054393745, 5943.91084133747, 5968.4926781224085, 6008.669523176267, 6013.0, 6061.6666083365835, 6080.0, 6084.269887613515, 6113.51091912637, 5922.3485416605, 5939.10913362999, 5953.464188223081, 5954.3152537458745, 5978.8206353809455, 5841.824745257649, 5925.0, 5955.40445955401, 5977.581569290108, 6061.999770037894, 5838.795642152504, 5851.941480585139, 5855.121731740273, 5865.882682346414, 5890.7349169288345], "value": 5654.517542200677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.2272239282951, 637.6301744987908, 659.482306389484, 666.1306994372345, 698.5145323999823, 41473.79263103684, 45822.770886145525, 46078.76960615197, 46141.07717845641, 46209.0, 46760.53239467604, 46964.76517617416, 47251.0, 47254.527454725445, 47342.52657473424, 9125.269978401746, 9200.907990920106, 9235.215006724437, 9254.398464099846, 9269.582868770922, 9245.399049061823, 9267.95366023169, 9302.0, 9324.393914395576, 9354.625814967394, 9249.768755781126, 9281.535923203814, 9291.76770580734, 9292.674756383529, 9296.302777291696, 9262.814743705121, 9296.116868897443, 9301.581428835718, 9309.674161404353, 9321.394109382869, 9090.454572725657, 9197.908020919773, 9206.677766278148, 9208.12522810332, 9217.308701847389, 43369.56630433687, 43661.12677746459, 43708.0, 43750.78124609389, 43827.78086109581, 3527.3121741260466, 3668.394714872043, 3740.3454395480953, 4235.131797981407, 4370.519242883281, 33635.15912102193, 33973.830130849434, 34077.48883766746, 34153.0, 36141.096472588135, 4487.551244875519, 4594.402727645418, 4660.37084993525, 4692.4603670577635, 4713.26944323627, 390069.0, 391474.99999999715, 391594.0, 391770.0, 393303.0334848336, 37866.62133378686, 38755.0, 38810.80594597009, 61664.69167654223, 61957.07064394038, 40765.38851917224, 40889.59110408858, 40975.0, 40980.79509602492, 41088.79455602703, 15972.920135399248, 16116.435924742578, 16227.432039878548, 16259.51221463358, 16306.836931630769, 14068.155910645393, 14106.224157671222, 14107.858921410654, 14141.646458838406, 14147.151170929777, 9229.077092290718, 9232.584533696, 9240.122188392092, 9275.860862087075, 9293.210077143383, 3580.427131658922, 3582.408902531053, 3599.9280014400088, 3619.6199399063244, 3627.05696518907, 1070.3310430980637, 1089.7057794395469, 1101.2236373356764, 1151.694800877768, 1177.5466445418576, 33493.665063349545, 33747.65009399645, 34135.14662133417, 34179.82910085483, 34396.82801585976, 1157.4751951874384, 1210.0414486580403, 1224.6632176151452, 1285.762134005212, 1286.0547497589264, 17601.7359739604, 17611.119444027747, 17796.288148473915, 17990.640187196444, 18113.818861811214, 632300.0, 632774.0, 634147.0, 635639.0, 636323.0, 62047.6897615509, 62624.373756261855, 62847.37152628507, 62886.0, 62964.685176573825, 1452.1287227663317, 1454.3746189138772, 1462.341946124227, 1486.167746062187, 1489.5307977987115, 32713.34573308568, 32814.83592582022, 33217.501737473474, 33380.734604083125, 33417.0, 54503.18245226245, 54581.45418545764, 54619.0, 54962.72518637381, 55116.0, 530839.0, 532118.0, 533574.0, 533852.0, 534428.0, 30462.0, 30693.0, 31763.205919851265, 31783.84108079445, 32801.83599081989, 50380.24429633485, 51054.744726276134, 51472.74263628658, 51857.0, 52627.0, 43500.564994349654, 43873.56126438823, 44760.32859507045, 44888.77555612331, 46206.30690539712, 43297.350539741296, 43500.0, 44044.11911761683, 46644.06711865812, 48489.0, 38538.0, 42548.36177457403, 43542.346864797684, 44307.0, 45698.0, 37966.43050354302, 38900.221995560496, 39033.609663903, 39721.60278397179, 39825.40261896132, 29731.405371892008, 29909.252268693457, 30322.84838575881, 30365.24086897757, 30625.387492249585], "value": 20295.864259273487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.5140382984425, 430.32009425108333, 438.460693347183, 443.357360977578, 450.2593234129856, 19352.806471935295, 20099.29652462164, 20579.485512862186, 20708.068136933838, 20727.792722072776, 19340.51648708783, 20278.391648250537, 20894.791052089473, 20982.475438114056, 21075.156993720233, 5796.8260952171395, 6033.064874944369, 6044.123602077696, 6054.061620448838, 6063.242094738158, 5709.857253568653, 5940.61386009908, 5968.31364393096, 5987.760489580412, 6056.697165141747, 6022.578419510636, 6025.517958563304, 6043.244594425697, 6077.665728384937, 6079.148919151322, 6116.143739876421, 6211.844703882439, 6221.937780622181, 6254.7185376657935, 6274.968625156868, 5842.649441033552, 5959.761609535613, 5965.880682386328, 5985.760569577212, 5992.041273396279, 15350.155741434217, 15917.52247432579, 23995.400114997265, 24704.258872233862, 24951.0, 2373.572756903774, 2399.8800059997106, 2473.9257822265363, 2480.6155045967726, 2749.2714430675887, 10901.454927253684, 11351.262167959056, 11371.0, 11407.372594507298, 11418.942905285503, 1985.5036240939764, 2042.7242322286597, 2047.1504325704814, 2050.661640829276, 2110.145391116585, 68916.0, 76964.61517692432, 79801.60099199525, 80639.0, 88578.11421885763, 11649.0, 12033.217840840492, 12049.108214028745, 12145.906868381888, 12454.688632784071, 17304.913475432793, 17323.65352692939, 17323.913380433016, 17359.65280694379, 17389.65220695604, 8948.8657670135, 8973.865392019125, 9036.277097832157, 9043.819123617623, 9447.716568502956, 8872.689455869013, 8934.4192627479, 8973.50645714492, 9049.954750226338, 9081.046490118442, 5057.873553161126, 5215.713135777492, 5272.759077392169, 5293.629445938747, 5388.7305634718105, 2112.36629011296, 2128.872267663945, 2150.8064274215394, 2181.7454963396112, 2200.3728937253127, 963.0, 1017.9032991865761, 1026.1277913773233, 1074.793070020637, 1108.224243029866, 20347.59304813925, 20663.793362066488, 20989.47526311824, 21048.0, 21159.25942592002, 1042.99478502607, 1087.2932593814085, 1093.9288946218471, 1110.8278216876397, 1124.5108377855659, 11330.150238732129, 11505.654830355103, 11662.94168529169, 11710.180287379802, 11818.527258909719, 502075.0, 509630.0, 524629.0, 559440.0, 560309.0, 95905.5204723972, 98074.0, 98160.50919745356, 99327.0, 100314.4984275074, 1010.6361709784471, 1016.1210552871861, 1038.408107378802, 1040.0275742181084, 1040.54216144896, 18135.093245337415, 18207.635847282716, 18505.444836654922, 18536.25854965786, 18940.905295473436, 44263.778681106385, 44418.0, 44621.55378446174, 44744.105117898114, 46240.8439789008, 62391.6880415595, 62575.0, 63031.0, 63376.68311658412, 63673.68163159154, 9333.67332143399, 9390.295727820305, 9480.146786788946, 9491.430514169171, 9617.79777527809, 11139.0, 14104.647383815487, 14214.147151170962, 14299.499517516837, 14406.0, 12053.63839084829, 12116.636500904988, 12324.32216228116, 12700.729927007225, 12990.350482476028, 11628.88371116278, 11977.520899163936, 12013.279203247834, 12275.0, 12356.443960022001, 12325.691857703629, 12507.687307817378, 12515.186512876633, 12522.622511523907, 12563.685907852012, 9110.362274640976, 9201.631934722804, 9246.630134794803, 9473.57368918414, 9526.523673816142, 9410.38832475887, 12089.093318001362, 12206.511739530319, 12215.389230538616, 12308.938455308024], "value": 9831.724327460592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.6110972256936, 1563.2105786577772, 1749.8512626426752, 1854.5734481069353, 1881.9059047047645, 8162.673493060285, 8961.641534338618, 9023.872015998, 9738.074882886123, 9742.659006934759, 9051.547422628875, 9319.813603727922, 9325.720228393158, 9406.71779846604, 9425.81148377032, 2517.043523461087, 2557.3350928758473, 2560.8463492190526, 2565.6664633597607, 2566.153169454076, 2478.3804048987754, 2531.784798292138, 2544.8345857519294, 2548.6941567011986, 2549.4518678484123, 2526.2673824590847, 2531.7974562035083, 2533.5946248600226, 2534.961975570368, 2543.9491210175784, 2434.026389444228, 2454.0797201049604, 2477.1206221791276, 2517.622356646499, 2518.0431436054364, 2444.132333021769, 2461.064795377745, 2461.101697880261, 2463.987680061606, 2512.899484020637, 9534.237261019101, 9577.23382129428, 9584.5686944087, 9587.472689002103, 9597.616095356178, 5654.123610840326, 5839.970800146015, 5878.088896221093, 5878.882422351529, 5892.175095486636, 3581.3016461789703, 3684.4841722158917, 3748.737588368815, 3757.7369584129124, 3777.527809023872, 1172.5192671004847, 1187.7149484123747, 1214.550853749072, 1228.4533382644727, 1237.7586370657725, 13554.254516001616, 13607.727845443036, 13646.727065458734, 13663.521776737767, 13669.589912302647, 4800.279958006327, 4846.5638092571835, 5197.922031169535, 5201.0, 5205.557527610195, 11459.77080458386, 11521.48153333102, 11527.13546484017, 11608.419579021183, 11625.0, 5849.6782676952325, 5854.648721076749, 5873.2658417697785, 5895.145203945404, 5899.882002359929, 4548.4541854977615, 5323.813666521653, 5408.215808707715, 5410.783568657288, 5485.670859748428, 4221.662267018631, 4292.441982542249, 4374.234508960919, 4378.1900348435, 4408.162449134654, 1429.9142051476945, 1448.0, 1460.3428457194304, 1468.12646475347, 1473.2044695864113, 977.8044391121804, 1078.5254488025244, 1092.6558134187705, 1096.6216655254084, 1104.9392283424488, 6232.220972378453, 6342.873142537123, 6428.292887782341, 6519.185101862267, 6583.769568065095, 492.22474602501205, 513.1558586125802, 519.2393144043918, 530.729328042701, 535.750875842735, 4431.534688857688, 4593.26507758757, 4611.446626404853, 4620.422447194101, 4747.406574178228, 11752.23610465317, 11961.0, 12055.095867809949, 12114.091443141624, 12246.44890979908, 12145.392730363446, 12163.331016793984, 12196.756064878653, 12197.451114699683, 12219.694507637203, 8505.702300419456, 8847.20375166238, 8932.374733768704, 9153.496557689257, 9159.175674189222, 6787.93212067873, 6848.794536163923, 6856.24581296067, 6865.141857267841, 6914.9308506914285, 10879.401632910265, 10897.945510272715, 11202.32786032808, 11370.886291137314, 11461.770764584828, 11055.557777688802, 11172.21794474379, 11244.156688248251, 11406.14453915943, 11505.539778409106, 7901.920980790119, 8191.344692424473, 8231.259186673227, 8320.916790832256, 8355.749327520183, 9189.264858811413, 9204.677836275698, 9222.861657075015, 9225.769355766159, 9248.907510924804, 7980.640871160927, 8258.628361723617, 8270.462419942685, 8311.501309921425, 8467.788305292417, 7863.174366691644, 7865.134835168242, 7908.920910791048, 7967.960160199162, 7970.561619111005, 7228.530145540523, 7461.328480436787, 7497.2877576630135, 7517.924820751941, 7521.548707077593, 5768.769249229984, 5824.970875145597, 5938.851528711644, 5949.970250148895, 5962.522998160223, 5387.946120538744, 5407.675539467645, 5430.484104010113, 5547.472990065938, 5620.718964051699], "value": 4978.323630672123, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.1123231235005, 363.12486906555205, 364.1388117103051, 368.3756033523179, 368.9797061161635, 5525.1214587040395, 5693.9715301423485, 5735.225744524488, 5761.740721667525, 5767.019606666871, 5725.541956643469, 5737.7991770287945, 5755.9424405756035, 5756.8272951811405, 5815.244018277628, 4534.433195850519, 4572.634189264851, 4573.016801387701, 4585.862424127282, 4588.967482316469, 4486.618637415807, 4524.6380289576755, 4547.704399214057, 4551.931721024171, 4612.46956599992, 4510.300903359985, 4510.571495707903, 4519.706219095749, 4520.954790452102, 4521.32180172975, 4528.139653465847, 4528.43394575678, 4531.864044078683, 4551.68138230324, 4584.7936842842155, 3899.8300509847218, 3971.463852379921, 3972.761634301922, 3994.962569089756, 4012.7391719538427, 5704.401037891044, 5711.343195532525, 5718.485336319751, 5752.504348869283, 5757.337906140764, 5086.92369614456, 5224.947750522484, 5225.634205605609, 5254.6847189168775, 5257.13257312543, 6027.7287522061615, 6032.758689652409, 6057.636541807506, 6073.271207455089, 6082.1789058477425, 4422.270325396305, 4440.311751678495, 4444.155610434007, 4447.666425018104, 4455.443069616298, 6217.316095229521, 6344.555881088326, 6364.204474440695, 6369.585976911486, 6383.265924418705, 4490.012197316585, 4497.955020449819, 4517.683762136685, 4525.954740452619, 4526.932096018562, 4598.747068911242, 4601.0, 4604.884877878013, 4606.239970404846, 4613.723176609415, 5145.614078944094, 5185.170372740344, 5204.42751297357, 5242.685438873604, 5242.7378631068295, 5908.586398952032, 6066.878662426727, 6074.574779765374, 6087.604305720114, 6141.570090093651, 1606.3173151410838, 1616.272677295222, 1629.1202750514826, 1629.8998176230996, 1630.9755353669705, 1000.9940010289612, 1024.830902901013, 1035.0374152038526, 1035.637526865591, 1039.449091981251, 5274.208868669731, 5285.920711189336, 5313.893722125613, 5333.386660534088, 5333.786648534093, 5493.642913210629, 5524.591229236519, 5538.252335934678, 5564.026295398289, 5568.916466253009, 4949.628777841676, 5254.185601231815, 5294.682319060868, 5313.760880760375, 5313.946860531345, 2939.544370622557, 2943.4701753684544, 2944.3080875994124, 2953.616029916097, 2957.0, 5518.613697041169, 5709.714514274269, 5719.48524632785, 5806.332271788799, 5812.854678632983, 5514.889702205934, 5621.7836622533105, 5631.029139801037, 5665.0, 5681.602287839812, 5696.715164241854, 5757.395473475309, 5769.259601689164, 5823.79616713413, 5889.676067816225, 5308.911673107081, 5490.725463726878, 5505.587080968863, 5524.723763811874, 5655.547556195576, 5480.424555421623, 5480.616356855141, 5557.416471270459, 5560.860978475571, 5565.749541270571, 5760.222369979999, 5784.797532086357, 5792.189093526994, 5819.418058194146, 5835.156819839608, 4020.3567429211184, 4134.958650413458, 4181.749095054306, 4182.749035057906, 4193.72740771861, 5505.862353441035, 5547.0, 5560.416156303691, 6133.570650054632, 6303.716332765129, 6139.201903752483, 6173.783917562864, 6197.450637340665, 6205.81382558524, 6210.254769427697, 6083.300420451527, 6190.845228869134, 6211.0, 6218.31598524171, 6287.371262873676, 6113.786017489367, 6125.9693701531205, 6137.263528376623, 6141.232345956755, 6157.322694503511, 6219.315875253809, 6242.313345531897, 6242.406971337716, 6244.6261822399, 6274.717637706223, 5870.354261031198, 6008.04738460011, 6027.78902738402, 6060.1212824139375, 6102.115193297036], "value": 4510.226866635926, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.5522314223037, 771.6488997506139, 817.7955511122219, 842.0863363250872, 880.9691660791874, 16185.190740462975, 17500.737488937677, 17551.64896702067, 17556.473305800813, 17557.12214389282, 15435.382584696627, 15524.689506209868, 15550.066995980249, 15576.68846623067, 15607.141607211628, 712.8253577873428, 840.7015509494103, 848.1010129262986, 869.7173418638936, 872.3283072034529, 860.2859626510013, 866.1901122450497, 866.1987661413199, 867.5965675960678, 867.6399294292861, 917.0600134861787, 917.7751450894507, 917.8393781088316, 918.8943271523793, 920.9309301802358, 911.5624500239921, 913.5751875377948, 914.6158613382395, 914.9130832570962, 919.7562645898843, 676.6650507998572, 678.5555461172939, 681.7681988124061, 681.924988251292, 683.3235097253732, 15782.526524204291, 15834.445794397141, 15841.0495370277, 15852.365905363888, 15855.44505942298, 14439.205843678594, 14573.0, 14708.338124784303, 14720.0, 14730.042547234396, 12906.870931290661, 12962.48150073996, 12969.41637626309, 13215.86784132156, 13321.200727956353, 3962.7622342659533, 4155.563665815076, 4181.184668989548, 4278.080212754273, 4286.121345124242, 76491.61754191249, 84917.99999999939, 85164.0, 85177.14822851754, 85551.0, 10310.690679279634, 10711.625093121704, 10820.13438924884, 11027.0, 11122.666320010412, 22738.31785046451, 22869.771302287096, 22959.655605165935, 23023.654645180002, 23254.069837206323, 8953.955230223937, 9140.08599140094, 9267.860982085274, 9290.442573445614, 9382.155605995493, 4583.816647334069, 4607.295300738748, 4709.929351059737, 4770.403699537558, 4837.588804951619, 3823.9235215296094, 3946.8223929923224, 3953.090789118519, 3953.7034722395933, 3953.92092158161, 681.0431343961742, 683.5351960666695, 690.0890824112124, 692.8718187135396, 698.8672152291049, 655.9147310849559, 674.4132604634, 722.3859719238606, 810.0805585660318, 821.2321479416764, 10509.159267258601, 10983.725406864893, 11048.0, 11064.391458469701, 12227.205231659913, 634.6953462338104, 664.2693037658537, 722.7362012865372, 740.6926125657899, 766.6894907562446, 4903.190973489405, 4938.209886418156, 5245.842624721265, 5293.629445938747, 5442.0, 71930.64034679793, 79694.0, 114616.0, 120461.0, 128940.35529822292, 106740.0, 109779.45110274397, 110846.0, 111539.44230278797, 115860.42069789597, 83008.58495707483, 83094.16345524316, 83939.16060839314, 96831.0, 97890.0, 10096.545655445376, 10122.696319110144, 10161.187105031431, 10479.318844275098, 10672.0, 49440.752796235785, 51260.0, 53795.92408151893, 58256.0, 58293.70853145707, 54750.72624636851, 67200.0, 76743.61628191824, 78002.6099869497, 80423.59788201256, 12920.870791291967, 13137.671558211121, 13782.93108534451, 13894.23581703016, 14098.08362456478, 15383.846161538242, 15421.922890385476, 15459.61350966235, 15654.9217253913, 15952.760708589149, 13106.60680179596, 13398.732025359634, 15202.771958420853, 15654.0, 15669.921650391676, 14297.428102875769, 14543.0, 15457.5362739118, 15464.226788660748, 15531.0, 12080.890652425858, 14445.92777036108, 14656.340464679328, 15097.169655669044, 15782.526524204291, 10574.101201397967, 10611.469426528796, 10944.726381840517, 11174.66476005721, 11624.150165506911, 9965.800683986425, 10823.350598964087, 11098.722531936442, 11695.649130526097, 11898.821517677416], "value": 7963.627074479285, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1493.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 106.0, 110.0, 111.0, 113.0, 112.0, 111.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 138.0, 165.0, 117.0, 147.0, 148.0, 117.0, 180.0, 118.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 168.0, 162.0, 162.0, 160.0, 164.0, 162.0, 161.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 172.0, 75.0, 75.0, 78.0, 75.0, 162.0, 74.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 145.0, 83.0, 84.0, 83.0, 143.0, 84.0, 84.0, 136.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 98.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 54.0, 56.0, 57.0, 54.0, 57.0, 56.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 73.0, 73.0, 72.0, 71.0, 82.0, 75.0, 73.0, 71.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 119.0, 133.0, 125.0, 126.0, 118.0, 118.0, 124.0, 151.0, 117.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 149.0, 150.0, 146.0, 148.0, 152.0, 150.0, 149.0, 151.0, 151.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 63.0, 61.0, 62.0, 61.0, 60.0, 61.0, 60.0], "value": 61.3, "unit": "score"}]}]} 23:04:09 INFO - Return code: 0 23:04:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:04:09 ERROR - # TBPL SUCCESS # 23:04:09 INFO - Running post-action listener: _resource_record_post_action 23:04:09 INFO - [mozharness: 2016-09-21 06:04:09.208372Z] Finished run-tests step (success) 23:04:09 INFO - Running post-run listener: _resource_record_post_run 23:04:09 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 290934784; Read time: 0; Write time: 177540 23:04:09 INFO - TinderboxPrint: CPU usage
13.2% 23:04:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:04:09 INFO - TinderboxPrint: I/O write bytes / time
290,934,784 / 177,540 23:04:09 INFO - TinderboxPrint: CPU idle
8,202.6 (86.7%) 23:04:09 INFO - TinderboxPrint: CPU user
1,200.4 (12.7%) 23:04:09 INFO - TinderboxPrint: Swap in / out
0 / 0 23:04:09 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70070272; Read time: 0; Write time: 65796 23:04:09 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 220864512; Read time: 0; Write time: 111744 23:04:09 INFO - Running post-run listener: _upload_blobber_files 23:04:09 INFO - Blob upload gear active. 23:04:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:04:09 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 23:04:09 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:04:09 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:04:10 INFO - (blobuploader) - INFO - Open directory for files ... 23:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:04:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:04:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:04:11 INFO - (blobuploader) - INFO - Done attempting. 23:04:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:04:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:04:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:04:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:04:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:04:14 INFO - (blobuploader) - INFO - Done attempting. 23:04:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:04:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:04:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:04:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:04:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:04:15 INFO - (blobuploader) - INFO - Done attempting. 23:04:15 INFO - (blobuploader) - INFO - Iteration through files over. 23:04:15 INFO - Return code: 0 23:04:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:04:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:04:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/638b8c740f8c231d6585658b1cd9c8fc6ccb14e95eab6c74496a897b07183a7fa3262a160098e35afae7f5fbfd1ea6aa05b7ab608754e4cab879c77dbb074f1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/956393a6043c2cd21944b80cce4e855b84c89dbd1136fc957654020226f4a447ec392ca7b30fe32a75e35cbae086b68edb33267c3f4ae28f902c660897cd96cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e160c3b9bea71e9886858a9f72fbfe21b4f8e76fbfdf6176b11fd5059d796c7e99b0140e451e7b668d1c9ed5edb0f6ed0f7b78c3af56015c43b52de04c9835d0"} 23:04:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:04:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:04:15 INFO - Contents: 23:04:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/638b8c740f8c231d6585658b1cd9c8fc6ccb14e95eab6c74496a897b07183a7fa3262a160098e35afae7f5fbfd1ea6aa05b7ab608754e4cab879c77dbb074f1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/956393a6043c2cd21944b80cce4e855b84c89dbd1136fc957654020226f4a447ec392ca7b30fe32a75e35cbae086b68edb33267c3f4ae28f902c660897cd96cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e160c3b9bea71e9886858a9f72fbfe21b4f8e76fbfdf6176b11fd5059d796c7e99b0140e451e7b668d1c9ed5edb0f6ed0f7b78c3af56015c43b52de04c9835d0"} 23:04:15 INFO - Running post-run listener: copy_logs_to_upload_dir 23:04:15 INFO - Copying logs to upload dir... 23:04:15 INFO - mkdir: /builds/slave/test/build/upload/logs 23:04:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1672.991994 ========= master_lag: 19.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 12 secs) (at 2016-09-20 23:04:34.878870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 23:04:34.882200) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660 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-Beta/sha512/638b8c740f8c231d6585658b1cd9c8fc6ccb14e95eab6c74496a897b07183a7fa3262a160098e35afae7f5fbfd1ea6aa05b7ab608754e4cab879c77dbb074f1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/956393a6043c2cd21944b80cce4e855b84c89dbd1136fc957654020226f4a447ec392ca7b30fe32a75e35cbae086b68edb33267c3f4ae28f902c660897cd96cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e160c3b9bea71e9886858a9f72fbfe21b4f8e76fbfdf6176b11fd5059d796c7e99b0140e451e7b668d1c9ed5edb0f6ed0f7b78c3af56015c43b52de04c9835d0"} build_url:https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/PcbuNN7uQpyXtA7dC4fFpQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/638b8c740f8c231d6585658b1cd9c8fc6ccb14e95eab6c74496a897b07183a7fa3262a160098e35afae7f5fbfd1ea6aa05b7ab608754e4cab879c77dbb074f1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/956393a6043c2cd21944b80cce4e855b84c89dbd1136fc957654020226f4a447ec392ca7b30fe32a75e35cbae086b68edb33267c3f4ae28f902c660897cd96cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e160c3b9bea71e9886858a9f72fbfe21b4f8e76fbfdf6176b11fd5059d796c7e99b0140e451e7b668d1c9ed5edb0f6ed0f7b78c3af56015c43b52de04c9835d0"}' ========= master_lag: 0.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 23:04:35.311463) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 23:04:35.311806) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1474436180.820299-719152660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.93 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 23:04:36.250414) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 23:04:36.253806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 23:04:36.256264) ========= ========= Total master_lag: 20.91 =========