builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1472897920.8 results: success (0) buildid: 20160902160050 builduid: b954e943d60047298c8c718863c8a0b0 revision: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:40.805027) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:40.805465) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:40.805752) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:40.820165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:40.820424) ========= 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=62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-03 03:18:40-- 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% 105M=0s 2016-09-03 03:18:40 (105 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100756 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:40.934798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:40.935105) ========= 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=62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021113 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:40.984212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:40.984528) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd --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 d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd --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=62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-03 03:18:41,048 truncating revision to first 12 chars 2016-09-03 03:18:41,049 Setting DEBUG logging. 2016-09-03 03:18:41,049 attempt 1/10 2016-09-03 03:18:41,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d35ac86c5271?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-03 03:18:41,506 unpacking tar archive at: mozilla-aurora-d35ac86c5271/testing/mozharness/ program finished with exit code 0 elapsedTime=0.798213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:41.796129) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:41.796450) ========= script_repo_revision: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:41.796868) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:41.797171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 03:18:41.807495) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-09-03 03:18:41.807775) ========= /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=62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:18:41 INFO - MultiFileLogger online at 20160903 03:18:41 in /builds/slave/test 03:18:41 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:18:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:18:41 INFO - {'append_to_log': False, 03:18:41 INFO - 'base_work_dir': '/builds/slave/test', 03:18:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:18:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:18:41 INFO - 'branch': 'Mozilla-Aurora', 03:18:41 INFO - 'buildbot_json_path': 'buildprops.json', 03:18:41 INFO - 'config_files': ('talos/linux_config.py',), 03:18:41 INFO - 'default_actions': ('clobber', 03:18:41 INFO - 'read-buildbot-config', 03:18:41 INFO - 'download-and-extract', 03:18:41 INFO - 'populate-webroot', 03:18:41 INFO - 'create-virtualenv', 03:18:41 INFO - 'install', 03:18:41 INFO - 'run-tests'), 03:18:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:18:41 INFO - 'download_minidump_stackwalk': True, 03:18:41 INFO - 'download_symbols': 'ondemand', 03:18:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:18:41 INFO - 'tooltool.py': '/tools/tooltool.py', 03:18:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:18:41 INFO - '/tools/misc-python/virtualenv.py')}, 03:18:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:18:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:18:41 INFO - 'installer_path': 'installer.exe', 03:18:41 INFO - 'log_level': 'info', 03:18:41 INFO - 'log_name': 'talos', 03:18:41 INFO - 'log_to_console': True, 03:18:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:18:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:18:41 INFO - 'opt_config_files': (), 03:18:41 INFO - 'pip_index': False, 03:18:41 INFO - 'sps_profile': False, 03:18:41 INFO - 'sps_profile_interval': 0, 03:18:41 INFO - 'suite': 'dromaeojs-e10s', 03:18:41 INFO - 'system_bits': '32', 03:18:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:18:41 INFO - 'title': 'talos-linux64-ix-018', 03:18:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:18:41 INFO - 'use_talos_json': True, 03:18:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:18:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:18:41 INFO - 'work_dir': 'build'} 03:18:41 INFO - [mozharness: 2016-09-03 10:18:41.964392Z] Running clobber step. 03:18:41 INFO - Running pre-action listener: _resource_record_pre_action 03:18:41 INFO - Running main action method: clobber 03:18:41 INFO - rmtree: /builds/slave/test/build 03:18:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:18:42 INFO - Running post-action listener: _resource_record_post_action 03:18:42 INFO - [mozharness: 2016-09-03 10:18:42.407822Z] Finished clobber step (success) 03:18:42 INFO - [mozharness: 2016-09-03 10:18:42.407923Z] Running read-buildbot-config step. 03:18:42 INFO - Running pre-action listener: _resource_record_pre_action 03:18:42 INFO - Running main action method: read_buildbot_config 03:18:42 INFO - Using buildbot properties: 03:18:42 INFO - { 03:18:42 INFO - "project": "", 03:18:42 INFO - "product": "firefox", 03:18:42 INFO - "script_repo_revision": "production", 03:18:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:18:42 INFO - "repository": "", 03:18:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:18:42 INFO - "buildid": "20160902160050", 03:18:42 INFO - "pgo_build": "True", 03:18:42 INFO - "basedir": "/builds/slave/test", 03:18:42 INFO - "buildnumber": 529, 03:18:42 INFO - "slavename": "talos-linux64-ix-018", 03:18:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:18:42 INFO - "platform": "ubuntu64_hw", 03:18:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:18:42 INFO - "branch": "mozilla-aurora", 03:18:42 INFO - "repo_path": "releases/mozilla-aurora", 03:18:42 INFO - "revision": "d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd", 03:18:42 INFO - "stage_platform": "linux64-pgo", 03:18:42 INFO - "builduid": "b954e943d60047298c8c718863c8a0b0", 03:18:42 INFO - "slavebuilddir": "test" 03:18:42 INFO - } 03:18:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:18:42 INFO - Running post-action listener: _resource_record_post_action 03:18:42 INFO - [mozharness: 2016-09-03 10:18:42.410357Z] Finished read-buildbot-config step (success) 03:18:42 INFO - [mozharness: 2016-09-03 10:18:42.410446Z] Running download-and-extract step. 03:18:42 INFO - Running pre-action listener: _resource_record_pre_action 03:18:42 INFO - Running main action method: download_and_extract 03:18:42 INFO - mkdir: /builds/slave/test/build/tests 03:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:42 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:18:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:18:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:18:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:18:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:18:42 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:18:42 INFO - retry: Failed, sleeping 30 seconds before retrying 03:19:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:19:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:19:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:19:12 INFO - retry: Failed, sleeping 60 seconds before retrying 03:20:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:20:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:20:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:20:12 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:20:12 INFO - Caught exception: HTTP Error 404: Not Found 03:20:12 INFO - Caught exception: HTTP Error 404: Not Found 03:20:12 INFO - Caught exception: HTTP Error 404: Not Found 03:20:12 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:20:12 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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:20:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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:20:13 INFO - Downloaded 1361 bytes. 03:20:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:20:13 INFO - Using the following test package requirements: 03:20:13 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:20:13 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:13 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:20:13 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:13 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:20:13 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:13 INFO - u'jsshell-linux-x86_64.zip'], 03:20:13 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:13 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:20:13 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:20:13 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:13 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:20:13 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:13 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:20:13 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:13 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:20:13 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:20:13 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:20:13 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:20:13 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:20:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:20:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:20:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:20:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:20:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:20:13 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:20:13 INFO - retry: Failed, sleeping 30 seconds before retrying 03:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:20:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:20:43 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:20:43 INFO - retry: Failed, sleeping 60 seconds before retrying 03:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:21:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:43 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:21:43 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:21:43 INFO - Caught exception: HTTP Error 404: Not Found 03:21:43 INFO - Caught exception: HTTP Error 404: Not Found 03:21:43 INFO - Caught exception: HTTP Error 404: Not Found 03:21:43 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:43 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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:21:44 INFO - Downloaded 21839364 bytes. 03:21:44 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:21:44 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:21:45 INFO - Return code: 0 03:21:45 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:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:45 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:21:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:21:45 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:21:45 INFO - retry: Failed, sleeping 30 seconds before retrying 03:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:22:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:22:15 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:22:15 INFO - retry: Failed, sleeping 60 seconds before retrying 03:23:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:23:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:15 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:23:15 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:23:15 INFO - Caught exception: HTTP Error 404: Not Found 03:23:15 INFO - Caught exception: HTTP Error 404: Not Found 03:23:15 INFO - Caught exception: HTTP Error 404: Not Found 03:23:15 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:23:15 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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:23:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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:23:16 INFO - Downloaded 21839364 bytes. 03:23:16 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:23:16 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:23:17 INFO - Return code: 0 03:23:17 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:17 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:23:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:23:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:23:17 INFO - retry: Failed, sleeping 30 seconds before retrying 03:23:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:23:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:23:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:23:47 INFO - retry: Failed, sleeping 60 seconds before retrying 03:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:24:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:24:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:24:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:24:47 INFO - Caught exception: HTTP Error 404: Not Found 03:24:47 INFO - Caught exception: HTTP Error 404: Not Found 03:24:47 INFO - Caught exception: HTTP Error 404: Not Found 03:24:47 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:24:47 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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:24:48 INFO - Downloaded 14413740 bytes. 03:24:48 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:24:48 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:24:48 INFO - Return code: 0 03:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:48 INFO - https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:24:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:24:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:24:48 INFO - retry: Failed, sleeping 30 seconds before retrying 03:25:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:25:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:25:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:25:18 INFO - retry: Failed, sleeping 60 seconds before retrying 03:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:26:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:26:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:26:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjJylzlOR_O887hXHVW16g/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:26:18 INFO - Caught exception: HTTP Error 404: Not Found 03:26:18 INFO - Caught exception: HTTP Error 404: Not Found 03:26:18 INFO - Caught exception: HTTP Error 404: Not Found 03:26:18 INFO - trying https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:26:18 INFO - Downloading https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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:26:19 INFO - Downloaded 63899078 bytes. 03:26:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:26:19 INFO - mkdir: /builds/slave/test/properties 03:26:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:26:19 INFO - Writing to file /builds/slave/test/properties/build_url 03:26:19 INFO - Contents: 03:26:19 INFO - build_url:https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:26:20 INFO - Running post-action listener: _resource_record_post_action 03:26:20 INFO - Running post-action listener: set_extra_try_arguments 03:26:20 INFO - [mozharness: 2016-09-03 10:26:20.588126Z] Finished download-and-extract step (success) 03:26:20 INFO - [mozharness: 2016-09-03 10:26:20.588359Z] Running populate-webroot step. 03:26:20 INFO - Running pre-action listener: _resource_record_pre_action 03:26:20 INFO - Running main action method: populate_webroot 03:26:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:26:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:26:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:26:20 INFO - '--tppagecycles', 03:26:20 INFO - '7'], 03:26:20 INFO - 'tests': ['tsvgm']}}, 03:26:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:26:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:26:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:26:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:26:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:20 INFO - 'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:26:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:20 INFO - 'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['damp', 'tps']}, 03:26:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:20 INFO - 'tests': ['damp', 'tps']}, 03:26:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['dromaeo_dom']}, 03:26:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:26:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['basic_compositor_video']}, 03:26:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:26:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['a11yr', 03:26:20 INFO - 'ts_paint', 03:26:20 INFO - 'tpaint', 03:26:20 INFO - 'sessionrestore', 03:26:20 INFO - 'sessionrestore_no_auto_restore', 03:26:20 INFO - 'tabpaint']}, 03:26:20 INFO - 'other-e10s': {'tests': ['a11yr', 03:26:20 INFO - 'ts_paint', 03:26:20 INFO - 'tpaint', 03:26:20 INFO - 'sessionrestore', 03:26:20 INFO - 'sessionrestore_no_auto_restore', 03:26:20 INFO - 'tabpaint']}, 03:26:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:26:20 INFO - 'ts_paint', 03:26:20 INFO - 'tpaint', 03:26:20 INFO - 'sessionrestore', 03:26:20 INFO - 'sessionrestore_no_auto_restore', 03:26:20 INFO - 'tabpaint']}, 03:26:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:26:20 INFO - 'ts_paint', 03:26:20 INFO - 'tpaint', 03:26:20 INFO - 'sessionrestore', 03:26:20 INFO - 'sessionrestore_no_auto_restore', 03:26:20 INFO - 'tabpaint']}, 03:26:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['a11yr', 03:26:20 INFO - 'ts_paint', 03:26:20 INFO - 'tpaint', 03:26:20 INFO - 'sessionrestore', 03:26:20 INFO - 'sessionrestore_no_auto_restore', 03:26:20 INFO - 'tabpaint']}, 03:26:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['a11yr', 03:26:20 INFO - 'ts_paint', 03:26:20 INFO - 'tpaint', 03:26:20 INFO - 'sessionrestore', 03:26:20 INFO - 'sessionrestore_no_auto_restore', 03:26:20 INFO - 'tabpaint']}, 03:26:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['tsvgx', 03:26:20 INFO - 'tsvgr_opacity', 03:26:20 INFO - 'tart', 03:26:20 INFO - 'tscrollx', 03:26:20 INFO - 'cart']}, 03:26:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:26:20 INFO - 'tsvgr_opacity', 03:26:20 INFO - 'tart', 03:26:20 INFO - 'tscrollx', 03:26:20 INFO - 'cart']}, 03:26:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:20 INFO - 'talos_options': ['--disable-e10s'], 03:26:20 INFO - 'tests': ['tp5o']}, 03:26:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:20 INFO - 'tests': ['tp5o']}, 03:26:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:20 INFO - 'talos_options': ['--disable-e10s', 03:26:20 INFO - '--xperf_path', 03:26:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:20 INFO - 'tests': ['tp5n']}, 03:26:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:26:20 INFO - 'talos_options': ['--xperf_path', 03:26:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:26:20 INFO - 'tests': ['tp5n']}}, 03:26:20 INFO - 'talos.zip': {'path': '', 03:26:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:26:20 INFO - Running post-action listener: _resource_record_post_action 03:26:20 INFO - [mozharness: 2016-09-03 10:26:20.610814Z] Finished populate-webroot step (success) 03:26:20 INFO - [mozharness: 2016-09-03 10:26:20.610914Z] Running create-virtualenv step. 03:26:20 INFO - Running pre-action listener: _resource_record_pre_action 03:26:20 INFO - Running main action method: create_virtualenv 03:26:20 INFO - Creating virtualenv /builds/slave/test/build/venv 03:26:20 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:26:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:26:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:26:20 INFO - Using real prefix '/usr' 03:26:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:26:21 INFO - Installing distribute.............................................................................................................................................................................................done. 03:26:23 INFO - Installing pip.................done. 03:26:23 INFO - Return code: 0 03:26:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x214d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, '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': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', '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:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:26:23 INFO - Using env: {'DISPLAY': ':0', 03:26:23 INFO - 'HOME': '/home/cltbld', 03:26:23 INFO - 'LANG': 'en_US.UTF-8', 03:26:23 INFO - 'LANGUAGE': 'en_US:en', 03:26:23 INFO - 'LOGNAME': 'cltbld', 03:26:23 INFO - 'MAIL': '/var/mail/cltbld', 03:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:23 INFO - 'MOZ_NO_REMOTE': '1', 03:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:23 INFO - 'NO_EM_RESTART': '1', 03:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:23 INFO - 'PWD': '/builds/slave/test', 03:26:23 INFO - 'SHELL': '/bin/bash', 03:26:23 INFO - 'SHLVL': '1', 03:26:23 INFO - 'TERM': 'linux', 03:26:23 INFO - 'TMOUT': '86400', 03:26:23 INFO - 'USER': 'cltbld', 03:26:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:23 INFO - '_': '/tools/buildbot/bin/python'} 03:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:23 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:26:23 INFO - Cleaning up... 03:26:23 INFO - Return code: 0 03:26:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x214d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, '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': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', '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:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:26:23 INFO - Using env: {'DISPLAY': ':0', 03:26:23 INFO - 'HOME': '/home/cltbld', 03:26:23 INFO - 'LANG': 'en_US.UTF-8', 03:26:23 INFO - 'LANGUAGE': 'en_US:en', 03:26:23 INFO - 'LOGNAME': 'cltbld', 03:26:23 INFO - 'MAIL': '/var/mail/cltbld', 03:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:23 INFO - 'MOZ_NO_REMOTE': '1', 03:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:23 INFO - 'NO_EM_RESTART': '1', 03:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:23 INFO - 'PWD': '/builds/slave/test', 03:26:23 INFO - 'SHELL': '/bin/bash', 03:26:23 INFO - 'SHLVL': '1', 03:26:23 INFO - 'TERM': 'linux', 03:26:23 INFO - 'TMOUT': '86400', 03:26:23 INFO - 'USER': 'cltbld', 03:26:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:23 INFO - '_': '/tools/buildbot/bin/python'} 03:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:23 INFO - Downloading/unpacking psutil>=3.1.1 03:26:23 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:26:23 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:26:23 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:26:23 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:26:23 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:26:23 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:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:25 INFO - Installing collected packages: psutil 03:26:25 INFO - Running setup.py install for psutil 03:26:25 INFO - building 'psutil._psutil_linux' extension 03:26:25 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:26:25 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:26:25 INFO - building 'psutil._psutil_posix' extension 03:26:25 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:26:26 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:26:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:26 INFO - Successfully installed psutil 03:26:26 INFO - Cleaning up... 03:26:26 INFO - Return code: 0 03:26:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26: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:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:26 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 0x214d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, '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': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', '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:26:26 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:26:26 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:26:26 INFO - Using env: {'DISPLAY': ':0', 03:26:26 INFO - 'HOME': '/home/cltbld', 03:26:26 INFO - 'LANG': 'en_US.UTF-8', 03:26:26 INFO - 'LANGUAGE': 'en_US:en', 03:26:26 INFO - 'LOGNAME': 'cltbld', 03:26:26 INFO - 'MAIL': '/var/mail/cltbld', 03:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:26 INFO - 'MOZ_NO_REMOTE': '1', 03:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:26 INFO - 'NO_EM_RESTART': '1', 03:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:26 INFO - 'PWD': '/builds/slave/test', 03:26:26 INFO - 'SHELL': '/bin/bash', 03:26:26 INFO - 'SHLVL': '1', 03:26:26 INFO - 'TERM': 'linux', 03:26:26 INFO - 'TMOUT': '86400', 03:26:26 INFO - 'USER': 'cltbld', 03:26:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:26 INFO - '_': '/tools/buildbot/bin/python'} 03:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:26 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:26:26 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:26:26 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:26:26 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:26:26 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:26:26 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:26:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:28 INFO - Installing collected packages: mozsystemmonitor 03:26:28 INFO - Running setup.py install for mozsystemmonitor 03:26:28 INFO - Successfully installed mozsystemmonitor 03:26:28 INFO - Cleaning up... 03:26:28 INFO - Return code: 0 03:26:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x214d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, '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': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', '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:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:26:28 INFO - Using env: {'DISPLAY': ':0', 03:26:28 INFO - 'HOME': '/home/cltbld', 03:26:28 INFO - 'LANG': 'en_US.UTF-8', 03:26:28 INFO - 'LANGUAGE': 'en_US:en', 03:26:28 INFO - 'LOGNAME': 'cltbld', 03:26:28 INFO - 'MAIL': '/var/mail/cltbld', 03:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:28 INFO - 'MOZ_NO_REMOTE': '1', 03:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:28 INFO - 'NO_EM_RESTART': '1', 03:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:28 INFO - 'PWD': '/builds/slave/test', 03:26:28 INFO - 'SHELL': '/bin/bash', 03:26:28 INFO - 'SHLVL': '1', 03:26:28 INFO - 'TERM': 'linux', 03:26:28 INFO - 'TMOUT': '86400', 03:26:28 INFO - 'USER': 'cltbld', 03:26:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:28 INFO - '_': '/tools/buildbot/bin/python'} 03:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:30 INFO - warning: no files found matching '*.txt' 03:26:30 INFO - no previously-included directories found matching 'build' 03:26:30 INFO - no previously-included directories found matching 'dist' 03:26:30 INFO - no previously-included directories found matching '.git*' 03:26:30 INFO - Installing collected packages: jsonschema, functools32 03:26:30 INFO - Running setup.py install for functools32 03:26:30 INFO - warning: no files found matching '*.txt' 03:26:30 INFO - no previously-included directories found matching 'build' 03:26:30 INFO - no previously-included directories found matching 'dist' 03:26:30 INFO - no previously-included directories found matching '.git*' 03:26:31 INFO - Successfully installed jsonschema functools32 03:26:31 INFO - Cleaning up... 03:26:31 INFO - Return code: 0 03:26:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:26:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:31 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 0x214d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, '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': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', '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:26:31 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:26:31 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:26:31 INFO - Using env: {'DISPLAY': ':0', 03:26:31 INFO - 'HOME': '/home/cltbld', 03:26:31 INFO - 'LANG': 'en_US.UTF-8', 03:26:31 INFO - 'LANGUAGE': 'en_US:en', 03:26:31 INFO - 'LOGNAME': 'cltbld', 03:26:31 INFO - 'MAIL': '/var/mail/cltbld', 03:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:31 INFO - 'MOZ_NO_REMOTE': '1', 03:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:31 INFO - 'NO_EM_RESTART': '1', 03:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:31 INFO - 'PWD': '/builds/slave/test', 03:26:31 INFO - 'SHELL': '/bin/bash', 03:26:31 INFO - 'SHLVL': '1', 03:26:31 INFO - 'TERM': 'linux', 03:26:31 INFO - 'TMOUT': '86400', 03:26:31 INFO - 'USER': 'cltbld', 03:26:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:31 INFO - '_': '/tools/buildbot/bin/python'} 03:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:26:31 INFO - Cleaning up... 03:26:31 INFO - Return code: 0 03:26:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:31 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 0x214d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, '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': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', '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:26:31 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:26:31 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:26:31 INFO - Using env: {'DISPLAY': ':0', 03:26:31 INFO - 'HOME': '/home/cltbld', 03:26:31 INFO - 'LANG': 'en_US.UTF-8', 03:26:31 INFO - 'LANGUAGE': 'en_US:en', 03:26:31 INFO - 'LOGNAME': 'cltbld', 03:26:31 INFO - 'MAIL': '/var/mail/cltbld', 03:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:31 INFO - 'MOZ_NO_REMOTE': '1', 03:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:31 INFO - 'NO_EM_RESTART': '1', 03:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:31 INFO - 'PWD': '/builds/slave/test', 03:26:31 INFO - 'SHELL': '/bin/bash', 03:26:31 INFO - 'SHLVL': '1', 03:26:31 INFO - 'TERM': 'linux', 03:26:31 INFO - 'TMOUT': '86400', 03:26:31 INFO - 'USER': 'cltbld', 03:26:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:31 INFO - '_': '/tools/buildbot/bin/python'} 03:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:31 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:26:31 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:26:31 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:26:31 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:26:31 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:26:31 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:26:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:34 INFO - Downloading docopt-0.6.1.tar.gz 03:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:34 INFO - Running setup.py install for blobuploader 03:26:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:34 INFO - Running setup.py install for requests 03:26:34 INFO - Running setup.py install for docopt 03:26:34 INFO - Successfully installed blobuploader requests docopt 03:26:34 INFO - Cleaning up... 03:26:34 INFO - Return code: 0 03:26:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:34 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 0x214d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, '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': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', '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:26:34 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:26:34 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:26:34 INFO - Using env: {'DISPLAY': ':0', 03:26:34 INFO - 'HOME': '/home/cltbld', 03:26:34 INFO - 'LANG': 'en_US.UTF-8', 03:26:34 INFO - 'LANGUAGE': 'en_US:en', 03:26:34 INFO - 'LOGNAME': 'cltbld', 03:26:34 INFO - 'MAIL': '/var/mail/cltbld', 03:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:34 INFO - 'MOZ_NO_REMOTE': '1', 03:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:34 INFO - 'NO_EM_RESTART': '1', 03:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:34 INFO - 'PWD': '/builds/slave/test', 03:26:34 INFO - 'SHELL': '/bin/bash', 03:26:34 INFO - 'SHLVL': '1', 03:26:34 INFO - 'TERM': 'linux', 03:26:34 INFO - 'TMOUT': '86400', 03:26:34 INFO - 'USER': 'cltbld', 03:26:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:34 INFO - '_': '/tools/buildbot/bin/python'} 03:26:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:34 INFO - Running setup.py (path:/tmp/pip-xh52RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:35 INFO - Running setup.py (path:/tmp/pip-bw74T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:35 INFO - Running setup.py (path:/tmp/pip-mDbi_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:35 INFO - Running setup.py (path:/tmp/pip-tDkJU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:35 INFO - Running setup.py (path:/tmp/pip-75t1em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:35 INFO - Running setup.py (path:/tmp/pip-Y3Ufbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:35 INFO - Running setup.py (path:/tmp/pip-ODLGxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:35 INFO - Running setup.py (path:/tmp/pip-LgEb16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:35 INFO - Running setup.py (path:/tmp/pip-f6Jc0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:35 INFO - Running setup.py (path:/tmp/pip-OBxUEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:35 INFO - Running setup.py (path:/tmp/pip-jH8p4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:35 INFO - Running setup.py (path:/tmp/pip-wZ8WVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:35 INFO - Running setup.py (path:/tmp/pip-oWBVJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:35 INFO - Running setup.py (path:/tmp/pip-Gbrbqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:35 INFO - Running setup.py (path:/tmp/pip-RntHLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:36 INFO - Running setup.py (path:/tmp/pip-mG3kcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:36 INFO - Running setup.py (path:/tmp/pip-JyyYSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:36 INFO - Running setup.py install for manifestparser 03:26:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:36 INFO - Running setup.py install for mozcrash 03:26:36 INFO - Running setup.py install for mozdebug 03:26:36 INFO - Running setup.py install for mozdevice 03:26:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:36 INFO - Running setup.py install for mozfile 03:26:36 INFO - Running setup.py install for mozhttpd 03:26:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:36 INFO - Running setup.py install for mozinfo 03:26:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:36 INFO - Running setup.py install for mozInstall 03:26:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:36 INFO - Running setup.py install for mozleak 03:26:37 INFO - Running setup.py install for mozlog 03:26:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:37 INFO - Running setup.py install for moznetwork 03:26:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:37 INFO - Running setup.py install for mozprocess 03:26:37 INFO - Running setup.py install for mozprofile 03:26:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:37 INFO - Running setup.py install for mozrunner 03:26:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:37 INFO - Running setup.py install for mozscreenshot 03:26:37 INFO - Running setup.py install for moztest 03:26:37 INFO - Running setup.py install for mozversion 03:26:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:37 INFO - Cleaning up... 03:26:37 INFO - Return code: 0 03:26:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26: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:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:37 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 0x214d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, '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': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', '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:26:37 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:26:37 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:26:37 INFO - Using env: {'DISPLAY': ':0', 03:26:37 INFO - 'HOME': '/home/cltbld', 03:26:37 INFO - 'LANG': 'en_US.UTF-8', 03:26:37 INFO - 'LANGUAGE': 'en_US:en', 03:26:37 INFO - 'LOGNAME': 'cltbld', 03:26:37 INFO - 'MAIL': '/var/mail/cltbld', 03:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:37 INFO - 'MOZ_NO_REMOTE': '1', 03:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:37 INFO - 'NO_EM_RESTART': '1', 03:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:37 INFO - 'PWD': '/builds/slave/test', 03:26:37 INFO - 'SHELL': '/bin/bash', 03:26:37 INFO - 'SHLVL': '1', 03:26:37 INFO - 'TERM': 'linux', 03:26:37 INFO - 'TMOUT': '86400', 03:26:37 INFO - 'USER': 'cltbld', 03:26:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:37 INFO - '_': '/tools/buildbot/bin/python'} 03:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:38 INFO - Running setup.py (path:/tmp/pip-LpxPXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:38 INFO - Running setup.py (path:/tmp/pip-Nh3e6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:38 INFO - Running setup.py (path:/tmp/pip-EQPmLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:38 INFO - Running setup.py (path:/tmp/pip-DqjOGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:38 INFO - Running setup.py (path:/tmp/pip-Yl9Eh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:38 INFO - Running setup.py (path:/tmp/pip-QahhBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:38 INFO - Running setup.py (path:/tmp/pip-Ov4uET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:38 INFO - Running setup.py (path:/tmp/pip-AgUrEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:38 INFO - Running setup.py (path:/tmp/pip-DVTjLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:38 INFO - Running setup.py (path:/tmp/pip-237xlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:38 INFO - Running setup.py (path:/tmp/pip-ipRLru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:38 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:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:38 INFO - Running setup.py (path:/tmp/pip-tC8xKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:39 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:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:39 INFO - Running setup.py (path:/tmp/pip-Hp_93h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:39 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:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:39 INFO - Running setup.py (path:/tmp/pip-4EATkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:39 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:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:39 INFO - Running setup.py (path:/tmp/pip-oI5hBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:39 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:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:39 INFO - Running setup.py (path:/tmp/pip-KF_SoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:39 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:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:39 INFO - Running setup.py (path:/tmp/pip-gNOhrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:39 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:26:39 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:26:39 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:26:39 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:26:39 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:26:39 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:26:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26: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:26: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:26: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:26: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:26: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:26: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:26:41 INFO - Downloading blessings-1.6.tar.gz 03:26:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:41 INFO - Installing collected packages: blessings 03:26:41 INFO - Running setup.py install for blessings 03:26:41 INFO - Successfully installed blessings 03:26:41 INFO - Cleaning up... 03:26:41 INFO - Return code: 0 03:26:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:41 INFO - Reading from file tmpfile_stdout 03:26:41 INFO - Current package versions: 03:26:41 INFO - argparse == 1.2.1 03:26:41 INFO - blessings == 1.6 03:26:41 INFO - blobuploader == 1.2.4 03:26:41 INFO - docopt == 0.6.1 03:26:41 INFO - functools32 == 3.2.3-2 03:26:41 INFO - jsonschema == 2.5.1 03:26:41 INFO - manifestparser == 1.1 03:26:41 INFO - mozInstall == 1.12 03:26:41 INFO - mozcrash == 0.17 03:26:41 INFO - mozdebug == 0.1 03:26:41 INFO - mozdevice == 0.48 03:26:41 INFO - mozfile == 1.2 03:26:41 INFO - mozhttpd == 0.7 03:26:41 INFO - mozinfo == 0.9 03:26:41 INFO - mozleak == 0.1 03:26:41 INFO - mozlog == 3.3 03:26:41 INFO - moznetwork == 0.27 03:26:41 INFO - mozprocess == 0.23 03:26:41 INFO - mozprofile == 0.28 03:26:41 INFO - mozrunner == 6.12 03:26:41 INFO - mozscreenshot == 0.1 03:26:41 INFO - mozsystemmonitor == 0.3 03:26:41 INFO - moztest == 0.7 03:26:41 INFO - mozversion == 1.4 03:26:41 INFO - psutil == 3.1.1 03:26:41 INFO - requests == 1.2.3 03:26:41 INFO - wsgiref == 0.1.2 03:26:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:41 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 0x214d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, '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': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', '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:26:41 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:26:41 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:26:41 INFO - Using env: {'DISPLAY': ':0', 03:26:41 INFO - 'HOME': '/home/cltbld', 03:26:41 INFO - 'LANG': 'en_US.UTF-8', 03:26:41 INFO - 'LANGUAGE': 'en_US:en', 03:26:41 INFO - 'LOGNAME': 'cltbld', 03:26:41 INFO - 'MAIL': '/var/mail/cltbld', 03:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:41 INFO - 'MOZ_NO_REMOTE': '1', 03:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:41 INFO - 'NO_EM_RESTART': '1', 03:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:41 INFO - 'PWD': '/builds/slave/test', 03:26:41 INFO - 'SHELL': '/bin/bash', 03:26:41 INFO - 'SHLVL': '1', 03:26:41 INFO - 'TERM': 'linux', 03:26:41 INFO - 'TMOUT': '86400', 03:26:41 INFO - 'USER': 'cltbld', 03:26:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:41 INFO - '_': '/tools/buildbot/bin/python'} 03:26:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 INFO - Cleaning up... 03:26:41 INFO - Return code: 0 03:26:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:41 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 0x214d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, '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': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', '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:26:41 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:26:41 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:26:41 INFO - Using env: {'DISPLAY': ':0', 03:26:41 INFO - 'HOME': '/home/cltbld', 03:26:41 INFO - 'LANG': 'en_US.UTF-8', 03:26:41 INFO - 'LANGUAGE': 'en_US:en', 03:26:41 INFO - 'LOGNAME': 'cltbld', 03:26:41 INFO - 'MAIL': '/var/mail/cltbld', 03:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:41 INFO - 'MOZ_NO_REMOTE': '1', 03:26:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:41 INFO - 'NO_EM_RESTART': '1', 03:26:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:41 INFO - 'PWD': '/builds/slave/test', 03:26:41 INFO - 'SHELL': '/bin/bash', 03:26:41 INFO - 'SHLVL': '1', 03:26:41 INFO - 'TERM': 'linux', 03:26:41 INFO - 'TMOUT': '86400', 03:26:41 INFO - 'USER': 'cltbld', 03:26:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:41 INFO - '_': '/tools/buildbot/bin/python'} 03:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:42 INFO - Cleaning up... 03:26:42 INFO - Return code: 0 03:26:42 INFO - Running post-action listener: _resource_record_post_action 03:26:42 INFO - Running post-action listener: _start_resource_monitoring 03:26:42 INFO - Starting resource monitoring. 03:26:42 INFO - [mozharness: 2016-09-03 10:26:42.231088Z] Finished create-virtualenv step (success) 03:26:42 INFO - [mozharness: 2016-09-03 10:26:42.231563Z] Running install step. 03:26:42 INFO - Running pre-action listener: _resource_record_pre_action 03:26:42 INFO - Running main action method: install 03:26:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:42 INFO - Reading from file tmpfile_stdout 03:26:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:42 INFO - Reading from file tmpfile_stdout 03:26:42 INFO - Output received: 03:26:42 INFO - Usage: mozinstall [options] installer 03:26:42 INFO - Options: 03:26:42 INFO - -h, --help show this help message and exit 03:26:42 INFO - -d DEST, --destination=DEST 03:26:42 INFO - Directory to install application into. [default: 03:26:42 INFO - "/builds/slave/test"] 03:26:42 INFO - --app=APP Application being installed. [default: firefox] 03:26:42 INFO - mkdir: /builds/slave/test/build/application 03:26:42 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:26:42 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:26:58 INFO - Reading from file tmpfile_stdout 03:26:58 INFO - Output received: 03:26:58 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:58 INFO - Running post-action listener: _resource_record_post_action 03:26:58 INFO - [mozharness: 2016-09-03 10:26:58.552656Z] Finished install step (success) 03:26:58 INFO - [mozharness: 2016-09-03 10:26:58.552927Z] Running run-tests step. 03:26:58 INFO - Running pre-action listener: _resource_record_pre_action 03:26:58 INFO - Running main action method: run_tests 03:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:58 INFO - Python 2.7.3 03:26:58 INFO - Return code: 0 03:26:58 INFO - grabbing minidump binary from tooltool 03:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:58 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 0x240b570>, '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 0x240c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:58 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:26:58 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:26:58 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:26:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:58 INFO - Return code: 0 03:26:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:58 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/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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:26:58 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/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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:26:58 INFO - Using env: {'DISPLAY': ':0', 03:26:58 INFO - 'HOME': '/home/cltbld', 03:26:58 INFO - 'LANG': 'en_US.UTF-8', 03:26:58 INFO - 'LANGUAGE': 'en_US:en', 03:26:58 INFO - 'LOGNAME': 'cltbld', 03:26:58 INFO - 'MAIL': '/var/mail/cltbld', 03:26:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:58 INFO - 'MOZ_NO_REMOTE': '1', 03:26:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:58 INFO - 'NO_EM_RESTART': '1', 03:26:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:58 INFO - 'PWD': '/builds/slave/test', 03:26:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:58 INFO - 'SHELL': '/bin/bash', 03:26:58 INFO - 'SHLVL': '1', 03:26:58 INFO - 'TERM': 'linux', 03:26:58 INFO - 'TMOUT': '86400', 03:26:58 INFO - 'USER': 'cltbld', 03:26:58 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872', 03:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:58 INFO - '_': '/tools/buildbot/bin/python'} 03:26:58 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/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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:26:58 INFO - mozversion application_buildid: 20160902160050 03:26:58 INFO - mozversion application_changeset: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd 03:26:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:26:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:58 INFO - mozversion application_name: Firefox 03:26:58 INFO - mozversion application_remotingname: firefox-dev 03:26:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:58 INFO - mozversion application_vendor: Mozilla 03:26:58 INFO - mozversion application_version: 50.0a2 03:26:58 INFO - mozversion platform_buildid: 20160902160050 03:26:58 INFO - mozversion platform_changeset: d35ac86c5271f6ad22bf1f76b1bc8adb0398e7bd 03:26:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:58 INFO - mozversion platform_version: 50.0a2 03:26:58 INFO - using testdate: 1472898418 03:26:58 INFO - actual date: 1472898418 03:26:58 INFO - starting webserver on 'localhost:56240' 03:26:58 INFO - SUITE-START | Running 2 tests 03:26:58 INFO - TEST-START | dromaeo_css 03:26:58 INFO - operating with platform_type : linux_ 03:26:58 INFO - Initialising browser for dromaeo_css test... 03:26:58 INFO - TEST-INFO | started process 6451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_i3_t/profile http://localhost:56240/getInfo.html) 03:27:03 INFO - PROCESS | 6451 | __metrics Screen width/height:1600/1200 03:27:03 INFO - PROCESS | 6451 | colorDepth:24 03:27:03 INFO - PROCESS | 6451 | Browser inner width/height: 1024/697 03:27:03 INFO - PROCESS | 6451 | __metrics 03:27:03 ERROR - PROCESS | 6451 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:27:04 INFO - TEST-INFO | 6451: exit 0 03:27:04 INFO - Browser initialized. 03:27:04 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:04 INFO - TEST-INFO | started process 6575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR_i3_t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:16 INFO - PROCESS | 6575 | RSS: Main: 152412160 03:27:16 INFO - PROCESS | 6575 | 03:28:06 INFO - PROCESS | 6575 | 1472898486045 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:30:14 INFO - PROCESS | 6575 | Cycle 1(1): loaded http://localhost:56240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56240/tests/dromaeo/cssquery-ext.html) 03:30:15 INFO - PROCESS | 6575 | RSS: Main: 158134272 03:30:15 INFO - PROCESS | 6575 | 03:33:17 INFO - PROCESS | 6575 | Cycle 1(1): loaded http://localhost:56240/tests/dromaeo/cssquery-ext.html (next: http://localhost:56240/tests/dromaeo/cssquery-jquery.html) 03:33:18 INFO - PROCESS | 6575 | RSS: Main: 153522176 03:33:18 INFO - PROCESS | 6575 | 03:36:20 INFO - PROCESS | 6575 | Cycle 1(1): loaded http://localhost:56240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56240/tests/dromaeo/cssquery-mootools.html) 03:36:20 INFO - PROCESS | 6575 | RSS: Main: 153702400 03:36:20 INFO - PROCESS | 6575 | 03:39:22 INFO - PROCESS | 6575 | Cycle 1(1): loaded http://localhost:56240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56240/tests/dromaeo/cssquery-prototype.html) 03:39:23 INFO - PROCESS | 6575 | RSS: Main: 152297472 03:39:23 INFO - PROCESS | 6575 | 03:42:25 INFO - PROCESS | 6575 | Cycle 1(1): loaded http://localhost:56240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56240/tests/dromaeo/cssquery-yui.html) 03:42:26 INFO - PROCESS | 6575 | RSS: Main: 154959872 03:42:26 INFO - PROCESS | 6575 | 03:45:28 INFO - PROCESS | 6575 | Cycle 1(1): loaded http://localhost:56240/tests/dromaeo/cssquery-yui.html (next: http://localhost:56240/tests/dromaeo/cssquery-dojo.html) 03:45:29 INFO - PROCESS | 6575 | RSS: Main: 155086848 03:45:29 INFO - PROCESS | 6575 | 03:45:29 INFO - PROCESS | 6575 | __start_tp_report 03:45:29 INFO - PROCESS | 6575 | _x_x_mozilla_page_load 03:45:29 INFO - PROCESS | 6575 | _x_x_mozilla_page_load_details 03:45:29 INFO - PROCESS | 6575 | |i|pagename|runs| 03:45:29 INFO - PROCESS | 6575 | |0;dojo.html;3258.1040213941164;3298.7361011119115;3311.1391038330025;3318.7179089777374;3325.9334813303735;5792.0443126884065;5794.449527294911;5822.767089316428;5825.796097136601;5850.180974663551;5681.403452637465;5748.5975981681295;5783.913241301384;5787.594868359217;5799.3620701722775;5240.764165612547;5259.105951988152;5271.26202331672;5313.867153321178;5341.145416733323;5158.535731784139;5189.558887494568;5230.293910322115;5258.710770907599;5291.100512912795;5272.209168624699;5282.630215884889;5291.1798671206025;5325.227841962913;5345.358556973169;5287.47125287472;5291.68249905005;5302.734863256822;5307.946920530784;5317.388500322474;5021.071101846133;5070.416902056274;5182.144946083891;5207.843764687065;5259.211118332242;5625.1843482695185;5701.429857014306;5708.1723150143;5729.512991395736;5739.569532285053;6047.546434017422;6060.878782424371;6088.817335479943;6104.26748790148;6118.571699981003;5925.170476133345;6133.946794548733;6156.415140561639;6167.167432396614;6170.228721409824;5760.567957403212;5845.386234445407;5848.970755146197;5874.765009399619;5878.941210587882;6348.428641422294;6375.681215939185;6376.426121648981;6377.553571249968;6382.936170638327;5866.677332746654;5945.1973983512535;6085.056816193497;6120.418560236771;6159.722812473449;6007.128966299862;6116.119654120117;6133.854967165038;6134.9079763803575;6139.140520327158;6044.214252147281;6060.939390606038;6085.9695701521205;6102.542309326729;6119.44924956756;5931.703414829328;6102.816915492543;6116.602420842631;6120.816375508742;6125.356837532084;4681.461631912373;4707.482176960531;4715.504871988392;4747.335373047776;4767.69010014348;4209.936850947238;4219.2194444027955;4219.78901054946;4235.237657221668;4239.788010599457;5739.110437882052;5901.026330655393;5985.790497332572;5993.220881285492;6014.248218972629;6132.998044146438;6196;6210.689465526705;6221.2845522765465;6235.376462353819;5964.671943043174;5968.940310596925;5978.970105149447;5988.730507127189;6021.488173505213;5180.300659411007;5235.0576896159055;5338.386085600206;5343.038253114477;5359.410464848864;6339.429451349401;6427.035944608346;6457.677116144174;6459.192600924885;6473.611583305017;6193.876122477615;6224.564280500322;6229.972054610938;6235.282942461494;6236.095766113797;6138.846528836815;6295.937040629535;6321.747130114744;6428.260750013808;6444.355564443518;6115.113308570321;6118.143459915526;6121.1430399743185;6121.908171377522;6124.234470691164;6183.84540386494;6214.25428948529;6217.875642487034;6222.906656400067;6234.0337247726675;5868.618539794899;5896.734646940812;5947.583669143119;6069.787557435468;6090.725917333819;6023.45788879003;6026.608270462406;6037.426444487766;6050.062240352752;6057.727877145849;5903.793367232126;5947.464728174485;5960.344362120077;5974.2830860297045;6000.21997140369;5940.702964851654;5951.732172052355;6003.429674180946;6032.185654936703;6035.1249068885645;5924.6149000314845;5962.582619216613;5968.134620480093;5982.52139828804;5983.162357269899 03:45:29 INFO - PROCESS | 6575 | |1;ext.html;580.9535237181026;641.6727468990815;657.4838751580011;677.0217036382427;704.6576272201459;35378;39020.21959560814;39102.80448597753;39107.80446097769;39144.60855391449;39799.602003979955;39881.40177897334;40326.7983660082;40408.39387409191;40435.797821010856;9228.584713687867;9336.066393360677;9340.3461757677;9342.859857102116;9345.906540934571;9317;9351.111644393772;9370.531473426336;9404.153626173644;9419.529023548796;9137.63449462024;9176.265898728087;9222.21611163052;9238.491882946435;9243.214326782232;9331;9395.201407880304;9414;9415.764605884839;9449.905500944971;9242.584083716249;9254.676086337013;9278;9333.439993600407;9338.906610933871;45242.09515809665;45585.316220256726;45626.08747825058;45742.313865292046;45748.77125614384;3768.1144930941205;3948.348522493785;4061.512618485771;4172.833086676529;4398.714083584557;35560.644393555995;35735.28529429397;35745;36476.0880977975;37076.44385334222;4849.951500484985;4854.223324268136;4863.19757240055;4918.385201849769;4946.1344264753525;393557;395977;396751.9999999971;397343;397773;39082.609173908466;67081.3291867075;67373.66313168402;67554.32445675578;67704.32295677079;39141.2171756569;39641.40537891934;39675.80162099171;40057.79971100184;40101.5964441249;14708.632284192767;14760.778588321184;14812;14830.480933167288;14855;12080.093992950387;12118.030557555374;12129.454174562166;12152.63542093721;12181.147319687538;9265.25877929764;9344;9353.438793672402;9397.107274808883;9472.95263523678;3487.250241198104;3537.9292414151573;3546.627604101584;3559.9644003559633;3564.7757407472227;1037.6420135053395;1076.5478499030426;1141.2752901907184;1155.6764106050318;1247.9376031198403;32967.67032329646;33829.323413531594;33986.38280120968;34099.4885076724;34188.82905585506;1198.3888217009214;1210.4673943464848;1213.0477575103678;1269.581038257373;1303.7848754955326;17670.558236044202;17802.46592602224;18024.90987545054;18043.909780451013;18121.818781812275;435070;630169;640153;647170;647176;67995;68042.65978670174;68153.31846681569;68167;68601;1438.1443041390355;1457.9489717859824;1486.3534362552325;1490.0761527852585;1492.0674578388507;35373.82313088418;35625.64374356327;35674.8216258917;35938.28123437464;36078.27843443169;59497.40502595092;60557.39442605517;60675;60702.696486517285;60841.39158608357;535128;537426;537945;538686;539163;30987.69012309848;31773.205669857514;32061.67938320587;32165.678343217205;34006.65993340035;53836;53921;54266.45733542614;54703.452965469834;55741.72129139328;44598;45419;45705.31442028439;45725;46727.766361169335;46421.53578464307;47805.521944781496;48582;48590.757046214545;49106.75446622744;45080.0983980312;45709.77145114253;45858.312125318815;47107.528924710314;49124.75437622932;39810.60189398069;40200.19599607933;40317.59682403138;41565.584344156174;41728;29300.853495732386;30835.84582077075;31180;32580.837095814368;32802.83598581992 03:45:29 INFO - PROCESS | 6575 | |2;jquery.html;393.92909276330283;395.4562476594682;405.8254950371339;407.78998815609964;423.8135220502978;19099.71350429743;20490.692639610417;20945.790542094575;21076.683849742247;21247.46881327966;19467.221311147572;19612.803871961278;20121.899390503026;20259.493512662153;20285.492862678402;5607.467290607396;5781.942180578182;5804.709764511757;5836.620619659709;5841.240638716982;5537.031019571579;5617.9719101404435;5697.173909783079;5701.600887937846;5701.629394089392;5599.356074051475;5601.383847776741;5613.971930140344;5656.773729050833;5673.8581535461735;5625.774969001235;5657.632253903504;5666.235058267163;5677.432256774331;5688.175214593882;5063.088644044071;5128.179491281415;5140.126178549655;5162.070827251093;5175.197844334134;22481.437964050867;22511.437214069614;22851.657225141636;22942.311730648107;23077.19229826965;2388.8447250928634;2457.4470744082437;2574.5751950928075;2616.8953241870304;2648.205538338491;10143.492825358702;10503.474826258656;10802.405867677275;10863.728406789814;10938.398388088652;2024.0992758222596;2087.9060442280133;2113.619548481273;2115.7355330583678;2123.0340195211143;88259.55870220672;89034.55482722545;89719.55140224258;89871.99999999935;90493;11068.225224234226;11214.383208923424;11250.887491125148;11388.202825802115;11555.364454955059;15414;15452.690946181014;15495.225238738018;15532.68934621324;15558.533244002698;8190.672373105128;8314.168583141638;8380.53907035119;8422.873656895152;8500.659973600987;7855.703808871473;7919.515413218281;7967.920320796834;8082.272595466318;8085.474444161228;4661.743604101807;4807.807687692453;4862.756862156878;4913.459519452857;4952.603791696655;1966.4002479243968;1977.3079422202113;2017.324196394195;2030.3705851185885;2046.6213750456213;962.5187406296851;1060.128708584055;1065.3980501016902;1084.1814430105221;1121.0695123047851;19640.312589059315;20038.998050097438;20531.897340513202;20540.589188216152;20790.1683932644;1063.6224140430036;1076.4402510694395;1089.411717672448;1090.3185509056839;1097.668575872224;11202.439878006067;11420.42897855104;11535.76928461426;11555.364454955059;11640.126990475748;528084;536956;547112;547424;555702;59374.40625593775;81112;94828.52585737027;96410.51794740981;100492;985.5663508056432;1000.5447521377756;1075.4891426572472;1121.8485504456794;1142.5886680794906;18656.533586660444;19275.8072419274;19352.129154187813;19355.806441935965;19544.80455195487;33143.33713325672;36452.63547364492;37821.43267851039;45605.77197113993;46067;66760.66619666871;67540;67547.66226168838;67773.32226677868;68994;8876.156765107304;8919.866202006846;8987.146221108984;9012.81974360496;9225.815483690423;13433.395497202844;13559.79660305116;13941.860581394056;14014.789778153132;14424.567262982127;11884;12171.695707607381;12466.750664986468;12548.372581371077;12700.428480718205;12142.392880356123;12282.385880706108;12340.876591233973;12484.812727809272;12758.425870835648;12286.508539658313;12298;12300;12549.686257843627;12628.242305461701;8759.824803503767;8850.291976641982;9003.864942025744;9100.271978241857;9166.862497062417;12380.257184568954;12453;12461.501539938663;12614.432350544064;12898.613041608767 03:45:29 INFO - PROCESS | 6575 | |3;mootools.html;1569.3722510995601;1571.214392803598;1759.296281487405;1855.1744473709205;1866.356107143036;8546.444481108723;9034.90965090349;9184.311176661744;9837.213022958154;9838.655647052346;9201.21789647879;9624.133827955482;9631.036896310365;9635.80728385432;9636.710898673033;2427.526632306701;2462.9507409851794;2466.839655422401;2468.568000599897;2471.789897858675;2437.549053425122;2507.53610582042;2523.684539432571;2525.6211568264816;2527.4186937004406;2488.962665560018;2494.725580186178;2546.5161619292367;2550.426154115328;2550.6429099926027;2469.604863221885;2480.5659009673236;2489;2515.710693270279;2518.962215566768;2444.5721998650342;2450.1669432393073;2450.2894160693377;2452.766987136219;2482.7889629381525;9601.807963840683;9650.08324209206;9659.420434773936;9739.951300243525;9746.658866939622;5478.369987451454;5730.111832665943;5745.712714364265;5747.798827041075;5755.366909639936;3580.2481478889204;3681.5398075240596;3685.4471829225563;3725.4970578972034;3736.4582135590185;1211.1945556205112;1222.10175520992;1228.8955438787714;1272.2811611439506;1281.4041470716068;13006;13064.346782660828;13098.803517947239;13129.803052954214;13136.474541018444;4879.536444037811;4992.650514464025;5206.843794686166;5240.135377662719;5280.049591073644;10316.123129533924;10426.322289051188;10435.16518678504;10445.477726113815;10456.477176141163;5752.741126649311;5755.568332375088;5757.942420575824;5760.8271751847515;5761.3950535194035;4644.465886423037;5113.616478764107;5123.538881500608;5157;5384.892302153935;4142.523609784853;4185.455890734185;4221.387898754725;4249.171411574775;4280.957190428118;1231.5073970411727;1261.3504045416619;1265.5507294910358;1266.5503746170161;1285.9807102893465;870.2907130688469;987.3384832162468;1012.9409184263629;1013.8783345998528;1040.9479526023667;6190.226221722285;6337.904931426032;6343.714532846033;6615.86768264632;6696.363845434676;480.8341122312797;483.87177397989564;485.33993768474846;486.82230985689966;488.91199584074496;4530.546945305509;4623.491415944243;4628.190066738307;4664.090502352076;4700.506446823034;11692.356920369291;12023;12153.878461215452;12171.878281217252;12176.573819916437;11747.118966077578;11793;12085.758284834254;12099.395030248452;12104.515819367127;8453.577321133918;8528.74413767588;8597.742067737978;8600.0109987351;8621.913780862236;6463.57986730861;6513.2835388108215;6530.67346632676;6597.901031484627;6627.768028118992;10917.672469825919;10957.287776294515;11017.779644407226;11026.44867756625;11047.226694131656;10878.510467028844;10923.453827308444;11088.279261847954;11169.553217871195;11186.552537898393;7207.27927207296;7756.418268629763;7773.961130194539;7997.720079797179;8075.515469071875;9038.231750301298;9168.31237657165;9171.128742769426;9176.990531041447;9192.862107068266;8286.254237118688;8316.251537361666;8429.747107586782;8461.23848853606;8488.405811593377;8295.211954864279;8296.170382961896;8298.54358010291;8312.87530687028;8367.07962124178;7745.22547745221;7856.646450909609;7903.802404939923;7928.246816552418;7931.682732690859;5474.233607294902;5502.367227768857;5585.441455854382;5637.830865074055;5724.885502289848;5858.091995740667;5881.264841894763;5946.821595352147;6011.308699499614;6058.0610005449225 03:45:29 INFO - PROCESS | 6575 | |4;prototype.html;350.94209455439847;352.964703529647;355.7634173274772;358.96948759355456;359.0467309293826;5902.793402230923;5914.467697907187;5922.496587790043;5950.58345915785;5967.433093856088;5715.3998830122755;5777.768889244425;5823.2138661280715;5834.6790926499025;5837.328707198673;4482.910341793162;4540.364348991136;4545.681802273843;4570.54294570542;4584.15193189261;4560.612347950429;4568.3147527870915;4568.538067818299;4571.908561828778;4591.104734576759;4455.866324010269;4540.818367265306;4546.977265113686;4549.363089167519;4552.68131230814;4379.978100109495;4501.234790085693;4547.295169248771;4557.954420455802;4569.451665800092;4022.839086436539;4032.334664780308;4043.3328500797334;4045.2111838191563;4058.817353219112;5710.428957104298;5760.82717518471;5769.3076830780155;5793.449622285876;5795.681237531934;5112.616553758483;5228.032813929435;5237.921431178535;5248.8425347239645;5281.339832520935;6064.332923378425;6094.288041821391;6119.714859879431;6134.9079763803575;6177.752889884399;4123.587641235882;4460.910781784346;4482.5965663090155;4507.414036175309;4510.751908645023;6130.724117414682;6313.147725057104;6330.290821478221;6338.39785220408;6416.358364163546;4417.8232870684815;4459.732416055047;4460.576245256695;4470.173017991682;4473.753943533137;4539.954600454019;4544.863654090383;4556.521565235603;4558.1795276849825;4559.38448309474;5012.624053196025;5179.456157103526;5196.233280684585;5213.2701421800975;5237.16205407133;6147.44672979434;6154.092231408278;6158.353372895782;6158.491169663372;6171.691415429211;1567.1067491529718;1575.4249698859833;1588.4758029850123;1588.626672731907;1593.0919375955593;995.9053889880449;998.201438848918;1005.4060523848453;1006.8389057750871;1020.4438580973388;5195.922061169085;5216.556592689588;5224.320838291073;5228.666689994027;5260.263563101169;5505.504504594525;5535.723213839292;5555.694436806015;5581.386047534768;5613.326400831845;4998.775055122528;5250.7637156328055;5287.894242115213;5310.9734451327495;5322.600804939568;2960.4901500235037;2979.553067039961;2986.3131479759777;3014.593029940974;3020.9546856797165;5556.277683901067;5634.887302253932;5678.744456499468;5683.209788916478;5714.514266287412;5603.663780173202;5629.24005259293;5638.830835074954;5649.745761440745;5660.801871934463;5647.915281270784;5678.801241956512;5716.28546431696;5773.094878690106;5774.566907481955;5416.485433883775;5540.864122854725;5602.159676048625;5615.410381909841;5622.409646987171;5434.3207099112615;5519.641223320471;5541.501264886179;5553.583481238842;5567;6291.112666200213;6372.808815735535;6578.407943284936;6579.572327798678;6592.253052940879;4388.451443569554;4416.6025057744955;4438.667099967451;4448.510663827041;4452.842261012095;6176.938230617637;6329.49984756028;6337.841553961188;6366.4588509977175;6409.9679501602195;6151.384861513813;6164.907526387018;6166.167567378347;6179.567430279837;6189.752409903554;5919.200907877382;6183.145056482947;6202.317745048132;6212.78850624124;6249.468795152463;6107.144999699956;6111.297200821785;6124.5712800103565;6129.540284478593;6162.476189523762;6188.597741146811;6189.96905015472;6223.906641400473;6240.095186198067;6261.681308906287;5755.683437410982;6050.969745151246;6068.118883146239;6085.9695701521205;6171.919914014939 03:45:29 INFO - PROCESS | 6575 | |5;yui.html;839.9211950422705;844.5692696724668;891.2157301574613;894.0567701075365;918.8437965545857;16560.337586496542;17764.822351776478;17809;17987.19057642406;18183.090845457722;15968.520944371658;16206.432774852883;16314.75527867083;16441;16666.416675416363;870.2994089757774;875.2910142784333;889.7864512516982;891.9108089191094;891.9554022298892;874.868769684546;895.50299583731;895.5566994337812;898.1826537850558;898.716904175186;938.0291398402654;944.1644144931751;945.0738276489045;950.6957773512479;951.538503825644;946.5267366316841;948.1040416806121;948.5778828421355;949.4777872170279;950.0357137505438;696.5124412910983;696.5368030259871;698.7938558125365;701.7894631610496;702.6135625406006;17108.315667373292;17192.398266060627;17241.741373879402;17256.396026139024;17256.913715431467;13904.86095139056;14294.928525357307;14479.42082316706;15181.316840742193;15551.169387633634;13304.667383315398;13446.529371471952;13472.865271347258;13473.797893031613;13515.121517101357;4062.5734297898885;4110.46563946685;4117.341225403921;4157;4161.583841615845;94173.5291323539;94593.99999999932;95031.52484237535;95936.52031739867;96077;11369;11486;11531.827022594667;11633.069354451623;12103.33431661267;23750.406239843796;23777.881110594335;23791.881040594686;23858.642120368208;23871.880640596686;8945.105489451133;8953.59708813105;8969.37214394986;9019.098090191059;9351;5367.463253674601;5422.547168869033;5427.620066595379;5549.417311182348;5558.055130627803;4017.4375587417785;4124.1957818225155;4147.937780933288;4149.896252593649;4152.854650087293;672.8418821576926;681.6898311268361;686.6806934775353;706.4030893894651;716.9103862017248;759.5404780108065;763.904511936008;774.5662429039755;778.4784194589638;814.7881550796717;10526.73683157912;10548;10642.467876606139;10969.83545246822;11001.394923279297;654.9246836613851;695.7078027228577;729.2525161709291;747.9513831600929;785.3442375616424;5106.208537676666;5226.973865130726;5238.109521381374;5246.6065045121;5258.842234732964;75997;96253.5187324059;108134.45932770286;128232;131813.34093329473;104568;106362;111290;114213.42893285646;114758.4262078701;54383.45616543863;54598.727006364716;87235.56382218048;87838;88330.55834720914;10484.842727359248;10699.641784203406;11110.333379997226;11161.944190278997;11211.383373914514;52876;53741.193882091015;53763.46236537741;53885;55114.17328739992;78322;82613.17386826055;82894;85186;85253.57373213094;12905.677358066123;13131.540396086091;13566.525171618947;13673.179609223478;13725.794113088112;15821.525354239391;15897.761533577237;15913.920430397773;16013.519594412186;16310.184490775651;15718.371265149266;15918.442854500037;15952.92023539875;16889.155542222594;17219.569510762332;13992.860071399156;14131.081479703786;16615.169241538115;17090.74363884518;17136.14319284006;12944.741105178033;14897;15302.464413745465;15343.156126413154;15589.064656120669;12520;12754.61736147917;13189.472421103048;13523.59429217125;13629.931850340685;10619.787604248026;11576.88423115758;12359.134860559674;12512.812307815571;12582.433790479266 03:45:29 INFO - PROCESS | 6575 | __end_tp_report 03:45:29 INFO - PROCESS | 6575 | __start_cc_report 03:45:29 INFO - PROCESS | 6575 | _x_x_mozilla_cycle_collect,319 03:45:29 INFO - PROCESS | 6575 | __end_cc_report 03:45:29 INFO - PROCESS | 6575 | __startTimestamp1472899529046__endTimestamp 03:45:29 INFO - PROCESS | 6575 | 03:45:29 INFO - PROCESS | 6575 | ------- Summary: start ------- 03:45:29 INFO - PROCESS | 6575 | Number of tests: 6 03:45:29 INFO - PROCESS | 6575 | 03:45:29 INFO - PROCESS | 6575 | [#0] dojo.html Cycles:165 Average:5731.84 Median:5968.13 stddev:651.72 (10.9%) stddev-sans-first:624.16 03:45:29 INFO - PROCESS | 6575 | Values: 3258.1 3298.7 3311.1 3318.7 3325.9 5792.0 5794.4 5822.8 5825.8 5850.2 5681.4 5748.6 5783.9 5787.6 5799.4 5240.8 5259.1 5271.3 5313.9 5341.1 5158.5 5189.6 5230.3 5258.7 5291.1 5272.2 5282.6 5291.2 5325.2 5345.4 5287.5 5291.7 5302.7 5307.9 5317.4 5021.1 5070.4 5182.1 5207.8 5259.2 5625.2 5701.4 5708.2 5729.5 5739.6 6047.5 6060.9 6088.8 6104.3 6118.6 5925.2 6133.9 6156.4 6167.2 6170.2 5760.6 5845.4 5849.0 5874.8 5878.9 6348.4 6375.7 6376.4 6377.6 6382.9 5866.7 5945.2 6085.1 6120.4 6159.7 6007.1 6116.1 6133.9 6134.9 6139.1 6044.2 6060.9 6086.0 6102.5 6119.4 5931.7 6102.8 6116.6 6120.8 6125.4 4681.5 4707.5 4715.5 4747.3 4767.7 4209.9 4219.2 4219.8 4235.2 4239.8 5739.1 5901.0 5985.8 5993.2 6014.2 6133.0 6196.0 6210.7 6221.3 6235.4 5964.7 5968.9 5979.0 5988.7 6021.5 5180.3 5235.1 5338.4 5343.0 5359.4 6339.4 6427.0 6457.7 6459.2 6473.6 6193.9 6224.6 6230.0 6235.3 6236.1 6138.8 6295.9 6321.7 6428.3 6444.4 6115.1 6118.1 6121.1 6121.9 6124.2 6183.8 6214.3 6217.9 6222.9 6234.0 5868.6 5896.7 5947.6 6069.8 6090.7 6023.5 6026.6 6037.4 6050.1 6057.7 5903.8 5947.5 5960.3 5974.3 6000.2 5940.7 5951.7 6003.4 6032.2 6035.1 5924.6 5962.6 5968.1 5982.5 5983.2 03:45:29 INFO - PROCESS | 6575 | 03:45:29 INFO - PROCESS | 6575 | [#1] ext.html Cycles:180 Average:66963.33 Median:219734.36 stddev:138697.10 (63.1%) stddev-sans-first:138996.63 03:45:29 INFO - PROCESS | 6575 | Values: 581.0 641.7 657.5 677.0 704.7 35378.0 39020.2 39102.8 39107.8 39144.6 39799.6 39881.4 40326.8 40408.4 40435.8 9228.6 9336.1 9340.3 9342.9 9345.9 9317.0 9351.1 9370.5 9404.2 9419.5 9137.6 9176.3 9222.2 9238.5 9243.2 9331.0 9395.2 9414.0 9415.8 9449.9 9242.6 9254.7 9278.0 9333.4 9338.9 45242.1 45585.3 45626.1 45742.3 45748.8 3768.1 3948.3 4061.5 4172.8 4398.7 35560.6 35735.3 35745.0 36476.1 37076.4 4850.0 4854.2 4863.2 4918.4 4946.1 393557.0 395977.0 396752.0 397343.0 397773.0 39082.6 67081.3 67373.7 67554.3 67704.3 39141.2 39641.4 39675.8 40057.8 40101.6 14708.6 14760.8 14812.0 14830.5 14855.0 12080.1 12118.0 12129.5 12152.6 12181.1 9265.3 9344.0 9353.4 9397.1 9473.0 3487.3 3537.9 3546.6 3560.0 3564.8 1037.6 1076.5 1141.3 1155.7 1247.9 32967.7 33829.3 33986.4 34099.5 34188.8 1198.4 1210.5 1213.0 1269.6 1303.8 17670.6 17802.5 18024.9 18043.9 18121.8 435070.0 630169.0 640153.0 647170.0 647176.0 67995.0 68042.7 68153.3 68167.0 68601.0 1438.1 1457.9 1486.4 1490.1 1492.1 35373.8 35625.6 35674.8 35938.3 36078.3 59497.4 60557.4 60675.0 60702.7 60841.4 535128.0 537426.0 537945.0 538686.0 539163.0 30987.7 31773.2 32061.7 32165.7 34006.7 53836.0 53921.0 54266.5 54703.5 55741.7 44598.0 45419.0 45705.3 45725.0 46727.8 46421.5 47805.5 48582.0 48590.8 49106.8 45080.1 45709.8 45858.3 47107.5 49124.8 39810.6 40200.2 40317.6 41565.6 41728.0 29300.9 30835.8 31180.0 32580.8 32802.8 03:45:29 INFO - PROCESS | 6575 | 03:45:29 INFO - PROCESS | 6575 | [#2] jquery.html Cycles:180 Average:31087.05 Median:22681.55 stddev:89404.21 (394.2%) stddev-sans-first:89625.31 03:45:29 INFO - PROCESS | 6575 | Values: 393.9 395.5 405.8 407.8 423.8 19099.7 20490.7 20945.8 21076.7 21247.5 19467.2 19612.8 20121.9 20259.5 20285.5 5607.5 5781.9 5804.7 5836.6 5841.2 5537.0 5618.0 5697.2 5701.6 5701.6 5599.4 5601.4 5614.0 5656.8 5673.9 5625.8 5657.6 5666.2 5677.4 5688.2 5063.1 5128.2 5140.1 5162.1 5175.2 22481.4 22511.4 22851.7 22942.3 23077.2 2388.8 2457.4 2574.6 2616.9 2648.2 10143.5 10503.5 10802.4 10863.7 10938.4 2024.1 2087.9 2113.6 2115.7 2123.0 88259.6 89034.6 89719.6 89872.0 90493.0 11068.2 11214.4 11250.9 11388.2 11555.4 15414.0 15452.7 15495.2 15532.7 15558.5 8190.7 8314.2 8380.5 8422.9 8500.7 7855.7 7919.5 7967.9 8082.3 8085.5 4661.7 4807.8 4862.8 4913.5 4952.6 1966.4 1977.3 2017.3 2030.4 2046.6 962.5 1060.1 1065.4 1084.2 1121.1 19640.3 20039.0 20531.9 20540.6 20790.2 1063.6 1076.4 1089.4 1090.3 1097.7 11202.4 11420.4 11535.8 11555.4 11640.1 528084.0 536956.0 547112.0 547424.0 555702.0 59374.4 81112.0 94828.5 96410.5 100492.0 985.6 1000.5 1075.5 1121.8 1142.6 18656.5 19275.8 19352.1 19355.8 19544.8 33143.3 36452.6 37821.4 45605.8 46067.0 66760.7 67540.0 67547.7 67773.3 68994.0 8876.2 8919.9 8987.1 9012.8 9225.8 13433.4 13559.8 13941.9 14014.8 14424.6 11884.0 12171.7 12466.8 12548.4 12700.4 12142.4 12282.4 12340.9 12484.8 12758.4 12286.5 12298.0 12300.0 12549.7 12628.2 8759.8 8850.3 9003.9 9100.3 9166.9 12380.3 12453.0 12461.5 12614.4 12898.6 03:45:29 INFO - PROCESS | 6575 | 03:45:29 INFO - PROCESS | 6575 | [#3] mootools.html Cycles:180 Average:6249.04 Median:484.61 stddev:3566.04 (735.9%) stddev-sans-first:3558.70 03:45:29 INFO - PROCESS | 6575 | Values: 1569.4 1571.2 1759.3 1855.2 1866.4 8546.4 9034.9 9184.3 9837.2 9838.7 9201.2 9624.1 9631.0 9635.8 9636.7 2427.5 2463.0 2466.8 2468.6 2471.8 2437.5 2507.5 2523.7 2525.6 2527.4 2489.0 2494.7 2546.5 2550.4 2550.6 2469.6 2480.6 2489.0 2515.7 2519.0 2444.6 2450.2 2450.3 2452.8 2482.8 9601.8 9650.1 9659.4 9740.0 9746.7 5478.4 5730.1 5745.7 5747.8 5755.4 3580.2 3681.5 3685.4 3725.5 3736.5 1211.2 1222.1 1228.9 1272.3 1281.4 13006.0 13064.3 13098.8 13129.8 13136.5 4879.5 4992.7 5206.8 5240.1 5280.0 10316.1 10426.3 10435.2 10445.5 10456.5 5752.7 5755.6 5757.9 5760.8 5761.4 4644.5 5113.6 5123.5 5157.0 5384.9 4142.5 4185.5 4221.4 4249.2 4281.0 1231.5 1261.4 1265.6 1266.6 1286.0 870.3 987.3 1012.9 1013.9 1040.9 6190.2 6337.9 6343.7 6615.9 6696.4 480.8 483.9 485.3 486.8 488.9 4530.5 4623.5 4628.2 4664.1 4700.5 11692.4 12023.0 12153.9 12171.9 12176.6 11747.1 11793.0 12085.8 12099.4 12104.5 8453.6 8528.7 8597.7 8600.0 8621.9 6463.6 6513.3 6530.7 6597.9 6627.8 10917.7 10957.3 11017.8 11026.4 11047.2 10878.5 10923.5 11088.3 11169.6 11186.6 7207.3 7756.4 7774.0 7997.7 8075.5 9038.2 9168.3 9171.1 9177.0 9192.9 8286.3 8316.3 8429.7 8461.2 8488.4 8295.2 8296.2 8298.5 8312.9 8367.1 7745.2 7856.6 7903.8 7928.2 7931.7 5474.2 5502.4 5585.4 5637.8 5724.9 5858.1 5881.3 5946.8 6011.3 6058.1 03:45:29 INFO - PROCESS | 6575 | 03:45:29 INFO - PROCESS | 6575 | [#4] prototype.html Cycles:180 Average:5001.89 Median:5554.64 stddev:1453.16 (26.2%) stddev-sans-first:1414.68 03:45:29 INFO - PROCESS | 6575 | Values: 350.9 353.0 355.8 359.0 359.0 5902.8 5914.5 5922.5 5950.6 5967.4 5715.4 5777.8 5823.2 5834.7 5837.3 4482.9 4540.4 4545.7 4570.5 4584.2 4560.6 4568.3 4568.5 4571.9 4591.1 4455.9 4540.8 4547.0 4549.4 4552.7 4380.0 4501.2 4547.3 4558.0 4569.5 4022.8 4032.3 4043.3 4045.2 4058.8 5710.4 5760.8 5769.3 5793.4 5795.7 5112.6 5228.0 5237.9 5248.8 5281.3 6064.3 6094.3 6119.7 6134.9 6177.8 4123.6 4460.9 4482.6 4507.4 4510.8 6130.7 6313.1 6330.3 6338.4 6416.4 4417.8 4459.7 4460.6 4470.2 4473.8 4540.0 4544.9 4556.5 4558.2 4559.4 5012.6 5179.5 5196.2 5213.3 5237.2 6147.4 6154.1 6158.4 6158.5 6171.7 1567.1 1575.4 1588.5 1588.6 1593.1 995.9 998.2 1005.4 1006.8 1020.4 5195.9 5216.6 5224.3 5228.7 5260.3 5505.5 5535.7 5555.7 5581.4 5613.3 4998.8 5250.8 5287.9 5311.0 5322.6 2960.5 2979.6 2986.3 3014.6 3021.0 5556.3 5634.9 5678.7 5683.2 5714.5 5603.7 5629.2 5638.8 5649.7 5660.8 5647.9 5678.8 5716.3 5773.1 5774.6 5416.5 5540.9 5602.2 5615.4 5622.4 5434.3 5519.6 5541.5 5553.6 5567.0 6291.1 6372.8 6578.4 6579.6 6592.3 4388.5 4416.6 4438.7 4448.5 4452.8 6176.9 6329.5 6337.8 6366.5 6410.0 6151.4 6164.9 6166.2 6179.6 6189.8 5919.2 6183.1 6202.3 6212.8 6249.5 6107.1 6111.3 6124.6 6129.5 6162.5 6188.6 6190.0 6223.9 6240.1 6261.7 5755.7 6051.0 6068.1 6086.0 6171.9 03:45:29 INFO - PROCESS | 6575 | 03:45:29 INFO - PROCESS | 6575 | [#5] yui.html Cycles:180 Average:22164.45 Median:4113.90 stddev:31319.18 (761.3%) stddev-sans-first:31366.11 03:45:29 INFO - PROCESS | 6575 | Values: 839.9 844.6 891.2 894.1 918.8 16560.3 17764.8 17809.0 17987.2 18183.1 15968.5 16206.4 16314.8 16441.0 16666.4 870.3 875.3 889.8 891.9 892.0 874.9 895.5 895.6 898.2 898.7 938.0 944.2 945.1 950.7 951.5 946.5 948.1 948.6 949.5 950.0 696.5 696.5 698.8 701.8 702.6 17108.3 17192.4 17241.7 17256.4 17256.9 13904.9 14294.9 14479.4 15181.3 15551.2 13304.7 13446.5 13472.9 13473.8 13515.1 4062.6 4110.5 4117.3 4157.0 4161.6 94173.5 94594.0 95031.5 95936.5 96077.0 11369.0 11486.0 11531.8 11633.1 12103.3 23750.4 23777.9 23791.9 23858.6 23871.9 8945.1 8953.6 8969.4 9019.1 9351.0 5367.5 5422.5 5427.6 5549.4 5558.1 4017.4 4124.2 4147.9 4149.9 4152.9 672.8 681.7 686.7 706.4 716.9 759.5 763.9 774.6 778.5 814.8 10526.7 10548.0 10642.5 10969.8 11001.4 654.9 695.7 729.3 748.0 785.3 5106.2 5227.0 5238.1 5246.6 5258.8 75997.0 96253.5 108134.5 128232.0 131813.3 104568.0 106362.0 111290.0 114213.4 114758.4 54383.5 54598.7 87235.6 87838.0 88330.6 10484.8 10699.6 11110.3 11161.9 11211.4 52876.0 53741.2 53763.5 53885.0 55114.2 78322.0 82613.2 82894.0 85186.0 85253.6 12905.7 13131.5 13566.5 13673.2 13725.8 15821.5 15897.8 15913.9 16013.5 16310.2 15718.4 15918.4 15952.9 16889.2 17219.6 13992.9 14131.1 16615.2 17090.7 17136.1 12944.7 14897.0 15302.5 15343.2 15589.1 12520.0 12754.6 13189.5 13523.6 13629.9 10619.8 11576.9 12359.1 12512.8 12582.4 03:45:29 INFO - PROCESS | 6575 | -------- Summary: end -------- 03:45:29 INFO - PROCESS | 6575 | 03:45:29 INFO - TEST-INFO | 6575: exit 0 03:45:29 INFO - TEST-OK | dromaeo_css | took 1110931ms 03:45:29 INFO - TEST-START | kraken 03:45:29 INFO - operating with platform_type : linux_ 03:45:29 INFO - Initialising browser for kraken test... 03:45:29 INFO - TEST-INFO | started process 6836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpusmYkM/profile http://localhost:56240/getInfo.html) 03:45:33 INFO - PROCESS | 6836 | __metrics Screen width/height:1600/1200 03:45:33 INFO - PROCESS | 6836 | colorDepth:24 03:45:33 INFO - PROCESS | 6836 | Browser inner width/height: 1024/697 03:45:33 INFO - PROCESS | 6836 | __metrics 03:45:34 ERROR - PROCESS | 6836 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:45:35 INFO - TEST-INFO | 6836: exit 0 03:45:35 INFO - Browser initialized. 03:45:35 INFO - Running cycle 1/1 for kraken test... 03:45:35 INFO - TEST-INFO | started process 6962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpusmYkM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:47 INFO - PROCESS | 6962 | RSS: Main: 152444928 03:45:47 INFO - PROCESS | 6962 | 03:45:49 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56240/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:50 INFO - PROCESS | 6962 | RSS: Main: 157929472 03:45:50 INFO - PROCESS | 6962 | 03:45:53 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56240/tests/kraken/driver.html?testName=audio-dft) 03:45:53 INFO - PROCESS | 6962 | RSS: Main: 156426240 03:45:53 INFO - PROCESS | 6962 | 03:45:56 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56240/tests/kraken/driver.html?testName=audio-fft) 03:45:57 INFO - PROCESS | 6962 | RSS: Main: 156925952 03:45:57 INFO - PROCESS | 6962 | 03:45:59 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56240/tests/kraken/driver.html?testName=audio-oscillator) 03:45:59 INFO - PROCESS | 6962 | RSS: Main: 156897280 03:45:59 INFO - PROCESS | 6962 | 03:46:02 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:02 INFO - PROCESS | 6962 | RSS: Main: 156688384 03:46:02 INFO - PROCESS | 6962 | 03:46:05 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56240/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:06 INFO - PROCESS | 6962 | RSS: Main: 155938816 03:46:06 INFO - PROCESS | 6962 | 03:46:09 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56240/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:10 INFO - PROCESS | 6962 | RSS: Main: 154808320 03:46:10 INFO - PROCESS | 6962 | 03:46:13 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56240/tests/kraken/driver.html?testName=json-parse-financial) 03:46:13 INFO - PROCESS | 6962 | RSS: Main: 156524544 03:46:13 INFO - PROCESS | 6962 | 03:46:15 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:16 INFO - PROCESS | 6962 | RSS: Main: 156667904 03:46:16 INFO - PROCESS | 6962 | 03:46:17 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56240/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:18 INFO - PROCESS | 6962 | RSS: Main: 156565504 03:46:18 INFO - PROCESS | 6962 | 03:46:20 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:21 INFO - PROCESS | 6962 | RSS: Main: 156749824 03:46:21 INFO - PROCESS | 6962 | 03:46:23 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:24 INFO - PROCESS | 6962 | RSS: Main: 157339648 03:46:24 INFO - PROCESS | 6962 | 03:46:26 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:27 INFO - PROCESS | 6962 | RSS: Main: 157806592 03:46:27 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | Cycle 1(1): loaded http://localhost:56240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56240/tests/kraken/driver.html?testName=ai-astar) 03:46:29 INFO - PROCESS | 6962 | RSS: Main: 158384128 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | __start_tp_report 03:46:29 INFO - PROCESS | 6962 | _x_x_mozilla_page_load 03:46:29 INFO - PROCESS | 6962 | _x_x_mozilla_page_load_details 03:46:29 INFO - PROCESS | 6962 | |i|pagename|runs| 03:46:29 INFO - PROCESS | 6962 | |0;ai-astar;100;111;105;109;111;120;110;112;109;110 03:46:29 INFO - PROCESS | 6962 | |1;audio-beat-detection;142;116;149;173;116;146;147;119;173;118 03:46:29 INFO - PROCESS | 6962 | |2;audio-dft;162;162;165;163;161;164;160;160;160;163 03:46:29 INFO - PROCESS | 6962 | |3;audio-fft;75;75;76;175;76;74;75;75;161;76 03:46:29 INFO - PROCESS | 6962 | |4;audio-oscillator;83;82;158;83;84;82;140;84;83;142 03:46:29 INFO - PROCESS | 6962 | |5;imaging-gaussian-blur;118;117;117;117;117;117;118;117;117;117 03:46:29 INFO - PROCESS | 6962 | |6;imaging-darkroom;148;146;146;147;147;147;146;147;147;148 03:46:29 INFO - PROCESS | 6962 | |7;imaging-desaturate;96;96;97;95;97;94;95;95;94;95 03:46:29 INFO - PROCESS | 6962 | |8;json-parse-financial;51;55;51;50;54;51;52;51;58;52 03:46:29 INFO - PROCESS | 6962 | |9;json-stringify-tinderbox;62;58;58;59;59;58;62;60;60;64 03:46:29 INFO - PROCESS | 6962 | |10;stanford-crypto-aes;72;80;74;77;72;72;72;73;72;72 03:46:29 INFO - PROCESS | 6962 | |11;stanford-crypto-ccm;118;117;126;121;121;135;122;125;156;117 03:46:29 INFO - PROCESS | 6962 | |12;stanford-crypto-pbkdf2;152;152;156;154;154;154;155;156;158;154 03:46:29 INFO - PROCESS | 6962 | |13;stanford-crypto-sha256-iterative;64;65;64;63;65;62;60;66;61;61 03:46:29 INFO - PROCESS | 6962 | __end_tp_report 03:46:29 INFO - PROCESS | 6962 | __start_cc_report 03:46:29 INFO - PROCESS | 6962 | _x_x_mozilla_cycle_collect,861 03:46:29 INFO - PROCESS | 6962 | __end_cc_report 03:46:29 INFO - PROCESS | 6962 | __startTimestamp1472899589497__endTimestamp 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | ------- Summary: start ------- 03:46:29 INFO - PROCESS | 6962 | Number of tests: 14 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:5.08 (4.6%) stddev-sans-first:3.99 03:46:29 INFO - PROCESS | 6962 | Values: 100.0 111.0 105.0 109.0 111.0 120.0 110.0 112.0 109.0 110.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:146.50 stddev:22.17 (15.1%) stddev-sans-first:23.51 03:46:29 INFO - PROCESS | 6962 | Values: 142.0 116.0 149.0 173.0 116.0 146.0 147.0 119.0 173.0 118.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.76 (1.1%) stddev-sans-first:1.87 03:46:29 INFO - PROCESS | 6962 | Values: 162.0 162.0 165.0 163.0 161.0 164.0 160.0 160.0 160.0 163.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:39.25 (52.3%) stddev-sans-first:41.04 03:46:29 INFO - PROCESS | 6962 | Values: 75.0 75.0 76.0 175.0 76.0 74.0 75.0 75.0 161.0 76.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:83.00 stddev:31.11 (37.5%) stddev-sans-first:32.22 03:46:29 INFO - PROCESS | 6962 | Values: 83.0 82.0 158.0 83.0 84.0 82.0 140.0 84.0 83.0 142.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:46:29 INFO - PROCESS | 6962 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 03:46:29 INFO - PROCESS | 6962 | Values: 148.0 146.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 148.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:1.07 (1.1%) stddev-sans-first:1.12 03:46:29 INFO - PROCESS | 6962 | Values: 96.0 96.0 97.0 95.0 97.0 94.0 95.0 95.0 94.0 95.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:2.46 (4.7%) stddev-sans-first:2.55 03:46:29 INFO - PROCESS | 6962 | Values: 51.0 55.0 51.0 50.0 54.0 51.0 52.0 51.0 58.0 52.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:2.05 (3.4%) stddev-sans-first:2.05 03:46:29 INFO - PROCESS | 6962 | Values: 62.0 58.0 58.0 59.0 59.0 58.0 62.0 60.0 60.0 64.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:72.50 stddev:2.76 (3.8%) stddev-sans-first:2.86 03:46:29 INFO - PROCESS | 6962 | Values: 72.0 80.0 74.0 77.0 72.0 72.0 72.0 73.0 72.0 72.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:123.50 stddev:11.90 (9.6%) stddev-sans-first:12.28 03:46:29 INFO - PROCESS | 6962 | Values: 118.0 117.0 126.0 121.0 121.0 135.0 122.0 125.0 156.0 117.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:154.50 stddev:1.84 (1.2%) stddev-sans-first:1.72 03:46:29 INFO - PROCESS | 6962 | Values: 152.0 152.0 156.0 154.0 154.0 154.0 155.0 156.0 158.0 154.0 03:46:29 INFO - PROCESS | 6962 | 03:46:29 INFO - PROCESS | 6962 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:64.00 stddev:2.02 (3.2%) stddev-sans-first:2.12 03:46:29 INFO - PROCESS | 6962 | Values: 64.0 65.0 64.0 63.0 65.0 62.0 60.0 66.0 61.0 61.0 03:46:29 INFO - PROCESS | 6962 | -------- Summary: end -------- 03:46:29 INFO - PROCESS | 6962 | 03:46:30 INFO - TEST-INFO | 6962: exit 0 03:46:30 INFO - TEST-OK | kraken | took 60662ms 03:46:30 INFO - SUITE-END | took 1171s 03:46:30 INFO - Completed test suite (00:19:31) 03:46:30 INFO - javascript benchmark 03:46:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7689.112253915425, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3258.1040213941164, 3298.7361011119115, 3311.1391038330025, 3318.7179089777374, 3325.9334813303735, 5792.0443126884065, 5794.449527294911, 5822.767089316428, 5825.796097136601, 5850.180974663551, 5681.403452637465, 5748.5975981681295, 5783.913241301384, 5787.594868359217, 5799.3620701722775, 5240.764165612547, 5259.105951988152, 5271.26202331672, 5313.867153321178, 5341.145416733323, 5158.535731784139, 5189.558887494568, 5230.293910322115, 5258.710770907599, 5291.100512912795, 5272.209168624699, 5282.630215884889, 5291.1798671206025, 5325.227841962913, 5345.358556973169, 5287.47125287472, 5291.68249905005, 5302.734863256822, 5307.946920530784, 5317.388500322474, 5021.071101846133, 5070.416902056274, 5182.144946083891, 5207.843764687065, 5259.211118332242, 5625.1843482695185, 5701.429857014306, 5708.1723150143, 5729.512991395736, 5739.569532285053, 6047.546434017422, 6060.878782424371, 6088.817335479943, 6104.26748790148, 6118.571699981003, 5925.170476133345, 6133.946794548733, 6156.415140561639, 6167.167432396614, 6170.228721409824, 5760.567957403212, 5845.386234445407, 5848.970755146197, 5874.765009399619, 5878.941210587882, 6348.428641422294, 6375.681215939185, 6376.426121648981, 6377.553571249968, 6382.936170638327, 5866.677332746654, 5945.1973983512535, 6085.056816193497, 6120.418560236771, 6159.722812473449, 6007.128966299862, 6116.119654120117, 6133.854967165038, 6134.9079763803575, 6139.140520327158, 6044.214252147281, 6060.939390606038, 6085.9695701521205, 6102.542309326729, 6119.44924956756, 5931.703414829328, 6102.816915492543, 6116.602420842631, 6120.816375508742, 6125.356837532084, 4681.461631912373, 4707.482176960531, 4715.504871988392, 4747.335373047776, 4767.69010014348, 4209.936850947238, 4219.2194444027955, 4219.78901054946, 4235.237657221668, 4239.788010599457, 5739.110437882052, 5901.026330655393, 5985.790497332572, 5993.220881285492, 6014.248218972629, 6132.998044146438, 6196.0, 6210.689465526705, 6221.2845522765465, 6235.376462353819, 5964.671943043174, 5968.940310596925, 5978.970105149447, 5988.730507127189, 6021.488173505213, 5180.300659411007, 5235.0576896159055, 5338.386085600206, 5343.038253114477, 5359.410464848864, 6339.429451349401, 6427.035944608346, 6457.677116144174, 6459.192600924885, 6473.611583305017, 6193.876122477615, 6224.564280500322, 6229.972054610938, 6235.282942461494, 6236.095766113797, 6138.846528836815, 6295.937040629535, 6321.747130114744, 6428.260750013808, 6444.355564443518, 6115.113308570321, 6118.143459915526, 6121.1430399743185, 6121.908171377522, 6124.234470691164, 6183.84540386494, 6214.25428948529, 6217.875642487034, 6222.906656400067, 6234.0337247726675, 5868.618539794899, 5896.734646940812, 5947.583669143119, 6069.787557435468, 6090.725917333819, 6023.45788879003, 6026.608270462406, 6037.426444487766, 6050.062240352752, 6057.727877145849, 5903.793367232126, 5947.464728174485, 5960.344362120077, 5974.2830860297045, 6000.21997140369, 5940.702964851654, 5951.732172052355, 6003.429674180946, 6032.185654936703, 6035.1249068885645, 5924.6149000314845, 5962.582619216613, 5968.134620480093, 5982.52139828804, 5983.162357269899], "value": 5687.451595094981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.9535237181026, 641.6727468990815, 657.4838751580011, 677.0217036382427, 704.6576272201459, 35378.0, 39020.21959560814, 39102.80448597753, 39107.80446097769, 39144.60855391449, 39799.602003979955, 39881.40177897334, 40326.7983660082, 40408.39387409191, 40435.797821010856, 9228.584713687867, 9336.066393360677, 9340.3461757677, 9342.859857102116, 9345.906540934571, 9317.0, 9351.111644393772, 9370.531473426336, 9404.153626173644, 9419.529023548796, 9137.63449462024, 9176.265898728087, 9222.21611163052, 9238.491882946435, 9243.214326782232, 9331.0, 9395.201407880304, 9414.0, 9415.764605884839, 9449.905500944971, 9242.584083716249, 9254.676086337013, 9278.0, 9333.439993600407, 9338.906610933871, 45242.09515809665, 45585.316220256726, 45626.08747825058, 45742.313865292046, 45748.77125614384, 3768.1144930941205, 3948.348522493785, 4061.512618485771, 4172.833086676529, 4398.714083584557, 35560.644393555995, 35735.28529429397, 35745.0, 36476.0880977975, 37076.44385334222, 4849.951500484985, 4854.223324268136, 4863.19757240055, 4918.385201849769, 4946.1344264753525, 393557.0, 395977.0, 396751.9999999971, 397343.0, 397773.0, 39082.609173908466, 67081.3291867075, 67373.66313168402, 67554.32445675578, 67704.32295677079, 39141.2171756569, 39641.40537891934, 39675.80162099171, 40057.79971100184, 40101.5964441249, 14708.632284192767, 14760.778588321184, 14812.0, 14830.480933167288, 14855.0, 12080.093992950387, 12118.030557555374, 12129.454174562166, 12152.63542093721, 12181.147319687538, 9265.25877929764, 9344.0, 9353.438793672402, 9397.107274808883, 9472.95263523678, 3487.250241198104, 3537.9292414151573, 3546.627604101584, 3559.9644003559633, 3564.7757407472227, 1037.6420135053395, 1076.5478499030426, 1141.2752901907184, 1155.6764106050318, 1247.9376031198403, 32967.67032329646, 33829.323413531594, 33986.38280120968, 34099.4885076724, 34188.82905585506, 1198.3888217009214, 1210.4673943464848, 1213.0477575103678, 1269.581038257373, 1303.7848754955326, 17670.558236044202, 17802.46592602224, 18024.90987545054, 18043.909780451013, 18121.818781812275, 435070.0, 630169.0, 640153.0, 647170.0, 647176.0, 67995.0, 68042.65978670174, 68153.31846681569, 68167.0, 68601.0, 1438.1443041390355, 1457.9489717859824, 1486.3534362552325, 1490.0761527852585, 1492.0674578388507, 35373.82313088418, 35625.64374356327, 35674.8216258917, 35938.28123437464, 36078.27843443169, 59497.40502595092, 60557.39442605517, 60675.0, 60702.696486517285, 60841.39158608357, 535128.0, 537426.0, 537945.0, 538686.0, 539163.0, 30987.69012309848, 31773.205669857514, 32061.67938320587, 32165.678343217205, 34006.65993340035, 53836.0, 53921.0, 54266.45733542614, 54703.452965469834, 55741.72129139328, 44598.0, 45419.0, 45705.31442028439, 45725.0, 46727.766361169335, 46421.53578464307, 47805.521944781496, 48582.0, 48590.757046214545, 49106.75446622744, 45080.0983980312, 45709.77145114253, 45858.312125318815, 47107.528924710314, 49124.75437622932, 39810.60189398069, 40200.19599607933, 40317.59682403138, 41565.584344156174, 41728.0, 29300.853495732386, 30835.84582077075, 31180.0, 32580.837095814368, 32802.83598581992], "value": 20551.288161959492, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.92909276330283, 395.4562476594682, 405.8254950371339, 407.78998815609964, 423.8135220502978, 19099.71350429743, 20490.692639610417, 20945.790542094575, 21076.683849742247, 21247.46881327966, 19467.221311147572, 19612.803871961278, 20121.899390503026, 20259.493512662153, 20285.492862678402, 5607.467290607396, 5781.942180578182, 5804.709764511757, 5836.620619659709, 5841.240638716982, 5537.031019571579, 5617.9719101404435, 5697.173909783079, 5701.600887937846, 5701.629394089392, 5599.356074051475, 5601.383847776741, 5613.971930140344, 5656.773729050833, 5673.8581535461735, 5625.774969001235, 5657.632253903504, 5666.235058267163, 5677.432256774331, 5688.175214593882, 5063.088644044071, 5128.179491281415, 5140.126178549655, 5162.070827251093, 5175.197844334134, 22481.437964050867, 22511.437214069614, 22851.657225141636, 22942.311730648107, 23077.19229826965, 2388.8447250928634, 2457.4470744082437, 2574.5751950928075, 2616.8953241870304, 2648.205538338491, 10143.492825358702, 10503.474826258656, 10802.405867677275, 10863.728406789814, 10938.398388088652, 2024.0992758222596, 2087.9060442280133, 2113.619548481273, 2115.7355330583678, 2123.0340195211143, 88259.55870220672, 89034.55482722545, 89719.55140224258, 89871.99999999935, 90493.0, 11068.225224234226, 11214.383208923424, 11250.887491125148, 11388.202825802115, 11555.364454955059, 15414.0, 15452.690946181014, 15495.225238738018, 15532.68934621324, 15558.533244002698, 8190.672373105128, 8314.168583141638, 8380.53907035119, 8422.873656895152, 8500.659973600987, 7855.703808871473, 7919.515413218281, 7967.920320796834, 8082.272595466318, 8085.474444161228, 4661.743604101807, 4807.807687692453, 4862.756862156878, 4913.459519452857, 4952.603791696655, 1966.4002479243968, 1977.3079422202113, 2017.324196394195, 2030.3705851185885, 2046.6213750456213, 962.5187406296851, 1060.128708584055, 1065.3980501016902, 1084.1814430105221, 1121.0695123047851, 19640.312589059315, 20038.998050097438, 20531.897340513202, 20540.589188216152, 20790.1683932644, 1063.6224140430036, 1076.4402510694395, 1089.411717672448, 1090.3185509056839, 1097.668575872224, 11202.439878006067, 11420.42897855104, 11535.76928461426, 11555.364454955059, 11640.126990475748, 528084.0, 536956.0, 547112.0, 547424.0, 555702.0, 59374.40625593775, 81112.0, 94828.52585737027, 96410.51794740981, 100492.0, 985.5663508056432, 1000.5447521377756, 1075.4891426572472, 1121.8485504456794, 1142.5886680794906, 18656.533586660444, 19275.8072419274, 19352.129154187813, 19355.806441935965, 19544.80455195487, 33143.33713325672, 36452.63547364492, 37821.43267851039, 45605.77197113993, 46067.0, 66760.66619666871, 67540.0, 67547.66226168838, 67773.32226677868, 68994.0, 8876.156765107304, 8919.866202006846, 8987.146221108984, 9012.81974360496, 9225.815483690423, 13433.395497202844, 13559.79660305116, 13941.860581394056, 14014.789778153132, 14424.567262982127, 11884.0, 12171.695707607381, 12466.750664986468, 12548.372581371077, 12700.428480718205, 12142.392880356123, 12282.385880706108, 12340.876591233973, 12484.812727809272, 12758.425870835648, 12286.508539658313, 12298.0, 12300.0, 12549.686257843627, 12628.242305461701, 8759.824803503767, 8850.291976641982, 9003.864942025744, 9100.271978241857, 9166.862497062417, 12380.257184568954, 12453.0, 12461.501539938663, 12614.432350544064, 12898.613041608767], "value": 9584.35142209596, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.3722510995601, 1571.214392803598, 1759.296281487405, 1855.1744473709205, 1866.356107143036, 8546.444481108723, 9034.90965090349, 9184.311176661744, 9837.213022958154, 9838.655647052346, 9201.21789647879, 9624.133827955482, 9631.036896310365, 9635.80728385432, 9636.710898673033, 2427.526632306701, 2462.9507409851794, 2466.839655422401, 2468.568000599897, 2471.789897858675, 2437.549053425122, 2507.53610582042, 2523.684539432571, 2525.6211568264816, 2527.4186937004406, 2488.962665560018, 2494.725580186178, 2546.5161619292367, 2550.426154115328, 2550.6429099926027, 2469.604863221885, 2480.5659009673236, 2489.0, 2515.710693270279, 2518.962215566768, 2444.5721998650342, 2450.1669432393073, 2450.2894160693377, 2452.766987136219, 2482.7889629381525, 9601.807963840683, 9650.08324209206, 9659.420434773936, 9739.951300243525, 9746.658866939622, 5478.369987451454, 5730.111832665943, 5745.712714364265, 5747.798827041075, 5755.366909639936, 3580.2481478889204, 3681.5398075240596, 3685.4471829225563, 3725.4970578972034, 3736.4582135590185, 1211.1945556205112, 1222.10175520992, 1228.8955438787714, 1272.2811611439506, 1281.4041470716068, 13006.0, 13064.346782660828, 13098.803517947239, 13129.803052954214, 13136.474541018444, 4879.536444037811, 4992.650514464025, 5206.843794686166, 5240.135377662719, 5280.049591073644, 10316.123129533924, 10426.322289051188, 10435.16518678504, 10445.477726113815, 10456.477176141163, 5752.741126649311, 5755.568332375088, 5757.942420575824, 5760.8271751847515, 5761.3950535194035, 4644.465886423037, 5113.616478764107, 5123.538881500608, 5157.0, 5384.892302153935, 4142.523609784853, 4185.455890734185, 4221.387898754725, 4249.171411574775, 4280.957190428118, 1231.5073970411727, 1261.3504045416619, 1265.5507294910358, 1266.5503746170161, 1285.9807102893465, 870.2907130688469, 987.3384832162468, 1012.9409184263629, 1013.8783345998528, 1040.9479526023667, 6190.226221722285, 6337.904931426032, 6343.714532846033, 6615.86768264632, 6696.363845434676, 480.8341122312797, 483.87177397989564, 485.33993768474846, 486.82230985689966, 488.91199584074496, 4530.546945305509, 4623.491415944243, 4628.190066738307, 4664.090502352076, 4700.506446823034, 11692.356920369291, 12023.0, 12153.878461215452, 12171.878281217252, 12176.573819916437, 11747.118966077578, 11793.0, 12085.758284834254, 12099.395030248452, 12104.515819367127, 8453.577321133918, 8528.74413767588, 8597.742067737978, 8600.0109987351, 8621.913780862236, 6463.57986730861, 6513.2835388108215, 6530.67346632676, 6597.901031484627, 6627.768028118992, 10917.672469825919, 10957.287776294515, 11017.779644407226, 11026.44867756625, 11047.226694131656, 10878.510467028844, 10923.453827308444, 11088.279261847954, 11169.553217871195, 11186.552537898393, 7207.27927207296, 7756.418268629763, 7773.961130194539, 7997.720079797179, 8075.515469071875, 9038.231750301298, 9168.31237657165, 9171.128742769426, 9176.990531041447, 9192.862107068266, 8286.254237118688, 8316.251537361666, 8429.747107586782, 8461.23848853606, 8488.405811593377, 8295.211954864279, 8296.170382961896, 8298.54358010291, 8312.87530687028, 8367.07962124178, 7745.22547745221, 7856.646450909609, 7903.802404939923, 7928.246816552418, 7931.682732690859, 5474.233607294902, 5502.367227768857, 5585.441455854382, 5637.830865074055, 5724.885502289848, 5858.091995740667, 5881.264841894763, 5946.821595352147, 6011.308699499614, 6058.0610005449225], "value": 4904.52677653398, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.94209455439847, 352.964703529647, 355.7634173274772, 358.96948759355456, 359.0467309293826, 5902.793402230923, 5914.467697907187, 5922.496587790043, 5950.58345915785, 5967.433093856088, 5715.3998830122755, 5777.768889244425, 5823.2138661280715, 5834.6790926499025, 5837.328707198673, 4482.910341793162, 4540.364348991136, 4545.681802273843, 4570.54294570542, 4584.15193189261, 4560.612347950429, 4568.3147527870915, 4568.538067818299, 4571.908561828778, 4591.104734576759, 4455.866324010269, 4540.818367265306, 4546.977265113686, 4549.363089167519, 4552.68131230814, 4379.978100109495, 4501.234790085693, 4547.295169248771, 4557.954420455802, 4569.451665800092, 4022.839086436539, 4032.334664780308, 4043.3328500797334, 4045.2111838191563, 4058.817353219112, 5710.428957104298, 5760.82717518471, 5769.3076830780155, 5793.449622285876, 5795.681237531934, 5112.616553758483, 5228.032813929435, 5237.921431178535, 5248.8425347239645, 5281.339832520935, 6064.332923378425, 6094.288041821391, 6119.714859879431, 6134.9079763803575, 6177.752889884399, 4123.587641235882, 4460.910781784346, 4482.5965663090155, 4507.414036175309, 4510.751908645023, 6130.724117414682, 6313.147725057104, 6330.290821478221, 6338.39785220408, 6416.358364163546, 4417.8232870684815, 4459.732416055047, 4460.576245256695, 4470.173017991682, 4473.753943533137, 4539.954600454019, 4544.863654090383, 4556.521565235603, 4558.1795276849825, 4559.38448309474, 5012.624053196025, 5179.456157103526, 5196.233280684585, 5213.2701421800975, 5237.16205407133, 6147.44672979434, 6154.092231408278, 6158.353372895782, 6158.491169663372, 6171.691415429211, 1567.1067491529718, 1575.4249698859833, 1588.4758029850123, 1588.626672731907, 1593.0919375955593, 995.9053889880449, 998.201438848918, 1005.4060523848453, 1006.8389057750871, 1020.4438580973388, 5195.922061169085, 5216.556592689588, 5224.320838291073, 5228.666689994027, 5260.263563101169, 5505.504504594525, 5535.723213839292, 5555.694436806015, 5581.386047534768, 5613.326400831845, 4998.775055122528, 5250.7637156328055, 5287.894242115213, 5310.9734451327495, 5322.600804939568, 2960.4901500235037, 2979.553067039961, 2986.3131479759777, 3014.593029940974, 3020.9546856797165, 5556.277683901067, 5634.887302253932, 5678.744456499468, 5683.209788916478, 5714.514266287412, 5603.663780173202, 5629.24005259293, 5638.830835074954, 5649.745761440745, 5660.801871934463, 5647.915281270784, 5678.801241956512, 5716.28546431696, 5773.094878690106, 5774.566907481955, 5416.485433883775, 5540.864122854725, 5602.159676048625, 5615.410381909841, 5622.409646987171, 5434.3207099112615, 5519.641223320471, 5541.501264886179, 5553.583481238842, 5567.0, 6291.112666200213, 6372.808815735535, 6578.407943284936, 6579.572327798678, 6592.253052940879, 4388.451443569554, 4416.6025057744955, 4438.667099967451, 4448.510663827041, 4452.842261012095, 6176.938230617637, 6329.49984756028, 6337.841553961188, 6366.4588509977175, 6409.9679501602195, 6151.384861513813, 6164.907526387018, 6166.167567378347, 6179.567430279837, 6189.752409903554, 5919.200907877382, 6183.145056482947, 6202.317745048132, 6212.78850624124, 6249.468795152463, 6107.144999699956, 6111.297200821785, 6124.5712800103565, 6129.540284478593, 6162.476189523762, 6188.597741146811, 6189.96905015472, 6223.906641400473, 6240.095186198067, 6261.681308906287, 5755.683437410982, 6050.969745151246, 6068.118883146239, 6085.9695701521205, 6171.919914014939], "value": 4538.848729522803, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.9211950422705, 844.5692696724668, 891.2157301574613, 894.0567701075365, 918.8437965545857, 16560.337586496542, 17764.822351776478, 17809.0, 17987.19057642406, 18183.090845457722, 15968.520944371658, 16206.432774852883, 16314.75527867083, 16441.0, 16666.416675416363, 870.2994089757774, 875.2910142784333, 889.7864512516982, 891.9108089191094, 891.9554022298892, 874.868769684546, 895.50299583731, 895.5566994337812, 898.1826537850558, 898.716904175186, 938.0291398402654, 944.1644144931751, 945.0738276489045, 950.6957773512479, 951.538503825644, 946.5267366316841, 948.1040416806121, 948.5778828421355, 949.4777872170279, 950.0357137505438, 696.5124412910983, 696.5368030259871, 698.7938558125365, 701.7894631610496, 702.6135625406006, 17108.315667373292, 17192.398266060627, 17241.741373879402, 17256.396026139024, 17256.913715431467, 13904.86095139056, 14294.928525357307, 14479.42082316706, 15181.316840742193, 15551.169387633634, 13304.667383315398, 13446.529371471952, 13472.865271347258, 13473.797893031613, 13515.121517101357, 4062.5734297898885, 4110.46563946685, 4117.341225403921, 4157.0, 4161.583841615845, 94173.5291323539, 94593.99999999932, 95031.52484237535, 95936.52031739867, 96077.0, 11369.0, 11486.0, 11531.827022594667, 11633.069354451623, 12103.33431661267, 23750.406239843796, 23777.881110594335, 23791.881040594686, 23858.642120368208, 23871.880640596686, 8945.105489451133, 8953.59708813105, 8969.37214394986, 9019.098090191059, 9351.0, 5367.463253674601, 5422.547168869033, 5427.620066595379, 5549.417311182348, 5558.055130627803, 4017.4375587417785, 4124.1957818225155, 4147.937780933288, 4149.896252593649, 4152.854650087293, 672.8418821576926, 681.6898311268361, 686.6806934775353, 706.4030893894651, 716.9103862017248, 759.5404780108065, 763.904511936008, 774.5662429039755, 778.4784194589638, 814.7881550796717, 10526.73683157912, 10548.0, 10642.467876606139, 10969.83545246822, 11001.394923279297, 654.9246836613851, 695.7078027228577, 729.2525161709291, 747.9513831600929, 785.3442375616424, 5106.208537676666, 5226.973865130726, 5238.109521381374, 5246.6065045121, 5258.842234732964, 75997.0, 96253.5187324059, 108134.45932770286, 128232.0, 131813.34093329473, 104568.0, 106362.0, 111290.0, 114213.42893285646, 114758.4262078701, 54383.45616543863, 54598.727006364716, 87235.56382218048, 87838.0, 88330.55834720914, 10484.842727359248, 10699.641784203406, 11110.333379997226, 11161.944190278997, 11211.383373914514, 52876.0, 53741.193882091015, 53763.46236537741, 53885.0, 55114.17328739992, 78322.0, 82613.17386826055, 82894.0, 85186.0, 85253.57373213094, 12905.677358066123, 13131.540396086091, 13566.525171618947, 13673.179609223478, 13725.794113088112, 15821.525354239391, 15897.761533577237, 15913.920430397773, 16013.519594412186, 16310.184490775651, 15718.371265149266, 15918.442854500037, 15952.92023539875, 16889.155542222594, 17219.569510762332, 13992.860071399156, 14131.081479703786, 16615.169241538115, 17090.74363884518, 17136.14319284006, 12944.741105178033, 14897.0, 15302.464413745465, 15343.156126413154, 15589.064656120669, 12520.0, 12754.61736147917, 13189.472421103048, 13523.59429217125, 13629.931850340685, 10619.787604248026, 11576.88423115758, 12359.134860559674, 12512.812307815571, 12582.433790479266], "value": 8286.179695018034, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 105.0, 109.0, 111.0, 120.0, 110.0, 112.0, 109.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 149.0, 173.0, 116.0, 146.0, 147.0, 119.0, 173.0, 118.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 165.0, 163.0, 161.0, 164.0, 160.0, 160.0, 160.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 175.0, 76.0, 74.0, 75.0, 75.0, 161.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 158.0, 83.0, 84.0, 82.0, 140.0, 84.0, 83.0, 142.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 97.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 55.0, 51.0, 50.0, 54.0, 51.0, 52.0, 51.0, 58.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 58.0, 59.0, 59.0, 58.0, 62.0, 60.0, 60.0, 64.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 80.0, 74.0, 77.0, 72.0, 72.0, 72.0, 73.0, 72.0, 72.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 126.0, 121.0, 121.0, 135.0, 122.0, 125.0, 156.0, 117.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 156.0, 154.0, 154.0, 154.0, 155.0, 156.0, 158.0, 154.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 63.0, 65.0, 62.0, 60.0, 66.0, 61.0, 61.0], "value": 63.1, "unit": "score"}]}]} 03:46:30 INFO - Return code: 0 03:46:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:30 ERROR - # TBPL SUCCESS # 03:46:30 INFO - Running post-action listener: _resource_record_post_action 03:46:30 INFO - [mozharness: 2016-09-03 10:46:30.830237Z] Finished run-tests step (success) 03:46:30 INFO - Running post-run listener: _resource_record_post_run 03:46:30 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 778240; Write bytes: 330027008; Read time: 272; Write time: 250728 03:46:30 INFO - TinderboxPrint: CPU usage
13.3% 03:46:30 INFO - TinderboxPrint: I/O read bytes / time
778,240 / 272 03:46:30 INFO - TinderboxPrint: I/O write bytes / time
330,027,008 / 250,728 03:46:30 INFO - TinderboxPrint: CPU idle
8,218.3 (86.7%) 03:46:30 INFO - TinderboxPrint: CPU user
1,206.0 (12.7%) 03:46:30 INFO - TinderboxPrint: Swap in / out
0 / 0 03:46:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 77205504; Read time: 12; Write time: 81524 03:46:30 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 770048; Write bytes: 250310656; Read time: 248; Write time: 168896 03:46:31 INFO - Running post-run listener: _upload_blobber_files 03:46:31 INFO - Blob upload gear active. 03:46:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:31 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:46:31 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:46:31 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:46:31 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:46:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:46:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:32 INFO - (blobuploader) - INFO - Done attempting. 03:46:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:46:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:46:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:33 INFO - (blobuploader) - INFO - Done attempting. 03:46:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:36 INFO - (blobuploader) - INFO - Done attempting. 03:46:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:36 INFO - Return code: 0 03:46:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cbbbc737ebf8840830ebc59700530b96cc592792b05f3b84da2eb8dd953987d3d7af08bc7192977fe6eeaa264f091a9b6bb570a0d94fb25086f4e6a10ca69d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdf54e6ffb0af68dd9b948a791b39591f37baf4195aa076b9019109147c2f3b5bb94b1f3651b1d72ad365bd7176f3db51d1804be9432da1ff84ba9191baeaa84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2236e20de49cc027d9e19d0c6e6917a5c8c53b8c0f2ac96cc99108b6121d4a3d7569d0388a5a736cd0da02df2f761208d8a3255c430e92c5a3bf4c467ea489c"} 03:46:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:36 INFO - Contents: 03:46:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1cbbbc737ebf8840830ebc59700530b96cc592792b05f3b84da2eb8dd953987d3d7af08bc7192977fe6eeaa264f091a9b6bb570a0d94fb25086f4e6a10ca69d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdf54e6ffb0af68dd9b948a791b39591f37baf4195aa076b9019109147c2f3b5bb94b1f3651b1d72ad365bd7176f3db51d1804be9432da1ff84ba9191baeaa84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2236e20de49cc027d9e19d0c6e6917a5c8c53b8c0f2ac96cc99108b6121d4a3d7569d0388a5a736cd0da02df2f761208d8a3255c430e92c5a3bf4c467ea489c"} 03:46:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:36 INFO - Copying logs to upload dir... 03:46:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.092507 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-09-03 03:46:36.922094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 03:46:36.926157) ========= 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=62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872 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/1cbbbc737ebf8840830ebc59700530b96cc592792b05f3b84da2eb8dd953987d3d7af08bc7192977fe6eeaa264f091a9b6bb570a0d94fb25086f4e6a10ca69d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdf54e6ffb0af68dd9b948a791b39591f37baf4195aa076b9019109147c2f3b5bb94b1f3651b1d72ad365bd7176f3db51d1804be9432da1ff84ba9191baeaa84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2236e20de49cc027d9e19d0c6e6917a5c8c53b8c0f2ac96cc99108b6121d4a3d7569d0388a5a736cd0da02df2f761208d8a3255c430e92c5a3bf4c467ea489c"} build_url:https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011055 build_url: 'https://queue.taskcluster.net/v1/task/CjJylzlOR_O887hXHVW16g/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/1cbbbc737ebf8840830ebc59700530b96cc592792b05f3b84da2eb8dd953987d3d7af08bc7192977fe6eeaa264f091a9b6bb570a0d94fb25086f4e6a10ca69d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdf54e6ffb0af68dd9b948a791b39591f37baf4195aa076b9019109147c2f3b5bb94b1f3651b1d72ad365bd7176f3db51d1804be9432da1ff84ba9191baeaa84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2236e20de49cc027d9e19d0c6e6917a5c8c53b8c0f2ac96cc99108b6121d4a3d7569d0388a5a736cd0da02df2f761208d8a3255c430e92c5a3bf4c467ea489c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 03:46:36.951909) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:46:36.952314) ========= 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=62c568580acbfdaac3eec7be000001dc-1472897919.918655-1792169872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 03:46:37.033799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 03:46:37.034280) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 03:46:37.034642) ========= ========= Total master_lag: 0.17 =========