builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1471300064.01 results: success (0) buildid: 20160815122516 builduid: 2288991ccabc43189d5b320c252ae3b4 revision: c16b845d20803e1d4e785b144ffd63e9545eb16b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.011817) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.012256) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.012527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.027395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.027773) ========= 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=826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 15:27:44-- 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% 221M=0s 2016-08-15 15:27:45 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109642 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.151491) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.151801) ========= 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=826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017502 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.201065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.201424) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c16b845d20803e1d4e785b144ffd63e9545eb16b --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 c16b845d20803e1d4e785b144ffd63e9545eb16b --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=826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 15:27:45,155 truncating revision to first 12 chars 2016-08-15 15:27:45,155 Setting DEBUG logging. 2016-08-15 15:27:45,155 attempt 1/10 2016-08-15 15:27:45,155 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c16b845d2080?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 15:27:45,507 unpacking tar archive at: mozilla-aurora-c16b845d2080/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696739 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.912452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.912773) ========= script_repo_revision: c16b845d20803e1d4e785b144ffd63e9545eb16b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.913171) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.913442) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 15:27:44.922990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-08-15 15:27:44.923280) ========= /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=826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:27:45 INFO - MultiFileLogger online at 20160815 15:27:45 in /builds/slave/test 15:27:45 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 15:27:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:27:45 INFO - {'append_to_log': False, 15:27:45 INFO - 'base_work_dir': '/builds/slave/test', 15:27:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:27:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:27:45 INFO - 'branch': 'Mozilla-Aurora', 15:27:45 INFO - 'buildbot_json_path': 'buildprops.json', 15:27:45 INFO - 'config_files': ('talos/linux_config.py',), 15:27:45 INFO - 'default_actions': ('clobber', 15:27:45 INFO - 'read-buildbot-config', 15:27:45 INFO - 'download-and-extract', 15:27:45 INFO - 'populate-webroot', 15:27:45 INFO - 'create-virtualenv', 15:27:45 INFO - 'install', 15:27:45 INFO - 'run-tests'), 15:27:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:27:45 INFO - 'download_minidump_stackwalk': True, 15:27:45 INFO - 'download_symbols': 'ondemand', 15:27:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:27:45 INFO - 'tooltool.py': '/tools/tooltool.py', 15:27:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:27:45 INFO - '/tools/misc-python/virtualenv.py')}, 15:27:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:27:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:27:45 INFO - 'installer_path': 'installer.exe', 15:27:45 INFO - 'log_level': 'info', 15:27:45 INFO - 'log_name': 'talos', 15:27:45 INFO - 'log_to_console': True, 15:27:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:27:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:27:45 INFO - 'opt_config_files': (), 15:27:45 INFO - 'pip_index': False, 15:27:45 INFO - 'sps_profile': False, 15:27:45 INFO - 'sps_profile_interval': 0, 15:27:45 INFO - 'suite': 'dromaeojs-e10s', 15:27:45 INFO - 'system_bits': '32', 15:27:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:27:45 INFO - 'title': 'talos-linux64-ix-052', 15:27:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:27:45 INFO - 'use_talos_json': True, 15:27:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:27:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:27:45 INFO - 'work_dir': 'build'} 15:27:45 INFO - [mozharness: 2016-08-15 22:27:45.966212Z] Running clobber step. 15:27:45 INFO - Running pre-action listener: _resource_record_pre_action 15:27:45 INFO - Running main action method: clobber 15:27:45 INFO - rmtree: /builds/slave/test/build 15:27:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:27:46 INFO - Running post-action listener: _resource_record_post_action 15:27:46 INFO - [mozharness: 2016-08-15 22:27:46.423209Z] Finished clobber step (success) 15:27:46 INFO - [mozharness: 2016-08-15 22:27:46.423310Z] Running read-buildbot-config step. 15:27:46 INFO - Running pre-action listener: _resource_record_pre_action 15:27:46 INFO - Running main action method: read_buildbot_config 15:27:46 INFO - Using buildbot properties: 15:27:46 INFO - { 15:27:46 INFO - "project": "", 15:27:46 INFO - "product": "firefox", 15:27:46 INFO - "script_repo_revision": "production", 15:27:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:27:46 INFO - "repository": "", 15:27:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:27:46 INFO - "buildid": "20160815122516", 15:27:46 INFO - "pgo_build": "True", 15:27:46 INFO - "basedir": "/builds/slave/test", 15:27:46 INFO - "buildnumber": 465, 15:27:46 INFO - "slavename": "talos-linux64-ix-052", 15:27:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:27:46 INFO - "platform": "ubuntu64_hw", 15:27:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:27:46 INFO - "branch": "mozilla-aurora", 15:27:46 INFO - "repo_path": "releases/mozilla-aurora", 15:27:46 INFO - "revision": "c16b845d20803e1d4e785b144ffd63e9545eb16b", 15:27:46 INFO - "stage_platform": "linux64-pgo", 15:27:46 INFO - "builduid": "2288991ccabc43189d5b320c252ae3b4", 15:27:46 INFO - "slavebuilddir": "test" 15:27:46 INFO - } 15:27:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 15:27:46 INFO - Running post-action listener: _resource_record_post_action 15:27:46 INFO - [mozharness: 2016-08-15 22:27:46.425753Z] Finished read-buildbot-config step (success) 15:27:46 INFO - [mozharness: 2016-08-15 22:27:46.425842Z] Running download-and-extract step. 15:27:46 INFO - Running pre-action listener: _resource_record_pre_action 15:27:46 INFO - Running main action method: download_and_extract 15:27:46 INFO - mkdir: /builds/slave/test/build/tests 15:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:46 INFO - https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:27:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:27:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:27:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:27:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:27:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:27:46 INFO - retry: Failed, sleeping 30 seconds before retrying 15:28:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:28:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:28:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:28:16 INFO - retry: Failed, sleeping 60 seconds before retrying 15:29:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:29:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:29:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:29:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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! 15:29:16 INFO - Caught exception: HTTP Error 404: Not Found 15:29:16 INFO - Caught exception: HTTP Error 404: Not Found 15:29:16 INFO - Caught exception: HTTP Error 404: Not Found 15:29:16 INFO - trying https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:29:16 INFO - Downloading https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:29:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:29:17 INFO - Downloaded 1361 bytes. 15:29:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:29:17 INFO - Using the following test package requirements: 15:29:17 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 15:29:17 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:29:17 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:29:17 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:29:17 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:29:17 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:29:17 INFO - u'jsshell-linux-x86_64.zip'], 15:29:17 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:29:17 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:29:17 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 15:29:17 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:29:17 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:29:17 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:29:17 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:29:17 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:29:17 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:29:17 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:29:17 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:29:17 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:29: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')]} 15:29:17 INFO - https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:29:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:29:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:29:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:29:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:29:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:29:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:29:17 INFO - retry: Failed, sleeping 30 seconds before retrying 15:29:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:29:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:29:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:29:47 INFO - retry: Failed, sleeping 60 seconds before retrying 15:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:30:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:30:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:30:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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! 15:30:47 INFO - Caught exception: HTTP Error 404: Not Found 15:30:47 INFO - Caught exception: HTTP Error 404: Not Found 15:30:47 INFO - Caught exception: HTTP Error 404: Not Found 15:30:47 INFO - trying https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:30:47 INFO - Downloading https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:30:48 INFO - Downloaded 21767933 bytes. 15:30:48 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'] 15:30:48 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 15:30:49 INFO - Return code: 0 15:30:49 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 15:30:49 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')]} 15:30:49 INFO - https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:30:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:30:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:30:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:30:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:30:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:30:49 INFO - retry: Failed, sleeping 30 seconds before retrying 15:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:31:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:31:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:31:19 INFO - retry: Failed, sleeping 60 seconds before retrying 15:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:32:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:32:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:32:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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! 15:32:19 INFO - Caught exception: HTTP Error 404: Not Found 15:32:19 INFO - Caught exception: HTTP Error 404: Not Found 15:32:19 INFO - Caught exception: HTTP Error 404: Not Found 15:32:19 INFO - trying https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:32:19 INFO - Downloading https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:32:20 INFO - Downloaded 21767933 bytes. 15:32:20 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'] 15:32:20 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 15:32:21 INFO - Return code: 0 15:32:21 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')]} 15:32:21 INFO - https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:32:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:32:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:32:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:32:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:32:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:32:21 INFO - retry: Failed, sleeping 30 seconds before retrying 15:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:32:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:32:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:32:51 INFO - retry: Failed, sleeping 60 seconds before retrying 15:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:33:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:33:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:33:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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! 15:33:51 INFO - Caught exception: HTTP Error 404: Not Found 15:33:51 INFO - Caught exception: HTTP Error 404: Not Found 15:33:51 INFO - Caught exception: HTTP Error 404: Not Found 15:33:51 INFO - trying https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:33:51 INFO - Downloading https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:33:52 INFO - Downloaded 14413723 bytes. 15:33:52 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'] 15:33:52 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 15:33:52 INFO - Return code: 0 15:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:33:52 INFO - https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:33:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:33:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:33:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:33:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:33:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:33:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:33:52 INFO - retry: Failed, sleeping 30 seconds before retrying 15:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:34:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:34:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:34:22 INFO - retry: Failed, sleeping 60 seconds before retrying 15:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:35:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:35:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:35:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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! 15:35:23 INFO - Caught exception: HTTP Error 404: Not Found 15:35:23 INFO - Caught exception: HTTP Error 404: Not Found 15:35:23 INFO - Caught exception: HTTP Error 404: Not Found 15:35:23 INFO - trying https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:35:23 INFO - Downloading https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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 15:35:24 INFO - Downloaded 63756612 bytes. 15:35:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:35:24 INFO - mkdir: /builds/slave/test/properties 15:35:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:35:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:35:24 INFO - Contents: 15:35:24 INFO - build_url:https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:35:24 INFO - Running post-action listener: _resource_record_post_action 15:35:24 INFO - Running post-action listener: set_extra_try_arguments 15:35:24 INFO - [mozharness: 2016-08-15 22:35:24.901116Z] Finished download-and-extract step (success) 15:35:24 INFO - [mozharness: 2016-08-15 22:35:24.901350Z] Running populate-webroot step. 15:35:24 INFO - Running pre-action listener: _resource_record_pre_action 15:35:24 INFO - Running main action method: populate_webroot 15:35:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:35:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:35:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:35:24 INFO - '--tppagecycles', 15:35:24 INFO - '7'], 15:35:24 INFO - 'tests': ['tsvgm']}}, 15:35:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:35:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:35:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:35:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:35:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:24 INFO - 'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:35:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:35:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:24 INFO - 'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['damp', 'tps']}, 15:35:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:24 INFO - 'tests': ['damp', 'tps']}, 15:35:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['dromaeo_dom']}, 15:35:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:35:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['basic_compositor_video']}, 15:35:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:35:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['a11yr', 15:35:24 INFO - 'ts_paint', 15:35:24 INFO - 'tpaint', 15:35:24 INFO - 'sessionrestore', 15:35:24 INFO - 'sessionrestore_no_auto_restore', 15:35:24 INFO - 'tabpaint']}, 15:35:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:35:24 INFO - 'ts_paint', 15:35:24 INFO - 'tpaint', 15:35:24 INFO - 'sessionrestore', 15:35:24 INFO - 'sessionrestore_no_auto_restore', 15:35:24 INFO - 'tabpaint']}, 15:35:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:35:24 INFO - 'ts_paint', 15:35:24 INFO - 'tpaint', 15:35:24 INFO - 'sessionrestore', 15:35:24 INFO - 'sessionrestore_no_auto_restore', 15:35:24 INFO - 'tabpaint']}, 15:35:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:35:24 INFO - 'ts_paint', 15:35:24 INFO - 'tpaint', 15:35:24 INFO - 'sessionrestore', 15:35:24 INFO - 'sessionrestore_no_auto_restore', 15:35:24 INFO - 'tabpaint']}, 15:35:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['a11yr', 15:35:24 INFO - 'ts_paint', 15:35:24 INFO - 'tpaint', 15:35:24 INFO - 'sessionrestore', 15:35:24 INFO - 'sessionrestore_no_auto_restore', 15:35:24 INFO - 'tabpaint']}, 15:35:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['a11yr', 15:35:24 INFO - 'ts_paint', 15:35:24 INFO - 'tpaint', 15:35:24 INFO - 'sessionrestore', 15:35:24 INFO - 'sessionrestore_no_auto_restore', 15:35:24 INFO - 'tabpaint']}, 15:35:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['tsvgx', 15:35:24 INFO - 'tsvgr_opacity', 15:35:24 INFO - 'tart', 15:35:24 INFO - 'tscrollx', 15:35:24 INFO - 'cart']}, 15:35:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:35:24 INFO - 'tsvgr_opacity', 15:35:24 INFO - 'tart', 15:35:24 INFO - 'tscrollx', 15:35:24 INFO - 'cart']}, 15:35:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:24 INFO - 'talos_options': ['--disable-e10s'], 15:35:24 INFO - 'tests': ['tp5o']}, 15:35:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:24 INFO - 'tests': ['tp5o']}, 15:35:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:24 INFO - 'talos_options': ['--disable-e10s', 15:35:24 INFO - '--xperf_path', 15:35:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:35:24 INFO - 'tests': ['tp5n']}, 15:35:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:24 INFO - 'talos_options': ['--xperf_path', 15:35:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:35:24 INFO - 'tests': ['tp5n']}}, 15:35:24 INFO - 'talos.zip': {'path': '', 15:35:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:35:24 INFO - Running post-action listener: _resource_record_post_action 15:35:24 INFO - [mozharness: 2016-08-15 22:35:24.916978Z] Finished populate-webroot step (success) 15:35:24 INFO - [mozharness: 2016-08-15 22:35:24.917069Z] Running create-virtualenv step. 15:35:24 INFO - Running pre-action listener: _resource_record_pre_action 15:35:24 INFO - Running main action method: create_virtualenv 15:35:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:35:24 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 15:35:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:35:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:35:25 INFO - Using real prefix '/usr' 15:35:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:35:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:35:27 INFO - Installing pip.................done. 15:35:27 INFO - Return code: 0 15:35:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:27 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 0x1f70030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, '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': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', '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 15:35:27 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 15:35:27 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 15:35:27 INFO - Using env: {'DISPLAY': ':0', 15:35:27 INFO - 'HOME': '/home/cltbld', 15:35:27 INFO - 'LANG': 'en_US.UTF-8', 15:35:27 INFO - 'LANGUAGE': 'en_US:en', 15:35:27 INFO - 'LOGNAME': 'cltbld', 15:35:27 INFO - 'MAIL': '/var/mail/cltbld', 15:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:27 INFO - 'MOZ_NO_REMOTE': '1', 15:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:27 INFO - 'NO_EM_RESTART': '1', 15:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:27 INFO - 'PWD': '/builds/slave/test', 15:35:27 INFO - 'SHELL': '/bin/bash', 15:35:27 INFO - 'SHLVL': '1', 15:35:27 INFO - 'TERM': 'linux', 15:35:27 INFO - 'TMOUT': '86400', 15:35:27 INFO - 'USER': 'cltbld', 15:35:27 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:27 INFO - '_': '/tools/buildbot/bin/python'} 15:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:27 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 15:35:27 INFO - Cleaning up... 15:35:27 INFO - Return code: 0 15:35:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:27 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 0x1f70030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, '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': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', '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 15:35:27 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 15:35:27 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 15:35:27 INFO - Using env: {'DISPLAY': ':0', 15:35:27 INFO - 'HOME': '/home/cltbld', 15:35:27 INFO - 'LANG': 'en_US.UTF-8', 15:35:27 INFO - 'LANGUAGE': 'en_US:en', 15:35:27 INFO - 'LOGNAME': 'cltbld', 15:35:27 INFO - 'MAIL': '/var/mail/cltbld', 15:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:27 INFO - 'MOZ_NO_REMOTE': '1', 15:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:27 INFO - 'NO_EM_RESTART': '1', 15:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:27 INFO - 'PWD': '/builds/slave/test', 15:35:27 INFO - 'SHELL': '/bin/bash', 15:35:27 INFO - 'SHLVL': '1', 15:35:27 INFO - 'TERM': 'linux', 15:35:27 INFO - 'TMOUT': '86400', 15:35:27 INFO - 'USER': 'cltbld', 15:35:27 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:27 INFO - '_': '/tools/buildbot/bin/python'} 15:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:27 INFO - Downloading/unpacking psutil>=3.1.1 15:35:27 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 15:35:27 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 15:35:27 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 15:35:27 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 15:35:27 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 15:35:27 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 15:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:35:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:29 INFO - Installing collected packages: psutil 15:35:29 INFO - Running setup.py install for psutil 15:35:29 INFO - building 'psutil._psutil_linux' extension 15:35:29 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 15:35:30 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 15:35:30 INFO - building 'psutil._psutil_posix' extension 15:35:30 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 15:35:30 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 15:35:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:30 INFO - Successfully installed psutil 15:35:30 INFO - Cleaning up... 15:35:30 INFO - Return code: 0 15:35:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:35: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')]} 15:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35: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')]} 15:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:30 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 0x1f70030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, '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': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', '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 15:35:30 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 15:35:30 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 15:35:30 INFO - Using env: {'DISPLAY': ':0', 15:35:30 INFO - 'HOME': '/home/cltbld', 15:35:30 INFO - 'LANG': 'en_US.UTF-8', 15:35:30 INFO - 'LANGUAGE': 'en_US:en', 15:35:30 INFO - 'LOGNAME': 'cltbld', 15:35:30 INFO - 'MAIL': '/var/mail/cltbld', 15:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:30 INFO - 'MOZ_NO_REMOTE': '1', 15:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:30 INFO - 'NO_EM_RESTART': '1', 15:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:30 INFO - 'PWD': '/builds/slave/test', 15:35:30 INFO - 'SHELL': '/bin/bash', 15:35:30 INFO - 'SHLVL': '1', 15:35:30 INFO - 'TERM': 'linux', 15:35:30 INFO - 'TMOUT': '86400', 15:35:30 INFO - 'USER': 'cltbld', 15:35:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:30 INFO - '_': '/tools/buildbot/bin/python'} 15:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:35:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:35:32 INFO - Installing collected packages: mozsystemmonitor 15:35:32 INFO - Running setup.py install for mozsystemmonitor 15:35:32 INFO - Successfully installed mozsystemmonitor 15:35:32 INFO - Cleaning up... 15:35:32 INFO - Return code: 0 15:35:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f70030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, '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': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', '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 15:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:35:32 INFO - Using env: {'DISPLAY': ':0', 15:35:32 INFO - 'HOME': '/home/cltbld', 15:35:32 INFO - 'LANG': 'en_US.UTF-8', 15:35:32 INFO - 'LANGUAGE': 'en_US:en', 15:35:32 INFO - 'LOGNAME': 'cltbld', 15:35:32 INFO - 'MAIL': '/var/mail/cltbld', 15:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:32 INFO - 'MOZ_NO_REMOTE': '1', 15:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:32 INFO - 'NO_EM_RESTART': '1', 15:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:32 INFO - 'PWD': '/builds/slave/test', 15:35:32 INFO - 'SHELL': '/bin/bash', 15:35:32 INFO - 'SHLVL': '1', 15:35:32 INFO - 'TERM': 'linux', 15:35:32 INFO - 'TMOUT': '86400', 15:35:32 INFO - 'USER': 'cltbld', 15:35:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:32 INFO - '_': '/tools/buildbot/bin/python'} 15:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:32 INFO - Downloading/unpacking jsonschema==2.5.1 15:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:35:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:35:34 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 15:35:34 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 15:35:34 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 15:35:34 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 15:35:34 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 15:35:34 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 15:35:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:35:35 INFO - warning: no files found matching '*.txt' 15:35:35 INFO - no previously-included directories found matching 'build' 15:35:35 INFO - no previously-included directories found matching 'dist' 15:35:35 INFO - no previously-included directories found matching '.git*' 15:35:35 INFO - Installing collected packages: jsonschema, functools32 15:35:35 INFO - Running setup.py install for functools32 15:35:35 INFO - warning: no files found matching '*.txt' 15:35:35 INFO - no previously-included directories found matching 'build' 15:35:35 INFO - no previously-included directories found matching 'dist' 15:35:35 INFO - no previously-included directories found matching '.git*' 15:35:35 INFO - Successfully installed jsonschema functools32 15:35:35 INFO - Cleaning up... 15:35:35 INFO - Return code: 0 15:35:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f70030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, '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': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', '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 15:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:35:35 INFO - Using env: {'DISPLAY': ':0', 15:35:35 INFO - 'HOME': '/home/cltbld', 15:35:35 INFO - 'LANG': 'en_US.UTF-8', 15:35:35 INFO - 'LANGUAGE': 'en_US:en', 15:35:35 INFO - 'LOGNAME': 'cltbld', 15:35:35 INFO - 'MAIL': '/var/mail/cltbld', 15:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:35 INFO - 'MOZ_NO_REMOTE': '1', 15:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:35 INFO - 'NO_EM_RESTART': '1', 15:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:35 INFO - 'PWD': '/builds/slave/test', 15:35:35 INFO - 'SHELL': '/bin/bash', 15:35:35 INFO - 'SHLVL': '1', 15:35:35 INFO - 'TERM': 'linux', 15:35:35 INFO - 'TMOUT': '86400', 15:35:35 INFO - 'USER': 'cltbld', 15:35:35 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:35 INFO - '_': '/tools/buildbot/bin/python'} 15:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:35:35 INFO - Cleaning up... 15:35:35 INFO - Return code: 0 15:35:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f70030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, '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': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', '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 15:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:35:35 INFO - Using env: {'DISPLAY': ':0', 15:35:35 INFO - 'HOME': '/home/cltbld', 15:35:35 INFO - 'LANG': 'en_US.UTF-8', 15:35:35 INFO - 'LANGUAGE': 'en_US:en', 15:35:35 INFO - 'LOGNAME': 'cltbld', 15:35:35 INFO - 'MAIL': '/var/mail/cltbld', 15:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:35 INFO - 'MOZ_NO_REMOTE': '1', 15:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:35 INFO - 'NO_EM_RESTART': '1', 15:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:35 INFO - 'PWD': '/builds/slave/test', 15:35:35 INFO - 'SHELL': '/bin/bash', 15:35:35 INFO - 'SHLVL': '1', 15:35:35 INFO - 'TERM': 'linux', 15:35:35 INFO - 'TMOUT': '86400', 15:35:35 INFO - 'USER': 'cltbld', 15:35:35 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:35 INFO - '_': '/tools/buildbot/bin/python'} 15:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:35 INFO - Downloading/unpacking blobuploader==1.2.4 15:35: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 15:35: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 15:35: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 15:35: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 15:35: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 15:35: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 15:35:37 INFO - Downloading blobuploader-1.2.4.tar.gz 15:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:35:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:35:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:38 INFO - Downloading docopt-0.6.1.tar.gz 15:35:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:35:38 INFO - Installing collected packages: blobuploader, requests, docopt 15:35:38 INFO - Running setup.py install for blobuploader 15:35:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:35:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:35:38 INFO - Running setup.py install for requests 15:35:39 INFO - Running setup.py install for docopt 15:35:39 INFO - Successfully installed blobuploader requests docopt 15:35:39 INFO - Cleaning up... 15:35:39 INFO - Return code: 0 15:35:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35: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')]} 15:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35: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')]} 15:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:39 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 0x1f70030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, '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': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', '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 15:35:39 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 15:35:39 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 15:35:39 INFO - Using env: {'DISPLAY': ':0', 15:35:39 INFO - 'HOME': '/home/cltbld', 15:35:39 INFO - 'LANG': 'en_US.UTF-8', 15:35:39 INFO - 'LANGUAGE': 'en_US:en', 15:35:39 INFO - 'LOGNAME': 'cltbld', 15:35:39 INFO - 'MAIL': '/var/mail/cltbld', 15:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:39 INFO - 'MOZ_NO_REMOTE': '1', 15:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:39 INFO - 'NO_EM_RESTART': '1', 15:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:39 INFO - 'PWD': '/builds/slave/test', 15:35:39 INFO - 'SHELL': '/bin/bash', 15:35:39 INFO - 'SHLVL': '1', 15:35:39 INFO - 'TERM': 'linux', 15:35:39 INFO - 'TMOUT': '86400', 15:35:39 INFO - 'USER': 'cltbld', 15:35:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:39 INFO - '_': '/tools/buildbot/bin/python'} 15:35:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:39 INFO - Running setup.py (path:/tmp/pip-c0LVhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:39 INFO - Running setup.py (path:/tmp/pip-_9M75b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:39 INFO - Running setup.py (path:/tmp/pip-PeVAbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:39 INFO - Running setup.py (path:/tmp/pip-gUreyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:39 INFO - Running setup.py (path:/tmp/pip-sFLnut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:39 INFO - Running setup.py (path:/tmp/pip-v4wo3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:39 INFO - Running setup.py (path:/tmp/pip-PW6QCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:40 INFO - Running setup.py (path:/tmp/pip-MLBEci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:40 INFO - Running setup.py (path:/tmp/pip-JEjaed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:40 INFO - Running setup.py (path:/tmp/pip-QbBFeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:40 INFO - Running setup.py (path:/tmp/pip-s0nNvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:40 INFO - Running setup.py (path:/tmp/pip-sS9S2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:40 INFO - Running setup.py (path:/tmp/pip-awXLKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:40 INFO - Running setup.py (path:/tmp/pip-kW1zmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:40 INFO - Running setup.py (path:/tmp/pip-7MmBll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:40 INFO - Running setup.py (path:/tmp/pip-FJYEZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:40 INFO - Running setup.py (path:/tmp/pip-fTCBnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:35:40 INFO - Running setup.py install for manifestparser 15:35:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:35:40 INFO - Running setup.py install for mozcrash 15:35:40 INFO - Running setup.py install for mozdebug 15:35:41 INFO - Running setup.py install for mozdevice 15:35:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:35:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:35:41 INFO - Running setup.py install for mozfile 15:35:41 INFO - Running setup.py install for mozhttpd 15:35:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:35:41 INFO - Running setup.py install for mozinfo 15:35:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:35:41 INFO - Running setup.py install for mozInstall 15:35:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:35:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:35:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:35:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:35:41 INFO - Running setup.py install for mozleak 15:35:41 INFO - Running setup.py install for mozlog 15:35:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:35:41 INFO - Running setup.py install for moznetwork 15:35:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:35:41 INFO - Running setup.py install for mozprocess 15:35:42 INFO - Running setup.py install for mozprofile 15:35:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:35:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:35:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:35:42 INFO - Running setup.py install for mozrunner 15:35:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:35:42 INFO - Running setup.py install for mozscreenshot 15:35:42 INFO - Running setup.py install for moztest 15:35:42 INFO - Running setup.py install for mozversion 15:35:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:35:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:35:42 INFO - Cleaning up... 15:35:42 INFO - Return code: 0 15:35:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:42 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 0x1f70030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, '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': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', '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 15:35:42 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 15:35:42 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 15:35:42 INFO - Using env: {'DISPLAY': ':0', 15:35:42 INFO - 'HOME': '/home/cltbld', 15:35:42 INFO - 'LANG': 'en_US.UTF-8', 15:35:42 INFO - 'LANGUAGE': 'en_US:en', 15:35:42 INFO - 'LOGNAME': 'cltbld', 15:35:42 INFO - 'MAIL': '/var/mail/cltbld', 15:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:42 INFO - 'MOZ_NO_REMOTE': '1', 15:35:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:42 INFO - 'NO_EM_RESTART': '1', 15:35:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:42 INFO - 'PWD': '/builds/slave/test', 15:35:42 INFO - 'SHELL': '/bin/bash', 15:35:42 INFO - 'SHLVL': '1', 15:35:42 INFO - 'TERM': 'linux', 15:35:42 INFO - 'TMOUT': '86400', 15:35:42 INFO - 'USER': 'cltbld', 15:35:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:42 INFO - '_': '/tools/buildbot/bin/python'} 15:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:42 INFO - Running setup.py (path:/tmp/pip-aZVbFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:42 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)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:42 INFO - Running setup.py (path:/tmp/pip-Lt6xaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:42 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)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:42 INFO - Running setup.py (path:/tmp/pip-WpQBAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:43 INFO - Running setup.py (path:/tmp/pip-Jg60Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:43 INFO - Running setup.py (path:/tmp/pip-zHR8WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:43 INFO - Running setup.py (path:/tmp/pip-1wVCLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:43 INFO - Running setup.py (path:/tmp/pip-c_AocM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:43 INFO - Running setup.py (path:/tmp/pip-fRIyDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:43 INFO - Running setup.py (path:/tmp/pip-qffhB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:43 INFO - Running setup.py (path:/tmp/pip-zUglu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:43 INFO - Running setup.py (path:/tmp/pip-6q5oZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:43 INFO - Running setup.py (path:/tmp/pip-bN1MdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:43 INFO - Running setup.py (path:/tmp/pip-8z3b7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:43 INFO - Running setup.py (path:/tmp/pip-DgTFaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:43 INFO - Running setup.py (path:/tmp/pip-w4HCm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:43 INFO - Running setup.py (path:/tmp/pip-D4LgO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:43 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)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:43 INFO - Running setup.py (path:/tmp/pip-gWDsqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:44 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)) 15:35:44 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)) 15:35:44 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)) 15:35:44 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)) 15:35:44 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)) 15:35:44 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)) 15:35:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:45 INFO - Downloading blessings-1.6.tar.gz 15:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:35:46 INFO - Installing collected packages: blessings 15:35:46 INFO - Running setup.py install for blessings 15:35:46 INFO - Successfully installed blessings 15:35:46 INFO - Cleaning up... 15:35:46 INFO - Return code: 0 15:35:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:35:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:35:46 INFO - Reading from file tmpfile_stdout 15:35:46 INFO - Current package versions: 15:35:46 INFO - argparse == 1.2.1 15:35:46 INFO - blessings == 1.6 15:35:46 INFO - blobuploader == 1.2.4 15:35:46 INFO - docopt == 0.6.1 15:35:46 INFO - functools32 == 3.2.3-2 15:35:46 INFO - jsonschema == 2.5.1 15:35:46 INFO - manifestparser == 1.1 15:35:46 INFO - mozInstall == 1.12 15:35:46 INFO - mozcrash == 0.17 15:35:46 INFO - mozdebug == 0.1 15:35:46 INFO - mozdevice == 0.48 15:35:46 INFO - mozfile == 1.2 15:35:46 INFO - mozhttpd == 0.7 15:35:46 INFO - mozinfo == 0.9 15:35:46 INFO - mozleak == 0.1 15:35:46 INFO - mozlog == 3.3 15:35:46 INFO - moznetwork == 0.27 15:35:46 INFO - mozprocess == 0.23 15:35:46 INFO - mozprofile == 0.28 15:35:46 INFO - mozrunner == 6.12 15:35:46 INFO - mozscreenshot == 0.1 15:35:46 INFO - mozsystemmonitor == 0.3 15:35:46 INFO - moztest == 0.7 15:35:46 INFO - mozversion == 1.4 15:35:46 INFO - psutil == 3.1.1 15:35:46 INFO - requests == 1.2.3 15:35:46 INFO - wsgiref == 0.1.2 15:35:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:46 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 0x1f70030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, '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': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', '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 15:35:46 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 15:35:46 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 15:35:46 INFO - Using env: {'DISPLAY': ':0', 15:35:46 INFO - 'HOME': '/home/cltbld', 15:35:46 INFO - 'LANG': 'en_US.UTF-8', 15:35:46 INFO - 'LANGUAGE': 'en_US:en', 15:35:46 INFO - 'LOGNAME': 'cltbld', 15:35:46 INFO - 'MAIL': '/var/mail/cltbld', 15:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:46 INFO - 'MOZ_NO_REMOTE': '1', 15:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:46 INFO - 'NO_EM_RESTART': '1', 15:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:46 INFO - 'PWD': '/builds/slave/test', 15:35:46 INFO - 'SHELL': '/bin/bash', 15:35:46 INFO - 'SHLVL': '1', 15:35:46 INFO - 'TERM': 'linux', 15:35:46 INFO - 'TMOUT': '86400', 15:35:46 INFO - 'USER': 'cltbld', 15:35:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:46 INFO - '_': '/tools/buildbot/bin/python'} 15:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 INFO - Cleaning up... 15:35:46 INFO - Return code: 0 15:35:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:46 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 0x1f70030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219f400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, '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': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', '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 15:35:46 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 15:35:46 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 15:35:46 INFO - Using env: {'DISPLAY': ':0', 15:35:46 INFO - 'HOME': '/home/cltbld', 15:35:46 INFO - 'LANG': 'en_US.UTF-8', 15:35:46 INFO - 'LANGUAGE': 'en_US:en', 15:35:46 INFO - 'LOGNAME': 'cltbld', 15:35:46 INFO - 'MAIL': '/var/mail/cltbld', 15:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:46 INFO - 'MOZ_NO_REMOTE': '1', 15:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:46 INFO - 'NO_EM_RESTART': '1', 15:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:46 INFO - 'PWD': '/builds/slave/test', 15:35:46 INFO - 'SHELL': '/bin/bash', 15:35:46 INFO - 'SHLVL': '1', 15:35:46 INFO - 'TERM': 'linux', 15:35:46 INFO - 'TMOUT': '86400', 15:35:46 INFO - 'USER': 'cltbld', 15:35:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:46 INFO - '_': '/tools/buildbot/bin/python'} 15:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:35:46 INFO - Cleaning up... 15:35:46 INFO - Return code: 0 15:35:46 INFO - Running post-action listener: _resource_record_post_action 15:35:46 INFO - Running post-action listener: _start_resource_monitoring 15:35:46 INFO - Starting resource monitoring. 15:35:46 INFO - [mozharness: 2016-08-15 22:35:46.914493Z] Finished create-virtualenv step (success) 15:35:46 INFO - [mozharness: 2016-08-15 22:35:46.914974Z] Running install step. 15:35:46 INFO - Running pre-action listener: _resource_record_pre_action 15:35:46 INFO - Running main action method: install 15:35:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:35:47 INFO - Reading from file tmpfile_stdout 15:35:47 INFO - Detecting whether we're running mozinstall >=1.0... 15:35:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:35:47 INFO - Reading from file tmpfile_stdout 15:35:47 INFO - Output received: 15:35:47 INFO - Usage: mozinstall [options] installer 15:35:47 INFO - Options: 15:35:47 INFO - -h, --help show this help message and exit 15:35:47 INFO - -d DEST, --destination=DEST 15:35:47 INFO - Directory to install application into. [default: 15:35:47 INFO - "/builds/slave/test"] 15:35:47 INFO - --app=APP Application being installed. [default: firefox] 15:35:47 INFO - mkdir: /builds/slave/test/build/application 15:35:47 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'] 15:35:47 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 15:36:03 INFO - Reading from file tmpfile_stdout 15:36:03 INFO - Output received: 15:36:03 INFO - /builds/slave/test/build/application/firefox/firefox 15:36:03 INFO - Running post-action listener: _resource_record_post_action 15:36:03 INFO - [mozharness: 2016-08-15 22:36:03.191512Z] Finished install step (success) 15:36:03 INFO - [mozharness: 2016-08-15 22:36:03.191637Z] Running run-tests step. 15:36:03 INFO - Running pre-action listener: _resource_record_pre_action 15:36:03 INFO - Running main action method: run_tests 15:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:36:03 INFO - Python 2.7.3 15:36:03 INFO - Return code: 0 15:36:03 INFO - grabbing minidump binary from tooltool 15:36:03 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')]} 15:36:03 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 0x222e570>, '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 0x222f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x222f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:36:03 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 15:36:03 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 15:36:03 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 15:36:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:36:03 INFO - Return code: 0 15:36:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:36:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:36:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:36:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:36:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:36:03 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/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 15:36:03 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/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 15:36:03 INFO - Using env: {'DISPLAY': ':0', 15:36:03 INFO - 'HOME': '/home/cltbld', 15:36:03 INFO - 'LANG': 'en_US.UTF-8', 15:36:03 INFO - 'LANGUAGE': 'en_US:en', 15:36:03 INFO - 'LOGNAME': 'cltbld', 15:36:03 INFO - 'MAIL': '/var/mail/cltbld', 15:36:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:36:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:03 INFO - 'MOZ_NO_REMOTE': '1', 15:36:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:03 INFO - 'NO_EM_RESTART': '1', 15:36:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:03 INFO - 'PWD': '/builds/slave/test', 15:36:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:36:03 INFO - 'SHELL': '/bin/bash', 15:36:03 INFO - 'SHLVL': '1', 15:36:03 INFO - 'TERM': 'linux', 15:36:03 INFO - 'TMOUT': '86400', 15:36:03 INFO - 'USER': 'cltbld', 15:36:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862', 15:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:03 INFO - '_': '/tools/buildbot/bin/python'} 15:36:03 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/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 15:36:03 INFO - mozversion application_buildid: 20160815122516 15:36:03 INFO - mozversion application_changeset: c16b845d20803e1d4e785b144ffd63e9545eb16b 15:36:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:36:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:36:03 INFO - mozversion application_name: Firefox 15:36:03 INFO - mozversion application_remotingname: firefox-dev 15:36:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:36:03 INFO - mozversion application_vendor: Mozilla 15:36:03 INFO - mozversion application_version: 50.0a2 15:36:03 INFO - mozversion platform_buildid: 20160815122516 15:36:03 INFO - mozversion platform_changeset: c16b845d20803e1d4e785b144ffd63e9545eb16b 15:36:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:36:03 INFO - mozversion platform_version: 50.0a2 15:36:03 INFO - using testdate: 1471300563 15:36:03 INFO - actual date: 1471300563 15:36:03 INFO - starting webserver on 'localhost:48502' 15:36:03 INFO - SUITE-START | Running 2 tests 15:36:03 INFO - TEST-START | dromaeo_css 15:36:03 INFO - operating with platform_type : linux_ 15:36:03 INFO - Initialising browser for dromaeo_css test... 15:36:03 INFO - TEST-INFO | started process 5825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA4js7e/profile http://localhost:48502/getInfo.html) 15:36:07 INFO - PROCESS | 5825 | __metrics Screen width/height:1600/1200 15:36:07 INFO - PROCESS | 5825 | colorDepth:24 15:36:07 INFO - PROCESS | 5825 | Browser inner width/height: 1024/697 15:36:07 INFO - PROCESS | 5825 | __metrics 15:36:07 ERROR - PROCESS | 5825 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:36:08 INFO - TEST-INFO | 5825: exit 0 15:36:08 INFO - Browser initialized. 15:36:08 INFO - Running cycle 1/1 for dromaeo_css test... 15:36:08 INFO - TEST-INFO | started process 5948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA4js7e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:36:20 INFO - PROCESS | 5948 | RSS: Main: 152657920 15:36:20 INFO - PROCESS | 5948 | 15:37:10 INFO - PROCESS | 5948 | 1471300630079 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] 15:39:18 INFO - PROCESS | 5948 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48502/tests/dromaeo/cssquery-ext.html) 15:39:19 INFO - PROCESS | 5948 | RSS: Main: 158224384 15:39:19 INFO - PROCESS | 5948 | 15:42:21 INFO - PROCESS | 5948 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-ext.html (next: http://localhost:48502/tests/dromaeo/cssquery-jquery.html) 15:42:22 INFO - PROCESS | 5948 | RSS: Main: 153247744 15:42:22 INFO - PROCESS | 5948 | 15:45:24 INFO - PROCESS | 5948 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48502/tests/dromaeo/cssquery-mootools.html) 15:45:24 INFO - PROCESS | 5948 | RSS: Main: 154497024 15:45:24 INFO - PROCESS | 5948 | 15:48:26 INFO - PROCESS | 5948 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48502/tests/dromaeo/cssquery-prototype.html) 15:48:27 INFO - PROCESS | 5948 | RSS: Main: 152522752 15:48:27 INFO - PROCESS | 5948 | 15:51:29 INFO - PROCESS | 5948 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48502/tests/dromaeo/cssquery-yui.html) 15:51:30 INFO - PROCESS | 5948 | RSS: Main: 155639808 15:51:30 INFO - PROCESS | 5948 | 15:54:32 INFO - PROCESS | 5948 | Cycle 1(1): loaded http://localhost:48502/tests/dromaeo/cssquery-yui.html (next: http://localhost:48502/tests/dromaeo/cssquery-dojo.html) 15:54:32 INFO - PROCESS | 5948 | RSS: Main: 156430336 15:54:32 INFO - PROCESS | 5948 | 15:54:32 INFO - PROCESS | 5948 | __start_tp_report 15:54:32 INFO - PROCESS | 5948 | _x_x_mozilla_page_load 15:54:32 INFO - PROCESS | 5948 | _x_x_mozilla_page_load_details 15:54:32 INFO - PROCESS | 5948 | |i|pagename|runs| 15:54:32 INFO - PROCESS | 5948 | |0;dojo.html;3360.88236911708;3363.260082781788;3393.7963722176673;3399.456087026076;3411.4200585900394;5756.654600723959;5869.50109240715;5887.676177810219;5901.911471327928;5915.940840591593;5718.399568045347;5781.884362312751;5787.623804452707;5791.478766910977;5812.0410132328225;5175.767090480937;5180.844574662748;5184.585233181337;5243.606729495284;5268.209768534732;5168.638195326329;5175.974120129394;5234.136367499358;5246.291750613656;5278.683279003272;5220.608454365938;5231.189165679326;5239.842804715865;5281.8943621127555;5365.409804921475;5268.341457317816;5289.973550132244;5292.391374991848;5294.41761406245;5304.575633949275;5019.749012549358;5116.079105760961;5156.845294641167;5190.792368305263;5260.368755749297;5699;5783.71081445926;5810.796622118248;5812;5828.06750919855;6216.595921265103;6241.843953901143;6270.153529273581;6283.842903927392;6292.842678933018;6007.579469437142;6083.847903802396;6244.531063558983;6292.370762923717;6299.622022678654;5727.541796656257;5766.971165144148;5777.162311464814;5795.246617939683;5806.44838740319;6259.342769009279;6270.0908368287255;6276.780312689034;6299.96850015747;6305.5901366411035;5882.176495290662;6020.217371741645;6078.483328917092;6079.75680972765;6091.390860913873;6233.657148856856;6306.2747784004505;6318.273398559132;6323.051542268697;6329.367063293634;6131.110988906673;6201.069839524108;6206.348333424925;6210.5031597473;6228;5968.1644569760265;6132.264128304543;6155.630662160284;6161.137440758297;6189.071639254148;4733.100710864925;4751;4758.857234282977;4767.141914455362;4782.0435912817575;4213.599708027732;4233.809478573472;4254.553271906467;4267.018585725238;4280.571942805756;5833.066709326572;5942.554308426886;6014.669193194416;6066.241719785027;6103.877922441615;6191.288001879841;6289.685515724195;6309.747610095636;6313.55805093639;6319.873602527924;5993.670348130808;6039.063945088518;6045.395460453919;6053.445009472477;6057.727402266909;5242.449542798027;5292.52367286946;5401.675899446046;5430.212619170277;5442.809501667422;6398.808035758934;6514;6519.217693876671;6530.444912182517;6544.149260596092;6193.628382297076;6206.813795586139;6214.72033758491;6219.689015549205;6237.563370564017;6243.625382477066;6257.342978987323;6441.066045423481;6454.741810327722;6521.64130972801;6013.067974463965;6096.969515152396;6104.26748790148;6136.171616831849;6139.815805525842;6170.413810687977;6170.413810687977;6172.845678857885;6180.381961803783;6181.84545386369;5831.970840145772;6015.248093988252;6068.848278793065;6069.283419472114;6120.204373431426;5978.282606087123;6002.639841609517;6073.210482637229;6088.147659327787;6090.756369745338;5946.5540084494705;5973.313068996948;5976.462118409364;5985.072313791369;6003.549733769897;5931.13998470228;5970.134330521963;6043.667598281961;6059.969700151471;6117.418845209698;5864.266966629171;5957.6127551709;5980.401959803985;5990.550708696778;6017.849553761191 15:54:32 INFO - PROCESS | 5948 | |1;ext.html;588.3028611095851;624.512879953636;637.400843207385;655.6852710698864;682.242710591244;42769.14461710764;46845.7657711711;47177;47196;47204.76397618011;48407.757961210234;48966;48992;48999.265011024865;49031.264531032066;9034.909650903506;9112.362134650577;9149;9153.542322883863;9172.63309467624;9113.772155696128;9211.907880921171;9243.953780231122;9256.814863702723;9280.071992800733;9255.53722313885;9274.350795444321;9282.303827212952;9315.580798864034;9316.534173291342;9210.861837072449;9216.400933939307;9279.118483744034;9283.071692830765;9317.39436936597;9157.862632060524;9213.355065145442;9218.492982885939;9229.492377919212;9265.861012084824;46184.76907615474;46324;46474.53525464736;46679;46747.06505869897;3611.5485564304463;3754.455603937414;3763.284975854579;3839.500864887547;4025.993501624594;35923.4611480828;36063.63936360629;36375;36850;36969.930031513526;4581.3815134956685;4610.585047345721;4627.537246275379;4638.814447422099;4725.362076119749;347669;348389;348856;350653.99999999744;352016;67251;67283;67706;67775.32224677788;67814;39915.80042099829;40382.79808600938;40651;42615.36076958848;69984.6500767503;17791.55521111957;17818.732719009226;17865.285388584573;17867.553311167067;17887.552811179823;15584.142872141914;15617.3753049879;15620.921895390678;15701.371945122295;15775.05349679;21521;21559.24542641;21563.892180539;21697.783022169577;21727.130914763547;7533.397328213729;7722.613869306512;7759.650815713307;7803.85946858618;7817.648205830751;1038.4859494550094;1084.2356138922041;1086.245059683528;1156.942152892352;1180.079537960375;34656.826715866766;34882.30235395278;34882.825585871906;35117.47323790145;35119.4732079019;1181.952721891132;1235.9011279097651;1237.127824883455;1250.4060571228777;1264.2919964819546;17978.1010949452;18443.446696599123;18463.630727385378;18481.075946202636;18551.53621159455;1010159;1022424;1024308;1025972;1030741;63063.36936630575;64049.67975160188;64180.35819641744;64197.67901160558;64222;1477.3573495529479;1492.656688961545;1501.8573235542606;1510.8791296696238;1514.0915450729474;34138.82930585331;34351.4847277286;34552.654473454946;34612.65387346094;34760.13099672528;54718.45281547293;55070.44929550653;55076.449235507134;55268.72365638307;55323;420883;421310;423825;424228;425059;30630.540541891445;30684.53973190359;31310.686893130776;31414.842925785226;31423.685763142992;51789;51831;51935.22097168621;51954.74022629863;52505.21242181447;43045.1390972185;43628.34557481704;43758.781206093765;43794.56205437905;44975.32537011882;44055.33916991184;44804.77597611991;46598.30102548397;46836.29745553751;49469.257961131334;43367.34948975705;46015.76992115018;46077.539224607324;47368.28947565858;47585;39417.60582394254;40265;40458.786236412954;40656.59343406528;41402.792986034874;30639;30778.38443231078;30857.537136943414;31261.8436907814;31301.530477043318 15:54:32 INFO - PROCESS | 5948 | |2;jquery.html;404.6863680647498;405.3473907009714;406.56903682097;408.91003979124594;417.70760467672636;19349;20865.68701469479;20883.68674469884;21224.8938755306;21584.568308633818;12167.939160304208;12518.436670349833;19375.612487750237;19761.209551617918;19865.801341986575;5434.2935418395655;6053.545984051192;6060.090986352038;6130.754769809225;6208.87582248357;4907.533784290505;6112.449879510843;6146.446819786218;6149.0468977308365;6152.0464328029;6002.909956350658;6126.203593532835;6143.662098584576;6147.108669242957;6156.138140660311;6051.12258722485;6116.327204007555;6128.969355153218;6143.846403839917;6168.0439531872635;5815.476607105381;5884.293884733816;5919;5930.1401296812155;5944.4352786485215;13355.265460399674;13645.454181832714;13718.38267277965;13847;13895.513657022057;2357.3163782503225;2365.929022129339;2453.0800949643885;2470.147799009339;2591.714911359749;10376.896231037668;10635.680929572125;10635.840462393071;11566;15729.528114156594;2017.656998310276;2048.09883651193;2058.6294466995937;2112.3662901129755;2120.713703650003;78359.21640783633;90210.54894725485;90227.29318120402;91201.5439922796;91286.54356728241;11624.476898539586;11643.41782910851;11741.823872641917;11818.586349477899;11972.880271197351;16670.416535421202;16707.832921670626;16720.331186752395;16723.581910452092;16749;8859.981102173333;8879.200871921557;8913.688020919237;9028.503432311287;9054.81890362189;8595.398322117517;8596.398252122417;8724.258438032712;8917.923316455812;8966.730998070068;4771.355866957986;4809.182438985381;4834.347363106006;4843.304843304815;4930.211166213388;1781.714925611896;2082.4689704125353;2115.661494160927;2119.491322082689;2160.848740588175;910.3991365698607;1023.3961962442195;1024.3393011507535;1034.6171916390983;1039.729670285716;17300.567485812957;20575.485612859797;20798.480037999172;21170.36488905335;21213.257535986166;1030.1912998296302;1051;1087.2226358153957;1124.6344937895053;1132.592266783957;10834;11502.769944601061;11815.11386646005;11834.704132396586;11903.345316007702;437916;450842;503725;507601;509928;87538.56230718805;88234;94870.52564737132;95516.52241738747;96645.51677241569;1074.666853275487;1101.6474728087096;1117.519466629341;1165.7260543772206;1170.9355985420884;18624.813751862308;19426.514337141118;19664.21343146258;19839;19859.801401986373;38519.614803851604;43881.78059109684;44358.33462498001;45094;46243.537564623926;65996.67001664962;66485.26665801264;66924.66537667475;67677.66161169359;68398.31601683919;7605.087389513073;7685.923140768521;7831.647575858986;7996.360291176576;8689.391742577958;11778.587749428729;14319.284035798377;14491.565253042425;15008.549743507712;15034;10262.281640285108;12016.399180041139;12248.938755306166;12396.752064958831;12624.99000079973;11879.406029698308;12385.071119665881;12651.87348126507;13057.738845223232;13430.328483575588;11922.582709605122;12411;12445.688857778629;12550.87449125497;12628.242305461701;8710.564471776512;9043.321750868843;9203.585838637144;9226.492542910204;9514.524273786144;9449.574769135268;11171.776564468828;11749.118816088656;11750.94124529372;12066.155369124077 15:54:32 INFO - PROCESS | 5948 | |3;mootools.html;1564.303884771277;1580.881433892458;1756.9121543922802;1856.684363658178;1874.7937726850053;8920;9122.726318210463;9361.672341468042;10070.647527336545;10076.345037572562;9288.489133097677;9352.064793520645;9354.438733675966;9410.905890941089;9432.481213533252;2463.482668639583;2498.675172227608;2519.231634351522;2528.456381877896;2530.8101892358145;2435.6224785158242;2504.5491811473926;2506.8495890246554;2514.170323793153;2522.1928982725535;2465.926022219336;2472.6909136357954;2489.800815934721;2496.301035709995;2499.175272160183;2442.658027876099;2443.1937460637946;2465.3097132802754;2469.790067844235;2476.36852602587;2401.987990060056;2408.385861605297;2429.368364225314;2435.330284171867;2464.642626819101;9965;10067.244956628283;10072.94963525185;10075.193984481224;10084.899151008543;5708.942910570882;5713;5779.075347944308;5825;5826.2134611827705;3625.836837342326;3681.650243226889;3733.0667333166707;3736.981315093434;3779.168582911755;1107.0866535108569;1182.2729021651708;1188.1089183112665;1196.5811965811897;1212.89083982442;13910.930445347809;13936.163830170222;13952.023358364919;13967.161970281713;13996.580102596938;4745.264484004984;4880.829170978998;4963.503649635008;5012.824551140692;5058.038972595195;11558.306501609763;11633.883661163449;11640;11648.767024659459;11686.94156529212;5832.650040997553;5840.445157710011;5849.6782676952325;5850.473457388855;5859.853503662443;4720.244760838318;5214.556762675215;5311.389190243094;5369.624126311199;5413.079776438015;4299.290617048215;4375.081232941055;4421.314696222091;4445.844395446144;4458.7324760514475;1269.5556555205603;1282.4805953588811;1313.4746101559263;1319.070055610792;1326.0121209698837;1040.3549799124592;1047.2355180718118;1049.1711547877092;1072.3512275073467;1087.2986923434498;6112.266528016667;6290.591111577733;6346.270178929482;6421.389967953037;6536.640484773288;437.66737279667683;454.6567341657028;455.5490064835855;462.4820201374415;464.2734121100534;4394.560543945644;4437.245668236407;4451.354553589711;4458.8439404620685;4484.372187893698;12124.333161676017;12357.38213089342;12457;12459.688507787196;12520.686982825502;11773.17587768865;12246.265224086583;12285.938570307091;12404.19372740769;12417.130800844036;8935.508547029976;9293.210077143383;9299.488528130882;9300.72097837066;9359.391639543408;6253.218347706536;6279.1209230708655;6279.309275979547;6369.777057802955;6567.540272181092;11149.108071354434;11151.72120696989;11210.103191744478;11308.321500709984;11365.54537818478;11085.445727713743;11138.443077846237;11155.944220278847;11289.491972861077;11437.599684011353;7879.527228366316;8378.874316885129;8587.141285871612;8632.093630168742;8705.782355441164;9558;9565.521723913636;9575.04249575037;9576.47329396862;9658;8501.81647837417;8544.700935467228;8673.609687563949;8707.956460217658;8746.737597872074;8665.696700615448;8681.782955426164;8697.434666746894;8829.64681412762;8900.109989001048;7265.600391978281;7346.302101300368;7412.592307423143;7418.109826820816;7447.47867649281;5576.10782274834;5611.102223644198;5623.465770751772;5699.715014249188;5704.1443783432815;5749.281339832521;5838.591298609226;5865.208196893364;5890.087036509348;5910.261217347832 15:54:32 INFO - PROCESS | 5948 | |4;prototype.html;329.88783813503403;336.11769106096494;339.74349366228495;342.85600047979847;344.91549570355266;5831.416858314166;5831.620944638596;5831.912521312173;5853.853653658661;5856.393904712405;5717.3139223293265;5734.885302293952;5751.597388182819;5752.137179423089;5769.7692092316365;3973.46358241638;4259.233337999167;4337.804798784046;4409.933850992237;4435.356873253377;4418.779061046935;4433.467983841943;4437.64498840092;4442.97778511107;4445.933311000337;4449.199144154051;4449.510553839075;4450.910981780363;4462;4465.37484752135;4312.3531470279395;4403.911921761579;4455.532169122261;4468.173387923229;4487;3852.3258429774955;3871.8838434847;3871.9612803871883;3892.785896775676;3899.1811719538646;5577.3028371453565;5586.692731899744;5626.54987600995;5641.605087643867;5656.886862262772;5048.217526283432;5083.491650834924;5140.820071297487;5160.6129540284255;5162;6002.879942401128;6034;6072.722728976633;6077.604955677911;6080.908786368163;4301.655867530621;4327.459067616548;4329.458817647794;4348.391225228471;4348.412964249817;6059.787907423219;6129.969350153266;6248.9062664060075;6281.057841323793;6304.211973503312;4329.588689074533;4366.257736184856;4367.27939889921;4377.649788016951;4380.540043295472;4404.031113155101;4412.271975124068;4426.026274219666;4434.445694288214;4437.423134992495;4945.777440015136;5001.799928002912;5118.232265160255;5138.897222055538;5145.202493613496;6062.938985677489;6064.3935606439;6070.696465176724;6081.6351018939;6141.723622437001;1490.3591455674164;1499.5951093204774;1506.6760646460843;1512.948500791939;1516.3707061569326;907.2515174980535;962.1340793286098;962.2013728605241;971.8250714871391;977.3647129365969;5223.764930578133;5320.494553017457;5324.828537721695;5325.946740532545;5345.251664766935;5498.697571633598;5535.750891209906;5556.166465066518;5574.136008918624;5581.944180558143;4970.130227210224;5250.606204534675;5257.8159764408065;5279.577633789288;5354.045773292798;2966.5401862710883;2971.687972762872;2978.717021882918;2981.925451863721;2993.8473687630417;5639.407862174495;5684.8863022739315;5700;5787.39232380594;5820.30156381237;5923.792667256712;6340.4293613575;6396.680165991682;6438.871222575523;6464.38588334117;6513.576617519846;6514.315996820361;6549.410553050248;6550.3449655035065;6571.835704107436;6007.90988135187;6220.72006759706;6283.088952102011;6287.610707930957;6317.778877739441;6196.47329976957;6235.815195112914;6266.530010249158;6287.654179020198;6310.716017779303;6276.278228003838;6324.968375158095;6473.287938326686;6480.740770369132;6523.64119973406;4280.935785963151;4357.411749413788;4365.956340436682;4372.6501879850175;4380.4305440292555;6123.785667501616;6229.937700622936;6309.012661011767;6331.240251169889;6351.364863513611;6091.7563297467605;6123.418275263843;6139.3553676863285;6163.19878415803;6204.751809927733;5978.432048955342;6111.205543279345;6166.0711162197595;6184.288806787277;6191.378043844402;6058.818825223005;6064.909026364697;6090.116933044772;6105.48103411215;6126.785562505291;6144.324124346408;6147.692615369124;6194.132821405097;6205.410486003822;6250.468710159687;5790.305163380422;5942.078228369255;5974.878917984053;5980.700964951648;6020.337762846171 15:54:32 INFO - PROCESS | 5948 | |5;yui.html;863.8661007543828;882.1311008656477;894.329253060205;900.3787386703174;953.3469573342265;16545.917270413647;18087.276508939627;18157.54606134844;18243.087845607733;18326.083695815207;16470.258838352274;16501.963448875405;16719.749203761952;16875.493735187963;17009.659806803855;898.9910100898989;899.5727029660924;905.9048799875984;906.3383729877194;906.863970404438;881.5151666583386;884.8009197930478;885.6014793342989;907.1065000974069;907.9818403631923;947.0198344713223;951.8334291498994;952.6237136331144;960.0207788056179;960.0255740423476;945.0407836046419;945.7021038372959;946.7491114854569;947.7535840681403;949.0841338108723;683.5795985468901;693.5180049865346;693.6913073682214;693.9236683964759;694.8818700820873;15995.760063599055;16019.759703604455;16048.518544443685;16066.357345706158;16105.114218717967;13194.736105277936;14041;14591.270436478133;15091.924540377227;16298.022118672918;14788.778168327377;14833.332500037524;14966.17686027268;14974;15320.004199726982;4179.185058913513;4209.221294060578;4234.3860140279485;4251;4893.339399181101;83517;86895.56552217324;87483.56258218669;87875.56062219712;88222.55888720516;12619.558315458915;12631.515991248029;12646.676008717097;12727.427265773062;12885.48458061667;23105.191318304114;23160;23183.072677093063;23578.764212358;23886.163984260467;8628.180322869317;8786.780330491789;8910;8937.910620893708;8952.8657070144;5084.847454576368;5084.898302033938;5113.258577506241;5254.632175747661;5292.603054770908;3949.3878448840474;4142.2751018572235;4150.3566947123245;4151.232022075926;4156.376543518436;706.159669992707;706.4348521183135;713.8179764160105;716.2014353995362;724.760828926453;810.8499927513429;812.6749300279936;839.1147339556704;851.2764150472173;854.9145085491401;10481.633142839964;10660.466976651136;10962.342259464458;11296.491657875415;11319.603813866639;698.5250029979561;735.3198291580267;739.9566611078461;785.2618538573722;838.3209600223717;5202.479752024768;5405.8107966221;5429.4027656957705;5507.834764957058;5562.360328562187;73149.26850731531;84996.57501712575;124579.3771031139;132879;133694;66206.33793662098;73003;91518.79684211021;112229.43885280685;113731;98639.50680246553;98867;100170.49914750525;100426.49786751019;100609.49695251623;10163.986849074116;10181.654855774088;10237.488125593542;10329.070383665507;10487.37075775456;55514.72242638761;56385.43614563966;56586.15120773274;57531;58354.12468812886;83826.16173838428;85591.57204214188;86881.56559217416;87454.1254587446;89058;12615.180013299107;12670.239785612892;12688.23870567769;12768.170068945861;12781.16922400041;14804.185769782765;14820.777688334469;14883.776743348642;14967.40130394772;16253.59366015859;13046.804297935729;13304;13723.382447790073;13906.58280251594;14009.859901401263;12640;13792.586222413343;14934;14992.625184370478;15426.22868856575;12479.625611231315;13704.246266455042;13780.862191377957;13791.241481718602;13995.370208340446;11707.590234341757;12978.633224463261;13175.275359854917;13406.530771423344;13642.181469111885;11025.77214661972;12223.87776122263;12597.244165350108;12694.809577856155;12792.360381980678 15:54:32 INFO - PROCESS | 5948 | __end_tp_report 15:54:32 INFO - PROCESS | 5948 | __start_cc_report 15:54:32 INFO - PROCESS | 5948 | _x_x_mozilla_cycle_collect,326 15:54:32 INFO - PROCESS | 5948 | __end_cc_report 15:54:32 INFO - PROCESS | 5948 | __startTimestamp1471301672548__endTimestamp 15:54:32 INFO - PROCESS | 5948 | 15:54:32 INFO - PROCESS | 5948 | ------- Summary: start ------- 15:54:32 INFO - PROCESS | 5948 | Number of tests: 6 15:54:32 INFO - PROCESS | 5948 | 15:54:32 INFO - PROCESS | 5948 | [#0] dojo.html Cycles:165 Average:5763.54 Median:6002.64 stddev:657.18 (10.9%) stddev-sans-first:631.58 15:54:32 INFO - PROCESS | 5948 | Values: 3360.9 3363.3 3393.8 3399.5 3411.4 5756.7 5869.5 5887.7 5901.9 5915.9 5718.4 5781.9 5787.6 5791.5 5812.0 5175.8 5180.8 5184.6 5243.6 5268.2 5168.6 5176.0 5234.1 5246.3 5278.7 5220.6 5231.2 5239.8 5281.9 5365.4 5268.3 5290.0 5292.4 5294.4 5304.6 5019.7 5116.1 5156.8 5190.8 5260.4 5699.0 5783.7 5810.8 5812.0 5828.1 6216.6 6241.8 6270.2 6283.8 6292.8 6007.6 6083.8 6244.5 6292.4 6299.6 5727.5 5767.0 5777.2 5795.2 5806.4 6259.3 6270.1 6276.8 6300.0 6305.6 5882.2 6020.2 6078.5 6079.8 6091.4 6233.7 6306.3 6318.3 6323.1 6329.4 6131.1 6201.1 6206.3 6210.5 6228.0 5968.2 6132.3 6155.6 6161.1 6189.1 4733.1 4751.0 4758.9 4767.1 4782.0 4213.6 4233.8 4254.6 4267.0 4280.6 5833.1 5942.6 6014.7 6066.2 6103.9 6191.3 6289.7 6309.7 6313.6 6319.9 5993.7 6039.1 6045.4 6053.4 6057.7 5242.4 5292.5 5401.7 5430.2 5442.8 6398.8 6514.0 6519.2 6530.4 6544.1 6193.6 6206.8 6214.7 6219.7 6237.6 6243.6 6257.3 6441.1 6454.7 6521.6 6013.1 6097.0 6104.3 6136.2 6139.8 6170.4 6170.4 6172.8 6180.4 6181.8 5832.0 6015.2 6068.8 6069.3 6120.2 5978.3 6002.6 6073.2 6088.1 6090.8 5946.6 5973.3 5976.5 5985.1 6003.5 5931.1 5970.1 6043.7 6060.0 6117.4 5864.3 5957.6 5980.4 5990.6 6017.8 15:54:32 INFO - PROCESS | 5948 | 15:54:32 INFO - PROCESS | 5948 | [#1] ext.html Cycles:180 Average:75197.19 Median:43206.24 stddev:181734.64 (420.6%) stddev-sans-first:182158.11 15:54:32 INFO - PROCESS | 5948 | Values: 588.3 624.5 637.4 655.7 682.2 42769.1 46845.8 47177.0 47196.0 47204.8 48407.8 48966.0 48992.0 48999.3 49031.3 9034.9 9112.4 9149.0 9153.5 9172.6 9113.8 9211.9 9244.0 9256.8 9280.1 9255.5 9274.4 9282.3 9315.6 9316.5 9210.9 9216.4 9279.1 9283.1 9317.4 9157.9 9213.4 9218.5 9229.5 9265.9 46184.8 46324.0 46474.5 46679.0 46747.1 3611.5 3754.5 3763.3 3839.5 4026.0 35923.5 36063.6 36375.0 36850.0 36969.9 4581.4 4610.6 4627.5 4638.8 4725.4 347669.0 348389.0 348856.0 350654.0 352016.0 67251.0 67283.0 67706.0 67775.3 67814.0 39915.8 40382.8 40651.0 42615.4 69984.7 17791.6 17818.7 17865.3 17867.6 17887.6 15584.1 15617.4 15620.9 15701.4 15775.1 21521.0 21559.2 21563.9 21697.8 21727.1 7533.4 7722.6 7759.7 7803.9 7817.6 1038.5 1084.2 1086.2 1156.9 1180.1 34656.8 34882.3 34882.8 35117.5 35119.5 1182.0 1235.9 1237.1 1250.4 1264.3 17978.1 18443.4 18463.6 18481.1 18551.5 1010159.0 1022424.0 1024308.0 1025972.0 1030741.0 63063.4 64049.7 64180.4 64197.7 64222.0 1477.4 1492.7 1501.9 1510.9 1514.1 34138.8 34351.5 34552.7 34612.7 34760.1 54718.5 55070.4 55076.4 55268.7 55323.0 420883.0 421310.0 423825.0 424228.0 425059.0 30630.5 30684.5 31310.7 31414.8 31423.7 51789.0 51831.0 51935.2 51954.7 52505.2 43045.1 43628.3 43758.8 43794.6 44975.3 44055.3 44804.8 46598.3 46836.3 49469.3 43367.3 46015.8 46077.5 47368.3 47585.0 39417.6 40265.0 40458.8 40656.6 41402.8 30639.0 30778.4 30857.5 31261.8 31301.5 15:54:32 INFO - PROCESS | 5948 | 15:54:32 INFO - PROCESS | 5948 | [#2] jquery.html Cycles:180 Average:29402.24 Median:21404.73 stddev:79924.50 (373.4%) stddev-sans-first:80119.05 15:54:32 INFO - PROCESS | 5948 | Values: 404.7 405.3 406.6 408.9 417.7 19349.0 20865.7 20883.7 21224.9 21584.6 12167.9 12518.4 19375.6 19761.2 19865.8 5434.3 6053.5 6060.1 6130.8 6208.9 4907.5 6112.4 6146.4 6149.0 6152.0 6002.9 6126.2 6143.7 6147.1 6156.1 6051.1 6116.3 6129.0 6143.8 6168.0 5815.5 5884.3 5919.0 5930.1 5944.4 13355.3 13645.5 13718.4 13847.0 13895.5 2357.3 2365.9 2453.1 2470.1 2591.7 10376.9 10635.7 10635.8 11566.0 15729.5 2017.7 2048.1 2058.6 2112.4 2120.7 78359.2 90210.5 90227.3 91201.5 91286.5 11624.5 11643.4 11741.8 11818.6 11972.9 16670.4 16707.8 16720.3 16723.6 16749.0 8860.0 8879.2 8913.7 9028.5 9054.8 8595.4 8596.4 8724.3 8917.9 8966.7 4771.4 4809.2 4834.3 4843.3 4930.2 1781.7 2082.5 2115.7 2119.5 2160.8 910.4 1023.4 1024.3 1034.6 1039.7 17300.6 20575.5 20798.5 21170.4 21213.3 1030.2 1051.0 1087.2 1124.6 1132.6 10834.0 11502.8 11815.1 11834.7 11903.3 437916.0 450842.0 503725.0 507601.0 509928.0 87538.6 88234.0 94870.5 95516.5 96645.5 1074.7 1101.6 1117.5 1165.7 1170.9 18624.8 19426.5 19664.2 19839.0 19859.8 38519.6 43881.8 44358.3 45094.0 46243.5 65996.7 66485.3 66924.7 67677.7 68398.3 7605.1 7685.9 7831.6 7996.4 8689.4 11778.6 14319.3 14491.6 15008.5 15034.0 10262.3 12016.4 12248.9 12396.8 12625.0 11879.4 12385.1 12651.9 13057.7 13430.3 11922.6 12411.0 12445.7 12550.9 12628.2 8710.6 9043.3 9203.6 9226.5 9514.5 9449.6 11171.8 11749.1 11750.9 12066.2 15:54:32 INFO - PROCESS | 5948 | 15:54:32 INFO - PROCESS | 5948 | [#3] mootools.html Cycles:180 Average:6394.65 Median:4429.28 stddev:3749.53 (84.7%) stddev-sans-first:3742.48 15:54:32 INFO - PROCESS | 5948 | Values: 1564.3 1580.9 1756.9 1856.7 1874.8 8920.0 9122.7 9361.7 10070.6 10076.3 9288.5 9352.1 9354.4 9410.9 9432.5 2463.5 2498.7 2519.2 2528.5 2530.8 2435.6 2504.5 2506.8 2514.2 2522.2 2465.9 2472.7 2489.8 2496.3 2499.2 2442.7 2443.2 2465.3 2469.8 2476.4 2402.0 2408.4 2429.4 2435.3 2464.6 9965.0 10067.2 10072.9 10075.2 10084.9 5708.9 5713.0 5779.1 5825.0 5826.2 3625.8 3681.7 3733.1 3737.0 3779.2 1107.1 1182.3 1188.1 1196.6 1212.9 13910.9 13936.2 13952.0 13967.2 13996.6 4745.3 4880.8 4963.5 5012.8 5058.0 11558.3 11633.9 11640.0 11648.8 11686.9 5832.7 5840.4 5849.7 5850.5 5859.9 4720.2 5214.6 5311.4 5369.6 5413.1 4299.3 4375.1 4421.3 4445.8 4458.7 1269.6 1282.5 1313.5 1319.1 1326.0 1040.4 1047.2 1049.2 1072.4 1087.3 6112.3 6290.6 6346.3 6421.4 6536.6 437.7 454.7 455.5 462.5 464.3 4394.6 4437.2 4451.4 4458.8 4484.4 12124.3 12357.4 12457.0 12459.7 12520.7 11773.2 12246.3 12285.9 12404.2 12417.1 8935.5 9293.2 9299.5 9300.7 9359.4 6253.2 6279.1 6279.3 6369.8 6567.5 11149.1 11151.7 11210.1 11308.3 11365.5 11085.4 11138.4 11155.9 11289.5 11437.6 7879.5 8378.9 8587.1 8632.1 8705.8 9558.0 9565.5 9575.0 9576.5 9658.0 8501.8 8544.7 8673.6 8708.0 8746.7 8665.7 8681.8 8697.4 8829.6 8900.1 7265.6 7346.3 7412.6 7418.1 7447.5 5576.1 5611.1 5623.5 5699.7 5704.1 5749.3 5838.6 5865.2 5890.1 5910.3 15:54:32 INFO - PROCESS | 5948 | 15:54:32 INFO - PROCESS | 5948 | [#4] prototype.html Cycles:180 Average:5021.61 Median:5670.89 stddev:1514.23 (26.7%) stddev-sans-first:1476.96 15:54:32 INFO - PROCESS | 5948 | Values: 329.9 336.1 339.7 342.9 344.9 5831.4 5831.6 5831.9 5853.9 5856.4 5717.3 5734.9 5751.6 5752.1 5769.8 3973.5 4259.2 4337.8 4409.9 4435.4 4418.8 4433.5 4437.6 4443.0 4445.9 4449.2 4449.5 4450.9 4462.0 4465.4 4312.4 4403.9 4455.5 4468.2 4487.0 3852.3 3871.9 3872.0 3892.8 3899.2 5577.3 5586.7 5626.5 5641.6 5656.9 5048.2 5083.5 5140.8 5160.6 5162.0 6002.9 6034.0 6072.7 6077.6 6080.9 4301.7 4327.5 4329.5 4348.4 4348.4 6059.8 6130.0 6248.9 6281.1 6304.2 4329.6 4366.3 4367.3 4377.6 4380.5 4404.0 4412.3 4426.0 4434.4 4437.4 4945.8 5001.8 5118.2 5138.9 5145.2 6062.9 6064.4 6070.7 6081.6 6141.7 1490.4 1499.6 1506.7 1512.9 1516.4 907.3 962.1 962.2 971.8 977.4 5223.8 5320.5 5324.8 5325.9 5345.3 5498.7 5535.8 5556.2 5574.1 5581.9 4970.1 5250.6 5257.8 5279.6 5354.0 2966.5 2971.7 2978.7 2981.9 2993.8 5639.4 5684.9 5700.0 5787.4 5820.3 5923.8 6340.4 6396.7 6438.9 6464.4 6513.6 6514.3 6549.4 6550.3 6571.8 6007.9 6220.7 6283.1 6287.6 6317.8 6196.5 6235.8 6266.5 6287.7 6310.7 6276.3 6325.0 6473.3 6480.7 6523.6 4280.9 4357.4 4366.0 4372.7 4380.4 6123.8 6229.9 6309.0 6331.2 6351.4 6091.8 6123.4 6139.4 6163.2 6204.8 5978.4 6111.2 6166.1 6184.3 6191.4 6058.8 6064.9 6090.1 6105.5 6126.8 6144.3 6147.7 6194.1 6205.4 6250.5 5790.3 5942.1 5974.9 5980.7 6020.3 15:54:32 INFO - PROCESS | 5948 | 15:54:32 INFO - PROCESS | 5948 | [#5] yui.html Cycles:180 Average:22189.81 Median:4150.79 stddev:31549.93 (760.1%) stddev-sans-first:31597.80 15:54:32 INFO - PROCESS | 5948 | Values: 863.9 882.1 894.3 900.4 953.3 16545.9 18087.3 18157.5 18243.1 18326.1 16470.3 16502.0 16719.7 16875.5 17009.7 899.0 899.6 905.9 906.3 906.9 881.5 884.8 885.6 907.1 908.0 947.0 951.8 952.6 960.0 960.0 945.0 945.7 946.7 947.8 949.1 683.6 693.5 693.7 693.9 694.9 15995.8 16019.8 16048.5 16066.4 16105.1 13194.7 14041.0 14591.3 15091.9 16298.0 14788.8 14833.3 14966.2 14974.0 15320.0 4179.2 4209.2 4234.4 4251.0 4893.3 83517.0 86895.6 87483.6 87875.6 88222.6 12619.6 12631.5 12646.7 12727.4 12885.5 23105.2 23160.0 23183.1 23578.8 23886.2 8628.2 8786.8 8910.0 8937.9 8952.9 5084.8 5084.9 5113.3 5254.6 5292.6 3949.4 4142.3 4150.4 4151.2 4156.4 706.2 706.4 713.8 716.2 724.8 810.8 812.7 839.1 851.3 854.9 10481.6 10660.5 10962.3 11296.5 11319.6 698.5 735.3 740.0 785.3 838.3 5202.5 5405.8 5429.4 5507.8 5562.4 73149.3 84996.6 124579.4 132879.0 133694.0 66206.3 73003.0 91518.8 112229.4 113731.0 98639.5 98867.0 100170.5 100426.5 100609.5 10164.0 10181.7 10237.5 10329.1 10487.4 55514.7 56385.4 56586.2 57531.0 58354.1 83826.2 85591.6 86881.6 87454.1 89058.0 12615.2 12670.2 12688.2 12768.2 12781.2 14804.2 14820.8 14883.8 14967.4 16253.6 13046.8 13304.0 13723.4 13906.6 14009.9 12640.0 13792.6 14934.0 14992.6 15426.2 12479.6 13704.2 13780.9 13791.2 13995.4 11707.6 12978.6 13175.3 13406.5 13642.2 11025.8 12223.9 12597.2 12694.8 12792.4 15:54:32 INFO - PROCESS | 5948 | -------- Summary: end -------- 15:54:32 INFO - PROCESS | 5948 | 15:54:33 INFO - TEST-INFO | 5948: exit 0 15:54:33 INFO - TEST-OK | dromaeo_css | took 1109834ms 15:54:33 INFO - TEST-START | kraken 15:54:33 INFO - operating with platform_type : linux_ 15:54:33 INFO - Initialising browser for kraken test... 15:54:33 INFO - TEST-INFO | started process 6216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph0cLa9/profile http://localhost:48502/getInfo.html) 15:54:37 INFO - PROCESS | 6216 | __metrics Screen width/height:1600/1200 15:54:37 INFO - PROCESS | 6216 | colorDepth:24 15:54:37 INFO - PROCESS | 6216 | Browser inner width/height: 1024/697 15:54:37 INFO - PROCESS | 6216 | __metrics 15:54:37 ERROR - PROCESS | 6216 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:54:38 INFO - TEST-INFO | 6216: exit 0 15:54:38 INFO - Browser initialized. 15:54:38 INFO - Running cycle 1/1 for kraken test... 15:54:38 INFO - TEST-INFO | started process 6338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph0cLa9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:50 INFO - PROCESS | 6338 | RSS: Main: 152449024 15:54:50 INFO - PROCESS | 6338 | 15:54:52 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48502/tests/kraken/driver.html?testName=audio-beat-detection) 15:54:53 INFO - PROCESS | 6338 | RSS: Main: 158154752 15:54:53 INFO - PROCESS | 6338 | 15:54:56 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48502/tests/kraken/driver.html?testName=audio-dft) 15:54:56 INFO - PROCESS | 6338 | RSS: Main: 156647424 15:54:56 INFO - PROCESS | 6338 | 15:54:59 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48502/tests/kraken/driver.html?testName=audio-fft) 15:55:00 INFO - PROCESS | 6338 | RSS: Main: 157151232 15:55:00 INFO - PROCESS | 6338 | 15:55:02 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48502/tests/kraken/driver.html?testName=audio-oscillator) 15:55:03 INFO - PROCESS | 6338 | RSS: Main: 156782592 15:55:03 INFO - PROCESS | 6338 | 15:55:05 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48502/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:55:05 INFO - PROCESS | 6338 | RSS: Main: 156413952 15:55:05 INFO - PROCESS | 6338 | 15:55:09 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48502/tests/kraken/driver.html?testName=imaging-darkroom) 15:55:09 INFO - PROCESS | 6338 | RSS: Main: 155521024 15:55:09 INFO - PROCESS | 6338 | 15:55:13 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48502/tests/kraken/driver.html?testName=imaging-desaturate) 15:55:13 INFO - PROCESS | 6338 | RSS: Main: 156573696 15:55:13 INFO - PROCESS | 6338 | 15:55:16 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48502/tests/kraken/driver.html?testName=json-parse-financial) 15:55:17 INFO - PROCESS | 6338 | RSS: Main: 157368320 15:55:17 INFO - PROCESS | 6338 | 15:55:18 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48502/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:55:19 INFO - PROCESS | 6338 | RSS: Main: 157380608 15:55:19 INFO - PROCESS | 6338 | 15:55:21 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:55:21 INFO - PROCESS | 6338 | RSS: Main: 157282304 15:55:21 INFO - PROCESS | 6338 | 15:55:23 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:55:24 INFO - PROCESS | 6338 | RSS: Main: 157036544 15:55:24 INFO - PROCESS | 6338 | 15:55:26 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:55:27 INFO - PROCESS | 6338 | RSS: Main: 157835264 15:55:27 INFO - PROCESS | 6338 | 15:55:30 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:55:30 INFO - PROCESS | 6338 | RSS: Main: 157782016 15:55:30 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | Cycle 1(1): loaded http://localhost:48502/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48502/tests/kraken/driver.html?testName=ai-astar) 15:55:32 INFO - PROCESS | 6338 | RSS: Main: 158363648 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | __start_tp_report 15:55:32 INFO - PROCESS | 6338 | _x_x_mozilla_page_load 15:55:32 INFO - PROCESS | 6338 | _x_x_mozilla_page_load_details 15:55:32 INFO - PROCESS | 6338 | |i|pagename|runs| 15:55:32 INFO - PROCESS | 6338 | |0;ai-astar;101;112;106;111;111;112;110;111;111;111 15:55:32 INFO - PROCESS | 6338 | |1;audio-beat-detection;141;118;140;168;115;145;139;116;173;117 15:55:32 INFO - PROCESS | 6338 | |2;audio-dft;164;163;164;161;161;162;161;165;162;164 15:55:32 INFO - PROCESS | 6338 | |3;audio-fft;75;74;75;189;75;76;75;75;191;77 15:55:32 INFO - PROCESS | 6338 | |4;audio-oscillator;83;83;158;83;82;83;141;83;82;137 15:55:32 INFO - PROCESS | 6338 | |5;imaging-gaussian-blur;118;117;116;118;117;118;117;117;117;117 15:55:32 INFO - PROCESS | 6338 | |6;imaging-darkroom;148;147;147;147;154;148;147;148;146;148 15:55:32 INFO - PROCESS | 6338 | |7;imaging-desaturate;95;96;98;95;98;95;95;96;95;95 15:55:32 INFO - PROCESS | 6338 | |8;json-parse-financial;55;56;52;54;58;53;54;52;52;52 15:55:32 INFO - PROCESS | 6338 | |9;json-stringify-tinderbox;62;59;59;60;60;59;59;59;60;60 15:55:32 INFO - PROCESS | 6338 | |10;stanford-crypto-aes;73;83;74;76;73;73;75;74;78;73 15:55:32 INFO - PROCESS | 6338 | |11;stanford-crypto-ccm;129;129;127;119;124;124;127;119;159;126 15:55:32 INFO - PROCESS | 6338 | |12;stanford-crypto-pbkdf2;158;152;152;152;150;163;154;149;152;163 15:55:32 INFO - PROCESS | 6338 | |13;stanford-crypto-sha256-iterative;63;61;61;63;62;65;61;60;62;60 15:55:32 INFO - PROCESS | 6338 | __end_tp_report 15:55:32 INFO - PROCESS | 6338 | __start_cc_report 15:55:32 INFO - PROCESS | 6338 | _x_x_mozilla_cycle_collect,866 15:55:32 INFO - PROCESS | 6338 | __end_cc_report 15:55:32 INFO - PROCESS | 6338 | __startTimestamp1471301732752__endTimestamp 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | ------- Summary: start ------- 15:55:32 INFO - PROCESS | 6338 | Number of tests: 14 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.47 (3.1%) stddev-sans-first:1.81 15:55:32 INFO - PROCESS | 6338 | Values: 101.0 112.0 106.0 111.0 111.0 112.0 110.0 111.0 111.0 111.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:140.50 stddev:21.18 (15.1%) stddev-sans-first:22.42 15:55:32 INFO - PROCESS | 6338 | Values: 141.0 118.0 140.0 168.0 115.0 145.0 139.0 116.0 173.0 117.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.50 stddev:1.49 (0.9%) stddev-sans-first:1.51 15:55:32 INFO - PROCESS | 6338 | Values: 164.0 163.0 164.0 161.0 161.0 162.0 161.0 165.0 162.0 164.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#3] audio-fft Cycles:10 Average:98.20 Median:75.00 stddev:48.39 (64.5%) stddev-sans-first:50.59 15:55:32 INFO - PROCESS | 6338 | Values: 75.0 74.0 75.0 189.0 75.0 76.0 75.0 75.0 191.0 77.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:83.00 stddev:30.70 (37.0%) stddev-sans-first:31.83 15:55:32 INFO - PROCESS | 6338 | Values: 83.0 83.0 158.0 83.0 82.0 83.0 141.0 83.0 82.0 137.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 15:55:32 INFO - PROCESS | 6338 | Values: 118.0 117.0 116.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:2.21 (1.5%) stddev-sans-first:2.35 15:55:32 INFO - PROCESS | 6338 | Values: 148.0 147.0 147.0 147.0 154.0 148.0 147.0 148.0 146.0 148.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.50 stddev:1.23 (1.3%) stddev-sans-first:1.27 15:55:32 INFO - PROCESS | 6338 | Values: 95.0 96.0 98.0 95.0 98.0 95.0 95.0 96.0 95.0 95.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:2.04 (3.8%) stddev-sans-first:2.12 15:55:32 INFO - PROCESS | 6338 | Values: 55.0 56.0 52.0 54.0 58.0 53.0 54.0 52.0 52.0 52.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.95 (1.6%) stddev-sans-first:0.53 15:55:32 INFO - PROCESS | 6338 | Values: 62.0 59.0 59.0 60.0 60.0 59.0 59.0 59.0 60.0 60.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:74.50 stddev:3.19 (4.3%) stddev-sans-first:3.28 15:55:32 INFO - PROCESS | 6338 | Values: 73.0 83.0 74.0 76.0 73.0 73.0 75.0 74.0 78.0 73.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:127.00 stddev:11.36 (8.9%) stddev-sans-first:12.05 15:55:32 INFO - PROCESS | 6338 | Values: 129.0 129.0 127.0 119.0 124.0 124.0 127.0 119.0 159.0 126.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:153.00 stddev:5.08 (3.3%) stddev-sans-first:5.23 15:55:32 INFO - PROCESS | 6338 | Values: 158.0 152.0 152.0 152.0 150.0 163.0 154.0 149.0 152.0 163.0 15:55:32 INFO - PROCESS | 6338 | 15:55:32 INFO - PROCESS | 6338 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.55 (2.5%) stddev-sans-first:1.58 15:55:32 INFO - PROCESS | 6338 | Values: 63.0 61.0 61.0 63.0 62.0 65.0 61.0 60.0 62.0 60.0 15:55:32 INFO - PROCESS | 6338 | -------- Summary: end -------- 15:55:32 INFO - PROCESS | 6338 | 15:55:33 INFO - TEST-INFO | 6338: exit 0 15:55:33 INFO - TEST-OK | kraken | took 60418ms 15:55:33 INFO - SUITE-END | took 1170s 15:55:33 INFO - Completed test suite (00:19:30) 15:55:33 INFO - javascript benchmark 15:55:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7789.713369484104, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.88236911708, 3363.260082781788, 3393.7963722176673, 3399.456087026076, 3411.4200585900394, 5756.654600723959, 5869.50109240715, 5887.676177810219, 5901.911471327928, 5915.940840591593, 5718.399568045347, 5781.884362312751, 5787.623804452707, 5791.478766910977, 5812.0410132328225, 5175.767090480937, 5180.844574662748, 5184.585233181337, 5243.606729495284, 5268.209768534732, 5168.638195326329, 5175.974120129394, 5234.136367499358, 5246.291750613656, 5278.683279003272, 5220.608454365938, 5231.189165679326, 5239.842804715865, 5281.8943621127555, 5365.409804921475, 5268.341457317816, 5289.973550132244, 5292.391374991848, 5294.41761406245, 5304.575633949275, 5019.749012549358, 5116.079105760961, 5156.845294641167, 5190.792368305263, 5260.368755749297, 5699.0, 5783.71081445926, 5810.796622118248, 5812.0, 5828.06750919855, 6216.595921265103, 6241.843953901143, 6270.153529273581, 6283.842903927392, 6292.842678933018, 6007.579469437142, 6083.847903802396, 6244.531063558983, 6292.370762923717, 6299.622022678654, 5727.541796656257, 5766.971165144148, 5777.162311464814, 5795.246617939683, 5806.44838740319, 6259.342769009279, 6270.0908368287255, 6276.780312689034, 6299.96850015747, 6305.5901366411035, 5882.176495290662, 6020.217371741645, 6078.483328917092, 6079.75680972765, 6091.390860913873, 6233.657148856856, 6306.2747784004505, 6318.273398559132, 6323.051542268697, 6329.367063293634, 6131.110988906673, 6201.069839524108, 6206.348333424925, 6210.5031597473, 6228.0, 5968.1644569760265, 6132.264128304543, 6155.630662160284, 6161.137440758297, 6189.071639254148, 4733.100710864925, 4751.0, 4758.857234282977, 4767.141914455362, 4782.0435912817575, 4213.599708027732, 4233.809478573472, 4254.553271906467, 4267.018585725238, 4280.571942805756, 5833.066709326572, 5942.554308426886, 6014.669193194416, 6066.241719785027, 6103.877922441615, 6191.288001879841, 6289.685515724195, 6309.747610095636, 6313.55805093639, 6319.873602527924, 5993.670348130808, 6039.063945088518, 6045.395460453919, 6053.445009472477, 6057.727402266909, 5242.449542798027, 5292.52367286946, 5401.675899446046, 5430.212619170277, 5442.809501667422, 6398.808035758934, 6514.0, 6519.217693876671, 6530.444912182517, 6544.149260596092, 6193.628382297076, 6206.813795586139, 6214.72033758491, 6219.689015549205, 6237.563370564017, 6243.625382477066, 6257.342978987323, 6441.066045423481, 6454.741810327722, 6521.64130972801, 6013.067974463965, 6096.969515152396, 6104.26748790148, 6136.171616831849, 6139.815805525842, 6170.413810687977, 6170.413810687977, 6172.845678857885, 6180.381961803783, 6181.84545386369, 5831.970840145772, 6015.248093988252, 6068.848278793065, 6069.283419472114, 6120.204373431426, 5978.282606087123, 6002.639841609517, 6073.210482637229, 6088.147659327787, 6090.756369745338, 5946.5540084494705, 5973.313068996948, 5976.462118409364, 5985.072313791369, 6003.549733769897, 5931.13998470228, 5970.134330521963, 6043.667598281961, 6059.969700151471, 6117.418845209698, 5864.266966629171, 5957.6127551709, 5980.401959803985, 5990.550708696778, 6017.849553761191], "value": 5719.307381778018, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.3028611095851, 624.512879953636, 637.400843207385, 655.6852710698864, 682.242710591244, 42769.14461710764, 46845.7657711711, 47177.0, 47196.0, 47204.76397618011, 48407.757961210234, 48966.0, 48992.0, 48999.265011024865, 49031.264531032066, 9034.909650903506, 9112.362134650577, 9149.0, 9153.542322883863, 9172.63309467624, 9113.772155696128, 9211.907880921171, 9243.953780231122, 9256.814863702723, 9280.071992800733, 9255.53722313885, 9274.350795444321, 9282.303827212952, 9315.580798864034, 9316.534173291342, 9210.861837072449, 9216.400933939307, 9279.118483744034, 9283.071692830765, 9317.39436936597, 9157.862632060524, 9213.355065145442, 9218.492982885939, 9229.492377919212, 9265.861012084824, 46184.76907615474, 46324.0, 46474.53525464736, 46679.0, 46747.06505869897, 3611.5485564304463, 3754.455603937414, 3763.284975854579, 3839.500864887547, 4025.993501624594, 35923.4611480828, 36063.63936360629, 36375.0, 36850.0, 36969.930031513526, 4581.3815134956685, 4610.585047345721, 4627.537246275379, 4638.814447422099, 4725.362076119749, 347669.0, 348389.0, 348856.0, 350653.99999999744, 352016.0, 67251.0, 67283.0, 67706.0, 67775.32224677788, 67814.0, 39915.80042099829, 40382.79808600938, 40651.0, 42615.36076958848, 69984.6500767503, 17791.55521111957, 17818.732719009226, 17865.285388584573, 17867.553311167067, 17887.552811179823, 15584.142872141914, 15617.3753049879, 15620.921895390678, 15701.371945122295, 15775.05349679, 21521.0, 21559.24542641, 21563.892180539, 21697.783022169577, 21727.130914763547, 7533.397328213729, 7722.613869306512, 7759.650815713307, 7803.85946858618, 7817.648205830751, 1038.4859494550094, 1084.2356138922041, 1086.245059683528, 1156.942152892352, 1180.079537960375, 34656.826715866766, 34882.30235395278, 34882.825585871906, 35117.47323790145, 35119.4732079019, 1181.952721891132, 1235.9011279097651, 1237.127824883455, 1250.4060571228777, 1264.2919964819546, 17978.1010949452, 18443.446696599123, 18463.630727385378, 18481.075946202636, 18551.53621159455, 1010159.0, 1022424.0, 1024308.0, 1025972.0, 1030741.0, 63063.36936630575, 64049.67975160188, 64180.35819641744, 64197.67901160558, 64222.0, 1477.3573495529479, 1492.656688961545, 1501.8573235542606, 1510.8791296696238, 1514.0915450729474, 34138.82930585331, 34351.4847277286, 34552.654473454946, 34612.65387346094, 34760.13099672528, 54718.45281547293, 55070.44929550653, 55076.449235507134, 55268.72365638307, 55323.0, 420883.0, 421310.0, 423825.0, 424228.0, 425059.0, 30630.540541891445, 30684.53973190359, 31310.686893130776, 31414.842925785226, 31423.685763142992, 51789.0, 51831.0, 51935.22097168621, 51954.74022629863, 52505.21242181447, 43045.1390972185, 43628.34557481704, 43758.781206093765, 43794.56205437905, 44975.32537011882, 44055.33916991184, 44804.77597611991, 46598.30102548397, 46836.29745553751, 49469.257961131334, 43367.34948975705, 46015.76992115018, 46077.539224607324, 47368.28947565858, 47585.0, 39417.60582394254, 40265.0, 40458.786236412954, 40656.59343406528, 41402.792986034874, 30639.0, 30778.38443231078, 30857.537136943414, 31261.8436907814, 31301.530477043318], "value": 21946.982684864208, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.6863680647498, 405.3473907009714, 406.56903682097, 408.91003979124594, 417.70760467672636, 19349.0, 20865.68701469479, 20883.68674469884, 21224.8938755306, 21584.568308633818, 12167.939160304208, 12518.436670349833, 19375.612487750237, 19761.209551617918, 19865.801341986575, 5434.2935418395655, 6053.545984051192, 6060.090986352038, 6130.754769809225, 6208.87582248357, 4907.533784290505, 6112.449879510843, 6146.446819786218, 6149.0468977308365, 6152.0464328029, 6002.909956350658, 6126.203593532835, 6143.662098584576, 6147.108669242957, 6156.138140660311, 6051.12258722485, 6116.327204007555, 6128.969355153218, 6143.846403839917, 6168.0439531872635, 5815.476607105381, 5884.293884733816, 5919.0, 5930.1401296812155, 5944.4352786485215, 13355.265460399674, 13645.454181832714, 13718.38267277965, 13847.0, 13895.513657022057, 2357.3163782503225, 2365.929022129339, 2453.0800949643885, 2470.147799009339, 2591.714911359749, 10376.896231037668, 10635.680929572125, 10635.840462393071, 11566.0, 15729.528114156594, 2017.656998310276, 2048.09883651193, 2058.6294466995937, 2112.3662901129755, 2120.713703650003, 78359.21640783633, 90210.54894725485, 90227.29318120402, 91201.5439922796, 91286.54356728241, 11624.476898539586, 11643.41782910851, 11741.823872641917, 11818.586349477899, 11972.880271197351, 16670.416535421202, 16707.832921670626, 16720.331186752395, 16723.581910452092, 16749.0, 8859.981102173333, 8879.200871921557, 8913.688020919237, 9028.503432311287, 9054.81890362189, 8595.398322117517, 8596.398252122417, 8724.258438032712, 8917.923316455812, 8966.730998070068, 4771.355866957986, 4809.182438985381, 4834.347363106006, 4843.304843304815, 4930.211166213388, 1781.714925611896, 2082.4689704125353, 2115.661494160927, 2119.491322082689, 2160.848740588175, 910.3991365698607, 1023.3961962442195, 1024.3393011507535, 1034.6171916390983, 1039.729670285716, 17300.567485812957, 20575.485612859797, 20798.480037999172, 21170.36488905335, 21213.257535986166, 1030.1912998296302, 1051.0, 1087.2226358153957, 1124.6344937895053, 1132.592266783957, 10834.0, 11502.769944601061, 11815.11386646005, 11834.704132396586, 11903.345316007702, 437916.0, 450842.0, 503725.0, 507601.0, 509928.0, 87538.56230718805, 88234.0, 94870.52564737132, 95516.52241738747, 96645.51677241569, 1074.666853275487, 1101.6474728087096, 1117.519466629341, 1165.7260543772206, 1170.9355985420884, 18624.813751862308, 19426.514337141118, 19664.21343146258, 19839.0, 19859.801401986373, 38519.614803851604, 43881.78059109684, 44358.33462498001, 45094.0, 46243.537564623926, 65996.67001664962, 66485.26665801264, 66924.66537667475, 67677.66161169359, 68398.31601683919, 7605.087389513073, 7685.923140768521, 7831.647575858986, 7996.360291176576, 8689.391742577958, 11778.587749428729, 14319.284035798377, 14491.565253042425, 15008.549743507712, 15034.0, 10262.281640285108, 12016.399180041139, 12248.938755306166, 12396.752064958831, 12624.99000079973, 11879.406029698308, 12385.071119665881, 12651.87348126507, 13057.738845223232, 13430.328483575588, 11922.582709605122, 12411.0, 12445.688857778629, 12550.87449125497, 12628.242305461701, 8710.564471776512, 9043.321750868843, 9203.585838637144, 9226.492542910204, 9514.524273786144, 9449.574769135268, 11171.776564468828, 11749.118816088656, 11750.94124529372, 12066.155369124077], "value": 9555.238782219965, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1564.303884771277, 1580.881433892458, 1756.9121543922802, 1856.684363658178, 1874.7937726850053, 8920.0, 9122.726318210463, 9361.672341468042, 10070.647527336545, 10076.345037572562, 9288.489133097677, 9352.064793520645, 9354.438733675966, 9410.905890941089, 9432.481213533252, 2463.482668639583, 2498.675172227608, 2519.231634351522, 2528.456381877896, 2530.8101892358145, 2435.6224785158242, 2504.5491811473926, 2506.8495890246554, 2514.170323793153, 2522.1928982725535, 2465.926022219336, 2472.6909136357954, 2489.800815934721, 2496.301035709995, 2499.175272160183, 2442.658027876099, 2443.1937460637946, 2465.3097132802754, 2469.790067844235, 2476.36852602587, 2401.987990060056, 2408.385861605297, 2429.368364225314, 2435.330284171867, 2464.642626819101, 9965.0, 10067.244956628283, 10072.94963525185, 10075.193984481224, 10084.899151008543, 5708.942910570882, 5713.0, 5779.075347944308, 5825.0, 5826.2134611827705, 3625.836837342326, 3681.650243226889, 3733.0667333166707, 3736.981315093434, 3779.168582911755, 1107.0866535108569, 1182.2729021651708, 1188.1089183112665, 1196.5811965811897, 1212.89083982442, 13910.930445347809, 13936.163830170222, 13952.023358364919, 13967.161970281713, 13996.580102596938, 4745.264484004984, 4880.829170978998, 4963.503649635008, 5012.824551140692, 5058.038972595195, 11558.306501609763, 11633.883661163449, 11640.0, 11648.767024659459, 11686.94156529212, 5832.650040997553, 5840.445157710011, 5849.6782676952325, 5850.473457388855, 5859.853503662443, 4720.244760838318, 5214.556762675215, 5311.389190243094, 5369.624126311199, 5413.079776438015, 4299.290617048215, 4375.081232941055, 4421.314696222091, 4445.844395446144, 4458.7324760514475, 1269.5556555205603, 1282.4805953588811, 1313.4746101559263, 1319.070055610792, 1326.0121209698837, 1040.3549799124592, 1047.2355180718118, 1049.1711547877092, 1072.3512275073467, 1087.2986923434498, 6112.266528016667, 6290.591111577733, 6346.270178929482, 6421.389967953037, 6536.640484773288, 437.66737279667683, 454.6567341657028, 455.5490064835855, 462.4820201374415, 464.2734121100534, 4394.560543945644, 4437.245668236407, 4451.354553589711, 4458.8439404620685, 4484.372187893698, 12124.333161676017, 12357.38213089342, 12457.0, 12459.688507787196, 12520.686982825502, 11773.17587768865, 12246.265224086583, 12285.938570307091, 12404.19372740769, 12417.130800844036, 8935.508547029976, 9293.210077143383, 9299.488528130882, 9300.72097837066, 9359.391639543408, 6253.218347706536, 6279.1209230708655, 6279.309275979547, 6369.777057802955, 6567.540272181092, 11149.108071354434, 11151.72120696989, 11210.103191744478, 11308.321500709984, 11365.54537818478, 11085.445727713743, 11138.443077846237, 11155.944220278847, 11289.491972861077, 11437.599684011353, 7879.527228366316, 8378.874316885129, 8587.141285871612, 8632.093630168742, 8705.782355441164, 9558.0, 9565.521723913636, 9575.04249575037, 9576.47329396862, 9658.0, 8501.81647837417, 8544.700935467228, 8673.609687563949, 8707.956460217658, 8746.737597872074, 8665.696700615448, 8681.782955426164, 8697.434666746894, 8829.64681412762, 8900.109989001048, 7265.600391978281, 7346.302101300368, 7412.592307423143, 7418.109826820816, 7447.47867649281, 5576.10782274834, 5611.102223644198, 5623.465770751772, 5699.715014249188, 5704.1443783432815, 5749.281339832521, 5838.591298609226, 5865.208196893364, 5890.087036509348, 5910.261217347832], "value": 4967.440022854465, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.88783813503403, 336.11769106096494, 339.74349366228495, 342.85600047979847, 344.91549570355266, 5831.416858314166, 5831.620944638596, 5831.912521312173, 5853.853653658661, 5856.393904712405, 5717.3139223293265, 5734.885302293952, 5751.597388182819, 5752.137179423089, 5769.7692092316365, 3973.46358241638, 4259.233337999167, 4337.804798784046, 4409.933850992237, 4435.356873253377, 4418.779061046935, 4433.467983841943, 4437.64498840092, 4442.97778511107, 4445.933311000337, 4449.199144154051, 4449.510553839075, 4450.910981780363, 4462.0, 4465.37484752135, 4312.3531470279395, 4403.911921761579, 4455.532169122261, 4468.173387923229, 4487.0, 3852.3258429774955, 3871.8838434847, 3871.9612803871883, 3892.785896775676, 3899.1811719538646, 5577.3028371453565, 5586.692731899744, 5626.54987600995, 5641.605087643867, 5656.886862262772, 5048.217526283432, 5083.491650834924, 5140.820071297487, 5160.6129540284255, 5162.0, 6002.879942401128, 6034.0, 6072.722728976633, 6077.604955677911, 6080.908786368163, 4301.655867530621, 4327.459067616548, 4329.458817647794, 4348.391225228471, 4348.412964249817, 6059.787907423219, 6129.969350153266, 6248.9062664060075, 6281.057841323793, 6304.211973503312, 4329.588689074533, 4366.257736184856, 4367.27939889921, 4377.649788016951, 4380.540043295472, 4404.031113155101, 4412.271975124068, 4426.026274219666, 4434.445694288214, 4437.423134992495, 4945.777440015136, 5001.799928002912, 5118.232265160255, 5138.897222055538, 5145.202493613496, 6062.938985677489, 6064.3935606439, 6070.696465176724, 6081.6351018939, 6141.723622437001, 1490.3591455674164, 1499.5951093204774, 1506.6760646460843, 1512.948500791939, 1516.3707061569326, 907.2515174980535, 962.1340793286098, 962.2013728605241, 971.8250714871391, 977.3647129365969, 5223.764930578133, 5320.494553017457, 5324.828537721695, 5325.946740532545, 5345.251664766935, 5498.697571633598, 5535.750891209906, 5556.166465066518, 5574.136008918624, 5581.944180558143, 4970.130227210224, 5250.606204534675, 5257.8159764408065, 5279.577633789288, 5354.045773292798, 2966.5401862710883, 2971.687972762872, 2978.717021882918, 2981.925451863721, 2993.8473687630417, 5639.407862174495, 5684.8863022739315, 5700.0, 5787.39232380594, 5820.30156381237, 5923.792667256712, 6340.4293613575, 6396.680165991682, 6438.871222575523, 6464.38588334117, 6513.576617519846, 6514.315996820361, 6549.410553050248, 6550.3449655035065, 6571.835704107436, 6007.90988135187, 6220.72006759706, 6283.088952102011, 6287.610707930957, 6317.778877739441, 6196.47329976957, 6235.815195112914, 6266.530010249158, 6287.654179020198, 6310.716017779303, 6276.278228003838, 6324.968375158095, 6473.287938326686, 6480.740770369132, 6523.64119973406, 4280.935785963151, 4357.411749413788, 4365.956340436682, 4372.6501879850175, 4380.4305440292555, 6123.785667501616, 6229.937700622936, 6309.012661011767, 6331.240251169889, 6351.364863513611, 6091.7563297467605, 6123.418275263843, 6139.3553676863285, 6163.19878415803, 6204.751809927733, 5978.432048955342, 6111.205543279345, 6166.0711162197595, 6184.288806787277, 6191.378043844402, 6058.818825223005, 6064.909026364697, 6090.116933044772, 6105.48103411215, 6126.785562505291, 6144.324124346408, 6147.692615369124, 6194.132821405097, 6205.410486003822, 6250.468710159687, 5790.305163380422, 5942.078228369255, 5974.878917984053, 5980.700964951648, 6020.337762846171], "value": 4529.040169449249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.8661007543828, 882.1311008656477, 894.329253060205, 900.3787386703174, 953.3469573342265, 16545.917270413647, 18087.276508939627, 18157.54606134844, 18243.087845607733, 18326.083695815207, 16470.258838352274, 16501.963448875405, 16719.749203761952, 16875.493735187963, 17009.659806803855, 898.9910100898989, 899.5727029660924, 905.9048799875984, 906.3383729877194, 906.863970404438, 881.5151666583386, 884.8009197930478, 885.6014793342989, 907.1065000974069, 907.9818403631923, 947.0198344713223, 951.8334291498994, 952.6237136331144, 960.0207788056179, 960.0255740423476, 945.0407836046419, 945.7021038372959, 946.7491114854569, 947.7535840681403, 949.0841338108723, 683.5795985468901, 693.5180049865346, 693.6913073682214, 693.9236683964759, 694.8818700820873, 15995.760063599055, 16019.759703604455, 16048.518544443685, 16066.357345706158, 16105.114218717967, 13194.736105277936, 14041.0, 14591.270436478133, 15091.924540377227, 16298.022118672918, 14788.778168327377, 14833.332500037524, 14966.17686027268, 14974.0, 15320.004199726982, 4179.185058913513, 4209.221294060578, 4234.3860140279485, 4251.0, 4893.339399181101, 83517.0, 86895.56552217324, 87483.56258218669, 87875.56062219712, 88222.55888720516, 12619.558315458915, 12631.515991248029, 12646.676008717097, 12727.427265773062, 12885.48458061667, 23105.191318304114, 23160.0, 23183.072677093063, 23578.764212358, 23886.163984260467, 8628.180322869317, 8786.780330491789, 8910.0, 8937.910620893708, 8952.8657070144, 5084.847454576368, 5084.898302033938, 5113.258577506241, 5254.632175747661, 5292.603054770908, 3949.3878448840474, 4142.2751018572235, 4150.3566947123245, 4151.232022075926, 4156.376543518436, 706.159669992707, 706.4348521183135, 713.8179764160105, 716.2014353995362, 724.760828926453, 810.8499927513429, 812.6749300279936, 839.1147339556704, 851.2764150472173, 854.9145085491401, 10481.633142839964, 10660.466976651136, 10962.342259464458, 11296.491657875415, 11319.603813866639, 698.5250029979561, 735.3198291580267, 739.9566611078461, 785.2618538573722, 838.3209600223717, 5202.479752024768, 5405.8107966221, 5429.4027656957705, 5507.834764957058, 5562.360328562187, 73149.26850731531, 84996.57501712575, 124579.3771031139, 132879.0, 133694.0, 66206.33793662098, 73003.0, 91518.79684211021, 112229.43885280685, 113731.0, 98639.50680246553, 98867.0, 100170.49914750525, 100426.49786751019, 100609.49695251623, 10163.986849074116, 10181.654855774088, 10237.488125593542, 10329.070383665507, 10487.37075775456, 55514.72242638761, 56385.43614563966, 56586.15120773274, 57531.0, 58354.12468812886, 83826.16173838428, 85591.57204214188, 86881.56559217416, 87454.1254587446, 89058.0, 12615.180013299107, 12670.239785612892, 12688.23870567769, 12768.170068945861, 12781.16922400041, 14804.185769782765, 14820.777688334469, 14883.776743348642, 14967.40130394772, 16253.59366015859, 13046.804297935729, 13304.0, 13723.382447790073, 13906.58280251594, 14009.859901401263, 12640.0, 13792.586222413343, 14934.0, 14992.625184370478, 15426.22868856575, 12479.625611231315, 13704.246266455042, 13780.862191377957, 13791.241481718602, 13995.370208340446, 11707.590234341757, 12978.633224463261, 13175.275359854917, 13406.530771423344, 13642.181469111885, 11025.77214661972, 12223.87776122263, 12597.244165350108, 12694.809577856155, 12792.360381980678], "value": 8279.189678547855, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 106.0, 111.0, 111.0, 112.0, 110.0, 111.0, 111.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 140.0, 168.0, 115.0, 145.0, 139.0, 116.0, 173.0, 117.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 161.0, 161.0, 162.0, 161.0, 165.0, 162.0, 164.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 189.0, 75.0, 76.0, 75.0, 75.0, 191.0, 77.0], "value": 98.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 158.0, 83.0, 82.0, 83.0, 141.0, 83.0, 82.0, 137.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 154.0, 148.0, 147.0, 148.0, 146.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 98.0, 95.0, 98.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 52.0, 54.0, 58.0, 53.0, 54.0, 52.0, 52.0, 52.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 83.0, 74.0, 76.0, 73.0, 73.0, 75.0, 74.0, 78.0, 73.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 127.0, 119.0, 124.0, 124.0, 127.0, 119.0, 159.0, 126.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 152.0, 152.0, 152.0, 150.0, 163.0, 154.0, 149.0, 152.0, 163.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 63.0, 62.0, 65.0, 61.0, 60.0, 62.0, 60.0], "value": 61.8, "unit": "score"}]}]} 15:55:34 INFO - Return code: 0 15:55:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:55:34 ERROR - # TBPL SUCCESS # 15:55:34 INFO - Running post-action listener: _resource_record_post_action 15:55:34 INFO - [mozharness: 2016-08-15 22:55:34.076582Z] Finished run-tests step (success) 15:55:34 INFO - Running post-run listener: _resource_record_post_run 15:55:34 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329486336; Read time: 12; Write time: 229544 15:55:34 INFO - TinderboxPrint: CPU usage
13.2% 15:55:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:55:34 INFO - TinderboxPrint: I/O write bytes / time
329,486,336 / 229,544 15:55:34 INFO - TinderboxPrint: CPU idle
8,216.8 (86.8%) 15:55:34 INFO - TinderboxPrint: CPU user
1,199.9 (12.7%) 15:55:34 INFO - TinderboxPrint: Swap in / out
0 / 0 15:55:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 77062144; Read time: 0; Write time: 80028 15:55:34 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 250044416; Read time: 0; Write time: 149316 15:55:34 INFO - Running post-run listener: _upload_blobber_files 15:55:34 INFO - Blob upload gear active. 15:55:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:55:34 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 15:55:34 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'] 15:55:34 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 15:55:35 INFO - (blobuploader) - INFO - Open directory for files ... 15:55:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:55:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:55:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:35 INFO - (blobuploader) - INFO - Done attempting. 15:55:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:55:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:55:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:39 INFO - (blobuploader) - INFO - Done attempting. 15:55:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:55:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:55:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:39 INFO - (blobuploader) - INFO - Done attempting. 15:55:39 INFO - (blobuploader) - INFO - Iteration through files over. 15:55:39 INFO - Return code: 0 15:55:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:55:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:55:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/64671ca687d877ee6d328993a3587f1c9c22057ea7d79023a6b6b76d62c798e365e2e6a0fa294b8269c1842e8a4d0a25a4b3d10d83f0d6d581dc21cbe938113e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d88865ade6e0e9f89e022522438263a35d3919ca4179d3b3603a2d498ccdc5c7db4b3c842574bb7612aed2a7af974503fae0f7728a86e320cedf5218ae87711f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc40a27fd2f182fb41f3b7ef20cce4142f0366ea230a21c78620e3048a2e7dfd1e7ed3a46da0f2710ec82bfcc511fcc511874145d969431285674e892145918c"} 15:55:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:55:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:55:39 INFO - Contents: 15:55:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/64671ca687d877ee6d328993a3587f1c9c22057ea7d79023a6b6b76d62c798e365e2e6a0fa294b8269c1842e8a4d0a25a4b3d10d83f0d6d581dc21cbe938113e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d88865ade6e0e9f89e022522438263a35d3919ca4179d3b3603a2d498ccdc5c7db4b3c842574bb7612aed2a7af974503fae0f7728a86e320cedf5218ae87711f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc40a27fd2f182fb41f3b7ef20cce4142f0366ea230a21c78620e3048a2e7dfd1e7ed3a46da0f2710ec82bfcc511fcc511874145d969431285674e892145918c"} 15:55:39 INFO - Running post-run listener: copy_logs_to_upload_dir 15:55:39 INFO - Copying logs to upload dir... 15:55:39 INFO - mkdir: /builds/slave/test/build/upload/logs 15:55:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1674.001985 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-08-15 15:55:38.932266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 15:55:38.935598) ========= 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=826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862 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/64671ca687d877ee6d328993a3587f1c9c22057ea7d79023a6b6b76d62c798e365e2e6a0fa294b8269c1842e8a4d0a25a4b3d10d83f0d6d581dc21cbe938113e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d88865ade6e0e9f89e022522438263a35d3919ca4179d3b3603a2d498ccdc5c7db4b3c842574bb7612aed2a7af974503fae0f7728a86e320cedf5218ae87711f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc40a27fd2f182fb41f3b7ef20cce4142f0366ea230a21c78620e3048a2e7dfd1e7ed3a46da0f2710ec82bfcc511fcc511874145d969431285674e892145918c"} build_url:https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/dDPjnQrmTISnsbjDE-dKnQ/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/64671ca687d877ee6d328993a3587f1c9c22057ea7d79023a6b6b76d62c798e365e2e6a0fa294b8269c1842e8a4d0a25a4b3d10d83f0d6d581dc21cbe938113e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d88865ade6e0e9f89e022522438263a35d3919ca4179d3b3603a2d498ccdc5c7db4b3c842574bb7612aed2a7af974503fae0f7728a86e320cedf5218ae87711f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc40a27fd2f182fb41f3b7ef20cce4142f0366ea230a21c78620e3048a2e7dfd1e7ed3a46da0f2710ec82bfcc511fcc511874145d969431285674e892145918c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 15:55:38.961665) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:55:38.962039) ========= 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=826874ccc97bd7bf541b4875000001d5-1471300063.925126-1030809862 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 15:55:39.045192) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 15:55:39.045547) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 15:55:39.045867) ========= ========= Total master_lag: 0.16 =========