builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1472159869.97 results: success (0) buildid: 20160825065326 builduid: a3401796f06e41f9874fbfc12178503b revision: b0b52bebfd3dff0705f0efddc1d0827144eb1e21 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:49.965818) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:49.966827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:49.967511) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:49.983686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:49.984283) ========= 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=41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 14:17:50-- 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% 37.8M=0s 2016-08-25 14:17:50 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134687 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:50.137871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:50.138408) ========= 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=41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:50.187814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:50.188198) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b0b52bebfd3dff0705f0efddc1d0827144eb1e21 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b0b52bebfd3dff0705f0efddc1d0827144eb1e21 --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=41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 14:17:50,315 truncating revision to first 12 chars 2016-08-25 14:17:50,315 Setting DEBUG logging. 2016-08-25 14:17:50,315 attempt 1/10 2016-08-25 14:17:50,315 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b0b52bebfd3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 14:17:50,961 unpacking tar archive at: mozilla-aurora-b0b52bebfd3d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.970663 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:51.175891) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:51.176652) ========= script_repo_revision: b0b52bebfd3dff0705f0efddc1d0827144eb1e21 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:51.177346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:51.177654) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 14:17:51.188412) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 2 secs) (at 2016-08-25 14:17:51.189050) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:17:51 INFO - MultiFileLogger online at 20160825 14:17:51 in /builds/slave/test 14:17:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:17:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:17:51 INFO - {'append_to_log': False, 14:17:51 INFO - 'base_work_dir': '/builds/slave/test', 14:17:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:17:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:17:51 INFO - 'branch': 'Mozilla-Aurora', 14:17:51 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:51 INFO - 'config_files': ('talos/linux_config.py',), 14:17:51 INFO - 'default_actions': ('clobber', 14:17:51 INFO - 'read-buildbot-config', 14:17:51 INFO - 'download-and-extract', 14:17:51 INFO - 'populate-webroot', 14:17:51 INFO - 'create-virtualenv', 14:17:51 INFO - 'install', 14:17:51 INFO - 'run-tests'), 14:17:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:51 INFO - 'download_minidump_stackwalk': True, 14:17:51 INFO - 'download_symbols': 'ondemand', 14:17:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:51 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:51 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:51 INFO - 'installer_path': 'installer.exe', 14:17:51 INFO - 'log_level': 'info', 14:17:51 INFO - 'log_name': 'talos', 14:17:51 INFO - 'log_to_console': True, 14:17:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:17:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:17:51 INFO - 'opt_config_files': (), 14:17:51 INFO - 'pip_index': False, 14:17:51 INFO - 'sps_profile': False, 14:17:51 INFO - 'sps_profile_interval': 0, 14:17:51 INFO - 'suite': 'dromaeojs-e10s', 14:17:51 INFO - 'system_bits': '32', 14:17:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:51 INFO - 'title': 'talos-linux64-ix-024', 14:17:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:51 INFO - 'use_talos_json': True, 14:17:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:17:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:51 INFO - 'work_dir': 'build'} 14:17:51 INFO - [mozharness: 2016-08-25 21:17:51.409890Z] Running clobber step. 14:17:51 INFO - Running pre-action listener: _resource_record_pre_action 14:17:51 INFO - Running main action method: clobber 14:17:51 INFO - rmtree: /builds/slave/test/build 14:17:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:17:51 INFO - Running post-action listener: _resource_record_post_action 14:17:51 INFO - [mozharness: 2016-08-25 21:17:51.871321Z] Finished clobber step (success) 14:17:51 INFO - [mozharness: 2016-08-25 21:17:51.871423Z] Running read-buildbot-config step. 14:17:51 INFO - Running pre-action listener: _resource_record_pre_action 14:17:51 INFO - Running main action method: read_buildbot_config 14:17:51 INFO - Using buildbot properties: 14:17:51 INFO - { 14:17:51 INFO - "project": "", 14:17:51 INFO - "product": "firefox", 14:17:51 INFO - "script_repo_revision": "production", 14:17:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:17:51 INFO - "repository": "", 14:17:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:17:51 INFO - "buildid": "20160825065326", 14:17:51 INFO - "pgo_build": "True", 14:17:51 INFO - "basedir": "/builds/slave/test", 14:17:51 INFO - "buildnumber": 508, 14:17:51 INFO - "slavename": "talos-linux64-ix-024", 14:17:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:17:51 INFO - "platform": "ubuntu64_hw", 14:17:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:17:51 INFO - "branch": "mozilla-aurora", 14:17:51 INFO - "repo_path": "releases/mozilla-aurora", 14:17:51 INFO - "revision": "b0b52bebfd3dff0705f0efddc1d0827144eb1e21", 14:17:51 INFO - "stage_platform": "linux64-pgo", 14:17:51 INFO - "builduid": "a3401796f06e41f9874fbfc12178503b", 14:17:51 INFO - "slavebuilddir": "test" 14:17:51 INFO - } 14:17:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 14:17:51 INFO - Running post-action listener: _resource_record_post_action 14:17:51 INFO - [mozharness: 2016-08-25 21:17:51.873854Z] Finished read-buildbot-config step (success) 14:17:51 INFO - [mozharness: 2016-08-25 21:17:51.873942Z] Running download-and-extract step. 14:17:51 INFO - Running pre-action listener: _resource_record_pre_action 14:17:51 INFO - Running main action method: download_and_extract 14:17:51 INFO - mkdir: /builds/slave/test/build/tests 14:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:51 INFO - https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:17:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:17:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:17:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:17:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:17:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:17:51 INFO - retry: Failed, sleeping 30 seconds before retrying 14:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 14:18:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:18:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:18:21 INFO - retry: Failed, sleeping 60 seconds before retrying 14:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 14:19:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:19:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:19:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 14:19:21 INFO - Caught exception: HTTP Error 404: Not Found 14:19:21 INFO - Caught exception: HTTP Error 404: Not Found 14:19:21 INFO - Caught exception: HTTP Error 404: Not Found 14:19:21 INFO - trying https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:19:21 INFO - Downloading https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:19:22 INFO - Downloaded 1361 bytes. 14:19:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:19:22 INFO - Using the following test package requirements: 14:19:22 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 14:19:22 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:19:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:19:22 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:19:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:19:22 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:19:22 INFO - u'jsshell-linux-x86_64.zip'], 14:19:22 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:19:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:19:22 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 14:19:22 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:19:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:19:22 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:19:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:19:22 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:19:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:19:22 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:19:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:19:22 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:19: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')]} 14:19:22 INFO - https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:19:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:19:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:19:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:19:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:19:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:19:22 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:19:22 INFO - retry: Failed, sleeping 30 seconds before retrying 14:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 14:19:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:19:52 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:19:52 INFO - retry: Failed, sleeping 60 seconds before retrying 14:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 14:20:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:20:52 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:20:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 14:20:52 INFO - Caught exception: HTTP Error 404: Not Found 14:20:52 INFO - Caught exception: HTTP Error 404: Not Found 14:20:52 INFO - Caught exception: HTTP Error 404: Not Found 14:20:52 INFO - trying https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:20:52 INFO - Downloading https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:20:53 INFO - Downloaded 21838973 bytes. 14:20:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:20:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:20:54 INFO - Return code: 0 14:20:54 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:20: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')]} 14:20:54 INFO - https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:20:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:20:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:20:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:20:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:20:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:20:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:20:54 INFO - retry: Failed, sleeping 30 seconds before retrying 14:21:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 14:21:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:21:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:21:24 INFO - retry: Failed, sleeping 60 seconds before retrying 14:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 14:22:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:22:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:22:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 14:22:24 INFO - Caught exception: HTTP Error 404: Not Found 14:22:24 INFO - Caught exception: HTTP Error 404: Not Found 14:22:24 INFO - Caught exception: HTTP Error 404: Not Found 14:22:24 INFO - trying https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:22:24 INFO - Downloading https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:22:25 INFO - Downloaded 21838973 bytes. 14:22:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:22:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:22:27 INFO - Return code: 0 14:22:27 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')]} 14:22:27 INFO - https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:22:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:22:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:22:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:22:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:22:27 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:22:27 INFO - retry: Failed, sleeping 30 seconds before retrying 14:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 14:22:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:22:57 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:22:57 INFO - retry: Failed, sleeping 60 seconds before retrying 14:23:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 14:23:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:23:57 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:23:57 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 14:23:57 INFO - Caught exception: HTTP Error 404: Not Found 14:23:57 INFO - Caught exception: HTTP Error 404: Not Found 14:23:57 INFO - Caught exception: HTTP Error 404: Not Found 14:23:57 INFO - trying https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:23:57 INFO - Downloading https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:23:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:23:57 INFO - Downloaded 14413723 bytes. 14:23:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:23:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:23:58 INFO - Return code: 0 14:23: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')]} 14:23:58 INFO - https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:23:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:23:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:23:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:23:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:23:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:23:58 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:23:58 INFO - retry: Failed, sleeping 30 seconds before retrying 14:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 14:24:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:24:28 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:24:28 INFO - retry: Failed, sleeping 60 seconds before retrying 14:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 14:25:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:25:28 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:25:28 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 14:25:28 INFO - Caught exception: HTTP Error 404: Not Found 14:25:28 INFO - Caught exception: HTTP Error 404: Not Found 14:25:28 INFO - Caught exception: HTTP Error 404: Not Found 14:25:28 INFO - trying https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:25:28 INFO - Downloading https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:25:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:25:29 INFO - Downloaded 63759104 bytes. 14:25:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:25:29 INFO - mkdir: /builds/slave/test/properties 14:25:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:25:29 INFO - Writing to file /builds/slave/test/properties/build_url 14:25:29 INFO - Contents: 14:25:29 INFO - build_url:https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:25:30 INFO - Running post-action listener: _resource_record_post_action 14:25:30 INFO - Running post-action listener: set_extra_try_arguments 14:25:30 INFO - [mozharness: 2016-08-25 21:25:30.180145Z] Finished download-and-extract step (success) 14:25:30 INFO - [mozharness: 2016-08-25 21:25:30.180377Z] Running populate-webroot step. 14:25:30 INFO - Running pre-action listener: _resource_record_pre_action 14:25:30 INFO - Running main action method: populate_webroot 14:25:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:25:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:25:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:25:30 INFO - '--tppagecycles', 14:25:30 INFO - '7'], 14:25:30 INFO - 'tests': ['tsvgm']}}, 14:25:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:25:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:25:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:25:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:25:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:30 INFO - 'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:25:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:25:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:30 INFO - 'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['damp', 'tps']}, 14:25:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:30 INFO - 'tests': ['damp', 'tps']}, 14:25:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['dromaeo_dom']}, 14:25:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:25:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['basic_compositor_video']}, 14:25:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:25:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['a11yr', 14:25:30 INFO - 'ts_paint', 14:25:30 INFO - 'tpaint', 14:25:30 INFO - 'sessionrestore', 14:25:30 INFO - 'sessionrestore_no_auto_restore', 14:25:30 INFO - 'tabpaint']}, 14:25:30 INFO - 'other-e10s': {'tests': ['a11yr', 14:25:30 INFO - 'ts_paint', 14:25:30 INFO - 'tpaint', 14:25:30 INFO - 'sessionrestore', 14:25:30 INFO - 'sessionrestore_no_auto_restore', 14:25:30 INFO - 'tabpaint']}, 14:25:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:25:30 INFO - 'ts_paint', 14:25:30 INFO - 'tpaint', 14:25:30 INFO - 'sessionrestore', 14:25:30 INFO - 'sessionrestore_no_auto_restore', 14:25:30 INFO - 'tabpaint']}, 14:25:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:25:30 INFO - 'ts_paint', 14:25:30 INFO - 'tpaint', 14:25:30 INFO - 'sessionrestore', 14:25:30 INFO - 'sessionrestore_no_auto_restore', 14:25:30 INFO - 'tabpaint']}, 14:25:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['a11yr', 14:25:30 INFO - 'ts_paint', 14:25:30 INFO - 'tpaint', 14:25:30 INFO - 'sessionrestore', 14:25:30 INFO - 'sessionrestore_no_auto_restore', 14:25:30 INFO - 'tabpaint']}, 14:25:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['a11yr', 14:25:30 INFO - 'ts_paint', 14:25:30 INFO - 'tpaint', 14:25:30 INFO - 'sessionrestore', 14:25:30 INFO - 'sessionrestore_no_auto_restore', 14:25:30 INFO - 'tabpaint']}, 14:25:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['tsvgx', 14:25:30 INFO - 'tsvgr_opacity', 14:25:30 INFO - 'tart', 14:25:30 INFO - 'tscrollx', 14:25:30 INFO - 'cart']}, 14:25:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:25:30 INFO - 'tsvgr_opacity', 14:25:30 INFO - 'tart', 14:25:30 INFO - 'tscrollx', 14:25:30 INFO - 'cart']}, 14:25:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:30 INFO - 'talos_options': ['--disable-e10s'], 14:25:30 INFO - 'tests': ['tp5o']}, 14:25:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:30 INFO - 'tests': ['tp5o']}, 14:25:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:30 INFO - 'talos_options': ['--disable-e10s', 14:25:30 INFO - '--xperf_path', 14:25:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:25:30 INFO - 'tests': ['tp5n']}, 14:25:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:25:30 INFO - 'talos_options': ['--xperf_path', 14:25:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:25:30 INFO - 'tests': ['tp5n']}}, 14:25:30 INFO - 'talos.zip': {'path': '', 14:25:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:25:30 INFO - Running post-action listener: _resource_record_post_action 14:25:30 INFO - [mozharness: 2016-08-25 21:25:30.201947Z] Finished populate-webroot step (success) 14:25:30 INFO - [mozharness: 2016-08-25 21:25:30.202036Z] Running create-virtualenv step. 14:25:30 INFO - Running pre-action listener: _resource_record_pre_action 14:25:30 INFO - Running main action method: create_virtualenv 14:25:30 INFO - Creating virtualenv /builds/slave/test/build/venv 14:25:30 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 14:25:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:25:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:25:30 INFO - Using real prefix '/usr' 14:25:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:25:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:25:32 INFO - Installing pip.................done. 14:25:32 INFO - Return code: 0 14:25:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:25:32 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')]} 14:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:32 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')]} 14:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:32 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 0x227d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, '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': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', '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 14:25:32 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 14:25:32 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 14:25:32 INFO - Using env: {'DISPLAY': ':0', 14:25:32 INFO - 'HOME': '/home/cltbld', 14:25:32 INFO - 'LANG': 'en_US.UTF-8', 14:25:32 INFO - 'LANGUAGE': 'en_US:en', 14:25:32 INFO - 'LOGNAME': 'cltbld', 14:25:32 INFO - 'MAIL': '/var/mail/cltbld', 14:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:32 INFO - 'MOZ_NO_REMOTE': '1', 14:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:32 INFO - 'NO_EM_RESTART': '1', 14:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:32 INFO - 'PWD': '/builds/slave/test', 14:25:32 INFO - 'SHELL': '/bin/bash', 14:25:32 INFO - 'SHLVL': '1', 14:25:32 INFO - 'TERM': 'linux', 14:25:32 INFO - 'TMOUT': '86400', 14:25:32 INFO - 'USER': 'cltbld', 14:25:32 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:32 INFO - '_': '/tools/buildbot/bin/python'} 14:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:32 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 14:25:32 INFO - Cleaning up... 14:25:33 INFO - Return code: 0 14:25:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x227d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, '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': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', '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 14:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:25:33 INFO - Using env: {'DISPLAY': ':0', 14:25:33 INFO - 'HOME': '/home/cltbld', 14:25:33 INFO - 'LANG': 'en_US.UTF-8', 14:25:33 INFO - 'LANGUAGE': 'en_US:en', 14:25:33 INFO - 'LOGNAME': 'cltbld', 14:25:33 INFO - 'MAIL': '/var/mail/cltbld', 14:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:33 INFO - 'MOZ_NO_REMOTE': '1', 14:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:33 INFO - 'NO_EM_RESTART': '1', 14:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:33 INFO - 'PWD': '/builds/slave/test', 14:25:33 INFO - 'SHELL': '/bin/bash', 14:25:33 INFO - 'SHLVL': '1', 14:25:33 INFO - 'TERM': 'linux', 14:25:33 INFO - 'TMOUT': '86400', 14:25:33 INFO - 'USER': 'cltbld', 14:25:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:33 INFO - '_': '/tools/buildbot/bin/python'} 14:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:33 INFO - Downloading/unpacking psutil>=3.1.1 14:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:25:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:25:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:25:35 INFO - Installing collected packages: psutil 14:25:35 INFO - Running setup.py install for psutil 14:25:35 INFO - building 'psutil._psutil_linux' extension 14:25:35 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 14:25:35 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 14:25:35 INFO - building 'psutil._psutil_posix' extension 14:25:35 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 14:25:35 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 14:25:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:25:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:25:35 INFO - Successfully installed psutil 14:25:35 INFO - Cleaning up... 14:25:35 INFO - Return code: 0 14:25:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:35 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 0x227d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, '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': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', '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 14:25:35 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 14:25:35 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 14:25:35 INFO - Using env: {'DISPLAY': ':0', 14:25:35 INFO - 'HOME': '/home/cltbld', 14:25:35 INFO - 'LANG': 'en_US.UTF-8', 14:25:35 INFO - 'LANGUAGE': 'en_US:en', 14:25:35 INFO - 'LOGNAME': 'cltbld', 14:25:35 INFO - 'MAIL': '/var/mail/cltbld', 14:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:35 INFO - 'MOZ_NO_REMOTE': '1', 14:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:35 INFO - 'NO_EM_RESTART': '1', 14:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:35 INFO - 'PWD': '/builds/slave/test', 14:25:35 INFO - 'SHELL': '/bin/bash', 14:25:35 INFO - 'SHLVL': '1', 14:25:35 INFO - 'TERM': 'linux', 14:25:35 INFO - 'TMOUT': '86400', 14:25:35 INFO - 'USER': 'cltbld', 14:25:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:35 INFO - '_': '/tools/buildbot/bin/python'} 14:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:25:37 INFO - Installing collected packages: mozsystemmonitor 14:25:37 INFO - Running setup.py install for mozsystemmonitor 14:25:37 INFO - Successfully installed mozsystemmonitor 14:25:37 INFO - Cleaning up... 14:25:38 INFO - Return code: 0 14:25:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:25:38 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')]} 14:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:38 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')]} 14:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:38 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 0x227d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, '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': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', '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 14:25:38 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 14:25:38 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 14:25:38 INFO - Using env: {'DISPLAY': ':0', 14:25:38 INFO - 'HOME': '/home/cltbld', 14:25:38 INFO - 'LANG': 'en_US.UTF-8', 14:25:38 INFO - 'LANGUAGE': 'en_US:en', 14:25:38 INFO - 'LOGNAME': 'cltbld', 14:25:38 INFO - 'MAIL': '/var/mail/cltbld', 14:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:38 INFO - 'MOZ_NO_REMOTE': '1', 14:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:38 INFO - 'NO_EM_RESTART': '1', 14:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:38 INFO - 'PWD': '/builds/slave/test', 14:25:38 INFO - 'SHELL': '/bin/bash', 14:25:38 INFO - 'SHLVL': '1', 14:25:38 INFO - 'TERM': 'linux', 14:25:38 INFO - 'TMOUT': '86400', 14:25:38 INFO - 'USER': 'cltbld', 14:25:38 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:38 INFO - '_': '/tools/buildbot/bin/python'} 14:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:25:38 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 14:25:38 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 14:25:38 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 14:25:38 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 14:25:38 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 14:25:38 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 14:25:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:25:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:40 INFO - Downloading functools32-3.2.3-2.tar.gz 14:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:25:40 INFO - warning: no files found matching '*.txt' 14:25:40 INFO - no previously-included directories found matching 'build' 14:25:40 INFO - no previously-included directories found matching 'dist' 14:25:40 INFO - no previously-included directories found matching '.git*' 14:25:40 INFO - Installing collected packages: jsonschema, functools32 14:25:40 INFO - Running setup.py install for functools32 14:25:40 INFO - warning: no files found matching '*.txt' 14:25:40 INFO - no previously-included directories found matching 'build' 14:25:40 INFO - no previously-included directories found matching 'dist' 14:25:40 INFO - no previously-included directories found matching '.git*' 14:25:40 INFO - Successfully installed jsonschema functools32 14:25:40 INFO - Cleaning up... 14:25:40 INFO - Return code: 0 14:25:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x227d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, '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': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', '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 14:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:25:40 INFO - Using env: {'DISPLAY': ':0', 14:25:40 INFO - 'HOME': '/home/cltbld', 14:25:40 INFO - 'LANG': 'en_US.UTF-8', 14:25:40 INFO - 'LANGUAGE': 'en_US:en', 14:25:40 INFO - 'LOGNAME': 'cltbld', 14:25:40 INFO - 'MAIL': '/var/mail/cltbld', 14:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:40 INFO - 'MOZ_NO_REMOTE': '1', 14:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:40 INFO - 'NO_EM_RESTART': '1', 14:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:40 INFO - 'PWD': '/builds/slave/test', 14:25:40 INFO - 'SHELL': '/bin/bash', 14:25:40 INFO - 'SHLVL': '1', 14:25:40 INFO - 'TERM': 'linux', 14:25:40 INFO - 'TMOUT': '86400', 14:25:40 INFO - 'USER': 'cltbld', 14:25:40 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:40 INFO - '_': '/tools/buildbot/bin/python'} 14:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:25:40 INFO - Cleaning up... 14:25:40 INFO - Return code: 0 14:25:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x227d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, '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': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', '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 14:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:25:40 INFO - Using env: {'DISPLAY': ':0', 14:25:40 INFO - 'HOME': '/home/cltbld', 14:25:40 INFO - 'LANG': 'en_US.UTF-8', 14:25:40 INFO - 'LANGUAGE': 'en_US:en', 14:25:40 INFO - 'LOGNAME': 'cltbld', 14:25:40 INFO - 'MAIL': '/var/mail/cltbld', 14:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:40 INFO - 'MOZ_NO_REMOTE': '1', 14:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:40 INFO - 'NO_EM_RESTART': '1', 14:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:40 INFO - 'PWD': '/builds/slave/test', 14:25:40 INFO - 'SHELL': '/bin/bash', 14:25:40 INFO - 'SHLVL': '1', 14:25:40 INFO - 'TERM': 'linux', 14:25:40 INFO - 'TMOUT': '86400', 14:25:40 INFO - 'USER': 'cltbld', 14:25:40 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:40 INFO - '_': '/tools/buildbot/bin/python'} 14:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:25:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:25:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:25:44 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 14:25:44 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 14:25:44 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 14:25:44 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 14:25:44 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 14:25:44 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 14:25:44 INFO - Downloading docopt-0.6.1.tar.gz 14:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:25:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:25:44 INFO - Running setup.py install for blobuploader 14:25:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:25:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:25:44 INFO - Running setup.py install for requests 14:25:45 INFO - Running setup.py install for docopt 14:25:45 INFO - Successfully installed blobuploader requests docopt 14:25:45 INFO - Cleaning up... 14:25:45 INFO - Return code: 0 14:25:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:45 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 0x227d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, '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': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', '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 14:25:45 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 14:25:45 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 14:25:45 INFO - Using env: {'DISPLAY': ':0', 14:25:45 INFO - 'HOME': '/home/cltbld', 14:25:45 INFO - 'LANG': 'en_US.UTF-8', 14:25:45 INFO - 'LANGUAGE': 'en_US:en', 14:25:45 INFO - 'LOGNAME': 'cltbld', 14:25:45 INFO - 'MAIL': '/var/mail/cltbld', 14:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:45 INFO - 'MOZ_NO_REMOTE': '1', 14:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:45 INFO - 'NO_EM_RESTART': '1', 14:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:45 INFO - 'PWD': '/builds/slave/test', 14:25:45 INFO - 'SHELL': '/bin/bash', 14:25:45 INFO - 'SHLVL': '1', 14:25:45 INFO - 'TERM': 'linux', 14:25:45 INFO - 'TMOUT': '86400', 14:25:45 INFO - 'USER': 'cltbld', 14:25:45 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:45 INFO - '_': '/tools/buildbot/bin/python'} 14:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:25:45 INFO - Running setup.py (path:/tmp/pip-O0VqT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:25:45 INFO - Running setup.py (path:/tmp/pip-Z8oQz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:25:45 INFO - Running setup.py (path:/tmp/pip-TefRLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:25:45 INFO - Running setup.py (path:/tmp/pip-QwNLzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:25:45 INFO - Running setup.py (path:/tmp/pip-5_7M3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:25:45 INFO - Running setup.py (path:/tmp/pip-QwcBMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:25:45 INFO - Running setup.py (path:/tmp/pip-EJo715-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:25:45 INFO - Running setup.py (path:/tmp/pip-Dzt8tL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:25:46 INFO - Running setup.py (path:/tmp/pip-Mb2k_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:25:46 INFO - Running setup.py (path:/tmp/pip-DjaQ7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:25:46 INFO - Running setup.py (path:/tmp/pip-cW7Sl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:25:46 INFO - Running setup.py (path:/tmp/pip-SoZGxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:25:46 INFO - Running setup.py (path:/tmp/pip-Ef_PFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:25:46 INFO - Running setup.py (path:/tmp/pip-fZf6C4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:25:46 INFO - Running setup.py (path:/tmp/pip-4wXItF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:25:46 INFO - Running setup.py (path:/tmp/pip-v0NgFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:25:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:25:46 INFO - Running setup.py (path:/tmp/pip-MepDnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:25:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:25:46 INFO - Running setup.py install for manifestparser 14:25:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:25:46 INFO - Running setup.py install for mozcrash 14:25:46 INFO - Running setup.py install for mozdebug 14:25:47 INFO - Running setup.py install for mozdevice 14:25:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:25:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:25:47 INFO - Running setup.py install for mozfile 14:25:47 INFO - Running setup.py install for mozhttpd 14:25:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:25:47 INFO - Running setup.py install for mozinfo 14:25:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:25:47 INFO - Running setup.py install for mozInstall 14:25:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:25:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:25:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:25:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:25:47 INFO - Running setup.py install for mozleak 14:25:47 INFO - Running setup.py install for mozlog 14:25:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:25:47 INFO - Running setup.py install for moznetwork 14:25:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:25:47 INFO - Running setup.py install for mozprocess 14:25:47 INFO - Running setup.py install for mozprofile 14:25:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:25:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:25:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:25:48 INFO - Running setup.py install for mozrunner 14:25:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:25:48 INFO - Running setup.py install for mozscreenshot 14:25:48 INFO - Running setup.py install for moztest 14:25:48 INFO - Running setup.py install for mozversion 14:25:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:25:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:25:48 INFO - Cleaning up... 14:25:48 INFO - Return code: 0 14:25:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:25:48 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')]} 14:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:48 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')]} 14:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:48 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 0x227d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, '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': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', '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 14:25:48 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 14:25:48 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 14:25:48 INFO - Using env: {'DISPLAY': ':0', 14:25:48 INFO - 'HOME': '/home/cltbld', 14:25:48 INFO - 'LANG': 'en_US.UTF-8', 14:25:48 INFO - 'LANGUAGE': 'en_US:en', 14:25:48 INFO - 'LOGNAME': 'cltbld', 14:25:48 INFO - 'MAIL': '/var/mail/cltbld', 14:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:48 INFO - 'MOZ_NO_REMOTE': '1', 14:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:48 INFO - 'NO_EM_RESTART': '1', 14:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:48 INFO - 'PWD': '/builds/slave/test', 14:25:48 INFO - 'SHELL': '/bin/bash', 14:25:48 INFO - 'SHLVL': '1', 14:25:48 INFO - 'TERM': 'linux', 14:25:48 INFO - 'TMOUT': '86400', 14:25:48 INFO - 'USER': 'cltbld', 14:25:48 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:48 INFO - '_': '/tools/buildbot/bin/python'} 14:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:25:48 INFO - Running setup.py (path:/tmp/pip-lQ7XhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:25:48 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)) 14:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:25:48 INFO - Running setup.py (path:/tmp/pip-USsWEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:25:48 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)) 14:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:25:48 INFO - Running setup.py (path:/tmp/pip-Qma4Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:25:48 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)) 14:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:25:48 INFO - Running setup.py (path:/tmp/pip-dPYcSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:25:49 INFO - Running setup.py (path:/tmp/pip-VxKgRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:25:49 INFO - Running setup.py (path:/tmp/pip-nH0gjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:25:49 INFO - Running setup.py (path:/tmp/pip-TxSutl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:25:49 INFO - Running setup.py (path:/tmp/pip-WQsyrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:25:49 INFO - Running setup.py (path:/tmp/pip-YlUG06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:25:49 INFO - Running setup.py (path:/tmp/pip-qwtfYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:25:49 INFO - Running setup.py (path:/tmp/pip-HO8zxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:25:49 INFO - Running setup.py (path:/tmp/pip-_j0wIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:25:49 INFO - Running setup.py (path:/tmp/pip-2UKevW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:25:49 INFO - Running setup.py (path:/tmp/pip-IZAPZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:25:49 INFO - Running setup.py (path:/tmp/pip-wAqvU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:25:49 INFO - Running setup.py (path:/tmp/pip-gvpOUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:25:49 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)) 14:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:25:49 INFO - Running setup.py (path:/tmp/pip-g0J3rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:25:49 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)) 14:25:49 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)) 14:25:49 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)) 14:25:49 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)) 14:25:49 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)) 14:25:49 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)) 14:25:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:25:49 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 14:25:49 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 14:25:49 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 14:25:49 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 14:25:49 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 14:25:49 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 14:25:51 INFO - Downloading blessings-1.6.tar.gz 14:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:25:51 INFO - Installing collected packages: blessings 14:25:51 INFO - Running setup.py install for blessings 14:25:52 INFO - Successfully installed blessings 14:25:52 INFO - Cleaning up... 14:25:52 INFO - Return code: 0 14:25:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:25:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:52 INFO - Reading from file tmpfile_stdout 14:25:52 INFO - Current package versions: 14:25:52 INFO - argparse == 1.2.1 14:25:52 INFO - blessings == 1.6 14:25:52 INFO - blobuploader == 1.2.4 14:25:52 INFO - docopt == 0.6.1 14:25:52 INFO - functools32 == 3.2.3-2 14:25:52 INFO - jsonschema == 2.5.1 14:25:52 INFO - manifestparser == 1.1 14:25:52 INFO - mozInstall == 1.12 14:25:52 INFO - mozcrash == 0.17 14:25:52 INFO - mozdebug == 0.1 14:25:52 INFO - mozdevice == 0.48 14:25:52 INFO - mozfile == 1.2 14:25:52 INFO - mozhttpd == 0.7 14:25:52 INFO - mozinfo == 0.9 14:25:52 INFO - mozleak == 0.1 14:25:52 INFO - mozlog == 3.3 14:25:52 INFO - moznetwork == 0.27 14:25:52 INFO - mozprocess == 0.23 14:25:52 INFO - mozprofile == 0.28 14:25:52 INFO - mozrunner == 6.12 14:25:52 INFO - mozscreenshot == 0.1 14:25:52 INFO - mozsystemmonitor == 0.3 14:25:52 INFO - moztest == 0.7 14:25:52 INFO - mozversion == 1.4 14:25:52 INFO - psutil == 3.1.1 14:25:52 INFO - requests == 1.2.3 14:25:52 INFO - wsgiref == 0.1.2 14:25:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:25:52 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')]} 14:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:52 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')]} 14:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:52 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 0x227d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, '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': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', '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 14:25:52 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 14:25:52 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 14:25:52 INFO - Using env: {'DISPLAY': ':0', 14:25:52 INFO - 'HOME': '/home/cltbld', 14:25:52 INFO - 'LANG': 'en_US.UTF-8', 14:25:52 INFO - 'LANGUAGE': 'en_US:en', 14:25:52 INFO - 'LOGNAME': 'cltbld', 14:25:52 INFO - 'MAIL': '/var/mail/cltbld', 14:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:52 INFO - 'MOZ_NO_REMOTE': '1', 14:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:52 INFO - 'NO_EM_RESTART': '1', 14:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:52 INFO - 'PWD': '/builds/slave/test', 14:25:52 INFO - 'SHELL': '/bin/bash', 14:25:52 INFO - 'SHLVL': '1', 14:25:52 INFO - 'TERM': 'linux', 14:25:52 INFO - 'TMOUT': '86400', 14:25:52 INFO - 'USER': 'cltbld', 14:25:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:52 INFO - '_': '/tools/buildbot/bin/python'} 14:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:52 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)) 14:25:52 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)) 14:25:52 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)) 14:25:52 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)) 14:25:52 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)) 14:25:52 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)) 14:25:52 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)) 14:25:52 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)) 14:25:52 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)) 14:25:52 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)) 14:25:52 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)) 14:25:52 INFO - Cleaning up... 14:25:52 INFO - Return code: 0 14:25:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:25:52 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')]} 14:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:52 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')]} 14:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:52 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 0x227d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, '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': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', '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 14:25:52 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 14:25:52 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 14:25:52 INFO - Using env: {'DISPLAY': ':0', 14:25:52 INFO - 'HOME': '/home/cltbld', 14:25:52 INFO - 'LANG': 'en_US.UTF-8', 14:25:52 INFO - 'LANGUAGE': 'en_US:en', 14:25:52 INFO - 'LOGNAME': 'cltbld', 14:25:52 INFO - 'MAIL': '/var/mail/cltbld', 14:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:52 INFO - 'MOZ_NO_REMOTE': '1', 14:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:25:52 INFO - 'NO_EM_RESTART': '1', 14:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:52 INFO - 'PWD': '/builds/slave/test', 14:25:52 INFO - 'SHELL': '/bin/bash', 14:25:52 INFO - 'SHLVL': '1', 14:25:52 INFO - 'TERM': 'linux', 14:25:52 INFO - 'TMOUT': '86400', 14:25:52 INFO - 'USER': 'cltbld', 14:25:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:52 INFO - '_': '/tools/buildbot/bin/python'} 14:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:25:52 INFO - Cleaning up... 14:25:52 INFO - Return code: 0 14:25:52 INFO - Running post-action listener: _resource_record_post_action 14:25:52 INFO - Running post-action listener: _start_resource_monitoring 14:25:52 INFO - Starting resource monitoring. 14:25:52 INFO - [mozharness: 2016-08-25 21:25:52.798193Z] Finished create-virtualenv step (success) 14:25:52 INFO - [mozharness: 2016-08-25 21:25:52.798666Z] Running install step. 14:25:52 INFO - Running pre-action listener: _resource_record_pre_action 14:25:52 INFO - Running main action method: install 14:25:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:53 INFO - Reading from file tmpfile_stdout 14:25:53 INFO - Detecting whether we're running mozinstall >=1.0... 14:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:25:53 INFO - Reading from file tmpfile_stdout 14:25:53 INFO - Output received: 14:25:53 INFO - Usage: mozinstall [options] installer 14:25:53 INFO - Options: 14:25:53 INFO - -h, --help show this help message and exit 14:25:53 INFO - -d DEST, --destination=DEST 14:25:53 INFO - Directory to install application into. [default: 14:25:53 INFO - "/builds/slave/test"] 14:25:53 INFO - --app=APP Application being installed. [default: firefox] 14:25:53 INFO - mkdir: /builds/slave/test/build/application 14:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:26:09 INFO - Reading from file tmpfile_stdout 14:26:09 INFO - Output received: 14:26:09 INFO - /builds/slave/test/build/application/firefox/firefox 14:26:09 INFO - Running post-action listener: _resource_record_post_action 14:26:09 INFO - [mozharness: 2016-08-25 21:26:09.811055Z] Finished install step (success) 14:26:09 INFO - [mozharness: 2016-08-25 21:26:09.811329Z] Running run-tests step. 14:26:09 INFO - Running pre-action listener: _resource_record_pre_action 14:26:09 INFO - Running main action method: run_tests 14:26:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:26:09 INFO - Python 2.7.3 14:26:09 INFO - Return code: 0 14:26:09 INFO - grabbing minidump binary from tooltool 14:26: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')]} 14:26:09 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 0x253b570>, '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 0x253c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:26:09 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 14:26:09 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 14:26:09 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 14:26:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:26:09 INFO - Return code: 0 14:26:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:26:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:26:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:26:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:26:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:26:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 14:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 14:26:09 INFO - Using env: {'DISPLAY': ':0', 14:26:09 INFO - 'HOME': '/home/cltbld', 14:26:09 INFO - 'LANG': 'en_US.UTF-8', 14:26:09 INFO - 'LANGUAGE': 'en_US:en', 14:26:09 INFO - 'LOGNAME': 'cltbld', 14:26:09 INFO - 'MAIL': '/var/mail/cltbld', 14:26:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:26:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:09 INFO - 'MOZ_NO_REMOTE': '1', 14:26:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:26:09 INFO - 'NO_EM_RESTART': '1', 14:26:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:09 INFO - 'PWD': '/builds/slave/test', 14:26:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:26:09 INFO - 'SHELL': '/bin/bash', 14:26:09 INFO - 'SHLVL': '1', 14:26:09 INFO - 'TERM': 'linux', 14:26:09 INFO - 'TMOUT': '86400', 14:26:09 INFO - 'USER': 'cltbld', 14:26:09 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168', 14:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:09 INFO - '_': '/tools/buildbot/bin/python'} 14:26:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 14:26:10 INFO - mozversion application_buildid: 20160825065326 14:26:10 INFO - mozversion application_changeset: b0b52bebfd3dff0705f0efddc1d0827144eb1e21 14:26:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:26:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:26:10 INFO - mozversion application_name: Firefox 14:26:10 INFO - mozversion application_remotingname: firefox-dev 14:26:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:26:10 INFO - mozversion application_vendor: Mozilla 14:26:10 INFO - mozversion application_version: 50.0a2 14:26:10 INFO - mozversion platform_buildid: 20160825065326 14:26:10 INFO - mozversion platform_changeset: b0b52bebfd3dff0705f0efddc1d0827144eb1e21 14:26:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:26:10 INFO - mozversion platform_version: 50.0a2 14:26:10 INFO - using testdate: 1472160370 14:26:10 INFO - actual date: 1472160370 14:26:10 INFO - starting webserver on 'localhost:55417' 14:26:10 INFO - SUITE-START | Running 2 tests 14:26:10 INFO - TEST-START | dromaeo_css 14:26:10 INFO - operating with platform_type : linux_ 14:26:10 INFO - Initialising browser for dromaeo_css test... 14:26:10 INFO - TEST-INFO | started process 18088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmOjoSQ/profile http://localhost:55417/getInfo.html) 14:26:14 INFO - PROCESS | 18088 | __metrics Screen width/height:1600/1200 14:26:14 INFO - PROCESS | 18088 | colorDepth:24 14:26:14 INFO - PROCESS | 18088 | Browser inner width/height: 1024/697 14:26:14 INFO - PROCESS | 18088 | __metrics 14:26:15 ERROR - PROCESS | 18088 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:26:16 INFO - TEST-INFO | 18088: exit 0 14:26:16 INFO - Browser initialized. 14:26:16 INFO - Running cycle 1/1 for dromaeo_css test... 14:26:16 INFO - TEST-INFO | started process 18216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmOjoSQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:28 INFO - PROCESS | 18216 | RSS: Main: 152678400 14:26:28 INFO - PROCESS | 18216 | 14:27:17 INFO - PROCESS | 18216 | 1472160437622 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] 14:29:25 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:55417/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55417/tests/dromaeo/cssquery-ext.html) 14:29:27 INFO - PROCESS | 18216 | RSS: Main: 157798400 14:29:27 INFO - PROCESS | 18216 | 14:32:29 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:55417/tests/dromaeo/cssquery-ext.html (next: http://localhost:55417/tests/dromaeo/cssquery-jquery.html) 14:32:29 INFO - PROCESS | 18216 | RSS: Main: 154083328 14:32:29 INFO - PROCESS | 18216 | 14:35:31 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:55417/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55417/tests/dromaeo/cssquery-mootools.html) 14:35:32 INFO - PROCESS | 18216 | RSS: Main: 154034176 14:35:32 INFO - PROCESS | 18216 | 14:38:33 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:55417/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55417/tests/dromaeo/cssquery-prototype.html) 14:38:34 INFO - PROCESS | 18216 | RSS: Main: 152973312 14:38:34 INFO - PROCESS | 18216 | 14:41:37 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:55417/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55417/tests/dromaeo/cssquery-yui.html) 14:41:37 INFO - PROCESS | 18216 | RSS: Main: 155713536 14:41:37 INFO - PROCESS | 18216 | 14:44:40 INFO - PROCESS | 18216 | Cycle 1(1): loaded http://localhost:55417/tests/dromaeo/cssquery-yui.html (next: http://localhost:55417/tests/dromaeo/cssquery-dojo.html) 14:44:40 INFO - PROCESS | 18216 | RSS: Main: 155979776 14:44:40 INFO - PROCESS | 18216 | 14:44:40 INFO - PROCESS | 18216 | __start_tp_report 14:44:40 INFO - PROCESS | 18216 | _x_x_mozilla_page_load 14:44:40 INFO - PROCESS | 18216 | _x_x_mozilla_page_load_details 14:44:40 INFO - PROCESS | 18216 | |i|pagename|runs| 14:44:40 INFO - PROCESS | 18216 | |0;dojo.html;3302.1909632140128;3326;3332.2002719347356;3348.5479460272854;3360.69753722165;5850.268716410449;5856.853578660535;5874.735636896339;5906.05503119501;5912.260967379078;5801.361850196475;5868.501177399916;5874.823755287338;5874.882502349961;5878.23582934219;5269.394019687737;5311.601629877755;5351.09031464652;5358.035553600351;5375.919361209585;5221.921671174935;5242.55438287746;5260.473952604747;5279.894402111955;5308.840734777963;5305.495977882095;5337.092694241969;5361.115415956362;5397.78408863645;5405.729713514328;5360.490753378443;5368.409474957752;5383.703896285702;5389.78440862365;5402.189671549299;5153.484651534854;5197.324347834795;5206.219067139921;5281;5358.758855851496;5780.364159942403;5846.3861294563885;5855.209546711225;5859.472647461706;5894.4989675877605;6272.247330320345;6316.905246421307;6330.525210609223;6335.461485773715;6340.239171299428;6081.969590152021;6226.097215903714;6376.48988080957;6381.266154392258;6399.04014397844;5839.211706419622;5925.525957923356;5934.317553481319;5956.821295361146;5973.492253158487;6492.740290388426;6499.480041596756;6528.118703974903;6539.051837483634;6543.1166792483355;6064.878702425926;6090.634561926298;6267.1539342188225;6277.874442511215;6295.118683384329;6136.549713441251;6238.407351301619;6281.466075383643;6282.183316168869;6288.465480434123;6251.374862513712;6252.406021427957;6262.530310226751;6265.373462653698;6279.560430769893;6131.040261761377;6134.38656134383;6259.749610015549;6268.808926303987;6281.2462504498835;4718.976405117953;4780.020095880336;4791.089692958327;4816.060868130681;4817.8313759018265;4241.597048280409;4257.40396344512;4257.701960862772;4286.807093680792;4287.056847493546;5905.852353691193;5925;6017.338092809788;6045.72794224261;6054.39456054391;6220.129181914535;6313.494920406357;6333.746650134035;6334.208223972004;6336.239651241881;6039.939600604026;6056.121862329937;6063.696815159225;6076.574639775262;6089.786857459968;5328.227407025959;5397.8380648580605;5403.621746477787;5448.536874365644;5454.536364409069;6511.251206111263;6628.171478565179;6638.137042184485;6638.634875081917;6650.833729156713;6347.174867267226;6372.840678983062;6400.135981642512;6411.711472983634;6414.230292364759;6361.491080713625;6459.450946669585;6556.311587283267;6562.704678289584;6619.735210591522;6161;6289.9371006291185;6294.653794041372;6301.96849015752;6315.810525684236;6402.743890244525;6406.679666016587;6409.839754006187;6410;6410.102585637921;5979.4618484336615;6021.096835474714;6170.352113028068;6202.317745048132;6217;6046.848828779316;6103.633781973096;6115.118650813463;6117.431594453822;6151.477124444473;6038.607490513103;6083.209182806207;6119.632822030692;6124.755009799558;6126.264848218242;6049.455549000435;6060.515158787374;6168.537359697951;6170.722317495633;6196.876062478635;5970.611910225995;6045;6080.513558915188;6088.299845517822;6106.755729770759 14:44:40 INFO - PROCESS | 18216 | |1;ext.html;586.1325238646803;635.5170070746233;652.5888690125217;657.1161787395952;712.1311999360778;42314.365284520754;47856.282155767694;47872.760636196814;47882;47898.28152577714;46924.296135558;47252;47383.28925066127;47391.28913066298;47424.28863567049;9152.405093668924;9332.440053596772;9334.813303733921;9348.298877584175;9366.625334986626;9372.484513351763;9377.249820014382;9428.434293942351;9455.101765332283;9467.242620590336;9425.81148377032;9440.575174117146;9460.38507497014;9486.762830929212;9518.333716639838;9334.579943902541;9406.9529652352;9424.104710052534;9424.528773561295;9437.905620943771;9310.767230819216;9337.393069450532;9362.438253704799;9369.203617692505;9392.436453812794;44131.11737765259;44362.556374436164;44407.55592444099;44419.77790111061;44453.77773111146;3216.2281052547455;3490.7556471047037;3551.7158627309755;3623.836927338276;3809.238152369537;33909.830450847585;34000.31999359999;34154.48768268478;34228.48657270143;34548.136296592784;4495.955040449619;4497.887552811206;4514.593686568224;4530.501644819067;4535.9773201133785;338385;338848;339788.99999999756;340463;341985.9999999975;38852.6114738849;39052.21895562073;39066.41400378996;39122.21755564873;39176.216475670895;39856.2028759429;39920.401193982114;40012;40037.59962400397;40057;19003.23987040503;19461.221551137794;19567.60864782725;20469.18123275082;20480.18079276842;15202.695946081238;15346.23268836576;15445.691086178214;15488.612784680474;15511.45709900148;21008.26471073505;21183.68224476634;21220.46948826261;21463;21487.67768483474;7319.890201646979;7466.552006879605;7515.812104697427;7602.695892164252;7757.650905709256;1047.8742550893942;1050.5272627317586;1125.6454216921643;1169.8128299472214;1203.3983008495752;34743;34919.301613968084;35067.298654026774;35130.64869351325;35381;1207.3299318877932;1210.842590463234;1217.0932655171953;1239.7582471417986;1270.1299609767339;17913.283468661368;18545.165467553994;18754.81245187558;18773.7183942241;18922.3377181798;171994;172305.41541876883;172930;173377;565085;65592.67203664046;65856;66108;66213.33786662167;66664.33335666679;1440.9337090553124;1462.5100591302032;1474.7714104314064;1489.3074720254917;1490.299559207171;34992;35296.647033529334;35357.823210883784;35464;35619.10952226215;56693;56715.149272761766;56727;56964.14553781613;57076.71461642665;376442;377592;378682;378763;379298;30866.068421782595;31257.687423126386;31588.894388696284;31843.36313273768;31962.041138765875;52562.73718631535;53101.4689853112;53381.19928201003;54283.18575221454;54604.18093728518;44925.32612010757;46451.30323045225;47210.527894721985;47366.76316618395;48211;46146.76926615345;46184.30723539217;46669.06661866812;46712.67345972853;47723.52276477191;42638.78680606577;43891;45553.31670024886;46251.76874115742;47709.28436073531;38647.806760966014;39324.606753932094;39384.6061539381;41043.589564103975;43223.783881080395;31244.218894527818;31389;31441.68558314479;31865.840670796497;31901.840490798328 14:44:40 INFO - PROCESS | 18216 | |2;jquery.html;404.11297202640196;407.76757248368443;416.1925863824181;419.5112693711826;426.72263029031126;19263.32578359758;20859.26992555261;21218.257360992367;21332.680009799828;22019.779802201974;20704.27535036274;20755.377338679828;20876.164953401883;21382.89308553459;21448.785512144874;5882.6764527950945;6101.78643747469;6102.26772787264;6104.298005729332;6107.877842443148;5815;5889.64662120272;5927.051671732502;5950.910736338937;5968.880622387572;5996.730147143389;5997.550183736215;6002.699865006754;6015.398460153971;6016.608920420181;5863.8534036649;5972.522198224132;5980.79067232647;6001.609895356832;6006.069059295773;5239.816606418795;5319.1223448131395;5325.680459172423;5346.705931173784;5380.650257733235;24976.375590610198;25058.874705626356;25079.24762257135;25115;25531.23406297814;2706.742859428351;2708.2823051891264;2793.0782841662203;2846.103477404611;3093.814371137739;15429;15599.532014039596;15849.920750396173;15950.282237299349;16184.433544825992;1994.3019943019972;2000.3298894870236;2056.8251698605636;2068.7414073240843;2138.0699395762895;83926;85421.57289213514;85960;86936.56531717365;88058.55970720106;10823.458827058615;10923.344599323907;10998.560057597606;11078.279911805706;11316.151288653384;15711;15756.842431575767;15797.36810527566;15799.131047792482;15846.920765396098;8443.324534037261;8737.60680769367;8765.649374024968;8774.692885748967;8938.86591701125;8534.402591818513;8628.784280392914;8700.695475658322;8767.12328767131;8859.867101993475;6784.7964561063245;6868.175818901664;6959.617221052789;7026.508144429943;7054.188768291609;1961.7057441383906;2013.426173540534;2029.553498230387;2030.959380812405;2034.8168664820237;1055.2824079625927;1056.572088304238;1059.1103473082649;1073.313079629038;1149.48273277024;18929.81070189308;19762.70355944662;20881.164753409692;21722.239721609985;21732.34802955914;1086.0442810326863;1087.228068071678;1093.4259513755342;1112.238116889933;1157.0627791488753;11197.384143872003;11865.406729663482;12059.155859089955;12270.079744019235;12372.13395062355;482099;486352;490471;536712;550652;87779.56110219409;90459.54770226238;90486.09513904908;91245;92170.07829921615;1057.1489950589696;1101.5924108080062;1102.3330884814732;1130.7060164357163;1137.4710759496875;16355;18275.908620456812;18440.723389148905;19052.523686907938;19149.712754308417;43480.565194347655;43540.78229608832;46510.76744616255;47508.52491475179;48097.5190248107;64257;64556.677216613614;65907.67046164739;66439;67436.6628166856;8792.296616270554;9041.819163616823;9139.086091390807;9252.907470925205;9322.906770932204;12900.548480803127;14308;14376.712465750836;14558.41766329335;14647.560573182822;12579.559715409916;12744.299063551594;12770.2337859725;12784;12789.296588687712;12396.81404778947;12483.31341776211;12571.434285456993;12591;12649.747005059664;12068.75862482763;12317.938410307892;12488.188267762567;12812.935935320636;12897.41961611711;8883.73348799537;8900.643974241217;8958.910410895807;9242.537873106452;9259.398139120936;9438.764030899283;11556.306621602731;12002.039836813208;12255.080868934687;13113.475460981454 14:44:40 INFO - PROCESS | 18216 | |3;mootools.html;1568.7254730422176;1591.021521764115;1770.2211027148053;1856.155449270582;1888.4806678163504;8625.95687021564;9321.254299656028;9344.486053267085;10046.648367307145;10049.397036177834;9447.574859131339;9702.272329575275;9773;9794.461304628243;9812.116909478145;2477.838940468873;2501.0996041425074;2509.498100379922;2525.217182673368;2531.949361012779;2414.396400899775;2461.126300163443;2463.519613675334;2474.5669507836146;2475.628655701641;2400.195934361982;2401.231605886117;2461.384653836541;2468.9135880244194;2469.814763892706;2405.6151015837468;2406.2300063979446;2425.551273014498;2427.1504973259393;2432;2439.097533912464;2448.4123810285405;2455.8280920335583;2456.066694656019;2465.2234546118093;9957.651482198089;10005.19958403326;10008.449535275557;10034.297599168061;10054.547545360476;5536.806211782568;5747.396523365028;5778.219940308047;5789.334226563957;5830.737616807254;3564.6435356464403;3606.1705807664384;3661.176235347052;3706.666400023984;3764.3224219640456;1185.5672679471932;1240.406078189522;1241.4103300932074;1253.5173958026135;1280.615815255429;13792;13865.306734663227;13882.722345553133;13896.58310250694;13896.791548126786;4930.433000205022;4951.331570237971;5105.489451054939;5113.565346945476;5124.590032797368;10933.28933619328;10993;11081.390523521122;11084.61203857861;11098.500567474483;5675.290588676416;5707.0868661014865;5708.628939118944;5723.885522289531;5733.827985160452;4721.551452611996;5103.2855400244;5175.353080864892;5197.402298735618;5351.598630102758;4159.459270294842;4192;4231.492220933507;4256.446661933929;4262.424572682648;1221.2306247064294;1253.6552448076852;1257.283348491351;1263.1158189267549;1263.759885621729;837.2381133168788;882.6998820400966;946.7822400847843;969.4571040217501;1044.5038606661926;6468.838279043061;6529.249136349285;6708.396244337935;6712.865742685119;6738.59568425896;1013.6097602423121;1023.2325755683238;1046.5081411736471;1083.685731137977;1097.3361116524547;4737.786799594027;4820.39745031871;4833.4441539223435;4869.732164730974;4870.707757534559;12065.215760975509;12463.439145238486;12554.560590379293;12570.120091593684;12579.308138052313;12408.19346742477;12431.440585173688;12449.875501244871;12503.49986000568;12515;8662.2637075848;8964.910350896538;8967.775805604782;9069.138431848964;9172.266218702622;6808.523403361717;6840.623765692736;6890.34541718556;6964.477664175106;7118.074650295428;11301.43492825339;11351.829722554334;11389.088872890314;11534.59628912984;11565.826512602485;11507.252028618448;11553.595624153115;11613.187076904873;11622.302661840316;11708.765824683629;7954;8498.277646400125;8670.609822557873;8674.522901240493;8727.170918762708;9571.473568953774;9651.469169195761;9658.468784216935;9723.611055557982;9733.853992190265;8333.749987500385;8342.87485687703;8359.832803344021;8408.453450525696;8475.83048339042;8128.715494957648;8245;8256.091829898827;8337.082920878578;8364.498130112213;7930.246626570467;8029.4379393441895;8046.0747014091785;8062.83874322522;8088.272055515032;5751.597388182787;5767.884642307215;5885.646861188171;6005.609635373687;6023.66869822164;5813.941860581509;5853.180554722428;5874.295084589706;5911.527077833849;5959.4934430573885 14:44:40 INFO - PROCESS | 18216 | |4;prototype.html;333.1122558381912;339.15042817741556;344.206603778291;348.59040627262976;350.2469690166144;5857.941420585793;5961.493273071788;6004.309504406994;6008.789692360758;6021.879562408749;5808.477237048664;5843.532517398608;5845.912311315334;5877.67672777997;5880.5883588148845;4358.585934336233;4393.538678438766;4497.190505708971;4529.682922195448;4535.206338890697;4491.910161796762;4502.144592527426;4504.954950450503;4524.411826462555;4528.9547104528865;4435.667324950626;4476.440444944382;4501;4508.797104130322;4524.61540769035;4424.911501769962;4437.2013037653205;4443.688941774077;4451.310046942729;4463.308187230984;3933.311670457687;3952.7430717003303;3961.7622942623534;3970.828605561366;3990.6408423241755;5681.204631351614;5687.402822703598;5697.800576979827;5714.22859912946;5727.284089488814;4906.435759887623;5104.846854594331;5126.359205099363;5137.2037334213255;5142.717150556718;6089;6122.734588202394;6157.630542167484;6170.197874276315;6185.319614842364;4098.774567398792;4246.830126794925;4257.637011458639;4284.892877678052;4290.206311832289;6261.027776250512;6300.21247344082;6308.653024083674;6308.905366419507;6352.523560732917;4436.733795972252;4443.9334559706085;4465.553444655573;4473.5526447355005;4480.574345437179;4334.306510958231;4500.819967201275;4536.364908912755;4541.6593755468475;4567.6802623816675;5125.974370128126;5160.483951604884;5162.225666150108;5179.22311653255;5180.637355385087;6056.939430605726;6170.753169873245;6196.752129914753;6220.911340515392;6237.5321850860455;1538.6768778556404;1545.2814441284856;1566.9921650391902;1595.1625396666843;1613.274026687995;1017.2523195451338;1042.0777611813598;1062.490004797686;1080.7514271717548;1119.8768135505088;5865.882682346414;5908.911366329508;5966.359251205953;5972.671503067286;6001.36985616504;6198.473129783929;6226;6259.280182779039;6302.180716506917;6330.183068534458;5650.237217975603;5874.618149820248;5923.555733320019;5937.168796368512;5953.464188222994;3351.8826841060445;3358.462645976632;3385.6783605557434;3386.9153271167925;3404.710599599062;6415.3722149801;6479.44924681398;6494.902576461357;6499.350064993558;6558.967205163944;6349.142865713162;6397.912354899679;6423.582467139714;6426.35736426363;6433.839154021187;6288.874222515616;6372.58578192416;6521.869562608721;6535.248446428626;6561.606303621798;6130.785422510369;6275.466585340298;6278.811635650938;6300.338464461165;6344.27040890285;6127.754889804358;6281.874362512633;6282.340354262737;6319.715612797343;6320.009197102898;6409.166808314889;6461;6468.8059358219325;6479.514036447191;6492.253390860112;4405.273129933653;4412.867613971586;4428.911421771482;4439.356293337512;4440.955590444183;6164.815055548341;6218.751249949952;6249.812505624838;6256.374362563707;6358.395952384702;5950;6022.36765139654;6042.607230530001;6050.001749711424;6068.4841788448475;5883.61756485827;6103.511719062553;6109.816705498843;6127.295361033538;6133.601315914451;5944.64332140073;6036;6048.550337113476;6146.754129834935;6173.197484327009;6234;6263.34021484298;6291.622502649856;6311.842203944754;6355.618662880057;5893.88016276906;6079.848003799941;6087.178230938944;6127.662978536223;6159.260888693386 14:44:40 INFO - PROCESS | 18216 | |5;yui.html;687.7858548018653;738.4609235258262;786.8780339047449;849.1847826086956;904.9049849765775;16115.113668748214;16911.66176676469;17243.655126897454;17394.043327616993;17647.64704705905;15320.923395383035;15507.224638768073;15525.223738813042;15549;15583.610409739762;835.7826964989116;870.8214815962713;888.404768804899;888.6845169964635;891.8439273127209;881.9470831750083;882.660175832306;883.514067263006;884.5135175653397;891.4473026723441;912.8448163812168;921.4839689773714;923.2475532441073;923.6305477808896;924.4083786376724;917.8347897378469;920.5489310238003;921.5898924978387;922.6724512797928;922.8246633139682;673.7305077968803;679.0968012543354;681.58082779091;682.4063065133316;682.7815099168268;15989.440369587008;16014.119223442705;16070.5982350441;16090.356385744673;16116.435924742578;15541.689166216725;15620;15649.608759780982;15848.52454426369;16050;13480;13648.931755341258;13666.316684165751;14171;14305.713885722227;4057;4070.8778736637946;4072.8574499892657;4106.897327566805;4208.242516347056;96870.51564742131;96909.51545242299;96944;98139;100000.49999749954;12878.80681789774;13001.284929328789;13104.737905241842;13158.473661053451;13169;24059.639105413433;24390.146344877845;24818.875905620356;25334.873325633624;25760.742392575834;9155.404898681565;9178.541072946326;9428.057194280655;9536.759050194665;9587.089226523469;5092.6180536459915;5107;5148.665336753099;5224.059669259494;5252.1596544552685;4019.376996565537;4122.670186385082;4150.958490415057;4155.8961025974595;4167.229062623424;701.6071000239882;702.8524009957864;715.849671568966;725.3109545931386;733.7175187552831;673.3367632881608;692.8371832619331;729.1614643160408;730.2660825869966;733.8202140475618;10521.421321827373;10612.20408469368;10945.83581246282;11238.623662781396;11318.151138664633;708.505054335352;765.6898955922749;815.8857759913617;821.1829229916152;858.6565373850385;5114.539691427789;5216.60875434344;5344.465553444625;5377.193420986883;5384.838454846361;99987.50006249922;101339;104434.47782761189;106806;124179.3791031039;61740.69129654323;69472.65263673649;90785.54607227053;98347;98464;86470;86801.56599216964;90271.64592531117;91830;94593.0540694598;10522.263441559018;11090.764847644172;11343.262687925258;11351.14866385041;11376.374299413612;53277.46722532725;53944.73027634837;54160;54452;55875.441245587026;48995.51004489909;69277;69463.65268173828;74817.22866253817;81504;14110.576682699535;14399.496017639332;14416.13503189812;14490.492832751224;14745.410183592536;16237.756433653269;16359.427420040241;16382.590435239214;16984.830151698327;16989.745153822456;14175.574732758034;15320.233988300317;15725.921370393075;15869.2858821351;16570.917145414194;14905.701885962004;15035.097894126387;15883.126428046568;16084.758728619314;16276.43032493857;14976.625584360478;15110.168940708367;15913.840861591236;15913.840861591236;16044.358225670843;12037.939810300892;12298.692532686755;12334.938325308674;12572.434240459384;13121.934390327988;13208.933955330162;13420.731585368043;13425.462981480632;13634.454621815017;14001.579952601438 14:44:40 INFO - PROCESS | 18216 | __end_tp_report 14:44:40 INFO - PROCESS | 18216 | __start_cc_report 14:44:40 INFO - PROCESS | 18216 | _x_x_mozilla_cycle_collect,334 14:44:40 INFO - PROCESS | 18216 | __end_cc_report 14:44:40 INFO - PROCESS | 18216 | __startTimestamp1472161480537__endTimestamp 14:44:40 INFO - PROCESS | 18216 | 14:44:40 INFO - PROCESS | 18216 | ------- Summary: start ------- 14:44:40 INFO - PROCESS | 18216 | Number of tests: 6 14:44:40 INFO - PROCESS | 18216 | 14:44:40 INFO - PROCESS | 18216 | [#0] dojo.html Cycles:165 Average:5848.62 Median:6076.57 stddev:688.70 (11.3%) stddev-sans-first:661.20 14:44:40 INFO - PROCESS | 18216 | Values: 3302.2 3326.0 3332.2 3348.5 3360.7 5850.3 5856.9 5874.7 5906.1 5912.3 5801.4 5868.5 5874.8 5874.9 5878.2 5269.4 5311.6 5351.1 5358.0 5375.9 5221.9 5242.6 5260.5 5279.9 5308.8 5305.5 5337.1 5361.1 5397.8 5405.7 5360.5 5368.4 5383.7 5389.8 5402.2 5153.5 5197.3 5206.2 5281.0 5358.8 5780.4 5846.4 5855.2 5859.5 5894.5 6272.2 6316.9 6330.5 6335.5 6340.2 6082.0 6226.1 6376.5 6381.3 6399.0 5839.2 5925.5 5934.3 5956.8 5973.5 6492.7 6499.5 6528.1 6539.1 6543.1 6064.9 6090.6 6267.2 6277.9 6295.1 6136.5 6238.4 6281.5 6282.2 6288.5 6251.4 6252.4 6262.5 6265.4 6279.6 6131.0 6134.4 6259.7 6268.8 6281.2 4719.0 4780.0 4791.1 4816.1 4817.8 4241.6 4257.4 4257.7 4286.8 4287.1 5905.9 5925.0 6017.3 6045.7 6054.4 6220.1 6313.5 6333.7 6334.2 6336.2 6039.9 6056.1 6063.7 6076.6 6089.8 5328.2 5397.8 5403.6 5448.5 5454.5 6511.3 6628.2 6638.1 6638.6 6650.8 6347.2 6372.8 6400.1 6411.7 6414.2 6361.5 6459.5 6556.3 6562.7 6619.7 6161.0 6289.9 6294.7 6302.0 6315.8 6402.7 6406.7 6409.8 6410.0 6410.1 5979.5 6021.1 6170.4 6202.3 6217.0 6046.8 6103.6 6115.1 6117.4 6151.5 6038.6 6083.2 6119.6 6124.8 6126.3 6049.5 6060.5 6168.5 6170.7 6196.9 5970.6 6045.0 6080.5 6088.3 6106.8 14:44:40 INFO - PROCESS | 18216 | 14:44:40 INFO - PROCESS | 18216 | [#1] ext.html Cycles:180 Average:51440.78 Median:40047.30 stddev:89476.74 (223.4%) stddev-sans-first:89646.27 14:44:40 INFO - PROCESS | 18216 | Values: 586.1 635.5 652.6 657.1 712.1 42314.4 47856.3 47872.8 47882.0 47898.3 46924.3 47252.0 47383.3 47391.3 47424.3 9152.4 9332.4 9334.8 9348.3 9366.6 9372.5 9377.2 9428.4 9455.1 9467.2 9425.8 9440.6 9460.4 9486.8 9518.3 9334.6 9407.0 9424.1 9424.5 9437.9 9310.8 9337.4 9362.4 9369.2 9392.4 44131.1 44362.6 44407.6 44419.8 44453.8 3216.2 3490.8 3551.7 3623.8 3809.2 33909.8 34000.3 34154.5 34228.5 34548.1 4496.0 4497.9 4514.6 4530.5 4536.0 338385.0 338848.0 339789.0 340463.0 341986.0 38852.6 39052.2 39066.4 39122.2 39176.2 39856.2 39920.4 40012.0 40037.6 40057.0 19003.2 19461.2 19567.6 20469.2 20480.2 15202.7 15346.2 15445.7 15488.6 15511.5 21008.3 21183.7 21220.5 21463.0 21487.7 7319.9 7466.6 7515.8 7602.7 7757.7 1047.9 1050.5 1125.6 1169.8 1203.4 34743.0 34919.3 35067.3 35130.6 35381.0 1207.3 1210.8 1217.1 1239.8 1270.1 17913.3 18545.2 18754.8 18773.7 18922.3 171994.0 172305.4 172930.0 173377.0 565085.0 65592.7 65856.0 66108.0 66213.3 66664.3 1440.9 1462.5 1474.8 1489.3 1490.3 34992.0 35296.6 35357.8 35464.0 35619.1 56693.0 56715.1 56727.0 56964.1 57076.7 376442.0 377592.0 378682.0 378763.0 379298.0 30866.1 31257.7 31588.9 31843.4 31962.0 52562.7 53101.5 53381.2 54283.2 54604.2 44925.3 46451.3 47210.5 47366.8 48211.0 46146.8 46184.3 46669.1 46712.7 47723.5 42638.8 43891.0 45553.3 46251.8 47709.3 38647.8 39324.6 39384.6 41043.6 43223.8 31244.2 31389.0 31441.7 31865.8 31901.8 14:44:40 INFO - PROCESS | 18216 | 14:44:40 INFO - PROCESS | 18216 | [#2] jquery.html Cycles:180 Average:30662.68 Median:25069.06 stddev:84021.48 (335.2%) stddev-sans-first:84226.46 14:44:40 INFO - PROCESS | 18216 | Values: 404.1 407.8 416.2 419.5 426.7 19263.3 20859.3 21218.3 21332.7 22019.8 20704.3 20755.4 20876.2 21382.9 21448.8 5882.7 6101.8 6102.3 6104.3 6107.9 5815.0 5889.6 5927.1 5950.9 5968.9 5996.7 5997.6 6002.7 6015.4 6016.6 5863.9 5972.5 5980.8 6001.6 6006.1 5239.8 5319.1 5325.7 5346.7 5380.7 24976.4 25058.9 25079.2 25115.0 25531.2 2706.7 2708.3 2793.1 2846.1 3093.8 15429.0 15599.5 15849.9 15950.3 16184.4 1994.3 2000.3 2056.8 2068.7 2138.1 83926.0 85421.6 85960.0 86936.6 88058.6 10823.5 10923.3 10998.6 11078.3 11316.2 15711.0 15756.8 15797.4 15799.1 15846.9 8443.3 8737.6 8765.6 8774.7 8938.9 8534.4 8628.8 8700.7 8767.1 8859.9 6784.8 6868.2 6959.6 7026.5 7054.2 1961.7 2013.4 2029.6 2031.0 2034.8 1055.3 1056.6 1059.1 1073.3 1149.5 18929.8 19762.7 20881.2 21722.2 21732.3 1086.0 1087.2 1093.4 1112.2 1157.1 11197.4 11865.4 12059.2 12270.1 12372.1 482099.0 486352.0 490471.0 536712.0 550652.0 87779.6 90459.5 90486.1 91245.0 92170.1 1057.1 1101.6 1102.3 1130.7 1137.5 16355.0 18275.9 18440.7 19052.5 19149.7 43480.6 43540.8 46510.8 47508.5 48097.5 64257.0 64556.7 65907.7 66439.0 67436.7 8792.3 9041.8 9139.1 9252.9 9322.9 12900.5 14308.0 14376.7 14558.4 14647.6 12579.6 12744.3 12770.2 12784.0 12789.3 12396.8 12483.3 12571.4 12591.0 12649.7 12068.8 12317.9 12488.2 12812.9 12897.4 8883.7 8900.6 8958.9 9242.5 9259.4 9438.8 11556.3 12002.0 12255.1 13113.5 14:44:40 INFO - PROCESS | 18216 | 14:44:40 INFO - PROCESS | 18216 | [#3] mootools.html Cycles:180 Average:6444.15 Median:4259.44 stddev:3736.50 (87.7%) stddev-sans-first:3729.01 14:44:40 INFO - PROCESS | 18216 | Values: 1568.7 1591.0 1770.2 1856.2 1888.5 8626.0 9321.3 9344.5 10046.6 10049.4 9447.6 9702.3 9773.0 9794.5 9812.1 2477.8 2501.1 2509.5 2525.2 2531.9 2414.4 2461.1 2463.5 2474.6 2475.6 2400.2 2401.2 2461.4 2468.9 2469.8 2405.6 2406.2 2425.6 2427.2 2432.0 2439.1 2448.4 2455.8 2456.1 2465.2 9957.7 10005.2 10008.4 10034.3 10054.5 5536.8 5747.4 5778.2 5789.3 5830.7 3564.6 3606.2 3661.2 3706.7 3764.3 1185.6 1240.4 1241.4 1253.5 1280.6 13792.0 13865.3 13882.7 13896.6 13896.8 4930.4 4951.3 5105.5 5113.6 5124.6 10933.3 10993.0 11081.4 11084.6 11098.5 5675.3 5707.1 5708.6 5723.9 5733.8 4721.6 5103.3 5175.4 5197.4 5351.6 4159.5 4192.0 4231.5 4256.4 4262.4 1221.2 1253.7 1257.3 1263.1 1263.8 837.2 882.7 946.8 969.5 1044.5 6468.8 6529.2 6708.4 6712.9 6738.6 1013.6 1023.2 1046.5 1083.7 1097.3 4737.8 4820.4 4833.4 4869.7 4870.7 12065.2 12463.4 12554.6 12570.1 12579.3 12408.2 12431.4 12449.9 12503.5 12515.0 8662.3 8964.9 8967.8 9069.1 9172.3 6808.5 6840.6 6890.3 6964.5 7118.1 11301.4 11351.8 11389.1 11534.6 11565.8 11507.3 11553.6 11613.2 11622.3 11708.8 7954.0 8498.3 8670.6 8674.5 8727.2 9571.5 9651.5 9658.5 9723.6 9733.9 8333.7 8342.9 8359.8 8408.5 8475.8 8128.7 8245.0 8256.1 8337.1 8364.5 7930.2 8029.4 8046.1 8062.8 8088.3 5751.6 5767.9 5885.6 6005.6 6023.7 5813.9 5853.2 5874.3 5911.5 5959.5 14:44:40 INFO - PROCESS | 18216 | 14:44:40 INFO - PROCESS | 18216 | [#4] prototype.html Cycles:180 Average:5151.07 Median:5901.40 stddev:1529.06 (25.9%) stddev-sans-first:1489.98 14:44:40 INFO - PROCESS | 18216 | Values: 333.1 339.2 344.2 348.6 350.2 5857.9 5961.5 6004.3 6008.8 6021.9 5808.5 5843.5 5845.9 5877.7 5880.6 4358.6 4393.5 4497.2 4529.7 4535.2 4491.9 4502.1 4505.0 4524.4 4529.0 4435.7 4476.4 4501.0 4508.8 4524.6 4424.9 4437.2 4443.7 4451.3 4463.3 3933.3 3952.7 3961.8 3970.8 3990.6 5681.2 5687.4 5697.8 5714.2 5727.3 4906.4 5104.8 5126.4 5137.2 5142.7 6089.0 6122.7 6157.6 6170.2 6185.3 4098.8 4246.8 4257.6 4284.9 4290.2 6261.0 6300.2 6308.7 6308.9 6352.5 4436.7 4443.9 4465.6 4473.6 4480.6 4334.3 4500.8 4536.4 4541.7 4567.7 5126.0 5160.5 5162.2 5179.2 5180.6 6056.9 6170.8 6196.8 6220.9 6237.5 1538.7 1545.3 1567.0 1595.2 1613.3 1017.3 1042.1 1062.5 1080.8 1119.9 5865.9 5908.9 5966.4 5972.7 6001.4 6198.5 6226.0 6259.3 6302.2 6330.2 5650.2 5874.6 5923.6 5937.2 5953.5 3351.9 3358.5 3385.7 3386.9 3404.7 6415.4 6479.4 6494.9 6499.4 6559.0 6349.1 6397.9 6423.6 6426.4 6433.8 6288.9 6372.6 6521.9 6535.2 6561.6 6130.8 6275.5 6278.8 6300.3 6344.3 6127.8 6281.9 6282.3 6319.7 6320.0 6409.2 6461.0 6468.8 6479.5 6492.3 4405.3 4412.9 4428.9 4439.4 4441.0 6164.8 6218.8 6249.8 6256.4 6358.4 5950.0 6022.4 6042.6 6050.0 6068.5 5883.6 6103.5 6109.8 6127.3 6133.6 5944.6 6036.0 6048.6 6146.8 6173.2 6234.0 6263.3 6291.6 6311.8 6355.6 5893.9 6079.8 6087.2 6127.7 6159.3 14:44:40 INFO - PROCESS | 18216 | 14:44:40 INFO - PROCESS | 18216 | [#5] yui.html Cycles:180 Average:21649.76 Median:4136.81 stddev:29639.44 (716.5%) stddev-sans-first:29680.79 14:44:40 INFO - PROCESS | 18216 | Values: 687.8 738.5 786.9 849.2 904.9 16115.1 16911.7 17243.7 17394.0 17647.6 15320.9 15507.2 15525.2 15549.0 15583.6 835.8 870.8 888.4 888.7 891.8 881.9 882.7 883.5 884.5 891.4 912.8 921.5 923.2 923.6 924.4 917.8 920.5 921.6 922.7 922.8 673.7 679.1 681.6 682.4 682.8 15989.4 16014.1 16070.6 16090.4 16116.4 15541.7 15620.0 15649.6 15848.5 16050.0 13480.0 13648.9 13666.3 14171.0 14305.7 4057.0 4070.9 4072.9 4106.9 4208.2 96870.5 96909.5 96944.0 98139.0 100000.5 12878.8 13001.3 13104.7 13158.5 13169.0 24059.6 24390.1 24818.9 25334.9 25760.7 9155.4 9178.5 9428.1 9536.8 9587.1 5092.6 5107.0 5148.7 5224.1 5252.2 4019.4 4122.7 4151.0 4155.9 4167.2 701.6 702.9 715.8 725.3 733.7 673.3 692.8 729.2 730.3 733.8 10521.4 10612.2 10945.8 11238.6 11318.2 708.5 765.7 815.9 821.2 858.7 5114.5 5216.6 5344.5 5377.2 5384.8 99987.5 101339.0 104434.5 106806.0 124179.4 61740.7 69472.7 90785.5 98347.0 98464.0 86470.0 86801.6 90271.6 91830.0 94593.1 10522.3 11090.8 11343.3 11351.1 11376.4 53277.5 53944.7 54160.0 54452.0 55875.4 48995.5 69277.0 69463.7 74817.2 81504.0 14110.6 14399.5 14416.1 14490.5 14745.4 16237.8 16359.4 16382.6 16984.8 16989.7 14175.6 15320.2 15725.9 15869.3 16570.9 14905.7 15035.1 15883.1 16084.8 16276.4 14976.6 15110.2 15913.8 15913.8 16044.4 12037.9 12298.7 12334.9 12572.4 13121.9 13208.9 13420.7 13425.5 13634.5 14001.6 14:44:40 INFO - PROCESS | 18216 | -------- Summary: end -------- 14:44:40 INFO - PROCESS | 18216 | 14:44:41 INFO - TEST-INFO | 18216: exit 0 14:44:41 INFO - TEST-OK | dromaeo_css | took 1111231ms 14:44:41 INFO - TEST-START | kraken 14:44:41 INFO - operating with platform_type : linux_ 14:44:41 INFO - Initialising browser for kraken test... 14:44:41 INFO - TEST-INFO | started process 18481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDhpOKS/profile http://localhost:55417/getInfo.html) 14:44:45 INFO - PROCESS | 18481 | __metrics Screen width/height:1600/1200 14:44:45 INFO - PROCESS | 18481 | colorDepth:24 14:44:45 INFO - PROCESS | 18481 | Browser inner width/height: 1024/697 14:44:45 INFO - PROCESS | 18481 | __metrics 14:44:46 ERROR - PROCESS | 18481 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:44:47 INFO - TEST-INFO | 18481: exit 0 14:44:47 INFO - Browser initialized. 14:44:47 INFO - Running cycle 1/1 for kraken test... 14:44:47 INFO - TEST-INFO | started process 18606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDhpOKS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:59 INFO - PROCESS | 18606 | RSS: Main: 152518656 14:44:59 INFO - PROCESS | 18606 | 14:45:01 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55417/tests/kraken/driver.html?testName=audio-beat-detection) 14:45:02 INFO - PROCESS | 18606 | RSS: Main: 158027776 14:45:02 INFO - PROCESS | 18606 | 14:45:05 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55417/tests/kraken/driver.html?testName=audio-dft) 14:45:05 INFO - PROCESS | 18606 | RSS: Main: 156127232 14:45:05 INFO - PROCESS | 18606 | 14:45:08 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55417/tests/kraken/driver.html?testName=audio-fft) 14:45:09 INFO - PROCESS | 18606 | RSS: Main: 156852224 14:45:09 INFO - PROCESS | 18606 | 14:45:11 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55417/tests/kraken/driver.html?testName=audio-oscillator) 14:45:11 INFO - PROCESS | 18606 | RSS: Main: 156696576 14:45:11 INFO - PROCESS | 18606 | 14:45:14 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55417/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:45:14 INFO - PROCESS | 18606 | RSS: Main: 156946432 14:45:14 INFO - PROCESS | 18606 | 14:45:17 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55417/tests/kraken/driver.html?testName=imaging-darkroom) 14:45:18 INFO - PROCESS | 18606 | RSS: Main: 156057600 14:45:18 INFO - PROCESS | 18606 | 14:45:21 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55417/tests/kraken/driver.html?testName=imaging-desaturate) 14:45:22 INFO - PROCESS | 18606 | RSS: Main: 156696576 14:45:22 INFO - PROCESS | 18606 | 14:45:25 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55417/tests/kraken/driver.html?testName=json-parse-financial) 14:45:25 INFO - PROCESS | 18606 | RSS: Main: 157237248 14:45:25 INFO - PROCESS | 18606 | 14:45:27 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55417/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:45:28 INFO - PROCESS | 18606 | RSS: Main: 156344320 14:45:28 INFO - PROCESS | 18606 | 14:45:29 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55417/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:45:30 INFO - PROCESS | 18606 | RSS: Main: 156635136 14:45:30 INFO - PROCESS | 18606 | 14:45:32 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55417/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:45:33 INFO - PROCESS | 18606 | RSS: Main: 157343744 14:45:33 INFO - PROCESS | 18606 | 14:45:35 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:45:36 INFO - PROCESS | 18606 | RSS: Main: 157650944 14:45:36 INFO - PROCESS | 18606 | 14:45:38 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:45:39 INFO - PROCESS | 18606 | RSS: Main: 158011392 14:45:39 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | Cycle 1(1): loaded http://localhost:55417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55417/tests/kraken/driver.html?testName=ai-astar) 14:45:41 INFO - PROCESS | 18606 | RSS: Main: 158494720 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | __start_tp_report 14:45:41 INFO - PROCESS | 18606 | _x_x_mozilla_page_load 14:45:41 INFO - PROCESS | 18606 | _x_x_mozilla_page_load_details 14:45:41 INFO - PROCESS | 18606 | |i|pagename|runs| 14:45:41 INFO - PROCESS | 18606 | |0;ai-astar;99;110;107;110;110;111;112;110;111;110 14:45:41 INFO - PROCESS | 18606 | |1;audio-beat-detection;154;116;145;167;116;138;143;116;184;120 14:45:41 INFO - PROCESS | 18606 | |2;audio-dft;163;162;162;164;163;164;165;162;162;162 14:45:41 INFO - PROCESS | 18606 | |3;audio-fft;74;76;74;166;75;75;76;75;165;76 14:45:41 INFO - PROCESS | 18606 | |4;audio-oscillator;84;83;143;83;85;83;136;83;83;142 14:45:41 INFO - PROCESS | 18606 | |5;imaging-gaussian-blur;118;117;116;117;116;119;118;117;117;118 14:45:41 INFO - PROCESS | 18606 | |6;imaging-darkroom;147;148;148;148;147;147;147;149;148;148 14:45:41 INFO - PROCESS | 18606 | |7;imaging-desaturate;95;95;96;96;95;95;96;96;96;95 14:45:41 INFO - PROCESS | 18606 | |8;json-parse-financial;54;53;53;51;56;52;53;51;51;52 14:45:41 INFO - PROCESS | 18606 | |9;json-stringify-tinderbox;65;60;60;59;60;61;61;60;60;60 14:45:41 INFO - PROCESS | 18606 | |10;stanford-crypto-aes;72;73;72;75;75;81;72;71;73;72 14:45:41 INFO - PROCESS | 18606 | |11;stanford-crypto-ccm;120;117;132;126;118;125;129;126;162;119 14:45:41 INFO - PROCESS | 18606 | |12;stanford-crypto-pbkdf2;150;162;154;155;152;156;158;156;153;150 14:45:41 INFO - PROCESS | 18606 | |13;stanford-crypto-sha256-iterative;62;62;63;61;63;62;64;65;60;62 14:45:41 INFO - PROCESS | 18606 | __end_tp_report 14:45:41 INFO - PROCESS | 18606 | __start_cc_report 14:45:41 INFO - PROCESS | 18606 | _x_x_mozilla_cycle_collect,832 14:45:41 INFO - PROCESS | 18606 | __end_cc_report 14:45:41 INFO - PROCESS | 18606 | __startTimestamp1472161541404__endTimestamp 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | ------- Summary: start ------- 14:45:41 INFO - PROCESS | 18606 | Number of tests: 14 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.74 (3.4%) stddev-sans-first:1.36 14:45:41 INFO - PROCESS | 18606 | Values: 99.0 110.0 107.0 110.0 110.0 111.0 112.0 110.0 111.0 110.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:144.00 stddev:23.63 (16.4%) stddev-sans-first:24.51 14:45:41 INFO - PROCESS | 18606 | Values: 154.0 116.0 145.0 167.0 116.0 138.0 143.0 116.0 184.0 120.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 14:45:41 INFO - PROCESS | 18606 | Values: 163.0 162.0 162.0 164.0 163.0 164.0 165.0 162.0 162.0 162.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:38.11 (50.8%) stddev-sans-first:39.79 14:45:41 INFO - PROCESS | 18606 | Values: 74.0 76.0 74.0 166.0 75.0 75.0 76.0 75.0 165.0 76.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:83.00 stddev:27.55 (33.2%) stddev-sans-first:28.57 14:45:41 INFO - PROCESS | 18606 | Values: 84.0 83.0 143.0 83.0 85.0 83.0 136.0 83.0 83.0 142.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.95 (0.8%) stddev-sans-first:0.97 14:45:41 INFO - PROCESS | 18606 | Values: 118.0 117.0 116.0 117.0 116.0 119.0 118.0 117.0 117.0 118.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 14:45:41 INFO - PROCESS | 18606 | Values: 147.0 148.0 148.0 148.0 147.0 147.0 147.0 149.0 148.0 148.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:45:41 INFO - PROCESS | 18606 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.58 (3.0%) stddev-sans-first:1.59 14:45:41 INFO - PROCESS | 18606 | Values: 54.0 53.0 53.0 51.0 56.0 52.0 53.0 51.0 51.0 52.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.65 (2.7%) stddev-sans-first:0.60 14:45:41 INFO - PROCESS | 18606 | Values: 65.0 60.0 60.0 59.0 60.0 61.0 61.0 60.0 60.0 60.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.00 stddev:2.91 (4.0%) stddev-sans-first:3.03 14:45:41 INFO - PROCESS | 18606 | Values: 72.0 73.0 72.0 75.0 75.0 81.0 72.0 71.0 73.0 72.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:126.00 stddev:13.13 (10.4%) stddev-sans-first:13.65 14:45:41 INFO - PROCESS | 18606 | Values: 120.0 117.0 132.0 126.0 118.0 125.0 129.0 126.0 162.0 119.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.50 stddev:3.69 (2.4%) stddev-sans-first:3.52 14:45:41 INFO - PROCESS | 18606 | Values: 150.0 162.0 154.0 155.0 152.0 156.0 158.0 156.0 153.0 150.0 14:45:41 INFO - PROCESS | 18606 | 14:45:41 INFO - PROCESS | 18606 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.43 (2.3%) stddev-sans-first:1.51 14:45:41 INFO - PROCESS | 18606 | Values: 62.0 62.0 63.0 61.0 63.0 62.0 64.0 65.0 60.0 62.0 14:45:41 INFO - PROCESS | 18606 | -------- Summary: end -------- 14:45:41 INFO - PROCESS | 18606 | 14:45:42 INFO - TEST-INFO | 18606: exit 0 14:45:42 INFO - TEST-OK | kraken | took 61008ms 14:45:42 INFO - SUITE-END | took 1172s 14:45:42 INFO - Completed test suite (00:19:32) 14:45:42 INFO - javascript benchmark 14:45:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7858.630401914841, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.1909632140128, 3326.0, 3332.2002719347356, 3348.5479460272854, 3360.69753722165, 5850.268716410449, 5856.853578660535, 5874.735636896339, 5906.05503119501, 5912.260967379078, 5801.361850196475, 5868.501177399916, 5874.823755287338, 5874.882502349961, 5878.23582934219, 5269.394019687737, 5311.601629877755, 5351.09031464652, 5358.035553600351, 5375.919361209585, 5221.921671174935, 5242.55438287746, 5260.473952604747, 5279.894402111955, 5308.840734777963, 5305.495977882095, 5337.092694241969, 5361.115415956362, 5397.78408863645, 5405.729713514328, 5360.490753378443, 5368.409474957752, 5383.703896285702, 5389.78440862365, 5402.189671549299, 5153.484651534854, 5197.324347834795, 5206.219067139921, 5281.0, 5358.758855851496, 5780.364159942403, 5846.3861294563885, 5855.209546711225, 5859.472647461706, 5894.4989675877605, 6272.247330320345, 6316.905246421307, 6330.525210609223, 6335.461485773715, 6340.239171299428, 6081.969590152021, 6226.097215903714, 6376.48988080957, 6381.266154392258, 6399.04014397844, 5839.211706419622, 5925.525957923356, 5934.317553481319, 5956.821295361146, 5973.492253158487, 6492.740290388426, 6499.480041596756, 6528.118703974903, 6539.051837483634, 6543.1166792483355, 6064.878702425926, 6090.634561926298, 6267.1539342188225, 6277.874442511215, 6295.118683384329, 6136.549713441251, 6238.407351301619, 6281.466075383643, 6282.183316168869, 6288.465480434123, 6251.374862513712, 6252.406021427957, 6262.530310226751, 6265.373462653698, 6279.560430769893, 6131.040261761377, 6134.38656134383, 6259.749610015549, 6268.808926303987, 6281.2462504498835, 4718.976405117953, 4780.020095880336, 4791.089692958327, 4816.060868130681, 4817.8313759018265, 4241.597048280409, 4257.40396344512, 4257.701960862772, 4286.807093680792, 4287.056847493546, 5905.852353691193, 5925.0, 6017.338092809788, 6045.72794224261, 6054.39456054391, 6220.129181914535, 6313.494920406357, 6333.746650134035, 6334.208223972004, 6336.239651241881, 6039.939600604026, 6056.121862329937, 6063.696815159225, 6076.574639775262, 6089.786857459968, 5328.227407025959, 5397.8380648580605, 5403.621746477787, 5448.536874365644, 5454.536364409069, 6511.251206111263, 6628.171478565179, 6638.137042184485, 6638.634875081917, 6650.833729156713, 6347.174867267226, 6372.840678983062, 6400.135981642512, 6411.711472983634, 6414.230292364759, 6361.491080713625, 6459.450946669585, 6556.311587283267, 6562.704678289584, 6619.735210591522, 6161.0, 6289.9371006291185, 6294.653794041372, 6301.96849015752, 6315.810525684236, 6402.743890244525, 6406.679666016587, 6409.839754006187, 6410.0, 6410.102585637921, 5979.4618484336615, 6021.096835474714, 6170.352113028068, 6202.317745048132, 6217.0, 6046.848828779316, 6103.633781973096, 6115.118650813463, 6117.431594453822, 6151.477124444473, 6038.607490513103, 6083.209182806207, 6119.632822030692, 6124.755009799558, 6126.264848218242, 6049.455549000435, 6060.515158787374, 6168.537359697951, 6170.722317495633, 6196.876062478635, 5970.611910225995, 6045.0, 6080.513558915188, 6088.299845517822, 6106.755729770759], "value": 5800.145830693152, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.1325238646803, 635.5170070746233, 652.5888690125217, 657.1161787395952, 712.1311999360778, 42314.365284520754, 47856.282155767694, 47872.760636196814, 47882.0, 47898.28152577714, 46924.296135558, 47252.0, 47383.28925066127, 47391.28913066298, 47424.28863567049, 9152.405093668924, 9332.440053596772, 9334.813303733921, 9348.298877584175, 9366.625334986626, 9372.484513351763, 9377.249820014382, 9428.434293942351, 9455.101765332283, 9467.242620590336, 9425.81148377032, 9440.575174117146, 9460.38507497014, 9486.762830929212, 9518.333716639838, 9334.579943902541, 9406.9529652352, 9424.104710052534, 9424.528773561295, 9437.905620943771, 9310.767230819216, 9337.393069450532, 9362.438253704799, 9369.203617692505, 9392.436453812794, 44131.11737765259, 44362.556374436164, 44407.55592444099, 44419.77790111061, 44453.77773111146, 3216.2281052547455, 3490.7556471047037, 3551.7158627309755, 3623.836927338276, 3809.238152369537, 33909.830450847585, 34000.31999359999, 34154.48768268478, 34228.48657270143, 34548.136296592784, 4495.955040449619, 4497.887552811206, 4514.593686568224, 4530.501644819067, 4535.9773201133785, 338385.0, 338848.0, 339788.99999999756, 340463.0, 341985.9999999975, 38852.6114738849, 39052.21895562073, 39066.41400378996, 39122.21755564873, 39176.216475670895, 39856.2028759429, 39920.401193982114, 40012.0, 40037.59962400397, 40057.0, 19003.23987040503, 19461.221551137794, 19567.60864782725, 20469.18123275082, 20480.18079276842, 15202.695946081238, 15346.23268836576, 15445.691086178214, 15488.612784680474, 15511.45709900148, 21008.26471073505, 21183.68224476634, 21220.46948826261, 21463.0, 21487.67768483474, 7319.890201646979, 7466.552006879605, 7515.812104697427, 7602.695892164252, 7757.650905709256, 1047.8742550893942, 1050.5272627317586, 1125.6454216921643, 1169.8128299472214, 1203.3983008495752, 34743.0, 34919.301613968084, 35067.298654026774, 35130.64869351325, 35381.0, 1207.3299318877932, 1210.842590463234, 1217.0932655171953, 1239.7582471417986, 1270.1299609767339, 17913.283468661368, 18545.165467553994, 18754.81245187558, 18773.7183942241, 18922.3377181798, 171994.0, 172305.41541876883, 172930.0, 173377.0, 565085.0, 65592.67203664046, 65856.0, 66108.0, 66213.33786662167, 66664.33335666679, 1440.9337090553124, 1462.5100591302032, 1474.7714104314064, 1489.3074720254917, 1490.299559207171, 34992.0, 35296.647033529334, 35357.823210883784, 35464.0, 35619.10952226215, 56693.0, 56715.149272761766, 56727.0, 56964.14553781613, 57076.71461642665, 376442.0, 377592.0, 378682.0, 378763.0, 379298.0, 30866.068421782595, 31257.687423126386, 31588.894388696284, 31843.36313273768, 31962.041138765875, 52562.73718631535, 53101.4689853112, 53381.19928201003, 54283.18575221454, 54604.18093728518, 44925.32612010757, 46451.30323045225, 47210.527894721985, 47366.76316618395, 48211.0, 46146.76926615345, 46184.30723539217, 46669.06661866812, 46712.67345972853, 47723.52276477191, 42638.78680606577, 43891.0, 45553.31670024886, 46251.76874115742, 47709.28436073531, 38647.806760966014, 39324.606753932094, 39384.6061539381, 41043.589564103975, 43223.783881080395, 31244.218894527818, 31389.0, 31441.68558314479, 31865.840670796497, 31901.840490798328], "value": 20690.059344762823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.11297202640196, 407.76757248368443, 416.1925863824181, 419.5112693711826, 426.72263029031126, 19263.32578359758, 20859.26992555261, 21218.257360992367, 21332.680009799828, 22019.779802201974, 20704.27535036274, 20755.377338679828, 20876.164953401883, 21382.89308553459, 21448.785512144874, 5882.6764527950945, 6101.78643747469, 6102.26772787264, 6104.298005729332, 6107.877842443148, 5815.0, 5889.64662120272, 5927.051671732502, 5950.910736338937, 5968.880622387572, 5996.730147143389, 5997.550183736215, 6002.699865006754, 6015.398460153971, 6016.608920420181, 5863.8534036649, 5972.522198224132, 5980.79067232647, 6001.609895356832, 6006.069059295773, 5239.816606418795, 5319.1223448131395, 5325.680459172423, 5346.705931173784, 5380.650257733235, 24976.375590610198, 25058.874705626356, 25079.24762257135, 25115.0, 25531.23406297814, 2706.742859428351, 2708.2823051891264, 2793.0782841662203, 2846.103477404611, 3093.814371137739, 15429.0, 15599.532014039596, 15849.920750396173, 15950.282237299349, 16184.433544825992, 1994.3019943019972, 2000.3298894870236, 2056.8251698605636, 2068.7414073240843, 2138.0699395762895, 83926.0, 85421.57289213514, 85960.0, 86936.56531717365, 88058.55970720106, 10823.458827058615, 10923.344599323907, 10998.560057597606, 11078.279911805706, 11316.151288653384, 15711.0, 15756.842431575767, 15797.36810527566, 15799.131047792482, 15846.920765396098, 8443.324534037261, 8737.60680769367, 8765.649374024968, 8774.692885748967, 8938.86591701125, 8534.402591818513, 8628.784280392914, 8700.695475658322, 8767.12328767131, 8859.867101993475, 6784.7964561063245, 6868.175818901664, 6959.617221052789, 7026.508144429943, 7054.188768291609, 1961.7057441383906, 2013.426173540534, 2029.553498230387, 2030.959380812405, 2034.8168664820237, 1055.2824079625927, 1056.572088304238, 1059.1103473082649, 1073.313079629038, 1149.48273277024, 18929.81070189308, 19762.70355944662, 20881.164753409692, 21722.239721609985, 21732.34802955914, 1086.0442810326863, 1087.228068071678, 1093.4259513755342, 1112.238116889933, 1157.0627791488753, 11197.384143872003, 11865.406729663482, 12059.155859089955, 12270.079744019235, 12372.13395062355, 482099.0, 486352.0, 490471.0, 536712.0, 550652.0, 87779.56110219409, 90459.54770226238, 90486.09513904908, 91245.0, 92170.07829921615, 1057.1489950589696, 1101.5924108080062, 1102.3330884814732, 1130.7060164357163, 1137.4710759496875, 16355.0, 18275.908620456812, 18440.723389148905, 19052.523686907938, 19149.712754308417, 43480.565194347655, 43540.78229608832, 46510.76744616255, 47508.52491475179, 48097.5190248107, 64257.0, 64556.677216613614, 65907.67046164739, 66439.0, 67436.6628166856, 8792.296616270554, 9041.819163616823, 9139.086091390807, 9252.907470925205, 9322.906770932204, 12900.548480803127, 14308.0, 14376.712465750836, 14558.41766329335, 14647.560573182822, 12579.559715409916, 12744.299063551594, 12770.2337859725, 12784.0, 12789.296588687712, 12396.81404778947, 12483.31341776211, 12571.434285456993, 12591.0, 12649.747005059664, 12068.75862482763, 12317.938410307892, 12488.188267762567, 12812.935935320636, 12897.41961611711, 8883.73348799537, 8900.643974241217, 8958.910410895807, 9242.537873106452, 9259.398139120936, 9438.764030899283, 11556.306621602731, 12002.039836813208, 12255.080868934687, 13113.475460981454], "value": 10008.747664490116, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1568.7254730422176, 1591.021521764115, 1770.2211027148053, 1856.155449270582, 1888.4806678163504, 8625.95687021564, 9321.254299656028, 9344.486053267085, 10046.648367307145, 10049.397036177834, 9447.574859131339, 9702.272329575275, 9773.0, 9794.461304628243, 9812.116909478145, 2477.838940468873, 2501.0996041425074, 2509.498100379922, 2525.217182673368, 2531.949361012779, 2414.396400899775, 2461.126300163443, 2463.519613675334, 2474.5669507836146, 2475.628655701641, 2400.195934361982, 2401.231605886117, 2461.384653836541, 2468.9135880244194, 2469.814763892706, 2405.6151015837468, 2406.2300063979446, 2425.551273014498, 2427.1504973259393, 2432.0, 2439.097533912464, 2448.4123810285405, 2455.8280920335583, 2456.066694656019, 2465.2234546118093, 9957.651482198089, 10005.19958403326, 10008.449535275557, 10034.297599168061, 10054.547545360476, 5536.806211782568, 5747.396523365028, 5778.219940308047, 5789.334226563957, 5830.737616807254, 3564.6435356464403, 3606.1705807664384, 3661.176235347052, 3706.666400023984, 3764.3224219640456, 1185.5672679471932, 1240.406078189522, 1241.4103300932074, 1253.5173958026135, 1280.615815255429, 13792.0, 13865.306734663227, 13882.722345553133, 13896.58310250694, 13896.791548126786, 4930.433000205022, 4951.331570237971, 5105.489451054939, 5113.565346945476, 5124.590032797368, 10933.28933619328, 10993.0, 11081.390523521122, 11084.61203857861, 11098.500567474483, 5675.290588676416, 5707.0868661014865, 5708.628939118944, 5723.885522289531, 5733.827985160452, 4721.551452611996, 5103.2855400244, 5175.353080864892, 5197.402298735618, 5351.598630102758, 4159.459270294842, 4192.0, 4231.492220933507, 4256.446661933929, 4262.424572682648, 1221.2306247064294, 1253.6552448076852, 1257.283348491351, 1263.1158189267549, 1263.759885621729, 837.2381133168788, 882.6998820400966, 946.7822400847843, 969.4571040217501, 1044.5038606661926, 6468.838279043061, 6529.249136349285, 6708.396244337935, 6712.865742685119, 6738.59568425896, 1013.6097602423121, 1023.2325755683238, 1046.5081411736471, 1083.685731137977, 1097.3361116524547, 4737.786799594027, 4820.39745031871, 4833.4441539223435, 4869.732164730974, 4870.707757534559, 12065.215760975509, 12463.439145238486, 12554.560590379293, 12570.120091593684, 12579.308138052313, 12408.19346742477, 12431.440585173688, 12449.875501244871, 12503.49986000568, 12515.0, 8662.2637075848, 8964.910350896538, 8967.775805604782, 9069.138431848964, 9172.266218702622, 6808.523403361717, 6840.623765692736, 6890.34541718556, 6964.477664175106, 7118.074650295428, 11301.43492825339, 11351.829722554334, 11389.088872890314, 11534.59628912984, 11565.826512602485, 11507.252028618448, 11553.595624153115, 11613.187076904873, 11622.302661840316, 11708.765824683629, 7954.0, 8498.277646400125, 8670.609822557873, 8674.522901240493, 8727.170918762708, 9571.473568953774, 9651.469169195761, 9658.468784216935, 9723.611055557982, 9733.853992190265, 8333.749987500385, 8342.87485687703, 8359.832803344021, 8408.453450525696, 8475.83048339042, 8128.715494957648, 8245.0, 8256.091829898827, 8337.082920878578, 8364.498130112213, 7930.246626570467, 8029.4379393441895, 8046.0747014091785, 8062.83874322522, 8088.272055515032, 5751.597388182787, 5767.884642307215, 5885.646861188171, 6005.609635373687, 6023.66869822164, 5813.941860581509, 5853.180554722428, 5874.295084589706, 5911.527077833849, 5959.4934430573885], "value": 5093.347262038921, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.1122558381912, 339.15042817741556, 344.206603778291, 348.59040627262976, 350.2469690166144, 5857.941420585793, 5961.493273071788, 6004.309504406994, 6008.789692360758, 6021.879562408749, 5808.477237048664, 5843.532517398608, 5845.912311315334, 5877.67672777997, 5880.5883588148845, 4358.585934336233, 4393.538678438766, 4497.190505708971, 4529.682922195448, 4535.206338890697, 4491.910161796762, 4502.144592527426, 4504.954950450503, 4524.411826462555, 4528.9547104528865, 4435.667324950626, 4476.440444944382, 4501.0, 4508.797104130322, 4524.61540769035, 4424.911501769962, 4437.2013037653205, 4443.688941774077, 4451.310046942729, 4463.308187230984, 3933.311670457687, 3952.7430717003303, 3961.7622942623534, 3970.828605561366, 3990.6408423241755, 5681.204631351614, 5687.402822703598, 5697.800576979827, 5714.22859912946, 5727.284089488814, 4906.435759887623, 5104.846854594331, 5126.359205099363, 5137.2037334213255, 5142.717150556718, 6089.0, 6122.734588202394, 6157.630542167484, 6170.197874276315, 6185.319614842364, 4098.774567398792, 4246.830126794925, 4257.637011458639, 4284.892877678052, 4290.206311832289, 6261.027776250512, 6300.21247344082, 6308.653024083674, 6308.905366419507, 6352.523560732917, 4436.733795972252, 4443.9334559706085, 4465.553444655573, 4473.5526447355005, 4480.574345437179, 4334.306510958231, 4500.819967201275, 4536.364908912755, 4541.6593755468475, 4567.6802623816675, 5125.974370128126, 5160.483951604884, 5162.225666150108, 5179.22311653255, 5180.637355385087, 6056.939430605726, 6170.753169873245, 6196.752129914753, 6220.911340515392, 6237.5321850860455, 1538.6768778556404, 1545.2814441284856, 1566.9921650391902, 1595.1625396666843, 1613.274026687995, 1017.2523195451338, 1042.0777611813598, 1062.490004797686, 1080.7514271717548, 1119.8768135505088, 5865.882682346414, 5908.911366329508, 5966.359251205953, 5972.671503067286, 6001.36985616504, 6198.473129783929, 6226.0, 6259.280182779039, 6302.180716506917, 6330.183068534458, 5650.237217975603, 5874.618149820248, 5923.555733320019, 5937.168796368512, 5953.464188222994, 3351.8826841060445, 3358.462645976632, 3385.6783605557434, 3386.9153271167925, 3404.710599599062, 6415.3722149801, 6479.44924681398, 6494.902576461357, 6499.350064993558, 6558.967205163944, 6349.142865713162, 6397.912354899679, 6423.582467139714, 6426.35736426363, 6433.839154021187, 6288.874222515616, 6372.58578192416, 6521.869562608721, 6535.248446428626, 6561.606303621798, 6130.785422510369, 6275.466585340298, 6278.811635650938, 6300.338464461165, 6344.27040890285, 6127.754889804358, 6281.874362512633, 6282.340354262737, 6319.715612797343, 6320.009197102898, 6409.166808314889, 6461.0, 6468.8059358219325, 6479.514036447191, 6492.253390860112, 4405.273129933653, 4412.867613971586, 4428.911421771482, 4439.356293337512, 4440.955590444183, 6164.815055548341, 6218.751249949952, 6249.812505624838, 6256.374362563707, 6358.395952384702, 5950.0, 6022.36765139654, 6042.607230530001, 6050.001749711424, 6068.4841788448475, 5883.61756485827, 6103.511719062553, 6109.816705498843, 6127.295361033538, 6133.601315914451, 5944.64332140073, 6036.0, 6048.550337113476, 6146.754129834935, 6173.197484327009, 6234.0, 6263.34021484298, 6291.622502649856, 6311.842203944754, 6355.618662880057, 5893.88016276906, 6079.848003799941, 6087.178230938944, 6127.662978536223, 6159.260888693386], "value": 4659.312135990169, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.7858548018653, 738.4609235258262, 786.8780339047449, 849.1847826086956, 904.9049849765775, 16115.113668748214, 16911.66176676469, 17243.655126897454, 17394.043327616993, 17647.64704705905, 15320.923395383035, 15507.224638768073, 15525.223738813042, 15549.0, 15583.610409739762, 835.7826964989116, 870.8214815962713, 888.404768804899, 888.6845169964635, 891.8439273127209, 881.9470831750083, 882.660175832306, 883.514067263006, 884.5135175653397, 891.4473026723441, 912.8448163812168, 921.4839689773714, 923.2475532441073, 923.6305477808896, 924.4083786376724, 917.8347897378469, 920.5489310238003, 921.5898924978387, 922.6724512797928, 922.8246633139682, 673.7305077968803, 679.0968012543354, 681.58082779091, 682.4063065133316, 682.7815099168268, 15989.440369587008, 16014.119223442705, 16070.5982350441, 16090.356385744673, 16116.435924742578, 15541.689166216725, 15620.0, 15649.608759780982, 15848.52454426369, 16050.0, 13480.0, 13648.931755341258, 13666.316684165751, 14171.0, 14305.713885722227, 4057.0, 4070.8778736637946, 4072.8574499892657, 4106.897327566805, 4208.242516347056, 96870.51564742131, 96909.51545242299, 96944.0, 98139.0, 100000.49999749954, 12878.80681789774, 13001.284929328789, 13104.737905241842, 13158.473661053451, 13169.0, 24059.639105413433, 24390.146344877845, 24818.875905620356, 25334.873325633624, 25760.742392575834, 9155.404898681565, 9178.541072946326, 9428.057194280655, 9536.759050194665, 9587.089226523469, 5092.6180536459915, 5107.0, 5148.665336753099, 5224.059669259494, 5252.1596544552685, 4019.376996565537, 4122.670186385082, 4150.958490415057, 4155.8961025974595, 4167.229062623424, 701.6071000239882, 702.8524009957864, 715.849671568966, 725.3109545931386, 733.7175187552831, 673.3367632881608, 692.8371832619331, 729.1614643160408, 730.2660825869966, 733.8202140475618, 10521.421321827373, 10612.20408469368, 10945.83581246282, 11238.623662781396, 11318.151138664633, 708.505054335352, 765.6898955922749, 815.8857759913617, 821.1829229916152, 858.6565373850385, 5114.539691427789, 5216.60875434344, 5344.465553444625, 5377.193420986883, 5384.838454846361, 99987.50006249922, 101339.0, 104434.47782761189, 106806.0, 124179.3791031039, 61740.69129654323, 69472.65263673649, 90785.54607227053, 98347.0, 98464.0, 86470.0, 86801.56599216964, 90271.64592531117, 91830.0, 94593.0540694598, 10522.263441559018, 11090.764847644172, 11343.262687925258, 11351.14866385041, 11376.374299413612, 53277.46722532725, 53944.73027634837, 54160.0, 54452.0, 55875.441245587026, 48995.51004489909, 69277.0, 69463.65268173828, 74817.22866253817, 81504.0, 14110.576682699535, 14399.496017639332, 14416.13503189812, 14490.492832751224, 14745.410183592536, 16237.756433653269, 16359.427420040241, 16382.590435239214, 16984.830151698327, 16989.745153822456, 14175.574732758034, 15320.233988300317, 15725.921370393075, 15869.2858821351, 16570.917145414194, 14905.701885962004, 15035.097894126387, 15883.126428046568, 16084.758728619314, 16276.43032493857, 14976.625584360478, 15110.168940708367, 15913.840861591236, 15913.840861591236, 16044.358225670843, 12037.939810300892, 12298.692532686755, 12334.938325308674, 12572.434240459384, 13121.934390327988, 13208.933955330162, 13420.731585368043, 13425.462981480632, 13634.454621815017, 14001.579952601438], "value": 8262.985623756002, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 107.0, 110.0, 110.0, 111.0, 112.0, 110.0, 111.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 116.0, 145.0, 167.0, 116.0, 138.0, 143.0, 116.0, 184.0, 120.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 164.0, 163.0, 164.0, 165.0, 162.0, 162.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 166.0, 75.0, 75.0, 76.0, 75.0, 165.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 143.0, 83.0, 85.0, 83.0, 136.0, 83.0, 83.0, 142.0], "value": 100.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 116.0, 119.0, 118.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 149.0, 148.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 51.0, 56.0, 52.0, 53.0, 51.0, 51.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 60.0, 59.0, 60.0, 61.0, 61.0, 60.0, 60.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 75.0, 75.0, 81.0, 72.0, 71.0, 73.0, 72.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 132.0, 126.0, 118.0, 125.0, 129.0, 126.0, 162.0, 119.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 162.0, 154.0, 155.0, 152.0, 156.0, 158.0, 156.0, 153.0, 150.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 61.0, 63.0, 62.0, 64.0, 65.0, 60.0, 62.0], "value": 62.4, "unit": "score"}]}]} 14:45:42 INFO - Return code: 0 14:45:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:45:42 ERROR - # TBPL SUCCESS # 14:45:42 INFO - Running post-action listener: _resource_record_post_action 14:45:42 INFO - [mozharness: 2016-08-25 21:45:42.693299Z] Finished run-tests step (success) 14:45:42 INFO - Running post-run listener: _resource_record_post_run 14:45:42 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 326651904; Read time: 0; Write time: 253948 14:45:42 INFO - TinderboxPrint: CPU usage
13.2% 14:45:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:45:42 INFO - TinderboxPrint: I/O write bytes / time
326,651,904 / 253,948 14:45:42 INFO - TinderboxPrint: CPU idle
8,231.2 (86.8%) 14:45:42 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 14:45:42 INFO - TinderboxPrint: Swap in / out
0 / 0 14:45:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78536704; Read time: 0; Write time: 54192 14:45:42 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 247500800; Read time: 0; Write time: 199756 14:45:43 INFO - Running post-run listener: _upload_blobber_files 14:45:43 INFO - Blob upload gear active. 14:45:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:45:43 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 14:45:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:45:43 INFO - (blobuploader) - INFO - Open directory for files ... 14:45:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:45:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:45:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:44 INFO - (blobuploader) - INFO - Done attempting. 14:45:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:45:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:52 INFO - (blobuploader) - INFO - Done attempting. 14:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:45:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:53 INFO - (blobuploader) - INFO - Done attempting. 14:45:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:45:53 INFO - Return code: 0 14:45:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:45:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:45:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a068db86993388781f47332f2f286598ba9ec578aaae34eb0359428a620d4ebe0194060ba73ad8d6776643f51910929072b2b6c909d01f5c3a4584cef20a7a19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d7feb2035dc2240610e436e69c6672f6fb1a9cf1b7deed11671cea7e981a5cc2206e4039c4225e7472d188e03624c95806b24d150ad18aef151163eb67e813b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/64b263f8335deb858e02e99346e66a302198ec7e08bb13dc4befd1557d71aa47d1e6191c0e3195612b57712ccf2440aa6cbab59357b2b8f4d2f050f80271328c"} 14:45:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:45:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:45:53 INFO - Contents: 14:45:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a068db86993388781f47332f2f286598ba9ec578aaae34eb0359428a620d4ebe0194060ba73ad8d6776643f51910929072b2b6c909d01f5c3a4584cef20a7a19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d7feb2035dc2240610e436e69c6672f6fb1a9cf1b7deed11671cea7e981a5cc2206e4039c4225e7472d188e03624c95806b24d150ad18aef151163eb67e813b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/64b263f8335deb858e02e99346e66a302198ec7e08bb13dc4befd1557d71aa47d1e6191c0e3195612b57712ccf2440aa6cbab59357b2b8f4d2f050f80271328c"} 14:45:53 INFO - Running post-run listener: copy_logs_to_upload_dir 14:45:53 INFO - Copying logs to upload dir... 14:45:53 INFO - mkdir: /builds/slave/test/build/upload/logs 14:45:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1682.164720 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 2 secs) (at 2016-08-25 14:45:53.381967) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 14:45:53.385403) ========= 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=41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a068db86993388781f47332f2f286598ba9ec578aaae34eb0359428a620d4ebe0194060ba73ad8d6776643f51910929072b2b6c909d01f5c3a4584cef20a7a19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d7feb2035dc2240610e436e69c6672f6fb1a9cf1b7deed11671cea7e981a5cc2206e4039c4225e7472d188e03624c95806b24d150ad18aef151163eb67e813b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/64b263f8335deb858e02e99346e66a302198ec7e08bb13dc4befd1557d71aa47d1e6191c0e3195612b57712ccf2440aa6cbab59357b2b8f4d2f050f80271328c"} build_url:https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/cwyrbK7WR0ykOo-53RQfew/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a068db86993388781f47332f2f286598ba9ec578aaae34eb0359428a620d4ebe0194060ba73ad8d6776643f51910929072b2b6c909d01f5c3a4584cef20a7a19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0d7feb2035dc2240610e436e69c6672f6fb1a9cf1b7deed11671cea7e981a5cc2206e4039c4225e7472d188e03624c95806b24d150ad18aef151163eb67e813b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/64b263f8335deb858e02e99346e66a302198ec7e08bb13dc4befd1557d71aa47d1e6191c0e3195612b57712ccf2440aa6cbab59357b2b8f4d2f050f80271328c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 14:45:53.413383) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 14:45:53.414144) ========= 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=41a7e32711b8e08598a63237000001d6-1472159869.165254-1561997168 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 14:45:53.496028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 14:45:53.496807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 14:45:53.497507) ========= ========= Total master_lag: 0.18 =========