builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1470738229.84 results: success (0) buildid: 20160809004002 builduid: 3f5a9bec98e54145b0f994d7db1ee9bd revision: 79f0792841417c6cdf8cb78e8ee5026f53ba72aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:49.844823) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:49.845269) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:49.845560) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:49.863481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:49.863798) ========= 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-1470738228.992833-329231176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 03:23:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-08-09 03:23:49 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077341 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:49.955011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:49.958366) ========= 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-1470738228.992833-329231176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019675 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:50.041849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:50.045227) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 79f0792841417c6cdf8cb78e8ee5026f53ba72aa --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 79f0792841417c6cdf8cb78e8ee5026f53ba72aa --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-1470738228.992833-329231176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 03:23:50,097 truncating revision to first 12 chars 2016-08-09 03:23:50,097 Setting DEBUG logging. 2016-08-09 03:23:50,097 attempt 1/10 2016-08-09 03:23:50,097 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/79f079284141?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 03:23:50,418 unpacking tar archive at: mozilla-aurora-79f079284141/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668667 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:50.798651) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:50.798958) ========= script_repo_revision: 79f0792841417c6cdf8cb78e8ee5026f53ba72aa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:50.799343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:50.799599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 03:23:50.809874) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-08-09 03:23:50.810265) ========= /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-1470738228.992833-329231176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:23:50 INFO - MultiFileLogger online at 20160809 03:23:50 in /builds/slave/test 03:23:50 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 03:23:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:50 INFO - {'append_to_log': False, 03:23:50 INFO - 'base_work_dir': '/builds/slave/test', 03:23:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:23:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:50 INFO - 'branch': 'Mozilla-Aurora', 03:23:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:50 INFO - 'config_files': ('talos/linux_config.py',), 03:23:50 INFO - 'default_actions': ('clobber', 03:23:50 INFO - 'read-buildbot-config', 03:23:50 INFO - 'download-and-extract', 03:23:50 INFO - 'populate-webroot', 03:23:50 INFO - 'create-virtualenv', 03:23:50 INFO - 'install', 03:23:50 INFO - 'run-tests'), 03:23:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:50 INFO - 'download_minidump_stackwalk': True, 03:23:50 INFO - 'download_symbols': 'ondemand', 03:23:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:23:50 INFO - 'tooltool.py': '/tools/tooltool.py', 03:23:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:23:50 INFO - '/tools/misc-python/virtualenv.py')}, 03:23:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:50 INFO - 'installer_path': 'installer.exe', 03:23:50 INFO - 'log_level': 'info', 03:23:50 INFO - 'log_name': 'talos', 03:23:50 INFO - 'log_to_console': True, 03:23:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:23:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:23:50 INFO - 'opt_config_files': (), 03:23:50 INFO - 'pip_index': False, 03:23:50 INFO - 'sps_profile': False, 03:23:50 INFO - 'sps_profile_interval': 0, 03:23:50 INFO - 'suite': 'dromaeojs-e10s', 03:23:50 INFO - 'system_bits': '32', 03:23:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:50 INFO - 'title': 'talos-linux64-ix-024', 03:23:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:50 INFO - 'use_talos_json': True, 03:23:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:50 INFO - 'work_dir': 'build'} 03:23:50 INFO - [mozharness: 2016-08-09 10:23:50.952761Z] Running clobber step. 03:23:50 INFO - Running pre-action listener: _resource_record_pre_action 03:23:50 INFO - Running main action method: clobber 03:23:50 INFO - rmtree: /builds/slave/test/build 03:23:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:51 INFO - Running post-action listener: _resource_record_post_action 03:23:51 INFO - [mozharness: 2016-08-09 10:23:51.420774Z] Finished clobber step (success) 03:23:51 INFO - [mozharness: 2016-08-09 10:23:51.420878Z] Running read-buildbot-config step. 03:23:51 INFO - Running pre-action listener: _resource_record_pre_action 03:23:51 INFO - Running main action method: read_buildbot_config 03:23:51 INFO - Using buildbot properties: 03:23:51 INFO - { 03:23:51 INFO - "project": "", 03:23:51 INFO - "product": "firefox", 03:23:51 INFO - "script_repo_revision": "production", 03:23:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:23:51 INFO - "repository": "", 03:23:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:23:51 INFO - "buildid": "20160809004002", 03:23:51 INFO - "stage_platform": "linux64-pgo", 03:23:51 INFO - "basedir": "/builds/slave/test", 03:23:51 INFO - "nightly_build": "True", 03:23:51 INFO - "buildnumber": 449, 03:23:51 INFO - "slavename": "talos-linux64-ix-024", 03:23:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:23:51 INFO - "platform": "ubuntu64_hw", 03:23:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:23:51 INFO - "branch": "mozilla-aurora", 03:23:51 INFO - "repo_path": "releases/mozilla-aurora", 03:23:51 INFO - "revision": "79f0792841417c6cdf8cb78e8ee5026f53ba72aa", 03:23:51 INFO - "pgo_build": "True", 03:23:51 INFO - "builduid": "3f5a9bec98e54145b0f994d7db1ee9bd", 03:23:51 INFO - "slavebuilddir": "test" 03:23:51 INFO - } 03:23:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:23:51 INFO - Running post-action listener: _resource_record_post_action 03:23:51 INFO - [mozharness: 2016-08-09 10:23:51.423444Z] Finished read-buildbot-config step (success) 03:23:51 INFO - [mozharness: 2016-08-09 10:23:51.423533Z] Running download-and-extract step. 03:23:51 INFO - Running pre-action listener: _resource_record_pre_action 03:23:51 INFO - Running main action method: download_and_extract 03:23:51 INFO - mkdir: /builds/slave/test/build/tests 03:23: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')]} 03:23:51 INFO - https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:23:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:23:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:23:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:23:51 INFO - retry: Failed, sleeping 30 seconds before retrying 03:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:24:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:24:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:24:21 INFO - retry: Failed, sleeping 60 seconds before retrying 03:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:25:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:25:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:25:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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! 03:25:21 INFO - Caught exception: HTTP Error 404: Not Found 03:25:21 INFO - Caught exception: HTTP Error 404: Not Found 03:25:21 INFO - Caught exception: HTTP Error 404: Not Found 03:25:21 INFO - trying https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:25:21 INFO - Downloading https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:25:22 INFO - Downloaded 1361 bytes. 03:25:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:25:22 INFO - Using the following test package requirements: 03:25:22 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:22 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:22 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:25:22 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:22 INFO - u'jsshell-linux-x86_64.zip'], 03:25:22 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:22 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:22 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:25:22 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:25:22 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:22 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:22 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:22 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25: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')]} 03:25:22 INFO - https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:25:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:25:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:25:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:25:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:25:22 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:25:22 INFO - retry: Failed, sleeping 30 seconds before retrying 03:25:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:25:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:25:52 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:25:52 INFO - retry: Failed, sleeping 60 seconds before retrying 03:26:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:26:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:52 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:26:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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! 03:26:52 INFO - Caught exception: HTTP Error 404: Not Found 03:26:52 INFO - Caught exception: HTTP Error 404: Not Found 03:26:52 INFO - Caught exception: HTTP Error 404: Not Found 03:26:52 INFO - trying https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:52 INFO - Downloading https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:26:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:26:53 INFO - Downloaded 21766120 bytes. 03:26: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'] 03:26: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 03:26:54 INFO - Return code: 0 03:26: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 03:26: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')]} 03:26:54 INFO - https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:26:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:26:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:26:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:26:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:26:54 INFO - retry: Failed, sleeping 30 seconds before retrying 03:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:27:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:27:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:27:24 INFO - retry: Failed, sleeping 60 seconds before retrying 03:28:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:28:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:28:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:28:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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! 03:28:24 INFO - Caught exception: HTTP Error 404: Not Found 03:28:24 INFO - Caught exception: HTTP Error 404: Not Found 03:28:24 INFO - Caught exception: HTTP Error 404: Not Found 03:28:24 INFO - trying https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:28:24 INFO - Downloading https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:28:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:28:25 INFO - Downloaded 21766120 bytes. 03:28: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'] 03:28: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 03:28:26 INFO - Return code: 0 03:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:26 INFO - https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:28:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:28:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:28:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:26 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:28:26 INFO - retry: Failed, sleeping 30 seconds before retrying 03:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:28:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:56 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:28:56 INFO - retry: Failed, sleeping 60 seconds before retrying 03:29:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:29:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:56 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:29:56 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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! 03:29:56 INFO - Caught exception: HTTP Error 404: Not Found 03:29:56 INFO - Caught exception: HTTP Error 404: Not Found 03:29:56 INFO - Caught exception: HTTP Error 404: Not Found 03:29:56 INFO - trying https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:29:56 INFO - Downloading https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:29:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:29:57 INFO - Downloaded 14413723 bytes. 03:29: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'] 03:29: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 03:29:57 INFO - Return code: 0 03:29:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:57 INFO - https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:29:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:29:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:29:57 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:29:57 INFO - retry: Failed, sleeping 30 seconds before retrying 03:30:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:30:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:30:27 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:30:27 INFO - retry: Failed, sleeping 60 seconds before retrying 03:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:31:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:31:27 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:31:27 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eUa0-gJYQhGdafDNIzaZQA/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! 03:31:27 INFO - Caught exception: HTTP Error 404: Not Found 03:31:27 INFO - Caught exception: HTTP Error 404: Not Found 03:31:27 INFO - Caught exception: HTTP Error 404: Not Found 03:31:27 INFO - trying https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:31:27 INFO - Downloading https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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 03:31:28 INFO - Downloaded 63744746 bytes. 03:31:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:31:28 INFO - mkdir: /builds/slave/test/properties 03:31:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:28 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:28 INFO - Contents: 03:31:28 INFO - build_url:https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:31:29 INFO - Running post-action listener: _resource_record_post_action 03:31:29 INFO - Running post-action listener: set_extra_try_arguments 03:31:29 INFO - [mozharness: 2016-08-09 10:31:29.562514Z] Finished download-and-extract step (success) 03:31:29 INFO - [mozharness: 2016-08-09 10:31:29.562750Z] Running populate-webroot step. 03:31:29 INFO - Running pre-action listener: _resource_record_pre_action 03:31:29 INFO - Running main action method: populate_webroot 03:31:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:29 INFO - '--tppagecycles', 03:31:29 INFO - '7'], 03:31:29 INFO - 'tests': ['tsvgm']}}, 03:31:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:29 INFO - 'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:29 INFO - 'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['damp', 'tps']}, 03:31:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:29 INFO - 'tests': ['damp', 'tps']}, 03:31:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['dromaeo_dom']}, 03:31:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['basic_compositor_video']}, 03:31:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:31:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['a11yr', 03:31:29 INFO - 'ts_paint', 03:31:29 INFO - 'tpaint', 03:31:29 INFO - 'sessionrestore', 03:31:29 INFO - 'sessionrestore_no_auto_restore', 03:31:29 INFO - 'tabpaint']}, 03:31:29 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:29 INFO - 'ts_paint', 03:31:29 INFO - 'tpaint', 03:31:29 INFO - 'sessionrestore', 03:31:29 INFO - 'sessionrestore_no_auto_restore', 03:31:29 INFO - 'tabpaint']}, 03:31:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:29 INFO - 'ts_paint', 03:31:29 INFO - 'tpaint', 03:31:29 INFO - 'sessionrestore', 03:31:29 INFO - 'sessionrestore_no_auto_restore', 03:31:29 INFO - 'tabpaint']}, 03:31:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:29 INFO - 'ts_paint', 03:31:29 INFO - 'tpaint', 03:31:29 INFO - 'sessionrestore', 03:31:29 INFO - 'sessionrestore_no_auto_restore', 03:31:29 INFO - 'tabpaint']}, 03:31:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['a11yr', 03:31:29 INFO - 'ts_paint', 03:31:29 INFO - 'tpaint', 03:31:29 INFO - 'sessionrestore', 03:31:29 INFO - 'sessionrestore_no_auto_restore', 03:31:29 INFO - 'tabpaint']}, 03:31:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['a11yr', 03:31:29 INFO - 'ts_paint', 03:31:29 INFO - 'tpaint', 03:31:29 INFO - 'sessionrestore', 03:31:29 INFO - 'sessionrestore_no_auto_restore', 03:31:29 INFO - 'tabpaint']}, 03:31:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['tsvgx', 03:31:29 INFO - 'tsvgr_opacity', 03:31:29 INFO - 'tart', 03:31:29 INFO - 'tscrollx', 03:31:29 INFO - 'cart']}, 03:31:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:29 INFO - 'tsvgr_opacity', 03:31:29 INFO - 'tart', 03:31:29 INFO - 'tscrollx', 03:31:29 INFO - 'cart']}, 03:31:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:29 INFO - 'talos_options': ['--disable-e10s'], 03:31:29 INFO - 'tests': ['tp5o']}, 03:31:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:29 INFO - 'tests': ['tp5o']}, 03:31:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:29 INFO - 'talos_options': ['--disable-e10s', 03:31:29 INFO - '--xperf_path', 03:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:29 INFO - 'tests': ['tp5n']}, 03:31:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:29 INFO - 'talos_options': ['--xperf_path', 03:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:29 INFO - 'tests': ['tp5n']}}, 03:31:29 INFO - 'talos.zip': {'path': '', 03:31:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:29 INFO - Running post-action listener: _resource_record_post_action 03:31:29 INFO - [mozharness: 2016-08-09 10:31:29.580334Z] Finished populate-webroot step (success) 03:31:29 INFO - [mozharness: 2016-08-09 10:31:29.580424Z] Running create-virtualenv step. 03:31:29 INFO - Running pre-action listener: _resource_record_pre_action 03:31:29 INFO - Running main action method: create_virtualenv 03:31:29 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:29 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 03:31:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:29 INFO - Using real prefix '/usr' 03:31:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:30 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:32 INFO - Installing pip.................done. 03:31:32 INFO - Return code: 0 03:31:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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 0x1d51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f80400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, '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-1470738228.992833-329231176', '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 03:31: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 03:31: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 03:31:32 INFO - Using env: {'DISPLAY': ':0', 03:31:32 INFO - 'HOME': '/home/cltbld', 03:31:32 INFO - 'LANG': 'en_US.UTF-8', 03:31:32 INFO - 'LANGUAGE': 'en_US:en', 03:31:32 INFO - 'LOGNAME': 'cltbld', 03:31:32 INFO - 'MAIL': '/var/mail/cltbld', 03:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:32 INFO - 'MOZ_NO_REMOTE': '1', 03:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:32 INFO - 'NO_EM_RESTART': '1', 03:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:32 INFO - 'PWD': '/builds/slave/test', 03:31:32 INFO - 'SHELL': '/bin/bash', 03:31:32 INFO - 'SHLVL': '1', 03:31:32 INFO - 'TERM': 'linux', 03:31:32 INFO - 'TMOUT': '86400', 03:31:32 INFO - 'USER': 'cltbld', 03:31:32 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:32 INFO - '_': '/tools/buildbot/bin/python'} 03:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31: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 03:31:32 INFO - Cleaning up... 03:31:32 INFO - Return code: 0 03:31:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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', '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 0x1d51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f80400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, '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-1470738228.992833-329231176', '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 03:31: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:31: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 psutil>=3.1.1 03:31:32 INFO - Using env: {'DISPLAY': ':0', 03:31:32 INFO - 'HOME': '/home/cltbld', 03:31:32 INFO - 'LANG': 'en_US.UTF-8', 03:31:32 INFO - 'LANGUAGE': 'en_US:en', 03:31:32 INFO - 'LOGNAME': 'cltbld', 03:31:32 INFO - 'MAIL': '/var/mail/cltbld', 03:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:32 INFO - 'MOZ_NO_REMOTE': '1', 03:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:32 INFO - 'NO_EM_RESTART': '1', 03:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:32 INFO - 'PWD': '/builds/slave/test', 03:31:32 INFO - 'SHELL': '/bin/bash', 03:31:32 INFO - 'SHLVL': '1', 03:31:32 INFO - 'TERM': 'linux', 03:31:32 INFO - 'TMOUT': '86400', 03:31:32 INFO - 'USER': 'cltbld', 03:31:32 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:32 INFO - '_': '/tools/buildbot/bin/python'} 03:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:32 INFO - Downloading/unpacking psutil>=3.1.1 03:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:34 INFO - Installing collected packages: psutil 03:31:34 INFO - Running setup.py install for psutil 03:31:34 INFO - building 'psutil._psutil_linux' extension 03:31:34 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 03:31:34 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 03:31:34 INFO - building 'psutil._psutil_posix' extension 03:31:34 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 03:31:34 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 03:31:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:35 INFO - Successfully installed psutil 03:31:35 INFO - Cleaning up... 03:31:35 INFO - Return code: 0 03:31:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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 0x1d51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f80400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, '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-1470738228.992833-329231176', '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 03:31: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 03:31: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 03:31:35 INFO - Using env: {'DISPLAY': ':0', 03:31:35 INFO - 'HOME': '/home/cltbld', 03:31:35 INFO - 'LANG': 'en_US.UTF-8', 03:31:35 INFO - 'LANGUAGE': 'en_US:en', 03:31:35 INFO - 'LOGNAME': 'cltbld', 03:31:35 INFO - 'MAIL': '/var/mail/cltbld', 03:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:35 INFO - 'MOZ_NO_REMOTE': '1', 03:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:35 INFO - 'NO_EM_RESTART': '1', 03:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:35 INFO - 'PWD': '/builds/slave/test', 03:31:35 INFO - 'SHELL': '/bin/bash', 03:31:35 INFO - 'SHLVL': '1', 03:31:35 INFO - 'TERM': 'linux', 03:31:35 INFO - 'TMOUT': '86400', 03:31:35 INFO - 'USER': 'cltbld', 03:31:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:35 INFO - '_': '/tools/buildbot/bin/python'} 03:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:31:37 INFO - Installing collected packages: mozsystemmonitor 03:31:37 INFO - Running setup.py install for mozsystemmonitor 03:31:37 INFO - Successfully installed mozsystemmonitor 03:31:37 INFO - Cleaning up... 03:31:37 INFO - Return code: 0 03:31:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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 0x1d51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f80400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, '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-1470738228.992833-329231176', '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 03:31:37 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 03:31:37 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 03:31:37 INFO - Using env: {'DISPLAY': ':0', 03:31:37 INFO - 'HOME': '/home/cltbld', 03:31:37 INFO - 'LANG': 'en_US.UTF-8', 03:31:37 INFO - 'LANGUAGE': 'en_US:en', 03:31:37 INFO - 'LOGNAME': 'cltbld', 03:31:37 INFO - 'MAIL': '/var/mail/cltbld', 03:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:37 INFO - 'MOZ_NO_REMOTE': '1', 03:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:37 INFO - 'NO_EM_RESTART': '1', 03:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:37 INFO - 'PWD': '/builds/slave/test', 03:31:37 INFO - 'SHELL': '/bin/bash', 03:31:37 INFO - 'SHLVL': '1', 03:31:37 INFO - 'TERM': 'linux', 03:31:37 INFO - 'TMOUT': '86400', 03:31:37 INFO - 'USER': 'cltbld', 03:31:37 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:37 INFO - '_': '/tools/buildbot/bin/python'} 03:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:37 INFO - Downloading/unpacking jsonschema==2.5.1 03:31:37 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 03:31:37 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 03:31:37 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 03:31:37 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 03:31:37 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 03:31:37 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 03:31:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:31:39 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 03:31:39 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 03:31:39 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 03:31:39 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 03:31:39 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 03:31:39 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 03:31:39 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:39 INFO - warning: no files found matching '*.txt' 03:31:39 INFO - no previously-included directories found matching 'build' 03:31:39 INFO - no previously-included directories found matching 'dist' 03:31:39 INFO - no previously-included directories found matching '.git*' 03:31:39 INFO - Installing collected packages: jsonschema, functools32 03:31:39 INFO - Running setup.py install for functools32 03:31:39 INFO - warning: no files found matching '*.txt' 03:31:39 INFO - no previously-included directories found matching 'build' 03:31:39 INFO - no previously-included directories found matching 'dist' 03:31:39 INFO - no previously-included directories found matching '.git*' 03:31:39 INFO - Successfully installed jsonschema functools32 03:31:39 INFO - Cleaning up... 03:31:39 INFO - Return code: 0 03:31:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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 0x1d51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f80400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, '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-1470738228.992833-329231176', '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 03:31: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 03:31: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 03:31:40 INFO - Using env: {'DISPLAY': ':0', 03:31:40 INFO - 'HOME': '/home/cltbld', 03:31:40 INFO - 'LANG': 'en_US.UTF-8', 03:31:40 INFO - 'LANGUAGE': 'en_US:en', 03:31:40 INFO - 'LOGNAME': 'cltbld', 03:31:40 INFO - 'MAIL': '/var/mail/cltbld', 03:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:40 INFO - 'MOZ_NO_REMOTE': '1', 03:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:40 INFO - 'NO_EM_RESTART': '1', 03:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:40 INFO - 'PWD': '/builds/slave/test', 03:31:40 INFO - 'SHELL': '/bin/bash', 03:31:40 INFO - 'SHLVL': '1', 03:31:40 INFO - 'TERM': 'linux', 03:31:40 INFO - 'TMOUT': '86400', 03:31:40 INFO - 'USER': 'cltbld', 03:31:40 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:40 INFO - '_': '/tools/buildbot/bin/python'} 03:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:31:40 INFO - Cleaning up... 03:31:40 INFO - Return code: 0 03:31:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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 0x1d51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f80400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, '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-1470738228.992833-329231176', '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 03:31: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 03:31: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 03:31:40 INFO - Using env: {'DISPLAY': ':0', 03:31:40 INFO - 'HOME': '/home/cltbld', 03:31:40 INFO - 'LANG': 'en_US.UTF-8', 03:31:40 INFO - 'LANGUAGE': 'en_US:en', 03:31:40 INFO - 'LOGNAME': 'cltbld', 03:31:40 INFO - 'MAIL': '/var/mail/cltbld', 03:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:40 INFO - 'MOZ_NO_REMOTE': '1', 03:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:40 INFO - 'NO_EM_RESTART': '1', 03:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:40 INFO - 'PWD': '/builds/slave/test', 03:31:40 INFO - 'SHELL': '/bin/bash', 03:31:40 INFO - 'SHLVL': '1', 03:31:40 INFO - 'TERM': 'linux', 03:31:40 INFO - 'TMOUT': '86400', 03:31:40 INFO - 'USER': 'cltbld', 03:31:40 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:40 INFO - '_': '/tools/buildbot/bin/python'} 03:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:40 INFO - Downloading/unpacking blobuploader==1.2.4 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:42 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:42 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 03:31:42 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 03:31:42 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 03:31:42 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 03:31:42 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 03:31:42 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 03:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:42 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 03:31:42 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 03:31:42 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 03:31:42 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 03:31:42 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 03:31:42 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 03:31:42 INFO - Downloading docopt-0.6.1.tar.gz 03:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:43 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:43 INFO - Running setup.py install for blobuploader 03:31:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:43 INFO - Running setup.py install for requests 03:31:43 INFO - Running setup.py install for docopt 03:31:43 INFO - Successfully installed blobuploader requests docopt 03:31:43 INFO - Cleaning up... 03:31:43 INFO - Return code: 0 03:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:43 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 0x1d51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f80400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, '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-1470738228.992833-329231176', '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 03:31:43 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 03:31:43 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 03:31:43 INFO - Using env: {'DISPLAY': ':0', 03:31:43 INFO - 'HOME': '/home/cltbld', 03:31:43 INFO - 'LANG': 'en_US.UTF-8', 03:31:43 INFO - 'LANGUAGE': 'en_US:en', 03:31:43 INFO - 'LOGNAME': 'cltbld', 03:31:43 INFO - 'MAIL': '/var/mail/cltbld', 03:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:43 INFO - 'MOZ_NO_REMOTE': '1', 03:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:43 INFO - 'NO_EM_RESTART': '1', 03:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:43 INFO - 'PWD': '/builds/slave/test', 03:31:43 INFO - 'SHELL': '/bin/bash', 03:31:43 INFO - 'SHLVL': '1', 03:31:43 INFO - 'TERM': 'linux', 03:31:43 INFO - 'TMOUT': '86400', 03:31:43 INFO - 'USER': 'cltbld', 03:31:43 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:43 INFO - '_': '/tools/buildbot/bin/python'} 03:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:43 INFO - Running setup.py (path:/tmp/pip-kgeGyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:43 INFO - Running setup.py (path:/tmp/pip-5DmGCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:44 INFO - Running setup.py (path:/tmp/pip-KWVQAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:44 INFO - Running setup.py (path:/tmp/pip-P18LcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:44 INFO - Running setup.py (path:/tmp/pip-M17BuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:44 INFO - Running setup.py (path:/tmp/pip-Pc30Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:44 INFO - Running setup.py (path:/tmp/pip-2Eomlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:44 INFO - Running setup.py (path:/tmp/pip-MvIChh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:44 INFO - Running setup.py (path:/tmp/pip-EUZ5GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:44 INFO - Running setup.py (path:/tmp/pip-XxNbcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:44 INFO - Running setup.py (path:/tmp/pip-AmtNiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:44 INFO - Running setup.py (path:/tmp/pip-uNiu_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:44 INFO - Running setup.py (path:/tmp/pip-fbQBlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:44 INFO - Running setup.py (path:/tmp/pip-KhS1NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:44 INFO - Running setup.py (path:/tmp/pip-kcl6V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:45 INFO - Running setup.py (path:/tmp/pip-Q8HMdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:45 INFO - Running setup.py (path:/tmp/pip-jvWGgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:45 INFO - Running setup.py install for manifestparser 03:31:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for mozcrash 03:31:45 INFO - Running setup.py install for mozdebug 03:31:45 INFO - Running setup.py install for mozdevice 03:31:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for mozfile 03:31:45 INFO - Running setup.py install for mozhttpd 03:31:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for mozinfo 03:31:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for mozInstall 03:31:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:45 INFO - Running setup.py install for mozleak 03:31:46 INFO - Running setup.py install for mozlog 03:31:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Running setup.py install for moznetwork 03:31:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Running setup.py install for mozprocess 03:31:46 INFO - Running setup.py install for mozprofile 03:31:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Running setup.py install for mozrunner 03:31:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Running setup.py install for mozscreenshot 03:31:46 INFO - Running setup.py install for moztest 03:31:46 INFO - Running setup.py install for mozversion 03:31:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:46 INFO - Cleaning up... 03:31:46 INFO - Return code: 0 03:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:46 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 0x1d51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f80400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, '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-1470738228.992833-329231176', '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 03:31:46 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 03:31:46 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 03:31:46 INFO - Using env: {'DISPLAY': ':0', 03:31:46 INFO - 'HOME': '/home/cltbld', 03:31:46 INFO - 'LANG': 'en_US.UTF-8', 03:31:46 INFO - 'LANGUAGE': 'en_US:en', 03:31:46 INFO - 'LOGNAME': 'cltbld', 03:31:46 INFO - 'MAIL': '/var/mail/cltbld', 03:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:46 INFO - 'MOZ_NO_REMOTE': '1', 03:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:46 INFO - 'NO_EM_RESTART': '1', 03:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:46 INFO - 'PWD': '/builds/slave/test', 03:31:46 INFO - 'SHELL': '/bin/bash', 03:31:46 INFO - 'SHLVL': '1', 03:31:46 INFO - 'TERM': 'linux', 03:31:46 INFO - 'TMOUT': '86400', 03:31:46 INFO - 'USER': 'cltbld', 03:31:46 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:46 INFO - '_': '/tools/buildbot/bin/python'} 03:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:47 INFO - Running setup.py (path:/tmp/pip-mKxZNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:47 INFO - Running setup.py (path:/tmp/pip-8Wsqbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:47 INFO - Running setup.py (path:/tmp/pip-MigiDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:47 INFO - Running setup.py (path:/tmp/pip-Q_JCBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:47 INFO - Running setup.py (path:/tmp/pip-qfBZlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:47 INFO - Running setup.py (path:/tmp/pip-8hIcMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:47 INFO - Running setup.py (path:/tmp/pip-lz61ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:47 INFO - Running setup.py (path:/tmp/pip-GFHWd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:47 INFO - Running setup.py (path:/tmp/pip-Dh7lOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:47 INFO - Running setup.py (path:/tmp/pip-cQPHGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:47 INFO - Running setup.py (path:/tmp/pip-lXzrug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:47 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)) 03:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:47 INFO - Running setup.py (path:/tmp/pip-xIQES4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:48 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)) 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:48 INFO - Running setup.py (path:/tmp/pip-P86him-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:48 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)) 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:48 INFO - Running setup.py (path:/tmp/pip-diF5DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:48 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)) 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:48 INFO - Running setup.py (path:/tmp/pip-Q8kprR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:48 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)) 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:48 INFO - Running setup.py (path:/tmp/pip-ls065L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:48 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)) 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:48 INFO - Running setup.py (path:/tmp/pip-PDWDup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 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)) 03:31:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:48 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 03:31:48 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 03:31:48 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 03:31:48 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 03:31:48 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 03:31:48 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 03:31:50 INFO - Downloading blessings-1.6.tar.gz 03:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:50 INFO - Installing collected packages: blessings 03:31:50 INFO - Running setup.py install for blessings 03:31:50 INFO - Successfully installed blessings 03:31:50 INFO - Cleaning up... 03:31:50 INFO - Return code: 0 03:31:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:50 INFO - Reading from file tmpfile_stdout 03:31:50 INFO - Current package versions: 03:31:50 INFO - argparse == 1.2.1 03:31:50 INFO - blessings == 1.6 03:31:50 INFO - blobuploader == 1.2.4 03:31:50 INFO - docopt == 0.6.1 03:31:50 INFO - functools32 == 3.2.3-2 03:31:50 INFO - jsonschema == 2.5.1 03:31:50 INFO - manifestparser == 1.1 03:31:50 INFO - mozInstall == 1.12 03:31:50 INFO - mozcrash == 0.17 03:31:50 INFO - mozdebug == 0.1 03:31:50 INFO - mozdevice == 0.48 03:31:50 INFO - mozfile == 1.2 03:31:50 INFO - mozhttpd == 0.7 03:31:50 INFO - mozinfo == 0.9 03:31:50 INFO - mozleak == 0.1 03:31:50 INFO - mozlog == 3.3 03:31:50 INFO - moznetwork == 0.27 03:31:50 INFO - mozprocess == 0.23 03:31:50 INFO - mozprofile == 0.28 03:31:50 INFO - mozrunner == 6.12 03:31:50 INFO - mozscreenshot == 0.1 03:31:50 INFO - mozsystemmonitor == 0.3 03:31:50 INFO - moztest == 0.7 03:31:50 INFO - mozversion == 1.4 03:31:50 INFO - psutil == 3.1.1 03:31:50 INFO - requests == 1.2.3 03:31:50 INFO - wsgiref == 0.1.2 03:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:50 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')]} 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 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')]} 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 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 0x1d51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f80400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, '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-1470738228.992833-329231176', '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 03:31:50 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 03:31:50 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 03:31:50 INFO - Using env: {'DISPLAY': ':0', 03:31:50 INFO - 'HOME': '/home/cltbld', 03:31:50 INFO - 'LANG': 'en_US.UTF-8', 03:31:50 INFO - 'LANGUAGE': 'en_US:en', 03:31:50 INFO - 'LOGNAME': 'cltbld', 03:31:50 INFO - 'MAIL': '/var/mail/cltbld', 03:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:50 INFO - 'MOZ_NO_REMOTE': '1', 03:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:50 INFO - 'NO_EM_RESTART': '1', 03:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:50 INFO - 'PWD': '/builds/slave/test', 03:31:50 INFO - 'SHELL': '/bin/bash', 03:31:50 INFO - 'SHLVL': '1', 03:31:50 INFO - 'TERM': 'linux', 03:31:50 INFO - 'TMOUT': '86400', 03:31:50 INFO - 'USER': 'cltbld', 03:31:50 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:50 INFO - '_': '/tools/buildbot/bin/python'} 03:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:50 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)) 03:31:50 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)) 03:31:50 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)) 03:31:50 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)) 03:31:50 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)) 03:31:50 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)) 03:31:50 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)) 03:31:50 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)) 03:31:50 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)) 03:31:50 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)) 03:31:50 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)) 03:31:50 INFO - Cleaning up... 03:31:50 INFO - Return code: 0 03:31:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:50 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')]} 03:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 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')]} 03:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:50 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 0x1d51030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f80400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, '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-1470738228.992833-329231176', '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 03:31:50 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 03:31:50 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 03:31:50 INFO - Using env: {'DISPLAY': ':0', 03:31:50 INFO - 'HOME': '/home/cltbld', 03:31:50 INFO - 'LANG': 'en_US.UTF-8', 03:31:50 INFO - 'LANGUAGE': 'en_US:en', 03:31:50 INFO - 'LOGNAME': 'cltbld', 03:31:50 INFO - 'MAIL': '/var/mail/cltbld', 03:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:50 INFO - 'MOZ_NO_REMOTE': '1', 03:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:50 INFO - 'NO_EM_RESTART': '1', 03:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:50 INFO - 'PWD': '/builds/slave/test', 03:31:50 INFO - 'SHELL': '/bin/bash', 03:31:50 INFO - 'SHLVL': '1', 03:31:50 INFO - 'TERM': 'linux', 03:31:50 INFO - 'TMOUT': '86400', 03:31:50 INFO - 'USER': 'cltbld', 03:31:50 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:50 INFO - '_': '/tools/buildbot/bin/python'} 03:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:31:51 INFO - Cleaning up... 03:31:51 INFO - Return code: 0 03:31:51 INFO - Running post-action listener: _resource_record_post_action 03:31:51 INFO - Running post-action listener: _start_resource_monitoring 03:31:51 INFO - Starting resource monitoring. 03:31:51 INFO - [mozharness: 2016-08-09 10:31:51.197044Z] Finished create-virtualenv step (success) 03:31:51 INFO - [mozharness: 2016-08-09 10:31:51.197572Z] Running install step. 03:31:51 INFO - Running pre-action listener: _resource_record_pre_action 03:31:51 INFO - Running main action method: install 03:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:51 INFO - Reading from file tmpfile_stdout 03:31:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:51 INFO - Reading from file tmpfile_stdout 03:31:51 INFO - Output received: 03:31:51 INFO - Usage: mozinstall [options] installer 03:31:51 INFO - Options: 03:31:51 INFO - -h, --help show this help message and exit 03:31:51 INFO - -d DEST, --destination=DEST 03:31:51 INFO - Directory to install application into. [default: 03:31:51 INFO - "/builds/slave/test"] 03:31:51 INFO - --app=APP Application being installed. [default: firefox] 03:31:51 INFO - mkdir: /builds/slave/test/build/application 03:31:51 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'] 03:31:51 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 03:32:07 INFO - Reading from file tmpfile_stdout 03:32:07 INFO - Output received: 03:32:07 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:07 INFO - Running post-action listener: _resource_record_post_action 03:32:07 INFO - [mozharness: 2016-08-09 10:32:07.459783Z] Finished install step (success) 03:32:07 INFO - [mozharness: 2016-08-09 10:32:07.460036Z] Running run-tests step. 03:32:07 INFO - Running pre-action listener: _resource_record_pre_action 03:32:07 INFO - Running main action method: run_tests 03:32:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:07 INFO - Python 2.7.3 03:32:07 INFO - Return code: 0 03:32:07 INFO - grabbing minidump binary from tooltool 03:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:07 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 0x200f570>, '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 0x2010470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2010900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:07 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 03:32:07 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 03:32:07 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 03:32:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:07 INFO - Return code: 0 03:32:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:07 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/eUa0-gJYQhGdafDNIzaZQA/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 03:32:07 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/eUa0-gJYQhGdafDNIzaZQA/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 03:32:07 INFO - Using env: {'DISPLAY': ':0', 03:32:07 INFO - 'HOME': '/home/cltbld', 03:32:07 INFO - 'LANG': 'en_US.UTF-8', 03:32:07 INFO - 'LANGUAGE': 'en_US:en', 03:32:07 INFO - 'LOGNAME': 'cltbld', 03:32:07 INFO - 'MAIL': '/var/mail/cltbld', 03:32:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:07 INFO - 'MOZ_NO_REMOTE': '1', 03:32:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:07 INFO - 'NO_EM_RESTART': '1', 03:32:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:07 INFO - 'PWD': '/builds/slave/test', 03:32:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:07 INFO - 'SHELL': '/bin/bash', 03:32:07 INFO - 'SHLVL': '1', 03:32:07 INFO - 'TERM': 'linux', 03:32:07 INFO - 'TMOUT': '86400', 03:32:07 INFO - 'USER': 'cltbld', 03:32:07 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1470738228.992833-329231176', 03:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:07 INFO - '_': '/tools/buildbot/bin/python'} 03:32:07 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/eUa0-gJYQhGdafDNIzaZQA/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 03:32:07 INFO - mozversion application_buildid: 20160809004002 03:32:07 INFO - mozversion application_changeset: 79f0792841417c6cdf8cb78e8ee5026f53ba72aa 03:32:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:32:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:07 INFO - mozversion application_name: Firefox 03:32:07 INFO - mozversion application_remotingname: firefox-dev 03:32:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:07 INFO - mozversion application_vendor: Mozilla 03:32:07 INFO - mozversion application_version: 50.0a2 03:32:07 INFO - mozversion platform_buildid: 20160809004002 03:32:07 INFO - mozversion platform_changeset: 79f0792841417c6cdf8cb78e8ee5026f53ba72aa 03:32:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:07 INFO - mozversion platform_version: 50.0a2 03:32:07 INFO - using testdate: 1470738727 03:32:07 INFO - actual date: 1470738727 03:32:07 INFO - starting webserver on 'localhost:53773' 03:32:07 INFO - SUITE-START | Running 2 tests 03:32:07 INFO - TEST-START | dromaeo_css 03:32:07 INFO - operating with platform_type : linux_ 03:32:07 INFO - Initialising browser for dromaeo_css test... 03:32:07 INFO - TEST-INFO | started process 9472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv2WeMz/profile http://localhost:53773/getInfo.html) 03:32:12 INFO - PROCESS | 9472 | __metrics Screen width/height:1600/1200 03:32:12 INFO - PROCESS | 9472 | colorDepth:24 03:32:12 INFO - PROCESS | 9472 | Browser inner width/height: 1024/697 03:32:12 INFO - PROCESS | 9472 | __metrics 03:32:13 ERROR - PROCESS | 9472 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:32:13 INFO - TEST-INFO | 9472: exit 0 03:32:13 INFO - Browser initialized. 03:32:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:13 INFO - TEST-INFO | started process 9597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv2WeMz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:25 INFO - PROCESS | 9597 | RSS: Main: 152768512 03:32:25 INFO - PROCESS | 9597 | 03:33:15 INFO - PROCESS | 9597 | 1470738795181 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] 03:35:23 INFO - PROCESS | 9597 | Cycle 1(1): loaded http://localhost:53773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53773/tests/dromaeo/cssquery-ext.html) 03:35:24 INFO - PROCESS | 9597 | RSS: Main: 157913088 03:35:24 INFO - PROCESS | 9597 | 03:38:26 INFO - PROCESS | 9597 | Cycle 1(1): loaded http://localhost:53773/tests/dromaeo/cssquery-ext.html (next: http://localhost:53773/tests/dromaeo/cssquery-jquery.html) 03:38:27 INFO - PROCESS | 9597 | RSS: Main: 153993216 03:38:27 INFO - PROCESS | 9597 | 03:41:29 INFO - PROCESS | 9597 | Cycle 1(1): loaded http://localhost:53773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53773/tests/dromaeo/cssquery-mootools.html) 03:41:29 INFO - PROCESS | 9597 | RSS: Main: 153407488 03:41:29 INFO - PROCESS | 9597 | 03:44:31 INFO - PROCESS | 9597 | Cycle 1(1): loaded http://localhost:53773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53773/tests/dromaeo/cssquery-prototype.html) 03:44:32 INFO - PROCESS | 9597 | RSS: Main: 151863296 03:44:32 INFO - PROCESS | 9597 | 03:47:34 INFO - PROCESS | 9597 | Cycle 1(1): loaded http://localhost:53773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53773/tests/dromaeo/cssquery-yui.html) 03:47:35 INFO - PROCESS | 9597 | RSS: Main: 154800128 03:47:35 INFO - PROCESS | 9597 | 03:50:37 INFO - PROCESS | 9597 | Cycle 1(1): loaded http://localhost:53773/tests/dromaeo/cssquery-yui.html (next: http://localhost:53773/tests/dromaeo/cssquery-dojo.html) 03:50:37 INFO - PROCESS | 9597 | RSS: Main: 156000256 03:50:37 INFO - PROCESS | 9597 | 03:50:37 INFO - PROCESS | 9597 | __start_tp_report 03:50:37 INFO - PROCESS | 9597 | _x_x_mozilla_page_load 03:50:37 INFO - PROCESS | 9597 | _x_x_mozilla_page_load_details 03:50:37 INFO - PROCESS | 9597 | |i|pagename|runs| 03:50:37 INFO - PROCESS | 9597 | |0;dojo.html;3318.850651720673;3319.983400082999;3337.21575429774;3340.930902111324;3361.5966084069914;5816.476517113459;5867.237259156309;5875.794347197849;5883.411658834115;5895.027320492124;5730.05454100074;5741.19623252745;5788.594798364116;5796.8260952171395;5799.710014499279;5241.816536421226;5247.7900883964785;5271.2356708277275;5295.8146464873735;5337.813176538822;5215.713135777531;5233.267342572043;5234.057869583474;5239.947600523984;5279.947200528003;5120.487951204868;5149.81975630853;5174.974125129369;5176.223566465042;5181.43004269532;5179.430262671103;5230.816921407771;5231.163013917755;5245.370555533342;5274.446183150791;5035.521625445577;5039.697618142886;5128.410232823236;5148.922766158511;5151.639385243035;5766.163906233573;5822.243108395924;5827.038538641119;5893.204417403638;5932.317783454915;6250.937490625081;6322.778702745381;6328.398802113792;6338.144350512668;6355.0785136155;6143.508519318489;6373.681315934185;6373.7450501979865;6383.936160638381;6389.8402539936405;5749.482546570787;5787.074068149076;5867.589268751231;5907.4683278505145;5914.61554998928;6343.841403964938;6368.039463346196;6391.360863913572;6394.168758061515;6401.359864013654;5986.610870293417;6135.815925522242;6155.84610384744;6172.4136207060255;6179.474744646665;6091.908621370683;6120.721420533169;6137.171481849982;6180.980138277134;6223.408776166257;6142.600730952563;6155;6162.383761623892;6175.042868355412;6181.876362472815;5988.490978266809;6149.108379284979;6153.107799369066;6156.938430615636;6160.599561028519;4626.306054091846;4653.185692503798;4687.9765601171775;4722.338872557844;4749.810007599726;4189.518205406356;4206.72656277341;4209.852655157055;4222.936655950163;4231.492220933507;5702.258706368146;5818.272715910512;5831.475167234885;5833.679147646835;5873.676947767828;6130.448259656652;6135.661410523283;6148.754049838046;6222.844428889314;6255;5832.912506312408;5851.61964472308;5864.354920958691;5869.941300586939;5907.675077870758;5193.532582067632;5338.652987555796;5355.651882627694;5356.946430535645;5372.328458942632;6322.146510221061;6335.049742538656;6382;6485.67571621417;6492.902606460907;6171.59884607499;6212.751489940351;6235.563510554218;6259.280182778948;6269.7178626962805;6310.7475700971445;6427.357264273535;6442.452391546771;6461.160049193575;6488.837779055372;6030.517558595214;6031.668258245839;6064.151018857276;6139.570230083851;6164.229471316085;6204.069389591597;6246.187995560548;6247.781327653511;6254.781082662085;6260.874782504416;5931.1992880960515;6114.7248373822395;6119.694015299128;6132.141500190066;6147;5854.853628659147;6001.969990150022;6005.969970150296;6011.969940150271;6125.998614523495;6051.0923361496125;6055.939440605537;6096.939030609815;6101.633901965896;6114.633122012693;6149.139120523219;6149.569530133027;6186.969065154825;6192.380761923771;6194.876102478015;5861.6189947653265;5926.496247818984;6004.969975150271;6028.909566356596;6126.6017708848785 03:50:37 INFO - PROCESS | 9597 | |1;ext.html;589.6462122726365;626.1703243202754;635.971381287842;656.4092316914778;727.3926271563245;40178.59821401785;44975.32537011943;45090.774546127264;45266;45571.31643025357;46733.532664673345;47011.29483057757;47237;47461.52538474614;47614.28578571324;9086.681966131187;9198.586063627154;9209.493477858716;9214.308926830481;9220.170184683377;9083;9178.219851312646;9193.95403022984;9201.907980920205;9251.722448326562;9234.39976401535;9241.029691882322;9251.98228194898;9263.675771348004;9267.490288034156;9224.30817688676;9266.073392660748;9276.026017268225;9276.257899368067;9284.071592840663;9154.176124148858;9212.355135140542;9217.354785165042;9218.585163667583;9231.215346695539;43825.56174438279;43969.12061758779;44064.77967610174;44346.113077738584;44411;3076.492378757502;3606.855725770966;3738.196287798109;3852.6725228355344;4071.4731975509185;32769.11316502692;32827;32945.176370590685;33067.3386532268;33076.6692333076;4533.954660453386;4640.443146822369;4680.742559159245;4700.741459219742;4749.62003039756;339211;339753;341129;341692;341853.9999999975;38631.227375452334;38820.611793882264;39090.804545977655;39095.21809563793;39116.21767564633;40902.38646420306;40963.180736385104;41355;41465;41561.58438415638;15294.311755970786;15352.385904563916;15428;15440.227988600525;15446;13786.310684465736;13820.861791381958;13825.585232443043;13825.723485530434;13834;9276.907230927603;9333.766655833659;9354.532273386303;9358.953205234066;9371.625134994523;3548.2193917338145;3575.8748443804343;3582.3193593217206;3631.4008188648577;3686.096906257984;1086.397049637443;1143.0741099709262;1152.0553146419854;1234.1546040961791;1252.7431876465484;34387.31225375478;34732.65267347345;35120.64879351225;35284.82357588196;35408.82295588506;1200.8799120087922;1218.585680868509;1246.376811594203;1251.561953316332;1286.5561381323428;18358.08209589515;18397.3560925367;18518.07409629513;18533.745282504293;18617.441476755717;647421;652562;653261;653875;656027;44656;44672;44680.77659611681;44686.553134468886;44725.776371117936;1452.194032312056;1492.8208614966056;1501.9774703379458;1507.5326648738926;1512.5764785859976;34427;34481.31037379288;34680.30639387249;34691;35295.11762205965;57826;57949;58004.70997644985;58654;58765.11852322304;542812;545419;547763;548261;549907;30930.22674433067;31520;31805.681943180272;31973.36053278875;32065.83967080243;52429.7378513105;52498.73750631375;52822.2076668858;52885.735571323436;53075.73462132664;44734;45241.32138017866;45401;45739.77130114328;46665;43937.16176331923;45562;45590.77204613956;46123.07753844972;46576.7671161642;45649.54350456453;45737.77131114323;46515.53484465112;46828.29757553708;47063.76468117638;38069.4289585662;39708;40200.597994019685;40296.597034029284;41030.58969410268;29296.560551591316;29544;30038.699613004464;30211.244718882204;30429.391412172074 03:50:37 INFO - PROCESS | 9597 | |2;jquery.html;413.52031643293776;420.2183937875551;423.40511581228344;431.52316690057484;435.71678409034126;20431.693524597144;20701.585968280644;21445.142194312208;21450.57098858024;21541.353759387206;20049.699254511157;20370;20952.26667066653;21087.57824843506;21210.681839772416;5790.594658373905;5987.161797348374;6065.181200537937;6082.178905847721;6087.026075827868;5958.910616340737;5992.460678538931;6064.090386442025;6163.137160797492;6180.351063138373;6287.748490060392;6289.8113056608145;6301.275353334357;6313.558050936436;6319.273283572379;6076.997295446246;6105.725242364104;6127.387261273881;6129.264488261437;6145.293291271516;5854.677992710399;5927.940720592782;6002.039673652238;6017.368176341509;6030.457258846681;14800.555983320517;14891.851081489263;14905.627359316104;14954.551363459113;27662.585061224097;2597.8701064946677;2791.4417116576765;2814.6481689788775;2999.2052106191877;3316.7844090134063;17221.913890430595;17637.382691605733;18030.459086227303;18200;18403.815961840344;2224.744154422246;2226.543558570489;2235.564065007324;2238.809701175402;2309.722833260003;78280.21719782786;94067;97855;101187;107349.46325268324;17882.195301211475;18416.447506574823;19438.708419373437;19561;19741.605167896563;34208.657913420546;34298.65701343004;34411.655883441344;34449.65550344464;34564;10376.429296388771;10452.477376131163;10522.684319470429;10628.149748020294;10767.138628909668;8692.565371731389;8704.564771761387;8722.47665140081;8766.693165739169;8932.151445612657;9514;9594.616215351447;9667.46828924416;9866.556004979793;9974.601015959426;3485.721142308609;3601.981990090085;3672.2288319452678;3708.4622729704042;3972.880813575597;1008.1581879131007;1026.707388394319;1093.7156339351666;1104.0229396983566;1126.566271985275;19818.90090549538;20521.897390512953;20697.27559535409;20748.792512074688;20799.68800467994;1035.8135535603665;1051.7791263834526;1079.2768844873954;1086.6631344283298;1139.4530625299903;11432.88567114335;11661.708457288465;11712.767542334937;11754.29474231549;11842.111841611913;527027;532435;536786;537456;542601;88897;98799;100956;101182;101402;428.16080482254506;441.697437255481;441.83652048741527;443.76480465353416;445.6434852118292;11775.941120294343;11907.76184476323;11970.940145299217;12345.814812777637;12498.37508124572;43807.78096109499;44025.779871100436;45078;45625.77187114043;45994.770026150996;56799.43200567942;59199;61165;61324.08013879885;63399.68300158469;9275.72172834816;9363.672271470467;9474.24206063527;9478;9526.904730952601;12253.938730306292;14027.228502432465;14251.57245282643;14322.355494002586;14342;8461;8639.092895245909;11823.467943942715;12064.215825971283;12100.334481603597;12020.579279725167;12266.754664906473;12355.135140540076;12530.310832904277;12578.245305281713;12325.137240393087;12394.467576740586;12682.746345073232;12696.492140314653;13048.086633935913;8890.777730556787;8935.28517718568;8995.415298005608;8998.280137589109;9202.585883635118;12199.817002744789;12498.937505312415;12626.305553194295;12678.556250531186;12965 03:50:37 INFO - PROCESS | 9597 | |3;mootools.html;1414;1489.0618910086644;1596.9920150399246;1854.8330650241476;1884.594812115395;8219.95890020549;9234.63061477541;9309.767255818608;9987.550560224789;9994.150497207736;9289.071092890708;9538.952305238465;9607.327487075907;9626.614935402575;9707;2460.9663941144718;2513.8240323177383;2516.584763514018;2520.3825062859532;2521.4830959653227;2454.1165180534995;2522.7890612506008;2539.200151952138;2540.098265115885;2551.872406379683;2516.8238223324374;2519.3071905226025;2522.419843436011;2528.05198050731;2529.860857652828;2398.9160379386813;2432.160904487958;2439.695038120235;2475.579151544242;2489.788367988723;2441.7802397784108;2455.177515532299;2463.2363967170236;2473.4311108444977;2474.4927289905527;9767.120959113714;9824.705258842247;9870.407775533491;9872.802543949081;9922.801543969152;5696.914546281809;5834;5838.970805145947;5844.357120716761;5852.12218167274;3539.929201415983;3612.187257866985;3632.9636703633155;3664.1022949377575;3720.3675375186285;1165.6969188011094;1218.1229514749366;1229.8032314829584;1258.6161220827644;1265.4685032286461;13449;13536.323183840866;13558.864411355957;13597.32013399336;13641.863581364258;5048.7728052237735;5157.6647517911215;5196.350456192976;5215.608829337815;5243.868903277448;11481.0815134789;11497.425128743696;11500.367479788525;11504.654860354203;11509.71225719347;5882.470577648032;5884.08796636522;5913.231279933667;5915.526757859361;5928.318243401977;4329.480462344476;5264.9736751315995;5324.094903866352;5368.731563421813;5442.782288708408;4361.214981303332;4363.650907927358;4483.932741008887;4592.288195329729;4610.585047345755;1374.0519041861085;1385.4735200623697;1391.8468968413467;1393.1223329302677;1410.1398147130242;992.4243938515643;1094.1574987259764;1117.94969226385;1117.9944100279608;1120.4341807387218;6586.934130658728;6713.328667133248;6780.932190678129;6866.107406037183;6918.688659010357;1022.0239671114068;1049.37037777333;1053.6092358087403;1096.8683757948938;1105.6848798092506;4624.676272660881;4736.8578942631775;4744.217204161275;4796.616270698336;4816.373871396696;12061.638150855488;12392;12409.193402428813;12456.190347627557;12478.563250286377;11394.544218231178;12386;12390.31853248062;12442.191257568411;12449.439775210138;8594.699185528601;9051.502167380857;9078;9088.500132492776;9114.726558203265;6726.293739157318;6789.355011273921;6818.659067046727;6855.177378714586;6985.196702379291;10858.67423977282;10948;11023.779524409307;11057.11543076568;11378.54485820558;11032.172587056164;11405.372704501333;11410.087193024705;11439.771204575696;11548.076153907836;8396.95038120235;8614.78463038429;8654.437461564978;8726.3891527595;8858.335624828034;9598.040195980346;9619;9648.179904708179;9660.275479339218;9664.613415463584;8471.491710497143;8553.74338769838;8591.44155629882;8700.78248043804;8746.69386571467;8270.586470676562;8318.542480163649;8454.36592255571;8518.616662250337;8695.260902823331;7785.14363420012;7787.688492460238;7792.805179870548;7810.687572497264;7836.255555722198;5593.552515798645;5884.47039766423;5984.341722410444;6014.278286605635;6135.877282454415;5897.439743224387;5987.31145918225;6007.098935159761;6062.818115456367;6110.052941794029 03:50:37 INFO - PROCESS | 9597 | |4;prototype.html;341.6822355209654;344.0435589062407;348.20609011453877;355.0714880587265;360.700618486656;5626.2967129108865;5741.598088133832;5796;5864.706764661772;5878.500327472159;5691.288588926384;5730.341010783761;5731.484166425021;5734.853029394128;5822.243108395914;4494.999999999992;4551.226291530448;4553.157665831815;4572.405587273666;4575.450945886481;4478.843240486583;4503.707259028169;4543.432070991126;4552.112338094073;4587.174308624446;4491.640668746492;4510.706804057726;4513.871532116971;4515.367848501212;4541.909161816761;4516.774161291923;4538.432695913011;4560.726356418592;4560.931586026212;4568.977155114203;3862.7446080024106;3932.9803350983348;3953.8616148434667;3955.062019610399;3979.7413168143976;5631.577631677641;5638.718064096779;5685.374608793029;5693.601447898649;5709.257796486471;5053.418856831475;5154.639175257734;5179.171332586768;5188.688678679291;5189.42916279209;5998.670073145975;6000.18997435345;6060.515158787331;6062.818115456499;6087.939120608781;4378.64970802335;4379.496357918848;4383.561643835623;4406.933895991563;4410.647148228134;5987.760489580412;6324.557280990332;6341.112244285804;6341.55609107358;6406.423421892052;4443.511213766483;4509.729416235036;4510.345999830072;4513.526079761644;4527.683062185615;4524.909501809945;4540.114677637829;4572.108438854458;4578.267477203632;4582.221022426195;4907.3620429343955;5143.742812859342;5156;5172.120739474299;5192.45479224676;5800.216970708984;5985.760569577255;5991.262533865218;6033;6033.3664965178905;1542.3984645988073;1569.9843001569839;1573.2369800646677;1578.534332371953;1578.873690104789;996.3025881882711;998.201438848918;1021.9984415273074;1032.200044965143;1035.171862510004;5123.180291153398;5156.664816786897;5205.375354957354;5283.233931079972;5294.841154765363;5509.752061157257;5523.4752698494385;5590.608657393944;5599.188117722907;5653.265075540154;4935.284383764334;5221.66059206158;5225.346831646044;5237.5548078413;5238.895222095537;2919.8102123362337;2953.3354995126356;2960.896368627131;2963.2739978705354;3000.3099287163636;5678.886422271614;5730.426957304319;5739.311282646026;5742.191209768909;5801.88396232073;5259.579233661374;5606.262058761797;5608.009156749376;5608.719564021782;5623.465770751772;5724.513416359656;5732.885342293131;5734.827955161351;5742.397048309951;5783.987802134609;5195.818146364859;5402.324709411324;5466;5528.391876893619;5540.89182163577;5404.8108316208745;5451.4276001019325;5514.503694667499;5537.394155694803;5541.282202517233;5584.274044374205;5692.6299790513485;5714.714264286852;5728.885422291614;5730.971345143247;3934;4045.4134150548593;4080.8979775504663;4097.508299004138;4113.8971525712095;5477.3427188737605;5501;5576.525995290446;6118.571699980958;6329.936700632935;6178.567500274938;6190.473809726043;6200.441960223421;6231.906521402273;6235.625862448268;6045.853721928828;6167.198264225622;6192.690365481798;6214.782482613087;6239.126522286974;6002.898985355091;6053.667048312385;6116.400529774739;6150.231221097363;6179.876402471836;6176.289726681489;6253.687315634109;6253.749850006131;6258.311585725475;6280.466160376419;5841.766329346779;6002.939970600238;6013.939860601338;6018.097285407224;6094.238220222473 03:50:37 INFO - PROCESS | 9597 | |5;yui.html;833.4291010657699;841.2344766262698;841.9494830310182;843.367474394204;908.2416182487623;14956.401743930242;15327.233638318081;15418.768718469231;15466.22668866555;15570.45503407381;15779.447719329826;16003.759943600855;16018;16032.599185020352;16093.436729714462;575.7812031428051;873.6811063961671;885.6191837509884;890.8663700444953;896.730980705789;902.1700035966926;903.5933829776594;903.70629545398;906.4108329585789;908.6274627402767;947.3794664494767;947.4078700811992;951.8048799996019;952.7284723853703;956.6699488676395;947.1428357336587;951.1914872358509;951.7525443384701;955.0640372435017;957.3059531839396;703.3810246982623;705.2277755857328;706.3148745716646;707.3351050012972;708.0865683268578;15555.844441555553;15665;15697.136657483834;15727.528174154793;15728.37086516538;14741.705165896728;14947.327370268364;15213.543593692208;15251.38994440221;15376.231188440644;14789.186594737284;14803.333849976776;14926.552203433914;14952.775708364274;15388.230588470531;4887.584555312803;4902.705837649717;4905.533974272438;4937.456879743261;5000.549950504435;90097;92827.53586232093;93011.99999999932;93120;93569.53215233948;12481.875181248253;12568.371581420892;12623.179493332904;12717.300548469922;12733.61799146027;22913.656295155586;23200;23339.533209335717;23549.29352119439;23593.174238901556;8990.235829954396;9022.278217742696;9087.09129087086;9095.454272743656;9210.309226808016;5102.617303702237;5104.668196567211;5156.071907056766;5163.715995620202;5197.740112994411;3688.133288677159;3820.522434695663;3826.770393776382;3828.980855095707;3830.1765120499226;661.0843981086231;661.5270081891471;667.3960066140054;673.8685956238585;682.8395327098128;592.2685483427963;685.1606781692486;711.1146622455077;712.7968528969219;741.1587847792794;9837.754056148511;10062.446565438971;10170;10177.33847299938;10385.792284154275;663.2107791727828;708.8936659501117;721.9783406497813;722.0396872160014;741.4735537768137;4658.767061646904;4967.850964471072;5013.473585273567;5024.522670346311;5060.367454068241;134019;134847;135684;137210;137657.3358543654;81913.59043204747;115067.42466287782;117035;117140;120649;98571.50714246383;102625.48687256516;103213.48393257985;106539;106554.46722766492;8614.956925215334;9057.320700947323;9194.17252447283;9197.908020919705;9221.216196623362;50562.2415663758;58905.41094589171;59185.11222331755;59738.103928441975;61327.6933615329;49170;77185.61407192927;77962;79577;82488;14148.363323650254;14258.572242832732;14400.207988560729;14606.415743370146;14672.413103475741;15975.600609984844;16185.67628647444;16449.355064493455;16849.831501684825;17143.14284285806;14484.34820433062;14566.781498277322;15480.922595386952;15681.764773528634;15689.764653529977;15074.321655525748;15141.545753627408;15396.307166177325;15621.297041633381;15971.103965277505;15000.624984375478;15817.525474235792;16117.838821612102;16326.673466530841;16573.91713041427;12314;12336.50653973867;12428.937855310665;12842.871571284168;12930.676733081747;12637.494500220257;12709.17390369623;12783.552575659807;12794.872051279368;12969.481220751064 03:50:37 INFO - PROCESS | 9597 | __end_tp_report 03:50:37 INFO - PROCESS | 9597 | __start_cc_report 03:50:37 INFO - PROCESS | 9597 | _x_x_mozilla_cycle_collect,327 03:50:37 INFO - PROCESS | 9597 | __end_cc_report 03:50:37 INFO - PROCESS | 9597 | __startTimestamp1470739837900__endTimestamp 03:50:37 INFO - PROCESS | 9597 | 03:50:37 INFO - PROCESS | 9597 | ------- Summary: start ------- 03:50:37 INFO - PROCESS | 9597 | Number of tests: 6 03:50:37 INFO - PROCESS | 9597 | 03:50:37 INFO - PROCESS | 9597 | [#0] dojo.html Cycles:165 Average:5759.99 Median:6004.97 stddev:676.45 (11.3%) stddev-sans-first:650.86 03:50:37 INFO - PROCESS | 9597 | Values: 3318.9 3320.0 3337.2 3340.9 3361.6 5816.5 5867.2 5875.8 5883.4 5895.0 5730.1 5741.2 5788.6 5796.8 5799.7 5241.8 5247.8 5271.2 5295.8 5337.8 5215.7 5233.3 5234.1 5239.9 5279.9 5120.5 5149.8 5175.0 5176.2 5181.4 5179.4 5230.8 5231.2 5245.4 5274.4 5035.5 5039.7 5128.4 5148.9 5151.6 5766.2 5822.2 5827.0 5893.2 5932.3 6250.9 6322.8 6328.4 6338.1 6355.1 6143.5 6373.7 6373.7 6383.9 6389.8 5749.5 5787.1 5867.6 5907.5 5914.6 6343.8 6368.0 6391.4 6394.2 6401.4 5986.6 6135.8 6155.8 6172.4 6179.5 6091.9 6120.7 6137.2 6181.0 6223.4 6142.6 6155.0 6162.4 6175.0 6181.9 5988.5 6149.1 6153.1 6156.9 6160.6 4626.3 4653.2 4688.0 4722.3 4749.8 4189.5 4206.7 4209.9 4222.9 4231.5 5702.3 5818.3 5831.5 5833.7 5873.7 6130.4 6135.7 6148.8 6222.8 6255.0 5832.9 5851.6 5864.4 5869.9 5907.7 5193.5 5338.7 5355.7 5356.9 5372.3 6322.1 6335.0 6382.0 6485.7 6492.9 6171.6 6212.8 6235.6 6259.3 6269.7 6310.7 6427.4 6442.5 6461.2 6488.8 6030.5 6031.7 6064.2 6139.6 6164.2 6204.1 6246.2 6247.8 6254.8 6260.9 5931.2 6114.7 6119.7 6132.1 6147.0 5854.9 6002.0 6006.0 6012.0 6126.0 6051.1 6055.9 6096.9 6101.6 6114.6 6149.1 6149.6 6187.0 6192.4 6194.9 5861.6 5926.5 6005.0 6028.9 6126.6 03:50:37 INFO - PROCESS | 9597 | 03:50:37 INFO - PROCESS | 9597 | [#1] ext.html Cycles:180 Average:65909.99 Median:44378.56 stddev:141503.84 (318.9%) stddev-sans-first:141815.81 03:50:37 INFO - PROCESS | 9597 | Values: 589.6 626.2 636.0 656.4 727.4 40178.6 44975.3 45090.8 45266.0 45571.3 46733.5 47011.3 47237.0 47461.5 47614.3 9086.7 9198.6 9209.5 9214.3 9220.2 9083.0 9178.2 9194.0 9201.9 9251.7 9234.4 9241.0 9252.0 9263.7 9267.5 9224.3 9266.1 9276.0 9276.3 9284.1 9154.2 9212.4 9217.4 9218.6 9231.2 43825.6 43969.1 44064.8 44346.1 44411.0 3076.5 3606.9 3738.2 3852.7 4071.5 32769.1 32827.0 32945.2 33067.3 33076.7 4534.0 4640.4 4680.7 4700.7 4749.6 339211.0 339753.0 341129.0 341692.0 341854.0 38631.2 38820.6 39090.8 39095.2 39116.2 40902.4 40963.2 41355.0 41465.0 41561.6 15294.3 15352.4 15428.0 15440.2 15446.0 13786.3 13820.9 13825.6 13825.7 13834.0 9276.9 9333.8 9354.5 9359.0 9371.6 3548.2 3575.9 3582.3 3631.4 3686.1 1086.4 1143.1 1152.1 1234.2 1252.7 34387.3 34732.7 35120.6 35284.8 35408.8 1200.9 1218.6 1246.4 1251.6 1286.6 18358.1 18397.4 18518.1 18533.7 18617.4 647421.0 652562.0 653261.0 653875.0 656027.0 44656.0 44672.0 44680.8 44686.6 44725.8 1452.2 1492.8 1502.0 1507.5 1512.6 34427.0 34481.3 34680.3 34691.0 35295.1 57826.0 57949.0 58004.7 58654.0 58765.1 542812.0 545419.0 547763.0 548261.0 549907.0 30930.2 31520.0 31805.7 31973.4 32065.8 52429.7 52498.7 52822.2 52885.7 53075.7 44734.0 45241.3 45401.0 45739.8 46665.0 43937.2 45562.0 45590.8 46123.1 46576.8 45649.5 45737.8 46515.5 46828.3 47063.8 38069.4 39708.0 40200.6 40296.6 41030.6 29296.6 29544.0 30038.7 30211.2 30429.4 03:50:37 INFO - PROCESS | 9597 | 03:50:37 INFO - PROCESS | 9597 | [#2] jquery.html Cycles:180 Average:32256.44 Median:2906.93 stddev:88264.21 (3036.3%) stddev-sans-first:88479.43 03:50:37 INFO - PROCESS | 9597 | Values: 413.5 420.2 423.4 431.5 435.7 20431.7 20701.6 21445.1 21450.6 21541.4 20049.7 20370.0 20952.3 21087.6 21210.7 5790.6 5987.2 6065.2 6082.2 6087.0 5958.9 5992.5 6064.1 6163.1 6180.4 6287.7 6289.8 6301.3 6313.6 6319.3 6077.0 6105.7 6127.4 6129.3 6145.3 5854.7 5927.9 6002.0 6017.4 6030.5 14800.6 14891.9 14905.6 14954.6 27662.6 2597.9 2791.4 2814.6 2999.2 3316.8 17221.9 17637.4 18030.5 18200.0 18403.8 2224.7 2226.5 2235.6 2238.8 2309.7 78280.2 94067.0 97855.0 101187.0 107349.5 17882.2 18416.4 19438.7 19561.0 19741.6 34208.7 34298.7 34411.7 34449.7 34564.0 10376.4 10452.5 10522.7 10628.1 10767.1 8692.6 8704.6 8722.5 8766.7 8932.2 9514.0 9594.6 9667.5 9866.6 9974.6 3485.7 3602.0 3672.2 3708.5 3972.9 1008.2 1026.7 1093.7 1104.0 1126.6 19818.9 20521.9 20697.3 20748.8 20799.7 1035.8 1051.8 1079.3 1086.7 1139.5 11432.9 11661.7 11712.8 11754.3 11842.1 527027.0 532435.0 536786.0 537456.0 542601.0 88897.0 98799.0 100956.0 101182.0 101402.0 428.2 441.7 441.8 443.8 445.6 11775.9 11907.8 11970.9 12345.8 12498.4 43807.8 44025.8 45078.0 45625.8 45994.8 56799.4 59199.0 61165.0 61324.1 63399.7 9275.7 9363.7 9474.2 9478.0 9526.9 12253.9 14027.2 14251.6 14322.4 14342.0 8461.0 8639.1 11823.5 12064.2 12100.3 12020.6 12266.8 12355.1 12530.3 12578.2 12325.1 12394.5 12682.7 12696.5 13048.1 8890.8 8935.3 8995.4 8998.3 9202.6 12199.8 12498.9 12626.3 12678.6 12965.0 03:50:37 INFO - PROCESS | 9597 | 03:50:37 INFO - PROCESS | 9597 | [#3] mootools.html Cycles:180 Average:6451.77 Median:4680.77 stddev:3675.42 (78.5%) stddev-sans-first:3666.23 03:50:37 INFO - PROCESS | 9597 | Values: 1414.0 1489.1 1597.0 1854.8 1884.6 8220.0 9234.6 9309.8 9987.6 9994.2 9289.1 9539.0 9607.3 9626.6 9707.0 2461.0 2513.8 2516.6 2520.4 2521.5 2454.1 2522.8 2539.2 2540.1 2551.9 2516.8 2519.3 2522.4 2528.1 2529.9 2398.9 2432.2 2439.7 2475.6 2489.8 2441.8 2455.2 2463.2 2473.4 2474.5 9767.1 9824.7 9870.4 9872.8 9922.8 5696.9 5834.0 5839.0 5844.4 5852.1 3539.9 3612.2 3633.0 3664.1 3720.4 1165.7 1218.1 1229.8 1258.6 1265.5 13449.0 13536.3 13558.9 13597.3 13641.9 5048.8 5157.7 5196.4 5215.6 5243.9 11481.1 11497.4 11500.4 11504.7 11509.7 5882.5 5884.1 5913.2 5915.5 5928.3 4329.5 5265.0 5324.1 5368.7 5442.8 4361.2 4363.7 4483.9 4592.3 4610.6 1374.1 1385.5 1391.8 1393.1 1410.1 992.4 1094.2 1117.9 1118.0 1120.4 6586.9 6713.3 6780.9 6866.1 6918.7 1022.0 1049.4 1053.6 1096.9 1105.7 4624.7 4736.9 4744.2 4796.6 4816.4 12061.6 12392.0 12409.2 12456.2 12478.6 11394.5 12386.0 12390.3 12442.2 12449.4 8594.7 9051.5 9078.0 9088.5 9114.7 6726.3 6789.4 6818.7 6855.2 6985.2 10858.7 10948.0 11023.8 11057.1 11378.5 11032.2 11405.4 11410.1 11439.8 11548.1 8397.0 8614.8 8654.4 8726.4 8858.3 9598.0 9619.0 9648.2 9660.3 9664.6 8471.5 8553.7 8591.4 8700.8 8746.7 8270.6 8318.5 8454.4 8518.6 8695.3 7785.1 7787.7 7792.8 7810.7 7836.3 5593.6 5884.5 5984.3 6014.3 6135.9 5897.4 5987.3 6007.1 6062.8 6110.1 03:50:37 INFO - PROCESS | 9597 | 03:50:37 INFO - PROCESS | 9597 | [#4] prototype.html Cycles:180 Average:4926.33 Median:5505.38 stddev:1422.41 (25.8%) stddev-sans-first:1384.15 03:50:37 INFO - PROCESS | 9597 | Values: 341.7 344.0 348.2 355.1 360.7 5626.3 5741.6 5796.0 5864.7 5878.5 5691.3 5730.3 5731.5 5734.9 5822.2 4495.0 4551.2 4553.2 4572.4 4575.5 4478.8 4503.7 4543.4 4552.1 4587.2 4491.6 4510.7 4513.9 4515.4 4541.9 4516.8 4538.4 4560.7 4560.9 4569.0 3862.7 3933.0 3953.9 3955.1 3979.7 5631.6 5638.7 5685.4 5693.6 5709.3 5053.4 5154.6 5179.2 5188.7 5189.4 5998.7 6000.2 6060.5 6062.8 6087.9 4378.6 4379.5 4383.6 4406.9 4410.6 5987.8 6324.6 6341.1 6341.6 6406.4 4443.5 4509.7 4510.3 4513.5 4527.7 4524.9 4540.1 4572.1 4578.3 4582.2 4907.4 5143.7 5156.0 5172.1 5192.5 5800.2 5985.8 5991.3 6033.0 6033.4 1542.4 1570.0 1573.2 1578.5 1578.9 996.3 998.2 1022.0 1032.2 1035.2 5123.2 5156.7 5205.4 5283.2 5294.8 5509.8 5523.5 5590.6 5599.2 5653.3 4935.3 5221.7 5225.3 5237.6 5238.9 2919.8 2953.3 2960.9 2963.3 3000.3 5678.9 5730.4 5739.3 5742.2 5801.9 5259.6 5606.3 5608.0 5608.7 5623.5 5724.5 5732.9 5734.8 5742.4 5784.0 5195.8 5402.3 5466.0 5528.4 5540.9 5404.8 5451.4 5514.5 5537.4 5541.3 5584.3 5692.6 5714.7 5728.9 5731.0 3934.0 4045.4 4080.9 4097.5 4113.9 5477.3 5501.0 5576.5 6118.6 6329.9 6178.6 6190.5 6200.4 6231.9 6235.6 6045.9 6167.2 6192.7 6214.8 6239.1 6002.9 6053.7 6116.4 6150.2 6179.9 6176.3 6253.7 6253.7 6258.3 6280.5 5841.8 6002.9 6013.9 6018.1 6094.2 03:50:37 INFO - PROCESS | 9597 | 03:50:37 INFO - PROCESS | 9597 | [#5] yui.html Cycles:180 Average:23437.22 Median:3829.58 stddev:34670.07 (905.3%) stddev-sans-first:34725.79 03:50:37 INFO - PROCESS | 9597 | Values: 833.4 841.2 841.9 843.4 908.2 14956.4 15327.2 15418.8 15466.2 15570.5 15779.4 16003.8 16018.0 16032.6 16093.4 575.8 873.7 885.6 890.9 896.7 902.2 903.6 903.7 906.4 908.6 947.4 947.4 951.8 952.7 956.7 947.1 951.2 951.8 955.1 957.3 703.4 705.2 706.3 707.3 708.1 15555.8 15665.0 15697.1 15727.5 15728.4 14741.7 14947.3 15213.5 15251.4 15376.2 14789.2 14803.3 14926.6 14952.8 15388.2 4887.6 4902.7 4905.5 4937.5 5000.5 90097.0 92827.5 93012.0 93120.0 93569.5 12481.9 12568.4 12623.2 12717.3 12733.6 22913.7 23200.0 23339.5 23549.3 23593.2 8990.2 9022.3 9087.1 9095.5 9210.3 5102.6 5104.7 5156.1 5163.7 5197.7 3688.1 3820.5 3826.8 3829.0 3830.2 661.1 661.5 667.4 673.9 682.8 592.3 685.2 711.1 712.8 741.2 9837.8 10062.4 10170.0 10177.3 10385.8 663.2 708.9 722.0 722.0 741.5 4658.8 4967.9 5013.5 5024.5 5060.4 134019.0 134847.0 135684.0 137210.0 137657.3 81913.6 115067.4 117035.0 117140.0 120649.0 98571.5 102625.5 103213.5 106539.0 106554.5 8615.0 9057.3 9194.2 9197.9 9221.2 50562.2 58905.4 59185.1 59738.1 61327.7 49170.0 77185.6 77962.0 79577.0 82488.0 14148.4 14258.6 14400.2 14606.4 14672.4 15975.6 16185.7 16449.4 16849.8 17143.1 14484.3 14566.8 15480.9 15681.8 15689.8 15074.3 15141.5 15396.3 15621.3 15971.1 15000.6 15817.5 16117.8 16326.7 16573.9 12314.0 12336.5 12428.9 12842.9 12930.7 12637.5 12709.2 12783.6 12794.9 12969.5 03:50:37 INFO - PROCESS | 9597 | -------- Summary: end -------- 03:50:37 INFO - PROCESS | 9597 | 03:50:38 INFO - TEST-INFO | 9597: exit 0 03:50:38 INFO - TEST-OK | dromaeo_css | took 1110884ms 03:50:38 INFO - TEST-START | kraken 03:50:38 INFO - operating with platform_type : linux_ 03:50:38 INFO - Initialising browser for kraken test... 03:50:38 INFO - TEST-INFO | started process 9857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkOshPU/profile http://localhost:53773/getInfo.html) 03:50:43 INFO - PROCESS | 9857 | __metrics Screen width/height:1600/1200 03:50:43 INFO - PROCESS | 9857 | colorDepth:24 03:50:43 INFO - PROCESS | 9857 | Browser inner width/height: 1024/697 03:50:43 INFO - PROCESS | 9857 | __metrics 03:50:43 ERROR - PROCESS | 9857 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:50:44 INFO - TEST-INFO | 9857: exit 0 03:50:44 INFO - Browser initialized. 03:50:44 INFO - Running cycle 1/1 for kraken test... 03:50:44 INFO - TEST-INFO | started process 9987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkOshPU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:56 INFO - PROCESS | 9987 | RSS: Main: 152199168 03:50:56 INFO - PROCESS | 9987 | 03:50:58 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53773/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:59 INFO - PROCESS | 9987 | RSS: Main: 158003200 03:50:59 INFO - PROCESS | 9987 | 03:51:02 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53773/tests/kraken/driver.html?testName=audio-dft) 03:51:03 INFO - PROCESS | 9987 | RSS: Main: 157204480 03:51:03 INFO - PROCESS | 9987 | 03:51:05 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53773/tests/kraken/driver.html?testName=audio-fft) 03:51:06 INFO - PROCESS | 9987 | RSS: Main: 156770304 03:51:06 INFO - PROCESS | 9987 | 03:51:08 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53773/tests/kraken/driver.html?testName=audio-oscillator) 03:51:09 INFO - PROCESS | 9987 | RSS: Main: 156594176 03:51:09 INFO - PROCESS | 9987 | 03:51:11 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:11 INFO - PROCESS | 9987 | RSS: Main: 156618752 03:51:11 INFO - PROCESS | 9987 | 03:51:15 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53773/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:15 INFO - PROCESS | 9987 | RSS: Main: 156966912 03:51:15 INFO - PROCESS | 9987 | 03:51:19 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53773/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:19 INFO - PROCESS | 9987 | RSS: Main: 156676096 03:51:19 INFO - PROCESS | 9987 | 03:51:22 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53773/tests/kraken/driver.html?testName=json-parse-financial) 03:51:23 INFO - PROCESS | 9987 | RSS: Main: 157396992 03:51:23 INFO - PROCESS | 9987 | 03:51:24 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:25 INFO - PROCESS | 9987 | RSS: Main: 156835840 03:51:25 INFO - PROCESS | 9987 | 03:51:26 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53773/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:27 INFO - PROCESS | 9987 | RSS: Main: 156782592 03:51:27 INFO - PROCESS | 9987 | 03:51:29 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:30 INFO - PROCESS | 9987 | RSS: Main: 157294592 03:51:30 INFO - PROCESS | 9987 | 03:51:32 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:33 INFO - PROCESS | 9987 | RSS: Main: 157392896 03:51:33 INFO - PROCESS | 9987 | 03:51:36 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:36 INFO - PROCESS | 9987 | RSS: Main: 157364224 03:51:36 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | Cycle 1(1): loaded http://localhost:53773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53773/tests/kraken/driver.html?testName=ai-astar) 03:51:38 INFO - PROCESS | 9987 | RSS: Main: 158879744 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | __start_tp_report 03:51:38 INFO - PROCESS | 9987 | _x_x_mozilla_page_load 03:51:38 INFO - PROCESS | 9987 | _x_x_mozilla_page_load_details 03:51:38 INFO - PROCESS | 9987 | |i|pagename|runs| 03:51:38 INFO - PROCESS | 9987 | |0;ai-astar;100;110;105;109;110;111;112;109;109;111 03:51:38 INFO - PROCESS | 9987 | |1;audio-beat-detection;147;116;141;165;123;146;147;122;182;117 03:51:38 INFO - PROCESS | 9987 | |2;audio-dft;163;166;163;163;162;163;162;163;162;160 03:51:38 INFO - PROCESS | 9987 | |3;audio-fft;76;74;76;169;76;75;74;75;167;75 03:51:38 INFO - PROCESS | 9987 | |4;audio-oscillator;84;84;138;84;83;84;139;84;84;142 03:51:38 INFO - PROCESS | 9987 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;118;117;118 03:51:38 INFO - PROCESS | 9987 | |6;imaging-darkroom;146;149;147;146;147;147;147;147;148;146 03:51:38 INFO - PROCESS | 9987 | |7;imaging-desaturate;96;95;95;98;95;97;96;100;96;95 03:51:38 INFO - PROCESS | 9987 | |8;json-parse-financial;52;56;51;51;52;52;51;51;52;52 03:51:38 INFO - PROCESS | 9987 | |9;json-stringify-tinderbox;62;60;59;59;59;60;59;59;60;61 03:51:38 INFO - PROCESS | 9987 | |10;stanford-crypto-aes;73;82;73;72;73;79;72;72;72;72 03:51:38 INFO - PROCESS | 9987 | |11;stanford-crypto-ccm;135;124;119;116;116;115;117;127;153;121 03:51:38 INFO - PROCESS | 9987 | |12;stanford-crypto-pbkdf2;158;160;159;157;155;156;151;159;154;153 03:51:38 INFO - PROCESS | 9987 | |13;stanford-crypto-sha256-iterative;67;74;64;63;64;63;62;65;62;61 03:51:38 INFO - PROCESS | 9987 | __end_tp_report 03:51:38 INFO - PROCESS | 9987 | __start_cc_report 03:51:38 INFO - PROCESS | 9987 | _x_x_mozilla_cycle_collect,842 03:51:38 INFO - PROCESS | 9987 | __end_cc_report 03:51:38 INFO - PROCESS | 9987 | __startTimestamp1470739898621__endTimestamp 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | ------- Summary: start ------- 03:51:38 INFO - PROCESS | 9987 | Number of tests: 14 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.57 (3.2%) stddev-sans-first:2.01 03:51:38 INFO - PROCESS | 9987 | Values: 100.0 110.0 105.0 109.0 110.0 111.0 112.0 109.0 109.0 111.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:146.50 stddev:21.70 (14.8%) stddev-sans-first:22.89 03:51:38 INFO - PROCESS | 9987 | Values: 147.0 116.0 141.0 165.0 123.0 146.0 147.0 122.0 182.0 117.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 03:51:38 INFO - PROCESS | 9987 | Values: 163.0 166.0 163.0 163.0 162.0 163.0 162.0 163.0 162.0 160.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:39.17 (52.2%) stddev-sans-first:41.02 03:51:38 INFO - PROCESS | 9987 | Values: 76.0 74.0 76.0 169.0 76.0 75.0 74.0 75.0 167.0 75.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:84.00 stddev:26.98 (32.1%) stddev-sans-first:27.94 03:51:38 INFO - PROCESS | 9987 | Values: 84.0 84.0 138.0 84.0 83.0 84.0 139.0 84.0 84.0 142.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 03:51:38 INFO - PROCESS | 9987 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 03:51:38 INFO - PROCESS | 9987 | Values: 146.0 149.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 146.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.64 (1.7%) stddev-sans-first:1.73 03:51:38 INFO - PROCESS | 9987 | Values: 96.0 95.0 95.0 98.0 95.0 97.0 96.0 100.0 96.0 95.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.49 (2.9%) stddev-sans-first:1.58 03:51:38 INFO - PROCESS | 9987 | Values: 52.0 56.0 51.0 51.0 52.0 52.0 51.0 51.0 52.0 52.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:1.03 (1.7%) stddev-sans-first:0.73 03:51:38 INFO - PROCESS | 9987 | Values: 62.0 60.0 59.0 59.0 59.0 60.0 59.0 59.0 60.0 61.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.00 stddev:3.53 (4.8%) stddev-sans-first:3.72 03:51:38 INFO - PROCESS | 9987 | Values: 73.0 82.0 73.0 72.0 73.0 79.0 72.0 72.0 72.0 72.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:122.50 stddev:11.84 (9.7%) stddev-sans-first:11.91 03:51:38 INFO - PROCESS | 9987 | Values: 135.0 124.0 119.0 116.0 116.0 115.0 117.0 127.0 153.0 121.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:157.50 stddev:2.94 (1.9%) stddev-sans-first:3.04 03:51:38 INFO - PROCESS | 9987 | Values: 158.0 160.0 159.0 157.0 155.0 156.0 151.0 159.0 154.0 153.0 03:51:38 INFO - PROCESS | 9987 | 03:51:38 INFO - PROCESS | 9987 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.00 stddev:3.75 (5.9%) stddev-sans-first:3.87 03:51:38 INFO - PROCESS | 9987 | Values: 67.0 74.0 64.0 63.0 64.0 63.0 62.0 65.0 62.0 61.0 03:51:38 INFO - PROCESS | 9987 | -------- Summary: end -------- 03:51:38 INFO - PROCESS | 9987 | 03:51:39 INFO - TEST-INFO | 9987: exit 0 03:51:39 INFO - TEST-OK | kraken | took 60965ms 03:51:39 INFO - SUITE-END | took 1171s 03:51:39 INFO - Completed test suite (00:19:32) 03:51:39 INFO - javascript benchmark 03:51:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7807.132649110492, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3318.850651720673, 3319.983400082999, 3337.21575429774, 3340.930902111324, 3361.5966084069914, 5816.476517113459, 5867.237259156309, 5875.794347197849, 5883.411658834115, 5895.027320492124, 5730.05454100074, 5741.19623252745, 5788.594798364116, 5796.8260952171395, 5799.710014499279, 5241.816536421226, 5247.7900883964785, 5271.2356708277275, 5295.8146464873735, 5337.813176538822, 5215.713135777531, 5233.267342572043, 5234.057869583474, 5239.947600523984, 5279.947200528003, 5120.487951204868, 5149.81975630853, 5174.974125129369, 5176.223566465042, 5181.43004269532, 5179.430262671103, 5230.816921407771, 5231.163013917755, 5245.370555533342, 5274.446183150791, 5035.521625445577, 5039.697618142886, 5128.410232823236, 5148.922766158511, 5151.639385243035, 5766.163906233573, 5822.243108395924, 5827.038538641119, 5893.204417403638, 5932.317783454915, 6250.937490625081, 6322.778702745381, 6328.398802113792, 6338.144350512668, 6355.0785136155, 6143.508519318489, 6373.681315934185, 6373.7450501979865, 6383.936160638381, 6389.8402539936405, 5749.482546570787, 5787.074068149076, 5867.589268751231, 5907.4683278505145, 5914.61554998928, 6343.841403964938, 6368.039463346196, 6391.360863913572, 6394.168758061515, 6401.359864013654, 5986.610870293417, 6135.815925522242, 6155.84610384744, 6172.4136207060255, 6179.474744646665, 6091.908621370683, 6120.721420533169, 6137.171481849982, 6180.980138277134, 6223.408776166257, 6142.600730952563, 6155.0, 6162.383761623892, 6175.042868355412, 6181.876362472815, 5988.490978266809, 6149.108379284979, 6153.107799369066, 6156.938430615636, 6160.599561028519, 4626.306054091846, 4653.185692503798, 4687.9765601171775, 4722.338872557844, 4749.810007599726, 4189.518205406356, 4206.72656277341, 4209.852655157055, 4222.936655950163, 4231.492220933507, 5702.258706368146, 5818.272715910512, 5831.475167234885, 5833.679147646835, 5873.676947767828, 6130.448259656652, 6135.661410523283, 6148.754049838046, 6222.844428889314, 6255.0, 5832.912506312408, 5851.61964472308, 5864.354920958691, 5869.941300586939, 5907.675077870758, 5193.532582067632, 5338.652987555796, 5355.651882627694, 5356.946430535645, 5372.328458942632, 6322.146510221061, 6335.049742538656, 6382.0, 6485.67571621417, 6492.902606460907, 6171.59884607499, 6212.751489940351, 6235.563510554218, 6259.280182778948, 6269.7178626962805, 6310.7475700971445, 6427.357264273535, 6442.452391546771, 6461.160049193575, 6488.837779055372, 6030.517558595214, 6031.668258245839, 6064.151018857276, 6139.570230083851, 6164.229471316085, 6204.069389591597, 6246.187995560548, 6247.781327653511, 6254.781082662085, 6260.874782504416, 5931.1992880960515, 6114.7248373822395, 6119.694015299128, 6132.141500190066, 6147.0, 5854.853628659147, 6001.969990150022, 6005.969970150296, 6011.969940150271, 6125.998614523495, 6051.0923361496125, 6055.939440605537, 6096.939030609815, 6101.633901965896, 6114.633122012693, 6149.139120523219, 6149.569530133027, 6186.969065154825, 6192.380761923771, 6194.876102478015, 5861.6189947653265, 5926.496247818984, 6004.969975150271, 6028.909566356596, 6126.6017708848785], "value": 5712.87736561198, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.6462122726365, 626.1703243202754, 635.971381287842, 656.4092316914778, 727.3926271563245, 40178.59821401785, 44975.32537011943, 45090.774546127264, 45266.0, 45571.31643025357, 46733.532664673345, 47011.29483057757, 47237.0, 47461.52538474614, 47614.28578571324, 9086.681966131187, 9198.586063627154, 9209.493477858716, 9214.308926830481, 9220.170184683377, 9083.0, 9178.219851312646, 9193.95403022984, 9201.907980920205, 9251.722448326562, 9234.39976401535, 9241.029691882322, 9251.98228194898, 9263.675771348004, 9267.490288034156, 9224.30817688676, 9266.073392660748, 9276.026017268225, 9276.257899368067, 9284.071592840663, 9154.176124148858, 9212.355135140542, 9217.354785165042, 9218.585163667583, 9231.215346695539, 43825.56174438279, 43969.12061758779, 44064.77967610174, 44346.113077738584, 44411.0, 3076.492378757502, 3606.855725770966, 3738.196287798109, 3852.6725228355344, 4071.4731975509185, 32769.11316502692, 32827.0, 32945.176370590685, 33067.3386532268, 33076.6692333076, 4533.954660453386, 4640.443146822369, 4680.742559159245, 4700.741459219742, 4749.62003039756, 339211.0, 339753.0, 341129.0, 341692.0, 341853.9999999975, 38631.227375452334, 38820.611793882264, 39090.804545977655, 39095.21809563793, 39116.21767564633, 40902.38646420306, 40963.180736385104, 41355.0, 41465.0, 41561.58438415638, 15294.311755970786, 15352.385904563916, 15428.0, 15440.227988600525, 15446.0, 13786.310684465736, 13820.861791381958, 13825.585232443043, 13825.723485530434, 13834.0, 9276.907230927603, 9333.766655833659, 9354.532273386303, 9358.953205234066, 9371.625134994523, 3548.2193917338145, 3575.8748443804343, 3582.3193593217206, 3631.4008188648577, 3686.096906257984, 1086.397049637443, 1143.0741099709262, 1152.0553146419854, 1234.1546040961791, 1252.7431876465484, 34387.31225375478, 34732.65267347345, 35120.64879351225, 35284.82357588196, 35408.82295588506, 1200.8799120087922, 1218.585680868509, 1246.376811594203, 1251.561953316332, 1286.5561381323428, 18358.08209589515, 18397.3560925367, 18518.07409629513, 18533.745282504293, 18617.441476755717, 647421.0, 652562.0, 653261.0, 653875.0, 656027.0, 44656.0, 44672.0, 44680.77659611681, 44686.553134468886, 44725.776371117936, 1452.194032312056, 1492.8208614966056, 1501.9774703379458, 1507.5326648738926, 1512.5764785859976, 34427.0, 34481.31037379288, 34680.30639387249, 34691.0, 35295.11762205965, 57826.0, 57949.0, 58004.70997644985, 58654.0, 58765.11852322304, 542812.0, 545419.0, 547763.0, 548261.0, 549907.0, 30930.22674433067, 31520.0, 31805.681943180272, 31973.36053278875, 32065.83967080243, 52429.7378513105, 52498.73750631375, 52822.2076668858, 52885.735571323436, 53075.73462132664, 44734.0, 45241.32138017866, 45401.0, 45739.77130114328, 46665.0, 43937.16176331923, 45562.0, 45590.77204613956, 46123.07753844972, 46576.7671161642, 45649.54350456453, 45737.77131114323, 46515.53484465112, 46828.29757553708, 47063.76468117638, 38069.4289585662, 39708.0, 40200.597994019685, 40296.597034029284, 41030.58969410268, 29296.560551591316, 29544.0, 30038.699613004464, 30211.244718882204, 30429.391412172074], "value": 20058.925509042107, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.52031643293776, 420.2183937875551, 423.40511581228344, 431.52316690057484, 435.71678409034126, 20431.693524597144, 20701.585968280644, 21445.142194312208, 21450.57098858024, 21541.353759387206, 20049.699254511157, 20370.0, 20952.26667066653, 21087.57824843506, 21210.681839772416, 5790.594658373905, 5987.161797348374, 6065.181200537937, 6082.178905847721, 6087.026075827868, 5958.910616340737, 5992.460678538931, 6064.090386442025, 6163.137160797492, 6180.351063138373, 6287.748490060392, 6289.8113056608145, 6301.275353334357, 6313.558050936436, 6319.273283572379, 6076.997295446246, 6105.725242364104, 6127.387261273881, 6129.264488261437, 6145.293291271516, 5854.677992710399, 5927.940720592782, 6002.039673652238, 6017.368176341509, 6030.457258846681, 14800.555983320517, 14891.851081489263, 14905.627359316104, 14954.551363459113, 27662.585061224097, 2597.8701064946677, 2791.4417116576765, 2814.6481689788775, 2999.2052106191877, 3316.7844090134063, 17221.913890430595, 17637.382691605733, 18030.459086227303, 18200.0, 18403.815961840344, 2224.744154422246, 2226.543558570489, 2235.564065007324, 2238.809701175402, 2309.722833260003, 78280.21719782786, 94067.0, 97855.0, 101187.0, 107349.46325268324, 17882.195301211475, 18416.447506574823, 19438.708419373437, 19561.0, 19741.605167896563, 34208.657913420546, 34298.65701343004, 34411.655883441344, 34449.65550344464, 34564.0, 10376.429296388771, 10452.477376131163, 10522.684319470429, 10628.149748020294, 10767.138628909668, 8692.565371731389, 8704.564771761387, 8722.47665140081, 8766.693165739169, 8932.151445612657, 9514.0, 9594.616215351447, 9667.46828924416, 9866.556004979793, 9974.601015959426, 3485.721142308609, 3601.981990090085, 3672.2288319452678, 3708.4622729704042, 3972.880813575597, 1008.1581879131007, 1026.707388394319, 1093.7156339351666, 1104.0229396983566, 1126.566271985275, 19818.90090549538, 20521.897390512953, 20697.27559535409, 20748.792512074688, 20799.68800467994, 1035.8135535603665, 1051.7791263834526, 1079.2768844873954, 1086.6631344283298, 1139.4530625299903, 11432.88567114335, 11661.708457288465, 11712.767542334937, 11754.29474231549, 11842.111841611913, 527027.0, 532435.0, 536786.0, 537456.0, 542601.0, 88897.0, 98799.0, 100956.0, 101182.0, 101402.0, 428.16080482254506, 441.697437255481, 441.83652048741527, 443.76480465353416, 445.6434852118292, 11775.941120294343, 11907.76184476323, 11970.940145299217, 12345.814812777637, 12498.37508124572, 43807.78096109499, 44025.779871100436, 45078.0, 45625.77187114043, 45994.770026150996, 56799.43200567942, 59199.0, 61165.0, 61324.08013879885, 63399.68300158469, 9275.72172834816, 9363.672271470467, 9474.24206063527, 9478.0, 9526.904730952601, 12253.938730306292, 14027.228502432465, 14251.57245282643, 14322.355494002586, 14342.0, 8461.0, 8639.092895245909, 11823.467943942715, 12064.215825971283, 12100.334481603597, 12020.579279725167, 12266.754664906473, 12355.135140540076, 12530.310832904277, 12578.245305281713, 12325.137240393087, 12394.467576740586, 12682.746345073232, 12696.492140314653, 13048.086633935913, 8890.777730556787, 8935.28517718568, 8995.415298005608, 8998.280137589109, 9202.585883635118, 12199.817002744789, 12498.937505312415, 12626.305553194295, 12678.556250531186, 12965.0], "value": 10347.373963567474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.0, 1489.0618910086644, 1596.9920150399246, 1854.8330650241476, 1884.594812115395, 8219.95890020549, 9234.63061477541, 9309.767255818608, 9987.550560224789, 9994.150497207736, 9289.071092890708, 9538.952305238465, 9607.327487075907, 9626.614935402575, 9707.0, 2460.9663941144718, 2513.8240323177383, 2516.584763514018, 2520.3825062859532, 2521.4830959653227, 2454.1165180534995, 2522.7890612506008, 2539.200151952138, 2540.098265115885, 2551.872406379683, 2516.8238223324374, 2519.3071905226025, 2522.419843436011, 2528.05198050731, 2529.860857652828, 2398.9160379386813, 2432.160904487958, 2439.695038120235, 2475.579151544242, 2489.788367988723, 2441.7802397784108, 2455.177515532299, 2463.2363967170236, 2473.4311108444977, 2474.4927289905527, 9767.120959113714, 9824.705258842247, 9870.407775533491, 9872.802543949081, 9922.801543969152, 5696.914546281809, 5834.0, 5838.970805145947, 5844.357120716761, 5852.12218167274, 3539.929201415983, 3612.187257866985, 3632.9636703633155, 3664.1022949377575, 3720.3675375186285, 1165.6969188011094, 1218.1229514749366, 1229.8032314829584, 1258.6161220827644, 1265.4685032286461, 13449.0, 13536.323183840866, 13558.864411355957, 13597.32013399336, 13641.863581364258, 5048.7728052237735, 5157.6647517911215, 5196.350456192976, 5215.608829337815, 5243.868903277448, 11481.0815134789, 11497.425128743696, 11500.367479788525, 11504.654860354203, 11509.71225719347, 5882.470577648032, 5884.08796636522, 5913.231279933667, 5915.526757859361, 5928.318243401977, 4329.480462344476, 5264.9736751315995, 5324.094903866352, 5368.731563421813, 5442.782288708408, 4361.214981303332, 4363.650907927358, 4483.932741008887, 4592.288195329729, 4610.585047345755, 1374.0519041861085, 1385.4735200623697, 1391.8468968413467, 1393.1223329302677, 1410.1398147130242, 992.4243938515643, 1094.1574987259764, 1117.94969226385, 1117.9944100279608, 1120.4341807387218, 6586.934130658728, 6713.328667133248, 6780.932190678129, 6866.107406037183, 6918.688659010357, 1022.0239671114068, 1049.37037777333, 1053.6092358087403, 1096.8683757948938, 1105.6848798092506, 4624.676272660881, 4736.8578942631775, 4744.217204161275, 4796.616270698336, 4816.373871396696, 12061.638150855488, 12392.0, 12409.193402428813, 12456.190347627557, 12478.563250286377, 11394.544218231178, 12386.0, 12390.31853248062, 12442.191257568411, 12449.439775210138, 8594.699185528601, 9051.502167380857, 9078.0, 9088.500132492776, 9114.726558203265, 6726.293739157318, 6789.355011273921, 6818.659067046727, 6855.177378714586, 6985.196702379291, 10858.67423977282, 10948.0, 11023.779524409307, 11057.11543076568, 11378.54485820558, 11032.172587056164, 11405.372704501333, 11410.087193024705, 11439.771204575696, 11548.076153907836, 8396.95038120235, 8614.78463038429, 8654.437461564978, 8726.3891527595, 8858.335624828034, 9598.040195980346, 9619.0, 9648.179904708179, 9660.275479339218, 9664.613415463584, 8471.491710497143, 8553.74338769838, 8591.44155629882, 8700.78248043804, 8746.69386571467, 8270.586470676562, 8318.542480163649, 8454.36592255571, 8518.616662250337, 8695.260902823331, 7785.14363420012, 7787.688492460238, 7792.805179870548, 7810.687572497264, 7836.255555722198, 5593.552515798645, 5884.47039766423, 5984.341722410444, 6014.278286605635, 6135.877282454415, 5897.439743224387, 5987.31145918225, 6007.098935159761, 6062.818115456367, 6110.052941794029], "value": 5144.194943713204, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.6822355209654, 344.0435589062407, 348.20609011453877, 355.0714880587265, 360.700618486656, 5626.2967129108865, 5741.598088133832, 5796.0, 5864.706764661772, 5878.500327472159, 5691.288588926384, 5730.341010783761, 5731.484166425021, 5734.853029394128, 5822.243108395914, 4494.999999999992, 4551.226291530448, 4553.157665831815, 4572.405587273666, 4575.450945886481, 4478.843240486583, 4503.707259028169, 4543.432070991126, 4552.112338094073, 4587.174308624446, 4491.640668746492, 4510.706804057726, 4513.871532116971, 4515.367848501212, 4541.909161816761, 4516.774161291923, 4538.432695913011, 4560.726356418592, 4560.931586026212, 4568.977155114203, 3862.7446080024106, 3932.9803350983348, 3953.8616148434667, 3955.062019610399, 3979.7413168143976, 5631.577631677641, 5638.718064096779, 5685.374608793029, 5693.601447898649, 5709.257796486471, 5053.418856831475, 5154.639175257734, 5179.171332586768, 5188.688678679291, 5189.42916279209, 5998.670073145975, 6000.18997435345, 6060.515158787331, 6062.818115456499, 6087.939120608781, 4378.64970802335, 4379.496357918848, 4383.561643835623, 4406.933895991563, 4410.647148228134, 5987.760489580412, 6324.557280990332, 6341.112244285804, 6341.55609107358, 6406.423421892052, 4443.511213766483, 4509.729416235036, 4510.345999830072, 4513.526079761644, 4527.683062185615, 4524.909501809945, 4540.114677637829, 4572.108438854458, 4578.267477203632, 4582.221022426195, 4907.3620429343955, 5143.742812859342, 5156.0, 5172.120739474299, 5192.45479224676, 5800.216970708984, 5985.760569577255, 5991.262533865218, 6033.0, 6033.3664965178905, 1542.3984645988073, 1569.9843001569839, 1573.2369800646677, 1578.534332371953, 1578.873690104789, 996.3025881882711, 998.201438848918, 1021.9984415273074, 1032.200044965143, 1035.171862510004, 5123.180291153398, 5156.664816786897, 5205.375354957354, 5283.233931079972, 5294.841154765363, 5509.752061157257, 5523.4752698494385, 5590.608657393944, 5599.188117722907, 5653.265075540154, 4935.284383764334, 5221.66059206158, 5225.346831646044, 5237.5548078413, 5238.895222095537, 2919.8102123362337, 2953.3354995126356, 2960.896368627131, 2963.2739978705354, 3000.3099287163636, 5678.886422271614, 5730.426957304319, 5739.311282646026, 5742.191209768909, 5801.88396232073, 5259.579233661374, 5606.262058761797, 5608.009156749376, 5608.719564021782, 5623.465770751772, 5724.513416359656, 5732.885342293131, 5734.827955161351, 5742.397048309951, 5783.987802134609, 5195.818146364859, 5402.324709411324, 5466.0, 5528.391876893619, 5540.89182163577, 5404.8108316208745, 5451.4276001019325, 5514.503694667499, 5537.394155694803, 5541.282202517233, 5584.274044374205, 5692.6299790513485, 5714.714264286852, 5728.885422291614, 5730.971345143247, 3934.0, 4045.4134150548593, 4080.8979775504663, 4097.508299004138, 4113.8971525712095, 5477.3427188737605, 5501.0, 5576.525995290446, 6118.571699980958, 6329.936700632935, 6178.567500274938, 6190.473809726043, 6200.441960223421, 6231.906521402273, 6235.625862448268, 6045.853721928828, 6167.198264225622, 6192.690365481798, 6214.782482613087, 6239.126522286974, 6002.898985355091, 6053.667048312385, 6116.400529774739, 6150.231221097363, 6179.876402471836, 6176.289726681489, 6253.687315634109, 6253.749850006131, 6258.311585725475, 6280.466160376419, 5841.766329346779, 6002.939970600238, 6013.939860601338, 6018.097285407224, 6094.238220222473], "value": 4474.832761419419, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.4291010657699, 841.2344766262698, 841.9494830310182, 843.367474394204, 908.2416182487623, 14956.401743930242, 15327.233638318081, 15418.768718469231, 15466.22668866555, 15570.45503407381, 15779.447719329826, 16003.759943600855, 16018.0, 16032.599185020352, 16093.436729714462, 575.7812031428051, 873.6811063961671, 885.6191837509884, 890.8663700444953, 896.730980705789, 902.1700035966926, 903.5933829776594, 903.70629545398, 906.4108329585789, 908.6274627402767, 947.3794664494767, 947.4078700811992, 951.8048799996019, 952.7284723853703, 956.6699488676395, 947.1428357336587, 951.1914872358509, 951.7525443384701, 955.0640372435017, 957.3059531839396, 703.3810246982623, 705.2277755857328, 706.3148745716646, 707.3351050012972, 708.0865683268578, 15555.844441555553, 15665.0, 15697.136657483834, 15727.528174154793, 15728.37086516538, 14741.705165896728, 14947.327370268364, 15213.543593692208, 15251.38994440221, 15376.231188440644, 14789.186594737284, 14803.333849976776, 14926.552203433914, 14952.775708364274, 15388.230588470531, 4887.584555312803, 4902.705837649717, 4905.533974272438, 4937.456879743261, 5000.549950504435, 90097.0, 92827.53586232093, 93011.99999999932, 93120.0, 93569.53215233948, 12481.875181248253, 12568.371581420892, 12623.179493332904, 12717.300548469922, 12733.61799146027, 22913.656295155586, 23200.0, 23339.533209335717, 23549.29352119439, 23593.174238901556, 8990.235829954396, 9022.278217742696, 9087.09129087086, 9095.454272743656, 9210.309226808016, 5102.617303702237, 5104.668196567211, 5156.071907056766, 5163.715995620202, 5197.740112994411, 3688.133288677159, 3820.522434695663, 3826.770393776382, 3828.980855095707, 3830.1765120499226, 661.0843981086231, 661.5270081891471, 667.3960066140054, 673.8685956238585, 682.8395327098128, 592.2685483427963, 685.1606781692486, 711.1146622455077, 712.7968528969219, 741.1587847792794, 9837.754056148511, 10062.446565438971, 10170.0, 10177.33847299938, 10385.792284154275, 663.2107791727828, 708.8936659501117, 721.9783406497813, 722.0396872160014, 741.4735537768137, 4658.767061646904, 4967.850964471072, 5013.473585273567, 5024.522670346311, 5060.367454068241, 134019.0, 134847.0, 135684.0, 137210.0, 137657.3358543654, 81913.59043204747, 115067.42466287782, 117035.0, 117140.0, 120649.0, 98571.50714246383, 102625.48687256516, 103213.48393257985, 106539.0, 106554.46722766492, 8614.956925215334, 9057.320700947323, 9194.17252447283, 9197.908020919705, 9221.216196623362, 50562.2415663758, 58905.41094589171, 59185.11222331755, 59738.103928441975, 61327.6933615329, 49170.0, 77185.61407192927, 77962.0, 79577.0, 82488.0, 14148.363323650254, 14258.572242832732, 14400.207988560729, 14606.415743370146, 14672.413103475741, 15975.600609984844, 16185.67628647444, 16449.355064493455, 16849.831501684825, 17143.14284285806, 14484.34820433062, 14566.781498277322, 15480.922595386952, 15681.764773528634, 15689.764653529977, 15074.321655525748, 15141.545753627408, 15396.307166177325, 15621.297041633381, 15971.103965277505, 15000.624984375478, 15817.525474235792, 16117.838821612102, 16326.673466530841, 16573.91713041427, 12314.0, 12336.50653973867, 12428.937855310665, 12842.871571284168, 12930.676733081747, 12637.494500220257, 12709.17390369623, 12783.552575659807, 12794.872051279368, 12969.481220751064], "value": 8295.12077605394, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 105.0, 109.0, 110.0, 111.0, 112.0, 109.0, 109.0, 111.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 141.0, 165.0, 123.0, 146.0, 147.0, 122.0, 182.0, 117.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 163.0, 162.0, 163.0, 162.0, 163.0, 162.0, 160.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 169.0, 76.0, 75.0, 74.0, 75.0, 167.0, 75.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 138.0, 84.0, 83.0, 84.0, 139.0, 84.0, 84.0, 142.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 98.0, 95.0, 97.0, 96.0, 100.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 56.0, 51.0, 51.0, 52.0, 52.0, 51.0, 51.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 60.0, 61.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 82.0, 73.0, 72.0, 73.0, 79.0, 72.0, 72.0, 72.0, 72.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 124.0, 119.0, 116.0, 116.0, 115.0, 117.0, 127.0, 153.0, 121.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 159.0, 157.0, 155.0, 156.0, 151.0, 159.0, 154.0, 153.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 64.0, 63.0, 64.0, 63.0, 62.0, 65.0, 62.0, 61.0], "value": 64.5, "unit": "score"}]}]} 03:51:39 INFO - Return code: 0 03:51:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:39 ERROR - # TBPL SUCCESS # 03:51:39 INFO - Running post-action listener: _resource_record_post_action 03:51:39 INFO - [mozharness: 2016-08-09 10:51:39.943721Z] Finished run-tests step (success) 03:51:39 INFO - Running post-run listener: _resource_record_post_run 03:51:40 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 326811648; Read time: 56; Write time: 201172 03:51:40 INFO - TinderboxPrint: CPU usage
13.3% 03:51:40 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 56 03:51:40 INFO - TinderboxPrint: I/O write bytes / time
326,811,648 / 201,172 03:51:40 INFO - TinderboxPrint: CPU idle
8,216.8 (86.7%) 03:51:40 INFO - TinderboxPrint: CPU user
1,204.8 (12.7%) 03:51:40 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 77033472; Read time: 0; Write time: 62588 03:51:40 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246898688; Read time: 20; Write time: 138332 03:51:40 INFO - Running post-run listener: _upload_blobber_files 03:51:40 INFO - Blob upload gear active. 03:51:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:40 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 03:51:40 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'] 03:51:40 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 03:51:40 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:51:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:51:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:41 INFO - (blobuploader) - INFO - Done attempting. 03:51:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:45 INFO - (blobuploader) - INFO - Done attempting. 03:51:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:51:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:51:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:46 INFO - (blobuploader) - INFO - Done attempting. 03:51:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:46 INFO - Return code: 0 03:51:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bb05462bacb71701dbc2a9dac3df4456c1b8a491b3aeb7ac3137fabfd6efb473e930b3d6ca08eef3bef0be7a67bd5813c945df95370bf32e99b51cb869a88ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5118c0b84f0fa3536a9d5e4507d4b00bc8ed38859dd1b133f9897ee5ef1fed2f527dd4928c522ec5ff03ea9111d1acb6a4c9de267640f2a380786f9f6afa618a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3f804ee99e2ebfac7d1521ec8a2d55fea7930d085855c94f87d2dbc1995b311dae8af4be8a147bf43713ba5101e3f5777519396499637c284c86340de2c0e89"} 03:51:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:46 INFO - Contents: 03:51:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bb05462bacb71701dbc2a9dac3df4456c1b8a491b3aeb7ac3137fabfd6efb473e930b3d6ca08eef3bef0be7a67bd5813c945df95370bf32e99b51cb869a88ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5118c0b84f0fa3536a9d5e4507d4b00bc8ed38859dd1b133f9897ee5ef1fed2f527dd4928c522ec5ff03ea9111d1acb6a4c9de267640f2a380786f9f6afa618a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3f804ee99e2ebfac7d1521ec8a2d55fea7930d085855c94f87d2dbc1995b311dae8af4be8a147bf43713ba5101e3f5777519396499637c284c86340de2c0e89"} 03:51:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:46 INFO - Copying logs to upload dir... 03:51:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.252625 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-08-09 03:51:46.079034) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 03:51:46.082655) ========= 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-1470738228.992833-329231176 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/5bb05462bacb71701dbc2a9dac3df4456c1b8a491b3aeb7ac3137fabfd6efb473e930b3d6ca08eef3bef0be7a67bd5813c945df95370bf32e99b51cb869a88ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5118c0b84f0fa3536a9d5e4507d4b00bc8ed38859dd1b133f9897ee5ef1fed2f527dd4928c522ec5ff03ea9111d1acb6a4c9de267640f2a380786f9f6afa618a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3f804ee99e2ebfac7d1521ec8a2d55fea7930d085855c94f87d2dbc1995b311dae8af4be8a147bf43713ba5101e3f5777519396499637c284c86340de2c0e89"} build_url:https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/eUa0-gJYQhGdafDNIzaZQA/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/5bb05462bacb71701dbc2a9dac3df4456c1b8a491b3aeb7ac3137fabfd6efb473e930b3d6ca08eef3bef0be7a67bd5813c945df95370bf32e99b51cb869a88ab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5118c0b84f0fa3536a9d5e4507d4b00bc8ed38859dd1b133f9897ee5ef1fed2f527dd4928c522ec5ff03ea9111d1acb6a4c9de267640f2a380786f9f6afa618a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a3f804ee99e2ebfac7d1521ec8a2d55fea7930d085855c94f87d2dbc1995b311dae8af4be8a147bf43713ba5101e3f5777519396499637c284c86340de2c0e89"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 03:51:46.108267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 03:51:46.108637) ========= 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-1470738228.992833-329231176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 03:51:46.191308) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 03:51:46.191685) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 03:51:46.191995) ========= ========= Total master_lag: 0.27 =========