builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1473158373.81 results: success (0) buildid: 20160906004000 builduid: ec02d44d15274cb8bb9c6ef5e2a3f820 revision: 37c314d53f827e5fc094fcb9b1537b4101681507 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:33.812508) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:33.813087) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:33.813401) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:33.840435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:33.840703) ========= 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=652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-06 03:39:34-- 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% 222M=0s 2016-09-06 03:39:34 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134263 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:33.989133) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:33.989454) ========= 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=652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018495 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:34.043317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-06 03:39:34.043648) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 37c314d53f827e5fc094fcb9b1537b4101681507 --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 37c314d53f827e5fc094fcb9b1537b4101681507 --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=652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-06 03:39:34,286 truncating revision to first 12 chars 2016-09-06 03:39:34,286 Setting DEBUG logging. 2016-09-06 03:39:34,286 attempt 1/10 2016-09-06 03:39:34,286 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/37c314d53f82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-06 03:39:35,785 unpacking tar archive at: mozilla-aurora-37c314d53f82/testing/mozharness/ program finished with exit code 0 elapsedTime=1.836247 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-06 03:39:35.892782) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:35.893133) ========= script_repo_revision: 37c314d53f827e5fc094fcb9b1537b4101681507 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:35.893529) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:35.893801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-06 03:39:35.902705) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-06 03:39:35.903150) ========= /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=652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:39:36 INFO - MultiFileLogger online at 20160906 03:39:36 in /builds/slave/test 03:39:36 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:39:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:36 INFO - {'append_to_log': False, 03:39:36 INFO - 'base_work_dir': '/builds/slave/test', 03:39:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:39:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:36 INFO - 'branch': 'Mozilla-Aurora', 03:39:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:36 INFO - 'config_files': ('talos/linux_config.py',), 03:39:36 INFO - 'default_actions': ('clobber', 03:39:36 INFO - 'read-buildbot-config', 03:39:36 INFO - 'download-and-extract', 03:39:36 INFO - 'populate-webroot', 03:39:36 INFO - 'create-virtualenv', 03:39:36 INFO - 'install', 03:39:36 INFO - 'run-tests'), 03:39:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:36 INFO - 'download_minidump_stackwalk': True, 03:39:36 INFO - 'download_symbols': 'ondemand', 03:39:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:36 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:36 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:36 INFO - 'installer_path': 'installer.exe', 03:39:36 INFO - 'log_level': 'info', 03:39:36 INFO - 'log_name': 'talos', 03:39:36 INFO - 'log_to_console': True, 03:39:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:39:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:39:36 INFO - 'opt_config_files': (), 03:39:36 INFO - 'pip_index': False, 03:39:36 INFO - 'sps_profile': False, 03:39:36 INFO - 'sps_profile_interval': 0, 03:39:36 INFO - 'suite': 'dromaeojs-e10s', 03:39:36 INFO - 'system_bits': '32', 03:39:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:36 INFO - 'title': 'talos-linux64-ix-046', 03:39:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:36 INFO - 'use_talos_json': True, 03:39:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:36 INFO - 'work_dir': 'build'} 03:39:36 INFO - [mozharness: 2016-09-06 10:39:36.234445Z] Running clobber step. 03:39:36 INFO - Running pre-action listener: _resource_record_pre_action 03:39:36 INFO - Running main action method: clobber 03:39:36 INFO - rmtree: /builds/slave/test/build 03:39:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:36 INFO - Running post-action listener: _resource_record_post_action 03:39:36 INFO - [mozharness: 2016-09-06 10:39:36.689244Z] Finished clobber step (success) 03:39:36 INFO - [mozharness: 2016-09-06 10:39:36.689362Z] Running read-buildbot-config step. 03:39:36 INFO - Running pre-action listener: _resource_record_pre_action 03:39:36 INFO - Running main action method: read_buildbot_config 03:39:36 INFO - Using buildbot properties: 03:39:36 INFO - { 03:39:36 INFO - "project": "", 03:39:36 INFO - "product": "firefox", 03:39:36 INFO - "script_repo_revision": "production", 03:39:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:39:36 INFO - "repository": "", 03:39:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:39:36 INFO - "buildid": "20160906004000", 03:39:36 INFO - "stage_platform": "linux64-pgo", 03:39:36 INFO - "basedir": "/builds/slave/test", 03:39:36 INFO - "nightly_build": "True", 03:39:36 INFO - "buildnumber": 485, 03:39:36 INFO - "slavename": "talos-linux64-ix-046", 03:39:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:39:36 INFO - "platform": "ubuntu64_hw", 03:39:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:39:36 INFO - "branch": "mozilla-aurora", 03:39:36 INFO - "repo_path": "releases/mozilla-aurora", 03:39:36 INFO - "revision": "37c314d53f827e5fc094fcb9b1537b4101681507", 03:39:36 INFO - "pgo_build": "True", 03:39:36 INFO - "builduid": "ec02d44d15274cb8bb9c6ef5e2a3f820", 03:39:36 INFO - "slavebuilddir": "test" 03:39:36 INFO - } 03:39:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:39:36 INFO - Running post-action listener: _resource_record_post_action 03:39:36 INFO - [mozharness: 2016-09-06 10:39:36.691873Z] Finished read-buildbot-config step (success) 03:39:36 INFO - [mozharness: 2016-09-06 10:39:36.691962Z] Running download-and-extract step. 03:39:36 INFO - Running pre-action listener: _resource_record_pre_action 03:39:36 INFO - Running main action method: download_and_extract 03:39:36 INFO - mkdir: /builds/slave/test/build/tests 03:39:36 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:39:36 INFO - https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:39:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:39:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:39:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:39:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:39:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:39:36 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:39:36 INFO - retry: Failed, sleeping 30 seconds before retrying 03:40:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:40:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:40:06 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:40:06 INFO - retry: Failed, sleeping 60 seconds before retrying 03:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:41:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:41:06 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:41:06 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:41:06 INFO - Caught exception: HTTP Error 404: Not Found 03:41:06 INFO - Caught exception: HTTP Error 404: Not Found 03:41:06 INFO - Caught exception: HTTP Error 404: Not Found 03:41:06 INFO - trying https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:41:06 INFO - Downloading https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:41:07 INFO - Downloaded 1361 bytes. 03:41:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:41:07 INFO - Using the following test package requirements: 03:41:07 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:41:07 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:41:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:41:07 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:41:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:41:07 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:41:07 INFO - u'jsshell-linux-x86_64.zip'], 03:41:07 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:41:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:41:07 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:41:07 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:41:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:41:07 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:41:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:41:07 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:41:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:41:07 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:41:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:41:07 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:41:07 INFO - https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:41:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:41:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:41:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:41:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:41:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:41:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:41:07 INFO - retry: Failed, sleeping 30 seconds before retrying 03:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:41:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:41:37 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:41:37 INFO - retry: Failed, sleeping 60 seconds before retrying 03:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:42:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:42:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:42:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:42:37 INFO - Caught exception: HTTP Error 404: Not Found 03:42:37 INFO - Caught exception: HTTP Error 404: Not Found 03:42:37 INFO - Caught exception: HTTP Error 404: Not Found 03:42:37 INFO - trying https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:42:37 INFO - Downloading https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:42:38 INFO - Downloaded 21770964 bytes. 03:42:38 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:42:38 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:42:39 INFO - Return code: 0 03:42:39 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:42:39 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:42:39 INFO - https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:42:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:42:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:42:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:42:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:42:39 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:42:39 INFO - retry: Failed, sleeping 30 seconds before retrying 03:43:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:43:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:43:09 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:43:09 INFO - retry: Failed, sleeping 60 seconds before retrying 03:44:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:44:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:44:09 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:44:09 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:44:09 INFO - Caught exception: HTTP Error 404: Not Found 03:44:09 INFO - Caught exception: HTTP Error 404: Not Found 03:44:09 INFO - Caught exception: HTTP Error 404: Not Found 03:44:09 INFO - trying https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:44:09 INFO - Downloading https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:44:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:44:10 INFO - Downloaded 21770964 bytes. 03:44:10 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:44:10 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:44:11 INFO - Return code: 0 03:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:11 INFO - https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:44:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:44:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:44:11 INFO - retry: Failed, sleeping 30 seconds before retrying 03:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:44:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:44:41 INFO - retry: Failed, sleeping 60 seconds before retrying 03:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:45:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:45:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:45:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:45:42 INFO - Caught exception: HTTP Error 404: Not Found 03:45:42 INFO - Caught exception: HTTP Error 404: Not Found 03:45:42 INFO - Caught exception: HTTP Error 404: Not Found 03:45:42 INFO - trying https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:45:42 INFO - Downloading https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:45:42 INFO - Downloaded 14413740 bytes. 03:45:42 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:45:42 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:45:43 INFO - Return code: 0 03:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:43 INFO - https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:45:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:45:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:45:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:45:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:45:43 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:45:43 INFO - retry: Failed, sleeping 30 seconds before retrying 03:46:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:46:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:46:13 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:46:13 INFO - retry: Failed, sleeping 60 seconds before retrying 03:47:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:47:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:47:13 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:47:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:47:13 INFO - Caught exception: HTTP Error 404: Not Found 03:47:13 INFO - Caught exception: HTTP Error 404: Not Found 03:47:13 INFO - Caught exception: HTTP Error 404: Not Found 03:47:13 INFO - trying https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:47:13 INFO - Downloading https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:47:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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:47:14 INFO - Downloaded 63899661 bytes. 03:47:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:47:14 INFO - mkdir: /builds/slave/test/properties 03:47:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:47:14 INFO - Writing to file /builds/slave/test/properties/build_url 03:47:14 INFO - Contents: 03:47:14 INFO - build_url:https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:47:14 INFO - Running post-action listener: _resource_record_post_action 03:47:14 INFO - Running post-action listener: set_extra_try_arguments 03:47:14 INFO - [mozharness: 2016-09-06 10:47:14.991522Z] Finished download-and-extract step (success) 03:47:14 INFO - [mozharness: 2016-09-06 10:47:14.991754Z] Running populate-webroot step. 03:47:14 INFO - Running pre-action listener: _resource_record_pre_action 03:47:14 INFO - Running main action method: populate_webroot 03:47:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:47:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:47:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:47:15 INFO - '--tppagecycles', 03:47:15 INFO - '7'], 03:47:15 INFO - 'tests': ['tsvgm']}}, 03:47:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:47:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:47:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:47:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:47:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:15 INFO - 'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:15 INFO - 'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['damp', 'tps']}, 03:47:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:15 INFO - 'tests': ['damp', 'tps']}, 03:47:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['dromaeo_dom']}, 03:47:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['basic_compositor_video']}, 03:47:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:47:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['a11yr', 03:47:15 INFO - 'ts_paint', 03:47:15 INFO - 'tpaint', 03:47:15 INFO - 'sessionrestore', 03:47:15 INFO - 'sessionrestore_no_auto_restore', 03:47:15 INFO - 'tabpaint']}, 03:47:15 INFO - 'other-e10s': {'tests': ['a11yr', 03:47:15 INFO - 'ts_paint', 03:47:15 INFO - 'tpaint', 03:47:15 INFO - 'sessionrestore', 03:47:15 INFO - 'sessionrestore_no_auto_restore', 03:47:15 INFO - 'tabpaint']}, 03:47:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:47:15 INFO - 'ts_paint', 03:47:15 INFO - 'tpaint', 03:47:15 INFO - 'sessionrestore', 03:47:15 INFO - 'sessionrestore_no_auto_restore', 03:47:15 INFO - 'tabpaint']}, 03:47:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:47:15 INFO - 'ts_paint', 03:47:15 INFO - 'tpaint', 03:47:15 INFO - 'sessionrestore', 03:47:15 INFO - 'sessionrestore_no_auto_restore', 03:47:15 INFO - 'tabpaint']}, 03:47:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['a11yr', 03:47:15 INFO - 'ts_paint', 03:47:15 INFO - 'tpaint', 03:47:15 INFO - 'sessionrestore', 03:47:15 INFO - 'sessionrestore_no_auto_restore', 03:47:15 INFO - 'tabpaint']}, 03:47:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['a11yr', 03:47:15 INFO - 'ts_paint', 03:47:15 INFO - 'tpaint', 03:47:15 INFO - 'sessionrestore', 03:47:15 INFO - 'sessionrestore_no_auto_restore', 03:47:15 INFO - 'tabpaint']}, 03:47:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['tsvgx', 03:47:15 INFO - 'tsvgr_opacity', 03:47:15 INFO - 'tart', 03:47:15 INFO - 'tscrollx', 03:47:15 INFO - 'cart']}, 03:47:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:47:15 INFO - 'tsvgr_opacity', 03:47:15 INFO - 'tart', 03:47:15 INFO - 'tscrollx', 03:47:15 INFO - 'cart']}, 03:47:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:15 INFO - 'talos_options': ['--disable-e10s'], 03:47:15 INFO - 'tests': ['tp5o']}, 03:47:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:15 INFO - 'tests': ['tp5o']}, 03:47:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:15 INFO - 'talos_options': ['--disable-e10s', 03:47:15 INFO - '--xperf_path', 03:47:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:15 INFO - 'tests': ['tp5n']}, 03:47:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:15 INFO - 'talos_options': ['--xperf_path', 03:47:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:15 INFO - 'tests': ['tp5n']}}, 03:47:15 INFO - 'talos.zip': {'path': '', 03:47:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:47:15 INFO - Running post-action listener: _resource_record_post_action 03:47:15 INFO - [mozharness: 2016-09-06 10:47:15.013591Z] Finished populate-webroot step (success) 03:47:15 INFO - [mozharness: 2016-09-06 10:47:15.013680Z] Running create-virtualenv step. 03:47:15 INFO - Running pre-action listener: _resource_record_pre_action 03:47:15 INFO - Running main action method: create_virtualenv 03:47:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:47:15 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:47:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:47:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:15 INFO - Using real prefix '/usr' 03:47:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:47:15 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:17 INFO - Installing pip.................done. 03:47:17 INFO - Return code: 0 03:47:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:47: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:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:17 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 0x2a9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, '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': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', '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:47:17 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:47:17 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:47:17 INFO - Using env: {'DISPLAY': ':0', 03:47:17 INFO - 'HOME': '/home/cltbld', 03:47:17 INFO - 'LANG': 'en_US.UTF-8', 03:47:17 INFO - 'LANGUAGE': 'en_US:en', 03:47:17 INFO - 'LOGNAME': 'cltbld', 03:47:17 INFO - 'MAIL': '/var/mail/cltbld', 03:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:17 INFO - 'MOZ_NO_REMOTE': '1', 03:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:17 INFO - 'NO_EM_RESTART': '1', 03:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:17 INFO - 'PWD': '/builds/slave/test', 03:47:17 INFO - 'SHELL': '/bin/bash', 03:47:17 INFO - 'SHLVL': '1', 03:47:17 INFO - 'TERM': 'linux', 03:47:17 INFO - 'TMOUT': '86400', 03:47:17 INFO - 'USER': 'cltbld', 03:47:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:17 INFO - '_': '/tools/buildbot/bin/python'} 03:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:17 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:47:17 INFO - Cleaning up... 03:47:17 INFO - Return code: 0 03:47:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:47: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:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:17 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 0x2a9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, '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': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', '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:47:17 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:47:17 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:47:17 INFO - Using env: {'DISPLAY': ':0', 03:47:17 INFO - 'HOME': '/home/cltbld', 03:47:17 INFO - 'LANG': 'en_US.UTF-8', 03:47:17 INFO - 'LANGUAGE': 'en_US:en', 03:47:17 INFO - 'LOGNAME': 'cltbld', 03:47:17 INFO - 'MAIL': '/var/mail/cltbld', 03:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:17 INFO - 'MOZ_NO_REMOTE': '1', 03:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:17 INFO - 'NO_EM_RESTART': '1', 03:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:17 INFO - 'PWD': '/builds/slave/test', 03:47:17 INFO - 'SHELL': '/bin/bash', 03:47:17 INFO - 'SHLVL': '1', 03:47:17 INFO - 'TERM': 'linux', 03:47:17 INFO - 'TMOUT': '86400', 03:47:17 INFO - 'USER': 'cltbld', 03:47:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:17 INFO - '_': '/tools/buildbot/bin/python'} 03:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:18 INFO - Downloading/unpacking psutil>=3.1.1 03:47:18 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:47:18 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:47:18 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:47:18 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:47:18 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:47:18 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:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:20 INFO - Installing collected packages: psutil 03:47:20 INFO - Running setup.py install for psutil 03:47:20 INFO - building 'psutil._psutil_linux' extension 03:47:20 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:47:20 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:47:20 INFO - building 'psutil._psutil_posix' extension 03:47:20 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:47:20 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:47:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:20 INFO - Successfully installed psutil 03:47:20 INFO - Cleaning up... 03:47:20 INFO - Return code: 0 03:47:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:47:20 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:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:20 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:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:20 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 0x2a9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, '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': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', '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:47:20 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:47:20 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:47:20 INFO - Using env: {'DISPLAY': ':0', 03:47:20 INFO - 'HOME': '/home/cltbld', 03:47:20 INFO - 'LANG': 'en_US.UTF-8', 03:47:20 INFO - 'LANGUAGE': 'en_US:en', 03:47:20 INFO - 'LOGNAME': 'cltbld', 03:47:20 INFO - 'MAIL': '/var/mail/cltbld', 03:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:20 INFO - 'MOZ_NO_REMOTE': '1', 03:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:20 INFO - 'NO_EM_RESTART': '1', 03:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:20 INFO - 'PWD': '/builds/slave/test', 03:47:20 INFO - 'SHELL': '/bin/bash', 03:47:20 INFO - 'SHLVL': '1', 03:47:20 INFO - 'TERM': 'linux', 03:47:20 INFO - 'TMOUT': '86400', 03:47:20 INFO - 'USER': 'cltbld', 03:47:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:20 INFO - '_': '/tools/buildbot/bin/python'} 03:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:47:22 INFO - Installing collected packages: mozsystemmonitor 03:47:22 INFO - Running setup.py install for mozsystemmonitor 03:47:22 INFO - Successfully installed mozsystemmonitor 03:47:22 INFO - Cleaning up... 03:47:22 INFO - Return code: 0 03:47:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:22 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 0x2a9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, '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': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', '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:47:22 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:47:22 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:47:22 INFO - Using env: {'DISPLAY': ':0', 03:47:22 INFO - 'HOME': '/home/cltbld', 03:47:22 INFO - 'LANG': 'en_US.UTF-8', 03:47:22 INFO - 'LANGUAGE': 'en_US:en', 03:47:22 INFO - 'LOGNAME': 'cltbld', 03:47:22 INFO - 'MAIL': '/var/mail/cltbld', 03:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:22 INFO - 'MOZ_NO_REMOTE': '1', 03:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:22 INFO - 'NO_EM_RESTART': '1', 03:47:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:22 INFO - 'PWD': '/builds/slave/test', 03:47:22 INFO - 'SHELL': '/bin/bash', 03:47:22 INFO - 'SHLVL': '1', 03:47:22 INFO - 'TERM': 'linux', 03:47:22 INFO - 'TMOUT': '86400', 03:47:22 INFO - 'USER': 'cltbld', 03:47:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:22 INFO - '_': '/tools/buildbot/bin/python'} 03:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:23 INFO - Downloading/unpacking jsonschema==2.5.1 03:47: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:47: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:47: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:47: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:47: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:47: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:47:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:47:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:47: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:47: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:47: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:47: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:47: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:47: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:47:26 INFO - Downloading functools32-3.2.3-2.tar.gz 03:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:47:26 INFO - warning: no files found matching '*.txt' 03:47:26 INFO - no previously-included directories found matching 'build' 03:47:26 INFO - no previously-included directories found matching 'dist' 03:47:26 INFO - no previously-included directories found matching '.git*' 03:47:26 INFO - Installing collected packages: jsonschema, functools32 03:47:26 INFO - Running setup.py install for functools32 03:47:26 INFO - warning: no files found matching '*.txt' 03:47:26 INFO - no previously-included directories found matching 'build' 03:47:26 INFO - no previously-included directories found matching 'dist' 03:47:26 INFO - no previously-included directories found matching '.git*' 03:47:26 INFO - Successfully installed jsonschema functools32 03:47:26 INFO - Cleaning up... 03:47:26 INFO - Return code: 0 03:47:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:47: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:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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', '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 0x2a9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, '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': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', '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:47: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:47: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 functools32==3.2.3-2 03:47:26 INFO - Using env: {'DISPLAY': ':0', 03:47:26 INFO - 'HOME': '/home/cltbld', 03:47:26 INFO - 'LANG': 'en_US.UTF-8', 03:47:26 INFO - 'LANGUAGE': 'en_US:en', 03:47:26 INFO - 'LOGNAME': 'cltbld', 03:47:26 INFO - 'MAIL': '/var/mail/cltbld', 03:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:26 INFO - 'MOZ_NO_REMOTE': '1', 03:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:26 INFO - 'NO_EM_RESTART': '1', 03:47:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:26 INFO - 'PWD': '/builds/slave/test', 03:47:26 INFO - 'SHELL': '/bin/bash', 03:47:26 INFO - 'SHLVL': '1', 03:47:26 INFO - 'TERM': 'linux', 03:47:26 INFO - 'TMOUT': '86400', 03:47:26 INFO - 'USER': 'cltbld', 03:47:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:26 INFO - '_': '/tools/buildbot/bin/python'} 03:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:47:26 INFO - Cleaning up... 03:47:26 INFO - Return code: 0 03:47:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:47: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:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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', '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 0x2a9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, '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': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', '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:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:47: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 blobuploader==1.2.4 03:47:26 INFO - Using env: {'DISPLAY': ':0', 03:47:26 INFO - 'HOME': '/home/cltbld', 03:47:26 INFO - 'LANG': 'en_US.UTF-8', 03:47:26 INFO - 'LANGUAGE': 'en_US:en', 03:47:26 INFO - 'LOGNAME': 'cltbld', 03:47:26 INFO - 'MAIL': '/var/mail/cltbld', 03:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:26 INFO - 'MOZ_NO_REMOTE': '1', 03:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:26 INFO - 'NO_EM_RESTART': '1', 03:47:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:26 INFO - 'PWD': '/builds/slave/test', 03:47:26 INFO - 'SHELL': '/bin/bash', 03:47:26 INFO - 'SHLVL': '1', 03:47:26 INFO - 'TERM': 'linux', 03:47:26 INFO - 'TMOUT': '86400', 03:47:26 INFO - 'USER': 'cltbld', 03:47:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:26 INFO - '_': '/tools/buildbot/bin/python'} 03:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:26 INFO - Downloading/unpacking blobuploader==1.2.4 03:47: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:47: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:47: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:47: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:47: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:47: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:47:28 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47:29 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:47:29 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:47:29 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:47:29 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:47:29 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:47:29 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:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:47:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:47:29 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:47:29 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:47:29 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:47:29 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:47:29 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:47:29 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:47:29 INFO - Downloading docopt-0.6.1.tar.gz 03:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:47:29 INFO - Installing collected packages: blobuploader, requests, docopt 03:47:29 INFO - Running setup.py install for blobuploader 03:47:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:47:29 INFO - Running setup.py install for requests 03:47:30 INFO - Running setup.py install for docopt 03:47:30 INFO - Successfully installed blobuploader requests docopt 03:47:30 INFO - Cleaning up... 03:47:30 INFO - Return code: 0 03:47:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:30 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 0x2a9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, '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': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', '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:47:30 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:47:30 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:47:30 INFO - Using env: {'DISPLAY': ':0', 03:47:30 INFO - 'HOME': '/home/cltbld', 03:47:30 INFO - 'LANG': 'en_US.UTF-8', 03:47:30 INFO - 'LANGUAGE': 'en_US:en', 03:47:30 INFO - 'LOGNAME': 'cltbld', 03:47:30 INFO - 'MAIL': '/var/mail/cltbld', 03:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:30 INFO - 'MOZ_NO_REMOTE': '1', 03:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:30 INFO - 'NO_EM_RESTART': '1', 03:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:30 INFO - 'PWD': '/builds/slave/test', 03:47:30 INFO - 'SHELL': '/bin/bash', 03:47:30 INFO - 'SHLVL': '1', 03:47:30 INFO - 'TERM': 'linux', 03:47:30 INFO - 'TMOUT': '86400', 03:47:30 INFO - 'USER': 'cltbld', 03:47:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:30 INFO - '_': '/tools/buildbot/bin/python'} 03:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:47:30 INFO - Running setup.py (path:/tmp/pip-0cJDiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:47:30 INFO - Running setup.py (path:/tmp/pip-7SCJJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:47:30 INFO - Running setup.py (path:/tmp/pip-tlPPss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:47:30 INFO - Running setup.py (path:/tmp/pip-nGG27n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:47:30 INFO - Running setup.py (path:/tmp/pip-F3YsZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:47:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:47:30 INFO - Running setup.py (path:/tmp/pip-JexQjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:47:31 INFO - Running setup.py (path:/tmp/pip-3_JIWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:47:31 INFO - Running setup.py (path:/tmp/pip-g9FRfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:47:31 INFO - Running setup.py (path:/tmp/pip-udXcSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:47:31 INFO - Running setup.py (path:/tmp/pip-mbr12z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:47:31 INFO - Running setup.py (path:/tmp/pip-gumADl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:47:31 INFO - Running setup.py (path:/tmp/pip-qo5Zlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:47:31 INFO - Running setup.py (path:/tmp/pip-PrfXYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:47:31 INFO - Running setup.py (path:/tmp/pip-1uAcvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:31 INFO - Running setup.py (path:/tmp/pip-aMLQm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:47:31 INFO - Running setup.py (path:/tmp/pip-9_NQgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:47:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:47:31 INFO - Running setup.py (path:/tmp/pip-X1I3lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:47:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:47:31 INFO - Running setup.py install for manifestparser 03:47:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:47:31 INFO - Running setup.py install for mozcrash 03:47:32 INFO - Running setup.py install for mozdebug 03:47:32 INFO - Running setup.py install for mozdevice 03:47:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Running setup.py install for mozfile 03:47:32 INFO - Running setup.py install for mozhttpd 03:47:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Running setup.py install for mozinfo 03:47:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Running setup.py install for mozInstall 03:47:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Running setup.py install for mozleak 03:47:32 INFO - Running setup.py install for mozlog 03:47:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Running setup.py install for moznetwork 03:47:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:47:32 INFO - Running setup.py install for mozprocess 03:47:33 INFO - Running setup.py install for mozprofile 03:47:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:47:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:47:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:47:33 INFO - Running setup.py install for mozrunner 03:47:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:47:33 INFO - Running setup.py install for mozscreenshot 03:47:33 INFO - Running setup.py install for moztest 03:47:33 INFO - Running setup.py install for mozversion 03:47:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:47:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:47:33 INFO - Cleaning up... 03:47:33 INFO - Return code: 0 03:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:33 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 0x2a9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, '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': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', '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:47:33 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:47:33 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:47:33 INFO - Using env: {'DISPLAY': ':0', 03:47:33 INFO - 'HOME': '/home/cltbld', 03:47:33 INFO - 'LANG': 'en_US.UTF-8', 03:47:33 INFO - 'LANGUAGE': 'en_US:en', 03:47:33 INFO - 'LOGNAME': 'cltbld', 03:47:33 INFO - 'MAIL': '/var/mail/cltbld', 03:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:33 INFO - 'MOZ_NO_REMOTE': '1', 03:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:33 INFO - 'NO_EM_RESTART': '1', 03:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:33 INFO - 'PWD': '/builds/slave/test', 03:47:33 INFO - 'SHELL': '/bin/bash', 03:47:33 INFO - 'SHLVL': '1', 03:47:33 INFO - 'TERM': 'linux', 03:47:33 INFO - 'TMOUT': '86400', 03:47:33 INFO - 'USER': 'cltbld', 03:47:33 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:33 INFO - '_': '/tools/buildbot/bin/python'} 03:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:47:33 INFO - Running setup.py (path:/tmp/pip-KncYHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:47:33 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:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:47:33 INFO - Running setup.py (path:/tmp/pip-Fd1dsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:47:33 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:47:34 INFO - Running setup.py (path:/tmp/pip-ygaule-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:47:34 INFO - Running setup.py (path:/tmp/pip-6HuGdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:47:34 INFO - Running setup.py (path:/tmp/pip-Yvzt7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:47:34 INFO - Running setup.py (path:/tmp/pip-HSnukp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:47:34 INFO - Running setup.py (path:/tmp/pip-c6O8of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:47:34 INFO - Running setup.py (path:/tmp/pip-nBqnGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:47:34 INFO - Running setup.py (path:/tmp/pip-B8djw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:47:34 INFO - Running setup.py (path:/tmp/pip-DYclCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:47:34 INFO - Running setup.py (path:/tmp/pip-NdiXAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:47:34 INFO - Running setup.py (path:/tmp/pip-RJnIua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:47:34 INFO - Running setup.py (path:/tmp/pip-F_kgCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:47:34 INFO - Running setup.py (path:/tmp/pip-Oe6DO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:34 INFO - Running setup.py (path:/tmp/pip-VLQlEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:34 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:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:47:34 INFO - Running setup.py (path:/tmp/pip-EgHUZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:47:35 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:47:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:47:35 INFO - Running setup.py (path:/tmp/pip-Ut8yXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:47:35 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:47:35 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:47:35 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:47:35 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:47:35 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:47:35 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:47:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:36 INFO - Downloading blessings-1.6.tar.gz 03:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:47:37 INFO - Installing collected packages: blessings 03:47:37 INFO - Running setup.py install for blessings 03:47:37 INFO - Successfully installed blessings 03:47:37 INFO - Cleaning up... 03:47:37 INFO - Return code: 0 03:47:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:47:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:47:37 INFO - Reading from file tmpfile_stdout 03:47:37 INFO - Current package versions: 03:47:37 INFO - argparse == 1.2.1 03:47:37 INFO - blessings == 1.6 03:47:37 INFO - blobuploader == 1.2.4 03:47:37 INFO - docopt == 0.6.1 03:47:37 INFO - functools32 == 3.2.3-2 03:47:37 INFO - jsonschema == 2.5.1 03:47:37 INFO - manifestparser == 1.1 03:47:37 INFO - mozInstall == 1.12 03:47:37 INFO - mozcrash == 0.17 03:47:37 INFO - mozdebug == 0.1 03:47:37 INFO - mozdevice == 0.48 03:47:37 INFO - mozfile == 1.2 03:47:37 INFO - mozhttpd == 0.7 03:47:37 INFO - mozinfo == 0.9 03:47:37 INFO - mozleak == 0.1 03:47:37 INFO - mozlog == 3.3 03:47:37 INFO - moznetwork == 0.27 03:47:37 INFO - mozprocess == 0.23 03:47:37 INFO - mozprofile == 0.28 03:47:37 INFO - mozrunner == 6.12 03:47:37 INFO - mozscreenshot == 0.1 03:47:37 INFO - mozsystemmonitor == 0.3 03:47:37 INFO - moztest == 0.7 03:47:37 INFO - mozversion == 1.4 03:47:37 INFO - psutil == 3.1.1 03:47:37 INFO - requests == 1.2.3 03:47:37 INFO - wsgiref == 0.1.2 03:47:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47: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:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:37 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 0x2a9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, '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': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', '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:47:37 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:47:37 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:47:37 INFO - Using env: {'DISPLAY': ':0', 03:47:37 INFO - 'HOME': '/home/cltbld', 03:47:37 INFO - 'LANG': 'en_US.UTF-8', 03:47:37 INFO - 'LANGUAGE': 'en_US:en', 03:47:37 INFO - 'LOGNAME': 'cltbld', 03:47:37 INFO - 'MAIL': '/var/mail/cltbld', 03:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:37 INFO - 'MOZ_NO_REMOTE': '1', 03:47:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:37 INFO - 'NO_EM_RESTART': '1', 03:47:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:37 INFO - 'PWD': '/builds/slave/test', 03:47:37 INFO - 'SHELL': '/bin/bash', 03:47:37 INFO - 'SHLVL': '1', 03:47:37 INFO - 'TERM': 'linux', 03:47:37 INFO - 'TMOUT': '86400', 03:47:37 INFO - 'USER': 'cltbld', 03:47:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:37 INFO - '_': '/tools/buildbot/bin/python'} 03:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:37 INFO - Cleaning up... 03:47:37 INFO - Return code: 0 03:47:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:47: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:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cce400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, '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': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', '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:47:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:47:37 INFO - Using env: {'DISPLAY': ':0', 03:47:37 INFO - 'HOME': '/home/cltbld', 03:47:37 INFO - 'LANG': 'en_US.UTF-8', 03:47:37 INFO - 'LANGUAGE': 'en_US:en', 03:47:37 INFO - 'LOGNAME': 'cltbld', 03:47:37 INFO - 'MAIL': '/var/mail/cltbld', 03:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:37 INFO - 'MOZ_NO_REMOTE': '1', 03:47:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:37 INFO - 'NO_EM_RESTART': '1', 03:47:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:37 INFO - 'PWD': '/builds/slave/test', 03:47:37 INFO - 'SHELL': '/bin/bash', 03:47:37 INFO - 'SHLVL': '1', 03:47:37 INFO - 'TERM': 'linux', 03:47:37 INFO - 'TMOUT': '86400', 03:47:37 INFO - 'USER': 'cltbld', 03:47:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:37 INFO - '_': '/tools/buildbot/bin/python'} 03:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:47:37 INFO - Cleaning up... 03:47:37 INFO - Return code: 0 03:47:37 INFO - Running post-action listener: _resource_record_post_action 03:47:37 INFO - Running post-action listener: _start_resource_monitoring 03:47:37 INFO - Starting resource monitoring. 03:47:37 INFO - [mozharness: 2016-09-06 10:47:37.932773Z] Finished create-virtualenv step (success) 03:47:37 INFO - [mozharness: 2016-09-06 10:47:37.933250Z] Running install step. 03:47:37 INFO - Running pre-action listener: _resource_record_pre_action 03:47:37 INFO - Running main action method: install 03:47:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:47:38 INFO - Reading from file tmpfile_stdout 03:47:38 INFO - Detecting whether we're running mozinstall >=1.0... 03:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:47:38 INFO - Reading from file tmpfile_stdout 03:47:38 INFO - Output received: 03:47:38 INFO - Usage: mozinstall [options] installer 03:47:38 INFO - Options: 03:47:38 INFO - -h, --help show this help message and exit 03:47:38 INFO - -d DEST, --destination=DEST 03:47:38 INFO - Directory to install application into. [default: 03:47:38 INFO - "/builds/slave/test"] 03:47:38 INFO - --app=APP Application being installed. [default: firefox] 03:47:38 INFO - mkdir: /builds/slave/test/build/application 03:47:38 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:47:38 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:47:54 INFO - Reading from file tmpfile_stdout 03:47:54 INFO - Output received: 03:47:54 INFO - /builds/slave/test/build/application/firefox/firefox 03:47:54 INFO - Running post-action listener: _resource_record_post_action 03:47:54 INFO - [mozharness: 2016-09-06 10:47:54.231150Z] Finished install step (success) 03:47:54 INFO - [mozharness: 2016-09-06 10:47:54.231426Z] Running run-tests step. 03:47:54 INFO - Running pre-action listener: _resource_record_pre_action 03:47:54 INFO - Running main action method: run_tests 03:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:47:54 INFO - Python 2.7.3 03:47:54 INFO - Return code: 0 03:47:54 INFO - grabbing minidump binary from tooltool 03:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:54 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 0x2d5d570>, '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 0x2d5e470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d5e900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:47:54 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:47:54 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:47:54 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:47:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:47:54 INFO - Return code: 0 03:47:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:47:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:47:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:47:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:47:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:47:54 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/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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:47:54 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/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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:47:54 INFO - Using env: {'DISPLAY': ':0', 03:47:54 INFO - 'HOME': '/home/cltbld', 03:47:54 INFO - 'LANG': 'en_US.UTF-8', 03:47:54 INFO - 'LANGUAGE': 'en_US:en', 03:47:54 INFO - 'LOGNAME': 'cltbld', 03:47:54 INFO - 'MAIL': '/var/mail/cltbld', 03:47:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:47:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:54 INFO - 'MOZ_NO_REMOTE': '1', 03:47:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:54 INFO - 'NO_EM_RESTART': '1', 03:47:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:54 INFO - 'PWD': '/builds/slave/test', 03:47:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:47:54 INFO - 'SHELL': '/bin/bash', 03:47:54 INFO - 'SHLVL': '1', 03:47:54 INFO - 'TERM': 'linux', 03:47:54 INFO - 'TMOUT': '86400', 03:47:54 INFO - 'USER': 'cltbld', 03:47:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341', 03:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:54 INFO - '_': '/tools/buildbot/bin/python'} 03:47:54 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/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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:47:54 INFO - mozversion application_buildid: 20160906004000 03:47:54 INFO - mozversion application_changeset: 37c314d53f827e5fc094fcb9b1537b4101681507 03:47:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:47:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:47:54 INFO - mozversion application_name: Firefox 03:47:54 INFO - mozversion application_remotingname: firefox-dev 03:47:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:47:54 INFO - mozversion application_vendor: Mozilla 03:47:54 INFO - mozversion application_version: 50.0a2 03:47:54 INFO - mozversion platform_buildid: 20160906004000 03:47:54 INFO - mozversion platform_changeset: 37c314d53f827e5fc094fcb9b1537b4101681507 03:47:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:47:54 INFO - mozversion platform_version: 50.0a2 03:47:54 INFO - using testdate: 1473158874 03:47:54 INFO - actual date: 1473158874 03:47:54 INFO - starting webserver on 'localhost:49204' 03:47:54 INFO - SUITE-START | Running 2 tests 03:47:54 INFO - TEST-START | dromaeo_css 03:47:54 INFO - operating with platform_type : linux_ 03:47:54 INFO - Initialising browser for dromaeo_css test... 03:47:54 INFO - TEST-INFO | started process 11093 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTT9nHI/profile http://localhost:49204/getInfo.html) 03:47:59 INFO - PROCESS | 11093 | __metrics Screen width/height:1600/1200 03:47:59 INFO - PROCESS | 11093 | colorDepth:24 03:47:59 INFO - PROCESS | 11093 | Browser inner width/height: 1024/697 03:47:59 INFO - PROCESS | 11093 | __metrics 03:47:59 ERROR - PROCESS | 11093 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:48:00 INFO - TEST-INFO | 11093: exit 0 03:48:00 INFO - Browser initialized. 03:48:00 INFO - Running cycle 1/1 for dromaeo_css test... 03:48:00 INFO - TEST-INFO | started process 11216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTT9nHI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:12 INFO - PROCESS | 11216 | RSS: Main: 152887296 03:48:12 INFO - PROCESS | 11216 | 03:49:02 INFO - PROCESS | 11216 | 1473158942004 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:51:10 INFO - PROCESS | 11216 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49204/tests/dromaeo/cssquery-ext.html) 03:51:11 INFO - PROCESS | 11216 | RSS: Main: 158015488 03:51:11 INFO - PROCESS | 11216 | 03:54:13 INFO - PROCESS | 11216 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-ext.html (next: http://localhost:49204/tests/dromaeo/cssquery-jquery.html) 03:54:14 INFO - PROCESS | 11216 | RSS: Main: 153518080 03:54:14 INFO - PROCESS | 11216 | 03:57:16 INFO - PROCESS | 11216 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49204/tests/dromaeo/cssquery-mootools.html) 03:57:16 INFO - PROCESS | 11216 | RSS: Main: 154550272 03:57:16 INFO - PROCESS | 11216 | 04:00:18 INFO - PROCESS | 11216 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49204/tests/dromaeo/cssquery-prototype.html) 04:00:19 INFO - PROCESS | 11216 | RSS: Main: 152199168 04:00:19 INFO - PROCESS | 11216 | 04:03:21 INFO - PROCESS | 11216 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49204/tests/dromaeo/cssquery-yui.html) 04:03:22 INFO - PROCESS | 11216 | RSS: Main: 154435584 04:03:22 INFO - PROCESS | 11216 | 04:06:24 INFO - PROCESS | 11216 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-yui.html (next: http://localhost:49204/tests/dromaeo/cssquery-dojo.html) 04:06:25 INFO - PROCESS | 11216 | RSS: Main: 155893760 04:06:25 INFO - PROCESS | 11216 | 04:06:25 INFO - PROCESS | 11216 | __start_tp_report 04:06:25 INFO - PROCESS | 11216 | _x_x_mozilla_page_load 04:06:25 INFO - PROCESS | 11216 | _x_x_mozilla_page_load_details 04:06:25 INFO - PROCESS | 11216 | |i|pagename|runs| 04:06:25 INFO - PROCESS | 11216 | |0;dojo.html;3269.950950735739;3282.441984862573;3302.3560405720887;3307.801531908084;3310.0400883743714;5668.489835914766;5702.8289151325425;5730.226419433376;5740.339860915996;5748.511376532994;5668.914966275499;5701.942980570193;5708.743106560204;5730.713464326788;5742.569307301958;5200.947990520084;5249.685018898859;5288.867778305535;5313.123334649778;5318.973405132969;5173.224016397552;5190.8702282443055;5202.453742357055;5216.165413533835;5219.19102539107;5192.584593232532;5199.298094757216;5206.271122042917;5284.207368894658;5344.465553444663;5253.159494480884;5270.288511050997;5270.92093618596;5279.868003299929;5300.125479295912;4990.50094990498;5058.696478211283;5147.150720131174;5215.269862219292;5217.50433708797;5629.971850140723;5683.5737319700775;5721.284839395075;5723.341815691166;5741.62679425836;6131;6170.537209709245;6196.907046394308;6202.875942481171;6206.627602343874;5952.375000624958;6029.698515074273;6211.0372892201785;6221.875562488724;6222.782202622931;5646.463585959327;5803.506701930341;5811.56413268998;5830;5840.649561026352;6217;6242.438180563771;6249.437550620375;6254.437100660963;6266.028765541349;5855;5885.352611212763;5970.940290597038;6060.272767267956;6062.878742425127;5950.077737950624;6105.786297479567;6116.052011938156;6126.6017708848785;6135.018397056449;6028.608140470856;6086.6348019119;6088.299845517734;6089.238845144357;6092.3603021682975;5916.053431451033;6019.518438524908;6027.336992930774;6027.7287522061615;6040.335563088057;4612.377329060601;4727;4728.361671174416;4734.242521196592;4750.168720473903;4205.116925445691;4211.303289644269;4221.409002739619;4222.619964203175;4249.447571815645;5738.971305143447;5842.152887831241;5950.523958083343;5952.970235148883;5970.134330522137;6120.326764055951;6201.131841542187;6213.937860621336;6226.906596401058;6227.221597300338;5954.46409823118;5959.016762234182;5959.851003724855;5962.701864906824;5986.760529578855;5205.7397130143345;5274.182501712164;5342.946570534323;5347.652402593819;5352.384475785257;6315.905261421082;6464.321246269074;6467.579607325509;6469.320721324193;6469.417752402306;6175.505959523138;6215.347388524321;6220.2535695715;6228.34602366745;6235.095911092957;6188.133661287334;6314.652694101685;6380.202474690664;6435.646039467874;6447;6005.39946005396;6120.995022892694;6126.426068710427;6128.930927367261;6141.3551577085545;6180.783672571439;6204.5036397089025;6220.284667263141;6223.813285601439;6227.719752611234;5810.854728631818;5923.49650279731;5937.050071988461;5958.880822383615;5965.4929331005615;5952.285725712942;6092.99465588173;6109.419605137505;6116.3883611638485;6123.4488895999575;5957.940420595912;5968.97015514937;5991.071383935497;6007.249093863267;6021.909671354845;5945.702714864326;5980.491658209101;6087.178230938766;6107.4197951194565;6160.414760597736;5860.267466566679;5985.311689155803;5995.250593675791;6005;6024.548158888013 04:06:25 INFO - PROCESS | 11216 | |1;ext.html;570.3099249907611;606.275500776572;615.9507239420847;638.3265654734255;658.5291516565661;42752.57247427529;46494.07011859765;46800.531994680045;46932.06135877281;47061.29408058882;47087.764561177144;47346.289805652945;47498.287525687054;47613;47695;9046.23107035901;9108.8633670495;9175;9178.54107294636;9196.678116265932;9167.220786233178;9243.352965292432;9261.53692315385;9275.072492750738;9288.442693438416;9180.44917304964;9216.723498295061;9226.400283981553;9276.814463710722;9292.860607090865;9233;9253.583588738524;9297.907020929772;9304.30217733666;9315.580798864068;9194.54027298639;9205.355625106245;9205.631774729003;9212.078792120734;9267.953660231655;43213;43356;43560.12879742419;43760.343594846105;43867.12265754667;3813.9809300953593;3942.6254505821903;4313.698041137121;4321.395004699345;4418.911621767546;35211.823940880386;35920.28159436797;35931;36098.63901360979;37143.814280928425;4737.763111844429;4753.643476739258;4757.976210118927;4791.832285869978;4854.393200849894;392928;394523;395382;396448;396479;64745.352546474875;64980;65226.673866630365;65380;65385.67307163434;41792.582074179474;42519.36220956688;42540;42579.36130958038;42669.35995960063;19488.805111948983;19556.119974601177;19656.21375145007;19679;19703.802961970483;13917.443302267999;13996.790048149285;14003.649908752363;14007.85992140086;14070.226137562327;20981.370558883256;21211.15155393798;21298.78701212999;21450.03474843636;21529.67705484419;7628.580428076398;7782.649780759766;7837.451378403571;7861.685532578633;7877.966982711698;998.7902540466438;1038.3769738157196;1074.2909679611575;1132.6262333429947;1180.557291015869;34938;35042.29915401678;35114.297714046086;35354.29291414157;35437;1142.5772464188303;1143.9771204576027;1167.0605162843822;1195.5516681244533;1279.456231101778;18138.062570524013;18176.45470635883;18201.180946857425;18241.543961400806;18323.541911452056;627991;628460;632737;634761;637073;67156.32843671598;67277;67514;67732.32267677359;67733;1415.2569900801955;1427.586000059971;1453.6220582648375;1459.2776575594937;1462;32648.510272346408;33328.50007249942;34258.828705856315;34260.314793704485;34672.479912801835;56221.43778562162;56483;56978.145327820945;57106;57417.42582574121;515372;516345;516932;516986;517704;31475.37049259048;31660;31704.524432133996;32193.839030804695;32239.35521289608;53426.46573534215;53650.46349536454;53869;53915;54526;44191.11617767691;46012.30981535347;46844.531554684014;47058.76470617625;47219.763901180275;44776;44806.3279050808;44986.32520512129;45519.31721024254;46907.53092469032;39103.804480977415;44102.779486102365;44918.550814491435;45111.32333015073;46760;39050.80474597723;39608.801955990035;39812.20375592414;40160.799196003834;40892;29942.550861737527;30749.692503074682;30821.69178308278;31235.37529249357;31357.372852543278 04:06:25 INFO - PROCESS | 11216 | |2;jquery.html;407.59647948530966;413.4914055711475;428.7084782348003;431.84669442347956;439.31028285591634;19371.32200372987;19991.900040499815;20819.479513012182;21072.262470813526;21087.57824843506;19453;19921.203151873942;20115.698264526007;20559.280425185123;20710.27514037009;5978.342382337928;6163.383661633846;6191.535634827406;6195.008798592226;6208.1308616793685;6003.369646187153;6017.69911504423;6026.8794624107495;6053.122297266894;6104.877902441948;5898.734556944926;5988.9101663475085;6048.243969503812;6056.60632058917;6076.149339092531;5998.1602575639445;5998.640081595118;6013.278406591194;6027.879442411149;6066.575339726221;5333.173358129496;5441.29263195786;5471.8084867029465;5473.343198816127;5480.26016487773;24131.879340603362;24563.508729825484;24621.87689061561;24715;25128.623070653954;2451.056343307839;2453.4234454903085;2559.9360015999564;2610.908618198354;2641.8546979916096;15396.692066158726;15561.299741511659;15565.922170389189;15826.683466330609;16206.513804585882;1948.298612499499;2016.3850025742142;2032.9288474903308;2047.2732180076007;2068.2864411777914;80398;82473.76289355605;82942;84664;85510;10838.458077096113;10840.945795271131;10883.83674244887;11122.888771112186;11261.718457038476;15483.84516154824;15552.611184720472;15587.844121558866;15603.141827199386;15607.21963901823;8565.914340856512;8767.167119123673;8794.692185773467;8902.109789021046;9052.954735226282;8771.868421973675;8772.868406973901;8803.515806630698;8958.596863141174;9009.54952252398;4624.468186158635;4743.335932969318;4749.4063242094735;4749.810007599726;4891.24185751202;2067.8759274443582;2113.5138918048933;2126.9149234030465;2153.8707677539396;2153.913843446276;990.9950450247702;1065.504540388723;1079.5250089960393;1114.1532435349031;1119.356370087203;20220;20692.58614827695;20744.79255207459;20945.47636309074;21115.366539003855;1063.5161001744189;1069.711177981956;1075.1882328841675;1079.5843600213818;1171.490401675274;10809.783804324026;11468;11633.825492617618;11667.183297169286;11689.123315751352;556641;560259;569625;572320;574778;90421;95340;95821;99822.50088749656;102105.48947255216;1031.7884833609241;1045.5504133222787;1073.495457135161;1078.2937176149635;1080.9675709728563;18560.907195463937;18590.721139183195;18976.62046759085;19110.61778764445;19279.036048197813;43534.78232608944;43749.12501749884;44550.3317450232;44625.77687111674;45960;62766.37233627605;64572.35427645664;65302;66651.33348666452;67374.66312668602;9048.140426659456;9097.363184577016;9108.817823643358;9122.771930701785;9208.769780755267;12543.62369128891;13230.735385292433;13560.796588051384;14385;14494.565163045125;11781.646550603497;11982.820257695967;11986.880131198925;12038.879611203776;12089.274643521418;12165.817512737493;12253.571125010581;12292.631221063382;12486.314347563326;12609.747805043664;12065.879341206826;12135.696607584881;12165.939170304091;12469.688257793629;12521.87478125207;8783.956080219557;8905.109489051043;8937.642494300155;9005.189532942066;9220.538973051454;9482.004389538999;11805.763884722086;11873.525058997544;11919.284842909106;11955.76088478243 04:06:25 INFO - PROCESS | 11216 | |3;mootools.html;1570.3169121432175;1580.0598643806934;1755.1662960093956;1866.4493974277595;1876.9906150469246;8244.34045276378;8629.611667474963;8688.218060374566;9457.905420945788;9473;8683.869741953877;8843.778905527364;9141.634334626608;9167.312451566142;9178.678746243882;2470.22188010776;2511.635812807142;2521.8865151068244;2523.6466894634764;2529.5067461844947;2413.4811015631635;2472.7279999200073;2475.2945410557995;2475.925722228336;2478.24413553866;2469.3826543364157;2479.5412848623064;2527.2039307618043;2536.9746302536923;2555.565553855849;2422.1522467136538;2431.598786200275;2441.0479912834007;2454.840435371704;2461.79074778644;2411.686480757508;2413.9396515087265;2414.0464516516054;2444.547758664635;2456.250843492734;9196.356255062148;9237.122473365087;9278.953605231998;9304.720858374192;9308.301877359225;5268.262443257947;5414.945850541523;5447.1829225616075;5467.835964921059;5469.206964990094;3436.5876094868777;3553.4314509678584;3613.373981708242;3613.6747692707518;3619;1124.1283263366486;1131.869834968981;1161.4947497838468;1173.178774857603;1183.0535571542732;12781.872181278255;12917.935410322889;12937.611871643865;12948;13002.479900803863;4694.076223041246;4713.835015774432;4788.425388953278;4919.065377578248;4956.826511072168;11033.83449248262;11053.171012173958;11082.722931926604;11118.722031949104;11140;5638.718064096779;5650.491455769001;5652.745626446737;5668.716564171775;5686.715664216773;4599.540045995441;4894.535019173173;4976.576990955809;4994.700317980933;5220.060389129917;4265.829366825355;4304.268274393361;4340.8480703175865;4358.237308471005;4398.934015989763;1286.581860895213;1350.0279798545032;1351.6283022168982;1360.3946243921557;1364.3519328319167;927.7216834949488;1072.2387105155271;1072.742541789965;1075.1613741281813;1085.1861104171871;6285.025820997753;6306.968465157736;6468.288488266287;6521.413072823374;6530.118434011348;472.55107647734104;478.30884372082005;485.5144855144855;493.3758795124171;495.8462876508222;4196.895077623084;4234.936475952802;4255.106427650167;4281.357796330575;4288.764117973541;11339.319640821577;11553.711157220969;11584.073274138049;11669;11683.649490515298;11511;11560.826587601192;11585.76828463426;11596;11606.76786464266;8183.83632327362;8582.527960962083;8637;8683.131686831266;8763.25512331459;6258.155149054819;6424.935750642434;6484.740610375532;6586.037600287421;6716.83207919806;10491.318064325795;10534.631287904887;10870.293430926964;10944;11031.613893513688;10772.461376931278;10868.130549555859;10894.964978327047;10986.230963832455;11044.723881903017;8087.595620219083;8203.425760196968;8262.380321475794;8307.086220515617;8515.74452766418;9139;9276.443413395218;9289.674861379819;9325.393849399767;9332.766680833034;8090.650317495149;8227.13615070409;8266.710665126691;8374.330053595819;8400.831983360176;8063.637136328762;8102.311303539265;8109.229623185788;8132.3900707448365;8254.628541715518;7482.1021477423055;7554.320111190019;7648.923510764821;7666.9616651916385;7687.423443241891;5401.3248343957;5409.323834520685;5575.940571291441;5703.429657034263;5732.111522713986;5481.5340696041285;5564.860878478071;5567.109262517978;5618.988582055269;5706.457886500776 04:06:25 INFO - PROCESS | 11216 | |4;prototype.html;344.31996806307546;353.70995783457556;354.84564214566666;357.81393675288837;359.51286007459873;5739.196512488255;5756.654600723959;5931.288245410551;5998.310194327653;6052.122442245872;5745.454181852718;5773.624714393572;5804.941950580493;5811.27359080115;5828.737706803194;4626.190416677085;4643.233866412055;4657.4876763555985;4662.487126416091;4667.976660116695;4541.159885421208;4597.149527337437;4600.930986035212;4636.97681511592;4668.6731928765;4561.498235194126;4591.65562582806;4613.408374110926;4615.930761038587;4624.953750462503;4604.930926036112;4612.377329060568;4621.168189725848;4667.393238878924;4668.11305851887;3848.8845334639727;3992.9201415971806;4003.619656132692;4128.855490057834;4152.2525945330135;5659.688717120557;5672.659640421588;5697.914531282034;5705.714714264312;5744.770209191627;5137.152369859006;5140.434552199255;5188.792448302063;5235.272360121189;5273.683578985235;5871.442212989759;6090.817275481742;6091.390860913917;6112.816615501542;6177.567570270083;4378.168148051892;4410.62509686677;4424.955750442518;4428.557144285545;4428.689991700582;6071.544634152457;6363.300036995926;6395.488360931161;6414.807555773287;6449.83875403114;4474.239379305526;4474.574915383034;4484.439445069366;4508.977455112769;4512.142692888341;4568.611668008257;4588.151192029485;4590.645759500889;4599.793009314589;4609;5152.175651895679;5226.425093239741;5242.1088414969545;5254.579633629301;5289.894202116013;5913.881722365529;6120.14317995481;6172.259328880563;6176.135341052256;6252;1559.3762495001863;1560.4460416552188;1565.420794306114;1571.1201727032899;1574.826769055403;933.3466573398648;969.5830792759182;971.3686104032295;1016.0753714120116;1019.5972590826582;5300.416954135042;5310.150375939831;5313.299744081934;5383.300170977826;5393.545936598838;5515.593523651443;5532.944670553243;5538.335399752055;5551.361593416808;5599.8880022400135;4952.4304704959395;5071.239314102841;5295.338082739658;5344.866378340573;5356.758945847446;2987.850607469661;3007.8345690986766;3009.9398012040074;3050.481418158918;3050.7559395248327;5588.3734644716915;5703.486686198262;5713.457221563945;5747.413663851284;5778.313084415767;5642.576806739429;5652.463016013472;5680.943190568124;5723.141528770634;5783.508401785811;5794;5808;5836.854078648068;5863.237779088691;5879.823605291763;5215.5486921147;5516.255305533701;5518.696471693935;5568.97215513936;5665.546756259571;5465.508104270635;5511.614187007031;5514.503694667499;5546.639468434539;5564.860878478071;5671.40450252734;5715.17130016137;5737.569682273763;5793.768249269982;5834.504067154339;4157.10622216225;4471.8658440246845;4474.642028637636;4481.529439408815;4486.7083639563325;6175.907361389673;6312.558120931674;6341.4292713656;6356.68216589178;6357.901892375413;6150.415710507495;6192.969035154795;6204.565680402328;6206.937930620636;6218.595791273553;6155.753769849156;6199.225096862892;6226.937730622636;6246.156768836149;6293.213348331458;6180.938190618036;6187.474064704371;6193.721282542207;6217.761605821991;6235.064740288812;6258.561900667091;6340.256429481929;6347.508335541236;6360.93639063622;6374.553781235269;5854.443827836349;6082.665453400105;6092.055731361646;6100.572959892765;6112.786052488142 04:06:25 INFO - PROCESS | 11216 | |5;yui.html;838.8532006898791;843.59929033709;877.7322916510464;899.7570655922901;906.8005038891441;16197.919010404947;17269;17383.391581294658;17479.65040699187;17482.38811641593;15861.20693965303;16179.35282588695;16209.432669856558;16262.43081492145;16322.183890805472;704.2570088556571;860.5267103093305;884.6903583745669;888.5468411110315;889.5107690770083;884.6947803007984;887.0863011098546;891.3983061433539;892.1836519584572;894.5884892949218;918.4764684130049;922.8569571716362;924.8751418558476;925.4771054354268;927.638221093774;918.485648037098;921.0605182713595;923.0861447167323;924.4638109896277;925.5927391947522;676.0366477769209;678.4368973751774;680.0445374249188;680.4896327754184;680.843406016614;14732.18972956487;14793.55619331411;14811.333489992976;14818.333175007043;14819;15391.615209619737;15494.61263468411;15558.844411555852;15626.14056226907;15845.60385990348;12869.09916305859;12902.677433064155;12951.352432378437;13046.478140874353;13190.60428187156;4126.194346429853;4154.065335299563;4181.0592616661315;4181.519125300599;4207.495100587918;89751;90799;91670.541647292;91863.54068229617;92553.53723231408;13033.218006919615;13058.738825223443;13135.146215495963;13174.143680660727;13237.536686216128;24978.875950582267;25081.247562573153;25092.623610645856;25203;25278.368040799127;9203.723888283363;9314.813703725888;9439.76400589977;9502.334836561375;9521.095495927875;5197.428282888879;5261.684298941999;5263.131583288791;5364.624476286701;5423.674579525241;3728.7949162795762;3836.4820749199057;3840.6735427488416;3843.26977874203;3844.4041173618134;652.0903339840991;654.443722835586;657.6908852839158;671.1509939925998;684.6131935456451;656.6519744535403;691.4675699711195;695.5896021347328;719.7552832037132;787.8857565653063;10484.161267098614;10527.789444211074;10548.525316360781;10729.570817167381;11337.376444295478;674.5244602555186;730.3390431659357;731;795.9920400796034;812.9268365846984;5184.326037615161;5377.300950876361;5451.863703407367;5535.308086489189;5611.298587676541;123689.38155309166;124170;124397;126393.36803315925;126779;105659;105843.4707826456;109388;109411.45294273477;111794;91545;95304;96766.51616741871;97095.51452242835;98051.01948980705;9380.296477764332;9485.857712134462;9491.288153388385;9683.467409292556;9833.62329273888;52748.20877686761;53006.352046298656;53370.1994470091;53721;54271.45728542664;72320;78370.6081469589;79292;81385.59307203663;82134.58932705298;14436.422543098159;15074.321655525308;15142.394304228148;16165;16562.17189140514;16715.164241788105;17262.22319995578;17311.7403238949;18115.637687246446;18418.17118229656;15863.286152123414;16432.260548275597;16627.08551029705;17499.475015749547;17535.736963945295;15913.68172636564;16026.198690065683;16898.23957921921;17440.73838892392;17562.38531651386;15530.611734706723;15868.285927133538;16912.74630880513;16941.91529042347;17011.48965531036;12237.571684990982;12442.315672638091;12475;12587.685307867376;13385.598432047054;10930.781384372427;11630.476628551905;12327.753444930871;12451;13216.140950838164 04:06:25 INFO - PROCESS | 11216 | __end_tp_report 04:06:25 INFO - PROCESS | 11216 | __start_cc_report 04:06:25 INFO - PROCESS | 11216 | _x_x_mozilla_cycle_collect,325 04:06:25 INFO - PROCESS | 11216 | __end_cc_report 04:06:25 INFO - PROCESS | 11216 | __startTimestamp1473159985113__endTimestamp 04:06:25 INFO - PROCESS | 11216 | 04:06:25 INFO - PROCESS | 11216 | ------- Summary: start ------- 04:06:25 INFO - PROCESS | 11216 | Number of tests: 6 04:06:25 INFO - PROCESS | 11216 | 04:06:25 INFO - PROCESS | 11216 | [#0] dojo.html Cycles:165 Average:5716.72 Median:5958.88 stddev:653.68 (11.0%) stddev-sans-first:626.87 04:06:25 INFO - PROCESS | 11216 | Values: 3270.0 3282.4 3302.4 3307.8 3310.0 5668.5 5702.8 5730.2 5740.3 5748.5 5668.9 5701.9 5708.7 5730.7 5742.6 5200.9 5249.7 5288.9 5313.1 5319.0 5173.2 5190.9 5202.5 5216.2 5219.2 5192.6 5199.3 5206.3 5284.2 5344.5 5253.2 5270.3 5270.9 5279.9 5300.1 4990.5 5058.7 5147.2 5215.3 5217.5 5630.0 5683.6 5721.3 5723.3 5741.6 6131.0 6170.5 6196.9 6202.9 6206.6 5952.4 6029.7 6211.0 6221.9 6222.8 5646.5 5803.5 5811.6 5830.0 5840.6 6217.0 6242.4 6249.4 6254.4 6266.0 5855.0 5885.4 5970.9 6060.3 6062.9 5950.1 6105.8 6116.1 6126.6 6135.0 6028.6 6086.6 6088.3 6089.2 6092.4 5916.1 6019.5 6027.3 6027.7 6040.3 4612.4 4727.0 4728.4 4734.2 4750.2 4205.1 4211.3 4221.4 4222.6 4249.4 5739.0 5842.2 5950.5 5953.0 5970.1 6120.3 6201.1 6213.9 6226.9 6227.2 5954.5 5959.0 5959.9 5962.7 5986.8 5205.7 5274.2 5342.9 5347.7 5352.4 6315.9 6464.3 6467.6 6469.3 6469.4 6175.5 6215.3 6220.3 6228.3 6235.1 6188.1 6314.7 6380.2 6435.6 6447.0 6005.4 6121.0 6126.4 6128.9 6141.4 6180.8 6204.5 6220.3 6223.8 6227.7 5810.9 5923.5 5937.1 5958.9 5965.5 5952.3 6093.0 6109.4 6116.4 6123.4 5957.9 5969.0 5991.1 6007.2 6021.9 5945.7 5980.5 6087.2 6107.4 6160.4 5860.3 5985.3 5995.3 6005.0 6024.5 04:06:25 INFO - PROCESS | 11216 | 04:06:25 INFO - PROCESS | 11216 | [#1] ext.html Cycles:180 Average:68067.65 Median:44952.44 stddev:139259.47 (309.8%) stddev-sans-first:139557.92 04:06:25 INFO - PROCESS | 11216 | Values: 570.3 606.3 616.0 638.3 658.5 42752.6 46494.1 46800.5 46932.1 47061.3 47087.8 47346.3 47498.3 47613.0 47695.0 9046.2 9108.9 9175.0 9178.5 9196.7 9167.2 9243.4 9261.5 9275.1 9288.4 9180.4 9216.7 9226.4 9276.8 9292.9 9233.0 9253.6 9297.9 9304.3 9315.6 9194.5 9205.4 9205.6 9212.1 9268.0 43213.0 43356.0 43560.1 43760.3 43867.1 3814.0 3942.6 4313.7 4321.4 4418.9 35211.8 35920.3 35931.0 36098.6 37143.8 4737.8 4753.6 4758.0 4791.8 4854.4 392928.0 394523.0 395382.0 396448.0 396479.0 64745.4 64980.0 65226.7 65380.0 65385.7 41792.6 42519.4 42540.0 42579.4 42669.4 19488.8 19556.1 19656.2 19679.0 19703.8 13917.4 13996.8 14003.6 14007.9 14070.2 20981.4 21211.2 21298.8 21450.0 21529.7 7628.6 7782.6 7837.5 7861.7 7878.0 998.8 1038.4 1074.3 1132.6 1180.6 34938.0 35042.3 35114.3 35354.3 35437.0 1142.6 1144.0 1167.1 1195.6 1279.5 18138.1 18176.5 18201.2 18241.5 18323.5 627991.0 628460.0 632737.0 634761.0 637073.0 67156.3 67277.0 67514.0 67732.3 67733.0 1415.3 1427.6 1453.6 1459.3 1462.0 32648.5 33328.5 34258.8 34260.3 34672.5 56221.4 56483.0 56978.1 57106.0 57417.4 515372.0 516345.0 516932.0 516986.0 517704.0 31475.4 31660.0 31704.5 32193.8 32239.4 53426.5 53650.5 53869.0 53915.0 54526.0 44191.1 46012.3 46844.5 47058.8 47219.8 44776.0 44806.3 44986.3 45519.3 46907.5 39103.8 44102.8 44918.6 45111.3 46760.0 39050.8 39608.8 39812.2 40160.8 40892.0 29942.6 30749.7 30821.7 31235.4 31357.4 04:06:25 INFO - PROCESS | 11216 | 04:06:25 INFO - PROCESS | 11216 | [#2] jquery.html Cycles:180 Average:32145.72 Median:2452.24 stddev:93179.85 (3799.8%) stddev-sans-first:93410.77 04:06:25 INFO - PROCESS | 11216 | Values: 407.6 413.5 428.7 431.8 439.3 19371.3 19991.9 20819.5 21072.3 21087.6 19453.0 19921.2 20115.7 20559.3 20710.3 5978.3 6163.4 6191.5 6195.0 6208.1 6003.4 6017.7 6026.9 6053.1 6104.9 5898.7 5988.9 6048.2 6056.6 6076.1 5998.2 5998.6 6013.3 6027.9 6066.6 5333.2 5441.3 5471.8 5473.3 5480.3 24131.9 24563.5 24621.9 24715.0 25128.6 2451.1 2453.4 2559.9 2610.9 2641.9 15396.7 15561.3 15565.9 15826.7 16206.5 1948.3 2016.4 2032.9 2047.3 2068.3 80398.0 82473.8 82942.0 84664.0 85510.0 10838.5 10840.9 10883.8 11122.9 11261.7 15483.8 15552.6 15587.8 15603.1 15607.2 8565.9 8767.2 8794.7 8902.1 9053.0 8771.9 8772.9 8803.5 8958.6 9009.5 4624.5 4743.3 4749.4 4749.8 4891.2 2067.9 2113.5 2126.9 2153.9 2153.9 991.0 1065.5 1079.5 1114.2 1119.4 20220.0 20692.6 20744.8 20945.5 21115.4 1063.5 1069.7 1075.2 1079.6 1171.5 10809.8 11468.0 11633.8 11667.2 11689.1 556641.0 560259.0 569625.0 572320.0 574778.0 90421.0 95340.0 95821.0 99822.5 102105.5 1031.8 1045.6 1073.5 1078.3 1081.0 18560.9 18590.7 18976.6 19110.6 19279.0 43534.8 43749.1 44550.3 44625.8 45960.0 62766.4 64572.4 65302.0 66651.3 67374.7 9048.1 9097.4 9108.8 9122.8 9208.8 12543.6 13230.7 13560.8 14385.0 14494.6 11781.6 11982.8 11986.9 12038.9 12089.3 12165.8 12253.6 12292.6 12486.3 12609.7 12065.9 12135.7 12165.9 12469.7 12521.9 8784.0 8905.1 8937.6 9005.2 9220.5 9482.0 11805.8 11873.5 11919.3 11955.8 04:06:25 INFO - PROCESS | 11216 | 04:06:25 INFO - PROCESS | 11216 | [#3] mootools.html Cycles:180 Average:6146.91 Median:4703.96 stddev:3511.76 (74.7%) stddev-sans-first:3504.77 04:06:25 INFO - PROCESS | 11216 | Values: 1570.3 1580.1 1755.2 1866.4 1877.0 8244.3 8629.6 8688.2 9457.9 9473.0 8683.9 8843.8 9141.6 9167.3 9178.7 2470.2 2511.6 2521.9 2523.6 2529.5 2413.5 2472.7 2475.3 2475.9 2478.2 2469.4 2479.5 2527.2 2537.0 2555.6 2422.2 2431.6 2441.0 2454.8 2461.8 2411.7 2413.9 2414.0 2444.5 2456.3 9196.4 9237.1 9279.0 9304.7 9308.3 5268.3 5414.9 5447.2 5467.8 5469.2 3436.6 3553.4 3613.4 3613.7 3619.0 1124.1 1131.9 1161.5 1173.2 1183.1 12781.9 12917.9 12937.6 12948.0 13002.5 4694.1 4713.8 4788.4 4919.1 4956.8 11033.8 11053.2 11082.7 11118.7 11140.0 5638.7 5650.5 5652.7 5668.7 5686.7 4599.5 4894.5 4976.6 4994.7 5220.1 4265.8 4304.3 4340.8 4358.2 4398.9 1286.6 1350.0 1351.6 1360.4 1364.4 927.7 1072.2 1072.7 1075.2 1085.2 6285.0 6307.0 6468.3 6521.4 6530.1 472.6 478.3 485.5 493.4 495.8 4196.9 4234.9 4255.1 4281.4 4288.8 11339.3 11553.7 11584.1 11669.0 11683.6 11511.0 11560.8 11585.8 11596.0 11606.8 8183.8 8582.5 8637.0 8683.1 8763.3 6258.2 6424.9 6484.7 6586.0 6716.8 10491.3 10534.6 10870.3 10944.0 11031.6 10772.5 10868.1 10895.0 10986.2 11044.7 8087.6 8203.4 8262.4 8307.1 8515.7 9139.0 9276.4 9289.7 9325.4 9332.8 8090.7 8227.1 8266.7 8374.3 8400.8 8063.6 8102.3 8109.2 8132.4 8254.6 7482.1 7554.3 7648.9 7667.0 7687.4 5401.3 5409.3 5575.9 5703.4 5732.1 5481.5 5564.9 5567.1 5619.0 5706.5 04:06:25 INFO - PROCESS | 11216 | 04:06:25 INFO - PROCESS | 11216 | [#4] prototype.html Cycles:180 Average:5003.29 Median:5542.49 stddev:1444.04 (26.1%) stddev-sans-first:1405.12 04:06:25 INFO - PROCESS | 11216 | Values: 344.3 353.7 354.8 357.8 359.5 5739.2 5756.7 5931.3 5998.3 6052.1 5745.5 5773.6 5804.9 5811.3 5828.7 4626.2 4643.2 4657.5 4662.5 4668.0 4541.2 4597.1 4600.9 4637.0 4668.7 4561.5 4591.7 4613.4 4615.9 4625.0 4604.9 4612.4 4621.2 4667.4 4668.1 3848.9 3992.9 4003.6 4128.9 4152.3 5659.7 5672.7 5697.9 5705.7 5744.8 5137.2 5140.4 5188.8 5235.3 5273.7 5871.4 6090.8 6091.4 6112.8 6177.6 4378.2 4410.6 4425.0 4428.6 4428.7 6071.5 6363.3 6395.5 6414.8 6449.8 4474.2 4474.6 4484.4 4509.0 4512.1 4568.6 4588.2 4590.6 4599.8 4609.0 5152.2 5226.4 5242.1 5254.6 5289.9 5913.9 6120.1 6172.3 6176.1 6252.0 1559.4 1560.4 1565.4 1571.1 1574.8 933.3 969.6 971.4 1016.1 1019.6 5300.4 5310.2 5313.3 5383.3 5393.5 5515.6 5532.9 5538.3 5551.4 5599.9 4952.4 5071.2 5295.3 5344.9 5356.8 2987.9 3007.8 3009.9 3050.5 3050.8 5588.4 5703.5 5713.5 5747.4 5778.3 5642.6 5652.5 5680.9 5723.1 5783.5 5794.0 5808.0 5836.9 5863.2 5879.8 5215.5 5516.3 5518.7 5569.0 5665.5 5465.5 5511.6 5514.5 5546.6 5564.9 5671.4 5715.2 5737.6 5793.8 5834.5 4157.1 4471.9 4474.6 4481.5 4486.7 6175.9 6312.6 6341.4 6356.7 6357.9 6150.4 6193.0 6204.6 6206.9 6218.6 6155.8 6199.2 6226.9 6246.2 6293.2 6180.9 6187.5 6193.7 6217.8 6235.1 6258.6 6340.3 6347.5 6360.9 6374.6 5854.4 6082.7 6092.1 6100.6 6112.8 04:06:25 INFO - PROCESS | 11216 | 04:06:25 INFO - PROCESS | 11216 | [#5] yui.html Cycles:180 Average:23086.97 Median:4140.13 stddev:32949.79 (795.9%) stddev-sans-first:32999.87 04:06:25 INFO - PROCESS | 11216 | Values: 838.9 843.6 877.7 899.8 906.8 16197.9 17269.0 17383.4 17479.7 17482.4 15861.2 16179.4 16209.4 16262.4 16322.2 704.3 860.5 884.7 888.5 889.5 884.7 887.1 891.4 892.2 894.6 918.5 922.9 924.9 925.5 927.6 918.5 921.1 923.1 924.5 925.6 676.0 678.4 680.0 680.5 680.8 14732.2 14793.6 14811.3 14818.3 14819.0 15391.6 15494.6 15558.8 15626.1 15845.6 12869.1 12902.7 12951.4 13046.5 13190.6 4126.2 4154.1 4181.1 4181.5 4207.5 89751.0 90799.0 91670.5 91863.5 92553.5 13033.2 13058.7 13135.1 13174.1 13237.5 24978.9 25081.2 25092.6 25203.0 25278.4 9203.7 9314.8 9439.8 9502.3 9521.1 5197.4 5261.7 5263.1 5364.6 5423.7 3728.8 3836.5 3840.7 3843.3 3844.4 652.1 654.4 657.7 671.2 684.6 656.7 691.5 695.6 719.8 787.9 10484.2 10527.8 10548.5 10729.6 11337.4 674.5 730.3 731.0 796.0 812.9 5184.3 5377.3 5451.9 5535.3 5611.3 123689.4 124170.0 124397.0 126393.4 126779.0 105659.0 105843.5 109388.0 109411.5 111794.0 91545.0 95304.0 96766.5 97095.5 98051.0 9380.3 9485.9 9491.3 9683.5 9833.6 52748.2 53006.4 53370.2 53721.0 54271.5 72320.0 78370.6 79292.0 81385.6 82134.6 14436.4 15074.3 15142.4 16165.0 16562.2 16715.2 17262.2 17311.7 18115.6 18418.2 15863.3 16432.3 16627.1 17499.5 17535.7 15913.7 16026.2 16898.2 17440.7 17562.4 15530.6 15868.3 16912.7 16941.9 17011.5 12237.6 12442.3 12475.0 12587.7 13385.6 10930.8 11630.5 12327.8 12451.0 13216.1 04:06:25 INFO - PROCESS | 11216 | -------- Summary: end -------- 04:06:25 INFO - PROCESS | 11216 | 04:06:25 INFO - TEST-INFO | 11216: exit 0 04:06:25 INFO - TEST-OK | dromaeo_css | took 1111326ms 04:06:25 INFO - TEST-START | kraken 04:06:25 INFO - operating with platform_type : linux_ 04:06:25 INFO - Initialising browser for kraken test... 04:06:25 INFO - TEST-INFO | started process 11478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB52vze/profile http://localhost:49204/getInfo.html) 04:06:30 INFO - PROCESS | 11478 | __metrics Screen width/height:1600/1200 04:06:30 INFO - PROCESS | 11478 | colorDepth:24 04:06:30 INFO - PROCESS | 11478 | Browser inner width/height: 1024/697 04:06:30 INFO - PROCESS | 11478 | __metrics 04:06:30 ERROR - PROCESS | 11478 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:06:31 INFO - TEST-INFO | 11478: exit 0 04:06:31 INFO - Browser initialized. 04:06:31 INFO - Running cycle 1/1 for kraken test... 04:06:31 INFO - TEST-INFO | started process 11602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB52vze/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:43 INFO - PROCESS | 11602 | RSS: Main: 152502272 04:06:43 INFO - PROCESS | 11602 | 04:06:45 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49204/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:46 INFO - PROCESS | 11602 | RSS: Main: 158416896 04:06:46 INFO - PROCESS | 11602 | 04:06:49 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49204/tests/kraken/driver.html?testName=audio-dft) 04:06:50 INFO - PROCESS | 11602 | RSS: Main: 156504064 04:06:50 INFO - PROCESS | 11602 | 04:06:52 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49204/tests/kraken/driver.html?testName=audio-fft) 04:06:53 INFO - PROCESS | 11602 | RSS: Main: 157491200 04:06:53 INFO - PROCESS | 11602 | 04:06:55 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49204/tests/kraken/driver.html?testName=audio-oscillator) 04:06:56 INFO - PROCESS | 11602 | RSS: Main: 157306880 04:06:56 INFO - PROCESS | 11602 | 04:06:58 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49204/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:59 INFO - PROCESS | 11602 | RSS: Main: 157388800 04:06:59 INFO - PROCESS | 11602 | 04:07:02 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49204/tests/kraken/driver.html?testName=imaging-darkroom) 04:07:02 INFO - PROCESS | 11602 | RSS: Main: 156798976 04:07:02 INFO - PROCESS | 11602 | 04:07:06 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49204/tests/kraken/driver.html?testName=imaging-desaturate) 04:07:06 INFO - PROCESS | 11602 | RSS: Main: 157585408 04:07:06 INFO - PROCESS | 11602 | 04:07:09 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49204/tests/kraken/driver.html?testName=json-parse-financial) 04:07:10 INFO - PROCESS | 11602 | RSS: Main: 157736960 04:07:10 INFO - PROCESS | 11602 | 04:07:11 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49204/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:07:12 INFO - PROCESS | 11602 | RSS: Main: 157077504 04:07:12 INFO - PROCESS | 11602 | 04:07:14 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:07:14 INFO - PROCESS | 11602 | RSS: Main: 157175808 04:07:14 INFO - PROCESS | 11602 | 04:07:16 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:07:17 INFO - PROCESS | 11602 | RSS: Main: 157097984 04:07:17 INFO - PROCESS | 11602 | 04:07:20 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:07:20 INFO - PROCESS | 11602 | RSS: Main: 158212096 04:07:20 INFO - PROCESS | 11602 | 04:07:23 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:23 INFO - PROCESS | 11602 | RSS: Main: 158638080 04:07:23 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49204/tests/kraken/driver.html?testName=ai-astar) 04:07:25 INFO - PROCESS | 11602 | RSS: Main: 159158272 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | __start_tp_report 04:07:25 INFO - PROCESS | 11602 | _x_x_mozilla_page_load 04:07:25 INFO - PROCESS | 11602 | _x_x_mozilla_page_load_details 04:07:25 INFO - PROCESS | 11602 | |i|pagename|runs| 04:07:25 INFO - PROCESS | 11602 | |0;ai-astar;101;111;105;110;111;113;111;113;111;113 04:07:25 INFO - PROCESS | 11602 | |1;audio-beat-detection;142;116;149;177;122;143;147;118;185;114 04:07:25 INFO - PROCESS | 11602 | |2;audio-dft;161;162;164;162;168;162;162;162;160;164 04:07:25 INFO - PROCESS | 11602 | |3;audio-fft;74;77;76;172;76;76;75;77;182;76 04:07:25 INFO - PROCESS | 11602 | |4;audio-oscillator;84;83;158;83;84;84;133;83;83;137 04:07:25 INFO - PROCESS | 11602 | |5;imaging-gaussian-blur;118;117;117;117;117;118;118;118;128;117 04:07:25 INFO - PROCESS | 11602 | |6;imaging-darkroom;146;147;148;146;147;147;147;146;146;147 04:07:25 INFO - PROCESS | 11602 | |7;imaging-desaturate;95;95;97;100;96;95;96;96;96;95 04:07:25 INFO - PROCESS | 11602 | |8;json-parse-financial;55;57;52;51;53;51;53;52;51;54 04:07:25 INFO - PROCESS | 11602 | |9;json-stringify-tinderbox;62;60;60;59;60;60;60;60;61;62 04:07:25 INFO - PROCESS | 11602 | |10;stanford-crypto-aes;72;72;73;72;71;82;74;73;72;71 04:07:25 INFO - PROCESS | 11602 | |11;stanford-crypto-ccm;127;132;120;117;128;119;118;125;146;130 04:07:25 INFO - PROCESS | 11602 | |12;stanford-crypto-pbkdf2;153;156;152;159;154;155;161;153;151;159 04:07:25 INFO - PROCESS | 11602 | |13;stanford-crypto-sha256-iterative;64;63;66;65;65;63;69;62;62;62 04:07:25 INFO - PROCESS | 11602 | __end_tp_report 04:07:25 INFO - PROCESS | 11602 | __start_cc_report 04:07:25 INFO - PROCESS | 11602 | _x_x_mozilla_cycle_collect,910 04:07:25 INFO - PROCESS | 11602 | __end_cc_report 04:07:25 INFO - PROCESS | 11602 | __startTimestamp1473160045828__endTimestamp 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | ------- Summary: start ------- 04:07:25 INFO - PROCESS | 11602 | Number of tests: 14 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.90 (3.5%) stddev-sans-first:2.47 04:07:25 INFO - PROCESS | 11602 | Values: 101.0 111.0 105.0 110.0 111.0 113.0 111.0 113.0 111.0 113.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:145.00 stddev:24.90 (17.2%) stddev-sans-first:26.41 04:07:25 INFO - PROCESS | 11602 | Values: 142.0 116.0 149.0 177.0 122.0 143.0 147.0 118.0 185.0 114.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.21 (1.4%) stddev-sans-first:2.26 04:07:25 INFO - PROCESS | 11602 | Values: 161.0 162.0 164.0 162.0 168.0 162.0 162.0 162.0 160.0 164.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:42.71 (56.2%) stddev-sans-first:44.55 04:07:25 INFO - PROCESS | 11602 | Values: 74.0 77.0 76.0 172.0 76.0 76.0 75.0 77.0 182.0 76.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:83.00 stddev:29.31 (35.3%) stddev-sans-first:30.42 04:07:25 INFO - PROCESS | 11602 | Values: 84.0 83.0 158.0 83.0 84.0 84.0 133.0 83.0 83.0 137.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.00 stddev:3.37 (2.9%) stddev-sans-first:3.57 04:07:25 INFO - PROCESS | 11602 | Values: 118.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 128.0 117.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 04:07:25 INFO - PROCESS | 11602 | Values: 146.0 147.0 148.0 146.0 147.0 147.0 147.0 146.0 146.0 147.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.52 (1.6%) stddev-sans-first:1.56 04:07:25 INFO - PROCESS | 11602 | Values: 95.0 95.0 97.0 100.0 96.0 95.0 96.0 96.0 96.0 95.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.97 (3.7%) stddev-sans-first:1.94 04:07:25 INFO - PROCESS | 11602 | Values: 55.0 57.0 52.0 51.0 53.0 51.0 53.0 52.0 51.0 54.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:0.97 (1.6%) stddev-sans-first:0.83 04:07:25 INFO - PROCESS | 11602 | Values: 62.0 60.0 60.0 59.0 60.0 60.0 60.0 60.0 61.0 62.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:72.50 stddev:3.22 (4.4%) stddev-sans-first:3.39 04:07:25 INFO - PROCESS | 11602 | Values: 72.0 72.0 73.0 72.0 71.0 82.0 74.0 73.0 72.0 71.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.50 stddev:8.74 (6.9%) stddev-sans-first:9.27 04:07:25 INFO - PROCESS | 11602 | Values: 127.0 132.0 120.0 117.0 128.0 119.0 118.0 125.0 146.0 130.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:155.50 stddev:3.37 (2.2%) stddev-sans-first:3.47 04:07:25 INFO - PROCESS | 11602 | Values: 153.0 156.0 152.0 159.0 154.0 155.0 161.0 153.0 151.0 159.0 04:07:25 INFO - PROCESS | 11602 | 04:07:25 INFO - PROCESS | 11602 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:2.23 (3.5%) stddev-sans-first:2.37 04:07:25 INFO - PROCESS | 11602 | Values: 64.0 63.0 66.0 65.0 65.0 63.0 69.0 62.0 62.0 62.0 04:07:25 INFO - PROCESS | 11602 | -------- Summary: end -------- 04:07:25 INFO - PROCESS | 11602 | 04:07:26 INFO - TEST-INFO | 11602: exit 0 04:07:26 INFO - TEST-OK | kraken | took 60956ms 04:07:26 INFO - SUITE-END | took 1172s 04:07:26 INFO - Completed test suite (00:19:32) 04:07:26 INFO - javascript benchmark 04:07:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7787.726930472131, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3269.950950735739, 3282.441984862573, 3302.3560405720887, 3307.801531908084, 3310.0400883743714, 5668.489835914766, 5702.8289151325425, 5730.226419433376, 5740.339860915996, 5748.511376532994, 5668.914966275499, 5701.942980570193, 5708.743106560204, 5730.713464326788, 5742.569307301958, 5200.947990520084, 5249.685018898859, 5288.867778305535, 5313.123334649778, 5318.973405132969, 5173.224016397552, 5190.8702282443055, 5202.453742357055, 5216.165413533835, 5219.19102539107, 5192.584593232532, 5199.298094757216, 5206.271122042917, 5284.207368894658, 5344.465553444663, 5253.159494480884, 5270.288511050997, 5270.92093618596, 5279.868003299929, 5300.125479295912, 4990.50094990498, 5058.696478211283, 5147.150720131174, 5215.269862219292, 5217.50433708797, 5629.971850140723, 5683.5737319700775, 5721.284839395075, 5723.341815691166, 5741.62679425836, 6131.0, 6170.537209709245, 6196.907046394308, 6202.875942481171, 6206.627602343874, 5952.375000624958, 6029.698515074273, 6211.0372892201785, 6221.875562488724, 6222.782202622931, 5646.463585959327, 5803.506701930341, 5811.56413268998, 5830.0, 5840.649561026352, 6217.0, 6242.438180563771, 6249.437550620375, 6254.437100660963, 6266.028765541349, 5855.0, 5885.352611212763, 5970.940290597038, 6060.272767267956, 6062.878742425127, 5950.077737950624, 6105.786297479567, 6116.052011938156, 6126.6017708848785, 6135.018397056449, 6028.608140470856, 6086.6348019119, 6088.299845517734, 6089.238845144357, 6092.3603021682975, 5916.053431451033, 6019.518438524908, 6027.336992930774, 6027.7287522061615, 6040.335563088057, 4612.377329060601, 4727.0, 4728.361671174416, 4734.242521196592, 4750.168720473903, 4205.116925445691, 4211.303289644269, 4221.409002739619, 4222.619964203175, 4249.447571815645, 5738.971305143447, 5842.152887831241, 5950.523958083343, 5952.970235148883, 5970.134330522137, 6120.326764055951, 6201.131841542187, 6213.937860621336, 6226.906596401058, 6227.221597300338, 5954.46409823118, 5959.016762234182, 5959.851003724855, 5962.701864906824, 5986.760529578855, 5205.7397130143345, 5274.182501712164, 5342.946570534323, 5347.652402593819, 5352.384475785257, 6315.905261421082, 6464.321246269074, 6467.579607325509, 6469.320721324193, 6469.417752402306, 6175.505959523138, 6215.347388524321, 6220.2535695715, 6228.34602366745, 6235.095911092957, 6188.133661287334, 6314.652694101685, 6380.202474690664, 6435.646039467874, 6447.0, 6005.39946005396, 6120.995022892694, 6126.426068710427, 6128.930927367261, 6141.3551577085545, 6180.783672571439, 6204.5036397089025, 6220.284667263141, 6223.813285601439, 6227.719752611234, 5810.854728631818, 5923.49650279731, 5937.050071988461, 5958.880822383615, 5965.4929331005615, 5952.285725712942, 6092.99465588173, 6109.419605137505, 6116.3883611638485, 6123.4488895999575, 5957.940420595912, 5968.97015514937, 5991.071383935497, 6007.249093863267, 6021.909671354845, 5945.702714864326, 5980.491658209101, 6087.178230938766, 6107.4197951194565, 6160.414760597736, 5860.267466566679, 5985.311689155803, 5995.250593675791, 6005.0, 6024.548158888013], "value": 5672.097300582518, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.3099249907611, 606.275500776572, 615.9507239420847, 638.3265654734255, 658.5291516565661, 42752.57247427529, 46494.07011859765, 46800.531994680045, 46932.06135877281, 47061.29408058882, 47087.764561177144, 47346.289805652945, 47498.287525687054, 47613.0, 47695.0, 9046.23107035901, 9108.8633670495, 9175.0, 9178.54107294636, 9196.678116265932, 9167.220786233178, 9243.352965292432, 9261.53692315385, 9275.072492750738, 9288.442693438416, 9180.44917304964, 9216.723498295061, 9226.400283981553, 9276.814463710722, 9292.860607090865, 9233.0, 9253.583588738524, 9297.907020929772, 9304.30217733666, 9315.580798864068, 9194.54027298639, 9205.355625106245, 9205.631774729003, 9212.078792120734, 9267.953660231655, 43213.0, 43356.0, 43560.12879742419, 43760.343594846105, 43867.12265754667, 3813.9809300953593, 3942.6254505821903, 4313.698041137121, 4321.395004699345, 4418.911621767546, 35211.823940880386, 35920.28159436797, 35931.0, 36098.63901360979, 37143.814280928425, 4737.763111844429, 4753.643476739258, 4757.976210118927, 4791.832285869978, 4854.393200849894, 392928.0, 394523.0, 395382.0, 396448.0, 396479.0, 64745.352546474875, 64980.0, 65226.673866630365, 65380.0, 65385.67307163434, 41792.582074179474, 42519.36220956688, 42540.0, 42579.36130958038, 42669.35995960063, 19488.805111948983, 19556.119974601177, 19656.21375145007, 19679.0, 19703.802961970483, 13917.443302267999, 13996.790048149285, 14003.649908752363, 14007.85992140086, 14070.226137562327, 20981.370558883256, 21211.15155393798, 21298.78701212999, 21450.03474843636, 21529.67705484419, 7628.580428076398, 7782.649780759766, 7837.451378403571, 7861.685532578633, 7877.966982711698, 998.7902540466438, 1038.3769738157196, 1074.2909679611575, 1132.6262333429947, 1180.557291015869, 34938.0, 35042.29915401678, 35114.297714046086, 35354.29291414157, 35437.0, 1142.5772464188303, 1143.9771204576027, 1167.0605162843822, 1195.5516681244533, 1279.456231101778, 18138.062570524013, 18176.45470635883, 18201.180946857425, 18241.543961400806, 18323.541911452056, 627991.0, 628460.0, 632737.0, 634761.0, 637073.0, 67156.32843671598, 67277.0, 67514.0, 67732.32267677359, 67733.0, 1415.2569900801955, 1427.586000059971, 1453.6220582648375, 1459.2776575594937, 1462.0, 32648.510272346408, 33328.50007249942, 34258.828705856315, 34260.314793704485, 34672.479912801835, 56221.43778562162, 56483.0, 56978.145327820945, 57106.0, 57417.42582574121, 515372.0, 516345.0, 516932.0, 516986.0, 517704.0, 31475.37049259048, 31660.0, 31704.524432133996, 32193.839030804695, 32239.35521289608, 53426.46573534215, 53650.46349536454, 53869.0, 53915.0, 54526.0, 44191.11617767691, 46012.30981535347, 46844.531554684014, 47058.76470617625, 47219.763901180275, 44776.0, 44806.3279050808, 44986.32520512129, 45519.31721024254, 46907.53092469032, 39103.804480977415, 44102.779486102365, 44918.550814491435, 45111.32333015073, 46760.0, 39050.80474597723, 39608.801955990035, 39812.20375592414, 40160.799196003834, 40892.0, 29942.550861737527, 30749.692503074682, 30821.69178308278, 31235.37529249357, 31357.372852543278], "value": 21740.135280897863, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.59647948530966, 413.4914055711475, 428.7084782348003, 431.84669442347956, 439.31028285591634, 19371.32200372987, 19991.900040499815, 20819.479513012182, 21072.262470813526, 21087.57824843506, 19453.0, 19921.203151873942, 20115.698264526007, 20559.280425185123, 20710.27514037009, 5978.342382337928, 6163.383661633846, 6191.535634827406, 6195.008798592226, 6208.1308616793685, 6003.369646187153, 6017.69911504423, 6026.8794624107495, 6053.122297266894, 6104.877902441948, 5898.734556944926, 5988.9101663475085, 6048.243969503812, 6056.60632058917, 6076.149339092531, 5998.1602575639445, 5998.640081595118, 6013.278406591194, 6027.879442411149, 6066.575339726221, 5333.173358129496, 5441.29263195786, 5471.8084867029465, 5473.343198816127, 5480.26016487773, 24131.879340603362, 24563.508729825484, 24621.87689061561, 24715.0, 25128.623070653954, 2451.056343307839, 2453.4234454903085, 2559.9360015999564, 2610.908618198354, 2641.8546979916096, 15396.692066158726, 15561.299741511659, 15565.922170389189, 15826.683466330609, 16206.513804585882, 1948.298612499499, 2016.3850025742142, 2032.9288474903308, 2047.2732180076007, 2068.2864411777914, 80398.0, 82473.76289355605, 82942.0, 84664.0, 85510.0, 10838.458077096113, 10840.945795271131, 10883.83674244887, 11122.888771112186, 11261.718457038476, 15483.84516154824, 15552.611184720472, 15587.844121558866, 15603.141827199386, 15607.21963901823, 8565.914340856512, 8767.167119123673, 8794.692185773467, 8902.109789021046, 9052.954735226282, 8771.868421973675, 8772.868406973901, 8803.515806630698, 8958.596863141174, 9009.54952252398, 4624.468186158635, 4743.335932969318, 4749.4063242094735, 4749.810007599726, 4891.24185751202, 2067.8759274443582, 2113.5138918048933, 2126.9149234030465, 2153.8707677539396, 2153.913843446276, 990.9950450247702, 1065.504540388723, 1079.5250089960393, 1114.1532435349031, 1119.356370087203, 20220.0, 20692.58614827695, 20744.79255207459, 20945.47636309074, 21115.366539003855, 1063.5161001744189, 1069.711177981956, 1075.1882328841675, 1079.5843600213818, 1171.490401675274, 10809.783804324026, 11468.0, 11633.825492617618, 11667.183297169286, 11689.123315751352, 556641.0, 560259.0, 569625.0, 572320.0, 574778.0, 90421.0, 95340.0, 95821.0, 99822.50088749656, 102105.48947255216, 1031.7884833609241, 1045.5504133222787, 1073.495457135161, 1078.2937176149635, 1080.9675709728563, 18560.907195463937, 18590.721139183195, 18976.62046759085, 19110.61778764445, 19279.036048197813, 43534.78232608944, 43749.12501749884, 44550.3317450232, 44625.77687111674, 45960.0, 62766.37233627605, 64572.35427645664, 65302.0, 66651.33348666452, 67374.66312668602, 9048.140426659456, 9097.363184577016, 9108.817823643358, 9122.771930701785, 9208.769780755267, 12543.62369128891, 13230.735385292433, 13560.796588051384, 14385.0, 14494.565163045125, 11781.646550603497, 11982.820257695967, 11986.880131198925, 12038.879611203776, 12089.274643521418, 12165.817512737493, 12253.571125010581, 12292.631221063382, 12486.314347563326, 12609.747805043664, 12065.879341206826, 12135.696607584881, 12165.939170304091, 12469.688257793629, 12521.87478125207, 8783.956080219557, 8905.109489051043, 8937.642494300155, 9005.189532942066, 9220.538973051454, 9482.004389538999, 11805.763884722086, 11873.525058997544, 11919.284842909106, 11955.76088478243], "value": 9855.505925641852, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1570.3169121432175, 1580.0598643806934, 1755.1662960093956, 1866.4493974277595, 1876.9906150469246, 8244.34045276378, 8629.611667474963, 8688.218060374566, 9457.905420945788, 9473.0, 8683.869741953877, 8843.778905527364, 9141.634334626608, 9167.312451566142, 9178.678746243882, 2470.22188010776, 2511.635812807142, 2521.8865151068244, 2523.6466894634764, 2529.5067461844947, 2413.4811015631635, 2472.7279999200073, 2475.2945410557995, 2475.925722228336, 2478.24413553866, 2469.3826543364157, 2479.5412848623064, 2527.2039307618043, 2536.9746302536923, 2555.565553855849, 2422.1522467136538, 2431.598786200275, 2441.0479912834007, 2454.840435371704, 2461.79074778644, 2411.686480757508, 2413.9396515087265, 2414.0464516516054, 2444.547758664635, 2456.250843492734, 9196.356255062148, 9237.122473365087, 9278.953605231998, 9304.720858374192, 9308.301877359225, 5268.262443257947, 5414.945850541523, 5447.1829225616075, 5467.835964921059, 5469.206964990094, 3436.5876094868777, 3553.4314509678584, 3613.373981708242, 3613.6747692707518, 3619.0, 1124.1283263366486, 1131.869834968981, 1161.4947497838468, 1173.178774857603, 1183.0535571542732, 12781.872181278255, 12917.935410322889, 12937.611871643865, 12948.0, 13002.479900803863, 4694.076223041246, 4713.835015774432, 4788.425388953278, 4919.065377578248, 4956.826511072168, 11033.83449248262, 11053.171012173958, 11082.722931926604, 11118.722031949104, 11140.0, 5638.718064096779, 5650.491455769001, 5652.745626446737, 5668.716564171775, 5686.715664216773, 4599.540045995441, 4894.535019173173, 4976.576990955809, 4994.700317980933, 5220.060389129917, 4265.829366825355, 4304.268274393361, 4340.8480703175865, 4358.237308471005, 4398.934015989763, 1286.581860895213, 1350.0279798545032, 1351.6283022168982, 1360.3946243921557, 1364.3519328319167, 927.7216834949488, 1072.2387105155271, 1072.742541789965, 1075.1613741281813, 1085.1861104171871, 6285.025820997753, 6306.968465157736, 6468.288488266287, 6521.413072823374, 6530.118434011348, 472.55107647734104, 478.30884372082005, 485.5144855144855, 493.3758795124171, 495.8462876508222, 4196.895077623084, 4234.936475952802, 4255.106427650167, 4281.357796330575, 4288.764117973541, 11339.319640821577, 11553.711157220969, 11584.073274138049, 11669.0, 11683.649490515298, 11511.0, 11560.826587601192, 11585.76828463426, 11596.0, 11606.76786464266, 8183.83632327362, 8582.527960962083, 8637.0, 8683.131686831266, 8763.25512331459, 6258.155149054819, 6424.935750642434, 6484.740610375532, 6586.037600287421, 6716.83207919806, 10491.318064325795, 10534.631287904887, 10870.293430926964, 10944.0, 11031.613893513688, 10772.461376931278, 10868.130549555859, 10894.964978327047, 10986.230963832455, 11044.723881903017, 8087.595620219083, 8203.425760196968, 8262.380321475794, 8307.086220515617, 8515.74452766418, 9139.0, 9276.443413395218, 9289.674861379819, 9325.393849399767, 9332.766680833034, 8090.650317495149, 8227.13615070409, 8266.710665126691, 8374.330053595819, 8400.831983360176, 8063.637136328762, 8102.311303539265, 8109.229623185788, 8132.3900707448365, 8254.628541715518, 7482.1021477423055, 7554.320111190019, 7648.923510764821, 7666.9616651916385, 7687.423443241891, 5401.3248343957, 5409.323834520685, 5575.940571291441, 5703.429657034263, 5732.111522713986, 5481.5340696041285, 5564.860878478071, 5567.109262517978, 5618.988582055269, 5706.457886500776], "value": 4836.693283938432, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.31996806307546, 353.70995783457556, 354.84564214566666, 357.81393675288837, 359.51286007459873, 5739.196512488255, 5756.654600723959, 5931.288245410551, 5998.310194327653, 6052.122442245872, 5745.454181852718, 5773.624714393572, 5804.941950580493, 5811.27359080115, 5828.737706803194, 4626.190416677085, 4643.233866412055, 4657.4876763555985, 4662.487126416091, 4667.976660116695, 4541.159885421208, 4597.149527337437, 4600.930986035212, 4636.97681511592, 4668.6731928765, 4561.498235194126, 4591.65562582806, 4613.408374110926, 4615.930761038587, 4624.953750462503, 4604.930926036112, 4612.377329060568, 4621.168189725848, 4667.393238878924, 4668.11305851887, 3848.8845334639727, 3992.9201415971806, 4003.619656132692, 4128.855490057834, 4152.2525945330135, 5659.688717120557, 5672.659640421588, 5697.914531282034, 5705.714714264312, 5744.770209191627, 5137.152369859006, 5140.434552199255, 5188.792448302063, 5235.272360121189, 5273.683578985235, 5871.442212989759, 6090.817275481742, 6091.390860913917, 6112.816615501542, 6177.567570270083, 4378.168148051892, 4410.62509686677, 4424.955750442518, 4428.557144285545, 4428.689991700582, 6071.544634152457, 6363.300036995926, 6395.488360931161, 6414.807555773287, 6449.83875403114, 4474.239379305526, 4474.574915383034, 4484.439445069366, 4508.977455112769, 4512.142692888341, 4568.611668008257, 4588.151192029485, 4590.645759500889, 4599.793009314589, 4609.0, 5152.175651895679, 5226.425093239741, 5242.1088414969545, 5254.579633629301, 5289.894202116013, 5913.881722365529, 6120.14317995481, 6172.259328880563, 6176.135341052256, 6252.0, 1559.3762495001863, 1560.4460416552188, 1565.420794306114, 1571.1201727032899, 1574.826769055403, 933.3466573398648, 969.5830792759182, 971.3686104032295, 1016.0753714120116, 1019.5972590826582, 5300.416954135042, 5310.150375939831, 5313.299744081934, 5383.300170977826, 5393.545936598838, 5515.593523651443, 5532.944670553243, 5538.335399752055, 5551.361593416808, 5599.8880022400135, 4952.4304704959395, 5071.239314102841, 5295.338082739658, 5344.866378340573, 5356.758945847446, 2987.850607469661, 3007.8345690986766, 3009.9398012040074, 3050.481418158918, 3050.7559395248327, 5588.3734644716915, 5703.486686198262, 5713.457221563945, 5747.413663851284, 5778.313084415767, 5642.576806739429, 5652.463016013472, 5680.943190568124, 5723.141528770634, 5783.508401785811, 5794.0, 5808.0, 5836.854078648068, 5863.237779088691, 5879.823605291763, 5215.5486921147, 5516.255305533701, 5518.696471693935, 5568.97215513936, 5665.546756259571, 5465.508104270635, 5511.614187007031, 5514.503694667499, 5546.639468434539, 5564.860878478071, 5671.40450252734, 5715.17130016137, 5737.569682273763, 5793.768249269982, 5834.504067154339, 4157.10622216225, 4471.8658440246845, 4474.642028637636, 4481.529439408815, 4486.7083639563325, 6175.907361389673, 6312.558120931674, 6341.4292713656, 6356.68216589178, 6357.901892375413, 6150.415710507495, 6192.969035154795, 6204.565680402328, 6206.937930620636, 6218.595791273553, 6155.753769849156, 6199.225096862892, 6226.937730622636, 6246.156768836149, 6293.213348331458, 6180.938190618036, 6187.474064704371, 6193.721282542207, 6217.761605821991, 6235.064740288812, 6258.561900667091, 6340.256429481929, 6347.508335541236, 6360.93639063622, 6374.553781235269, 5854.443827836349, 6082.665453400105, 6092.055731361646, 6100.572959892765, 6112.786052488142], "value": 4539.459065819175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.8532006898791, 843.59929033709, 877.7322916510464, 899.7570655922901, 906.8005038891441, 16197.919010404947, 17269.0, 17383.391581294658, 17479.65040699187, 17482.38811641593, 15861.20693965303, 16179.35282588695, 16209.432669856558, 16262.43081492145, 16322.183890805472, 704.2570088556571, 860.5267103093305, 884.6903583745669, 888.5468411110315, 889.5107690770083, 884.6947803007984, 887.0863011098546, 891.3983061433539, 892.1836519584572, 894.5884892949218, 918.4764684130049, 922.8569571716362, 924.8751418558476, 925.4771054354268, 927.638221093774, 918.485648037098, 921.0605182713595, 923.0861447167323, 924.4638109896277, 925.5927391947522, 676.0366477769209, 678.4368973751774, 680.0445374249188, 680.4896327754184, 680.843406016614, 14732.18972956487, 14793.55619331411, 14811.333489992976, 14818.333175007043, 14819.0, 15391.615209619737, 15494.61263468411, 15558.844411555852, 15626.14056226907, 15845.60385990348, 12869.09916305859, 12902.677433064155, 12951.352432378437, 13046.478140874353, 13190.60428187156, 4126.194346429853, 4154.065335299563, 4181.0592616661315, 4181.519125300599, 4207.495100587918, 89751.0, 90799.0, 91670.541647292, 91863.54068229617, 92553.53723231408, 13033.218006919615, 13058.738825223443, 13135.146215495963, 13174.143680660727, 13237.536686216128, 24978.875950582267, 25081.247562573153, 25092.623610645856, 25203.0, 25278.368040799127, 9203.723888283363, 9314.813703725888, 9439.76400589977, 9502.334836561375, 9521.095495927875, 5197.428282888879, 5261.684298941999, 5263.131583288791, 5364.624476286701, 5423.674579525241, 3728.7949162795762, 3836.4820749199057, 3840.6735427488416, 3843.26977874203, 3844.4041173618134, 652.0903339840991, 654.443722835586, 657.6908852839158, 671.1509939925998, 684.6131935456451, 656.6519744535403, 691.4675699711195, 695.5896021347328, 719.7552832037132, 787.8857565653063, 10484.161267098614, 10527.789444211074, 10548.525316360781, 10729.570817167381, 11337.376444295478, 674.5244602555186, 730.3390431659357, 731.0, 795.9920400796034, 812.9268365846984, 5184.326037615161, 5377.300950876361, 5451.863703407367, 5535.308086489189, 5611.298587676541, 123689.38155309166, 124170.0, 124397.0, 126393.36803315925, 126779.0, 105659.0, 105843.4707826456, 109388.0, 109411.45294273477, 111794.0, 91545.0, 95304.0, 96766.51616741871, 97095.51452242835, 98051.01948980705, 9380.296477764332, 9485.857712134462, 9491.288153388385, 9683.467409292556, 9833.62329273888, 52748.20877686761, 53006.352046298656, 53370.1994470091, 53721.0, 54271.45728542664, 72320.0, 78370.6081469589, 79292.0, 81385.59307203663, 82134.58932705298, 14436.422543098159, 15074.321655525308, 15142.394304228148, 16165.0, 16562.17189140514, 16715.164241788105, 17262.22319995578, 17311.7403238949, 18115.637687246446, 18418.17118229656, 15863.286152123414, 16432.260548275597, 16627.08551029705, 17499.475015749547, 17535.736963945295, 15913.68172636564, 16026.198690065683, 16898.23957921921, 17440.73838892392, 17562.38531651386, 15530.611734706723, 15868.285927133538, 16912.74630880513, 16941.91529042347, 17011.48965531036, 12237.571684990982, 12442.315672638091, 12475.0, 12587.685307867376, 13385.598432047054, 10930.781384372427, 11630.476628551905, 12327.753444930871, 12451.0, 13216.140950838164], "value": 8359.55936091305, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1504.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 110.0, 111.0, 113.0, 111.0, 113.0, 111.0, 113.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 149.0, 177.0, 122.0, 143.0, 147.0, 118.0, 185.0, 114.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 162.0, 168.0, 162.0, 162.0, 162.0, 160.0, 164.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 172.0, 76.0, 76.0, 75.0, 77.0, 182.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 158.0, 83.0, 84.0, 84.0, 133.0, 83.0, 83.0, 137.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 128.0, 117.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 100.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 52.0, 51.0, 53.0, 51.0, 53.0, 52.0, 51.0, 54.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 61.0, 62.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 72.0, 71.0, 82.0, 74.0, 73.0, 72.0, 71.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 132.0, 120.0, 117.0, 128.0, 119.0, 118.0, 125.0, 146.0, 130.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 156.0, 152.0, 159.0, 154.0, 155.0, 161.0, 153.0, 151.0, 159.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 66.0, 65.0, 65.0, 63.0, 69.0, 62.0, 62.0, 62.0], "value": 64.1, "unit": "score"}]}]} 04:07:27 INFO - Return code: 0 04:07:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:07:27 ERROR - # TBPL SUCCESS # 04:07:27 INFO - Running post-action listener: _resource_record_post_action 04:07:27 INFO - [mozharness: 2016-09-06 11:07:27.114307Z] Finished run-tests step (success) 04:07:27 INFO - Running post-run listener: _resource_record_post_run 04:07:27 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 328765440; Read time: 40; Write time: 238516 04:07:27 INFO - TinderboxPrint: CPU usage
13.3% 04:07:27 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 40 04:07:27 INFO - TinderboxPrint: I/O write bytes / time
328,765,440 / 238,516 04:07:27 INFO - TinderboxPrint: CPU idle
8,225.3 (86.7%) 04:07:27 INFO - TinderboxPrint: CPU user
1,204.8 (12.7%) 04:07:27 INFO - TinderboxPrint: Swap in / out
0 / 0 04:07:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 79597568; Read time: 0; Write time: 85408 04:07:27 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249167872; Read time: 16; Write time: 153108 04:07:27 INFO - Running post-run listener: _upload_blobber_files 04:07:27 INFO - Blob upload gear active. 04:07:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:07:27 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 04:07:27 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'] 04:07:27 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 04:07:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:07:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:07:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:07:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:29 INFO - (blobuploader) - INFO - Done attempting. 04:07:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:07:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:07:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:30 INFO - (blobuploader) - INFO - Done attempting. 04:07:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:07:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:07:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:33 INFO - (blobuploader) - INFO - Done attempting. 04:07:33 INFO - (blobuploader) - INFO - Iteration through files over. 04:07:33 INFO - Return code: 0 04:07:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:07:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:07:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffa79256b00ae8fd071bbe59780fa8bc8ae6f810e5863c80672af10fce519b383396454a061bccf7af237efc09478c00ed3ad539ba5e7a607e3871458dc648d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6950378c0f14ae0414ce14b72cfc4197ebae4933a71be20d23c69a25ec7962910bebf7dbab5befb26ccd671ca207d2aa050c7e23ed59caec05ebaaabd7cc0536", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f5ca0ec939a76a9af3bc6c328b753688922414eb852de144ab109fc6d4e7f8cd6150c7a470cb6590fbaa9040f5935c44751a5e1f39ce806d275e92f7ab9ce6e"} 04:07:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:07:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:07:33 INFO - Contents: 04:07:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffa79256b00ae8fd071bbe59780fa8bc8ae6f810e5863c80672af10fce519b383396454a061bccf7af237efc09478c00ed3ad539ba5e7a607e3871458dc648d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6950378c0f14ae0414ce14b72cfc4197ebae4933a71be20d23c69a25ec7962910bebf7dbab5befb26ccd671ca207d2aa050c7e23ed59caec05ebaaabd7cc0536", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f5ca0ec939a76a9af3bc6c328b753688922414eb852de144ab109fc6d4e7f8cd6150c7a470cb6590fbaa9040f5935c44751a5e1f39ce806d275e92f7ab9ce6e"} 04:07:33 INFO - Running post-run listener: copy_logs_to_upload_dir 04:07:33 INFO - Copying logs to upload dir... 04:07:33 INFO - mkdir: /builds/slave/test/build/upload/logs 04:07:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.513701 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-06 04:07:33.482301) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 04:07:33.489544) ========= 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=652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341 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/ffa79256b00ae8fd071bbe59780fa8bc8ae6f810e5863c80672af10fce519b383396454a061bccf7af237efc09478c00ed3ad539ba5e7a607e3871458dc648d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6950378c0f14ae0414ce14b72cfc4197ebae4933a71be20d23c69a25ec7962910bebf7dbab5befb26ccd671ca207d2aa050c7e23ed59caec05ebaaabd7cc0536", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f5ca0ec939a76a9af3bc6c328b753688922414eb852de144ab109fc6d4e7f8cd6150c7a470cb6590fbaa9040f5935c44751a5e1f39ce806d275e92f7ab9ce6e"} build_url:https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/IUyDvUW1SnO_5G7ps7j_3Q/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/ffa79256b00ae8fd071bbe59780fa8bc8ae6f810e5863c80672af10fce519b383396454a061bccf7af237efc09478c00ed3ad539ba5e7a607e3871458dc648d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6950378c0f14ae0414ce14b72cfc4197ebae4933a71be20d23c69a25ec7962910bebf7dbab5befb26ccd671ca207d2aa050c7e23ed59caec05ebaaabd7cc0536", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f5ca0ec939a76a9af3bc6c328b753688922414eb852de144ab109fc6d4e7f8cd6150c7a470cb6590fbaa9040f5935c44751a5e1f39ce806d275e92f7ab9ce6e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-06 04:07:33.517933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 04:07:33.518368) ========= 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=652eb03db935cfc1c15ebda0000001ad-1473156336.172074-1731132341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-06 04:07:33.600989) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 04:07:33.601322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-06 04:07:33.601629) ========= ========= Total master_lag: 0.22 =========