builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1471354002.61 results: success (0) buildid: 20160816032622 builduid: 1b227b9b41fc4a47bf152b3ea5ffe79e revision: a609f6015009feea8362b149ec175f63a5b14cb8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:42.613833) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:42.614314) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:42.614600) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:42.665652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:42.665939) ========= 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=523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 06:26:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-08-16 06:26:42 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101991 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:42.781886) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:42.785227) ========= 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=523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015049 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:42.875249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:42.875578) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a609f6015009feea8362b149ec175f63a5b14cb8 --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 a609f6015009feea8362b149ec175f63a5b14cb8 --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=523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 06:26:42,975 truncating revision to first 12 chars 2016-08-16 06:26:42,975 Setting DEBUG logging. 2016-08-16 06:26:42,975 attempt 1/10 2016-08-16 06:26:42,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a609f6015009?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 06:26:43,287 unpacking tar archive at: mozilla-aurora-a609f6015009/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662155 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:43.551885) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:43.552272) ========= script_repo_revision: a609f6015009feea8362b149ec175f63a5b14cb8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:43.552675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:43.552947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 06:26:43.564947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 10 secs) (at 2016-08-16 06:26:43.565250) ========= /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=523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:26:43 INFO - MultiFileLogger online at 20160816 06:26:43 in /builds/slave/test 06:26:43 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 06:26:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:26:43 INFO - {'append_to_log': False, 06:26:43 INFO - 'base_work_dir': '/builds/slave/test', 06:26:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:26:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:26:43 INFO - 'branch': 'Mozilla-Aurora', 06:26:43 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:43 INFO - 'config_files': ('talos/linux_config.py',), 06:26:43 INFO - 'default_actions': ('clobber', 06:26:43 INFO - 'read-buildbot-config', 06:26:43 INFO - 'download-and-extract', 06:26:43 INFO - 'populate-webroot', 06:26:43 INFO - 'create-virtualenv', 06:26:43 INFO - 'install', 06:26:43 INFO - 'run-tests'), 06:26:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:43 INFO - 'download_minidump_stackwalk': True, 06:26:43 INFO - 'download_symbols': 'ondemand', 06:26:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:43 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:43 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:43 INFO - 'installer_path': 'installer.exe', 06:26:43 INFO - 'log_level': 'info', 06:26:43 INFO - 'log_name': 'talos', 06:26:43 INFO - 'log_to_console': True, 06:26:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:26:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:26:43 INFO - 'opt_config_files': (), 06:26:43 INFO - 'pip_index': False, 06:26:43 INFO - 'sps_profile': False, 06:26:43 INFO - 'sps_profile_interval': 0, 06:26:43 INFO - 'suite': 'dromaeojs-e10s', 06:26:43 INFO - 'system_bits': '32', 06:26:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:43 INFO - 'title': 'talos-linux64-ix-065', 06:26:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:43 INFO - 'use_talos_json': True, 06:26:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:26:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:43 INFO - 'work_dir': 'build'} 06:26:43 INFO - [mozharness: 2016-08-16 13:26:43.758366Z] Running clobber step. 06:26:43 INFO - Running pre-action listener: _resource_record_pre_action 06:26:43 INFO - Running main action method: clobber 06:26:43 INFO - rmtree: /builds/slave/test/build 06:26:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:26:44 INFO - Running post-action listener: _resource_record_post_action 06:26:44 INFO - [mozharness: 2016-08-16 13:26:44.209109Z] Finished clobber step (success) 06:26:44 INFO - [mozharness: 2016-08-16 13:26:44.209211Z] Running read-buildbot-config step. 06:26:44 INFO - Running pre-action listener: _resource_record_pre_action 06:26:44 INFO - Running main action method: read_buildbot_config 06:26:44 INFO - Using buildbot properties: 06:26:44 INFO - { 06:26:44 INFO - "project": "", 06:26:44 INFO - "product": "firefox", 06:26:44 INFO - "script_repo_revision": "production", 06:26:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:26:44 INFO - "repository": "", 06:26:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:26:44 INFO - "buildid": "20160816032622", 06:26:44 INFO - "pgo_build": "True", 06:26:44 INFO - "basedir": "/builds/slave/test", 06:26:44 INFO - "buildnumber": 466, 06:26:44 INFO - "slavename": "talos-linux64-ix-065", 06:26:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:26:44 INFO - "platform": "ubuntu64_hw", 06:26:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:26:44 INFO - "branch": "mozilla-aurora", 06:26:44 INFO - "repo_path": "releases/mozilla-aurora", 06:26:44 INFO - "revision": "a609f6015009feea8362b149ec175f63a5b14cb8", 06:26:44 INFO - "stage_platform": "linux64-pgo", 06:26:44 INFO - "builduid": "1b227b9b41fc4a47bf152b3ea5ffe79e", 06:26:44 INFO - "slavebuilddir": "test" 06:26:44 INFO - } 06:26:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 06:26:44 INFO - Running post-action listener: _resource_record_post_action 06:26:44 INFO - [mozharness: 2016-08-16 13:26:44.211664Z] Finished read-buildbot-config step (success) 06:26:44 INFO - [mozharness: 2016-08-16 13:26:44.211753Z] Running download-and-extract step. 06:26:44 INFO - Running pre-action listener: _resource_record_pre_action 06:26:44 INFO - Running main action method: download_and_extract 06:26:44 INFO - mkdir: /builds/slave/test/build/tests 06:26:44 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')]} 06:26:44 INFO - https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:26:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:26:44 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:26:44 INFO - retry: Failed, sleeping 30 seconds before retrying 06:27:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:27:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:27:14 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:27:14 INFO - retry: Failed, sleeping 60 seconds before retrying 06:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:28:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:28:14 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:28:14 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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! 06:28:14 INFO - Caught exception: HTTP Error 404: Not Found 06:28:14 INFO - Caught exception: HTTP Error 404: Not Found 06:28:14 INFO - Caught exception: HTTP Error 404: Not Found 06:28:14 INFO - trying https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:28:14 INFO - Downloading https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:28:14 INFO - Downloaded 1361 bytes. 06:28:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 06:28:14 INFO - Using the following test package requirements: 06:28:14 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 06:28:14 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:14 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:28:14 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:14 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:28:14 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:14 INFO - u'jsshell-linux-x86_64.zip'], 06:28:14 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:14 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:28:14 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 06:28:14 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:14 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:28:14 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:14 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:28:14 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:14 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:28:14 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 06:28:14 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:28:14 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:28:14 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')]} 06:28:14 INFO - https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:28:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:28:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:28:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:28:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:28:14 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:28:14 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:28:14 INFO - retry: Failed, sleeping 30 seconds before retrying 06:28:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:28:44 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:28:44 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:28:44 INFO - retry: Failed, sleeping 60 seconds before retrying 06:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:29:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:29:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:29:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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! 06:29:45 INFO - Caught exception: HTTP Error 404: Not Found 06:29:45 INFO - Caught exception: HTTP Error 404: Not Found 06:29:45 INFO - Caught exception: HTTP Error 404: Not Found 06:29:45 INFO - trying https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:29:45 INFO - Downloading https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:29:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:29:45 INFO - Downloaded 21765323 bytes. 06:29:45 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'] 06:29:45 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 06:29:46 INFO - Return code: 0 06:29:46 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 06:29: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')]} 06:29:46 INFO - https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:29:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:29:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:29:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:29:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:29:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:29:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:29:46 INFO - retry: Failed, sleeping 30 seconds before retrying 06:30:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:30:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:30:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:30:17 INFO - retry: Failed, sleeping 60 seconds before retrying 06:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:31:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:31:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:31:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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! 06:31:17 INFO - Caught exception: HTTP Error 404: Not Found 06:31:17 INFO - Caught exception: HTTP Error 404: Not Found 06:31:17 INFO - Caught exception: HTTP Error 404: Not Found 06:31:17 INFO - trying https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 06:31:17 INFO - Downloading https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:31:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:31:17 INFO - Downloaded 21765323 bytes. 06:31:17 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'] 06:31:17 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 06:31:19 INFO - Return code: 0 06:31:19 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')]} 06:31:19 INFO - https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:31:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:31:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:31:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06: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/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:31:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:31:19 INFO - retry: Failed, sleeping 30 seconds before retrying 06:31:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:31:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:31:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:31:49 INFO - retry: Failed, sleeping 60 seconds before retrying 06:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:32:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:32:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:32:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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! 06:32:49 INFO - Caught exception: HTTP Error 404: Not Found 06:32:49 INFO - Caught exception: HTTP Error 404: Not Found 06:32:49 INFO - Caught exception: HTTP Error 404: Not Found 06:32:49 INFO - trying https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 06:32:49 INFO - Downloading https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:32:50 INFO - Downloaded 14413723 bytes. 06:32:50 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'] 06:32:50 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 06:32:50 INFO - Return code: 0 06:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:32:50 INFO - https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:32:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:32:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:32:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:32:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:32:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:32:50 INFO - retry: Failed, sleeping 30 seconds before retrying 06:33:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:33:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:33:20 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:33:20 INFO - retry: Failed, sleeping 60 seconds before retrying 06:34:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:34:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:34:20 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:34:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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! 06:34:20 INFO - Caught exception: HTTP Error 404: Not Found 06:34:20 INFO - Caught exception: HTTP Error 404: Not Found 06:34:20 INFO - Caught exception: HTTP Error 404: Not Found 06:34:20 INFO - trying https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:34:20 INFO - Downloading https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:34:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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 06:34:22 INFO - Downloaded 63756469 bytes. 06:34:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:34:22 INFO - mkdir: /builds/slave/test/properties 06:34:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:34:22 INFO - Writing to file /builds/slave/test/properties/build_url 06:34:22 INFO - Contents: 06:34:22 INFO - build_url:https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 06:34:23 INFO - Running post-action listener: _resource_record_post_action 06:34:23 INFO - Running post-action listener: set_extra_try_arguments 06:34:23 INFO - [mozharness: 2016-08-16 13:34:23.141383Z] Finished download-and-extract step (success) 06:34:23 INFO - [mozharness: 2016-08-16 13:34:23.141614Z] Running populate-webroot step. 06:34:23 INFO - Running pre-action listener: _resource_record_pre_action 06:34:23 INFO - Running main action method: populate_webroot 06:34:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:34:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:34:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:34:23 INFO - '--tppagecycles', 06:34:23 INFO - '7'], 06:34:23 INFO - 'tests': ['tsvgm']}}, 06:34:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:34:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:34:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:34:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:34:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:23 INFO - 'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:34:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:34:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:23 INFO - 'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['damp', 'tps']}, 06:34:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:23 INFO - 'tests': ['damp', 'tps']}, 06:34:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['dromaeo_dom']}, 06:34:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:34:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['basic_compositor_video']}, 06:34:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:34:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['a11yr', 06:34:23 INFO - 'ts_paint', 06:34:23 INFO - 'tpaint', 06:34:23 INFO - 'sessionrestore', 06:34:23 INFO - 'sessionrestore_no_auto_restore', 06:34:23 INFO - 'tabpaint']}, 06:34:23 INFO - 'other-e10s': {'tests': ['a11yr', 06:34:23 INFO - 'ts_paint', 06:34:23 INFO - 'tpaint', 06:34:23 INFO - 'sessionrestore', 06:34:23 INFO - 'sessionrestore_no_auto_restore', 06:34:23 INFO - 'tabpaint']}, 06:34:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:34:23 INFO - 'ts_paint', 06:34:23 INFO - 'tpaint', 06:34:23 INFO - 'sessionrestore', 06:34:23 INFO - 'sessionrestore_no_auto_restore', 06:34:23 INFO - 'tabpaint']}, 06:34:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:34:23 INFO - 'ts_paint', 06:34:23 INFO - 'tpaint', 06:34:23 INFO - 'sessionrestore', 06:34:23 INFO - 'sessionrestore_no_auto_restore', 06:34:23 INFO - 'tabpaint']}, 06:34:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['a11yr', 06:34:23 INFO - 'ts_paint', 06:34:23 INFO - 'tpaint', 06:34:23 INFO - 'sessionrestore', 06:34:23 INFO - 'sessionrestore_no_auto_restore', 06:34:23 INFO - 'tabpaint']}, 06:34:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['a11yr', 06:34:23 INFO - 'ts_paint', 06:34:23 INFO - 'tpaint', 06:34:23 INFO - 'sessionrestore', 06:34:23 INFO - 'sessionrestore_no_auto_restore', 06:34:23 INFO - 'tabpaint']}, 06:34:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['tsvgx', 06:34:23 INFO - 'tsvgr_opacity', 06:34:23 INFO - 'tart', 06:34:23 INFO - 'tscrollx', 06:34:23 INFO - 'cart']}, 06:34:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:34:23 INFO - 'tsvgr_opacity', 06:34:23 INFO - 'tart', 06:34:23 INFO - 'tscrollx', 06:34:23 INFO - 'cart']}, 06:34:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:23 INFO - 'talos_options': ['--disable-e10s'], 06:34:23 INFO - 'tests': ['tp5o']}, 06:34:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:23 INFO - 'tests': ['tp5o']}, 06:34:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:23 INFO - 'talos_options': ['--disable-e10s', 06:34:23 INFO - '--xperf_path', 06:34:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:34:23 INFO - 'tests': ['tp5n']}, 06:34:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:34:23 INFO - 'talos_options': ['--xperf_path', 06:34:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:34:23 INFO - 'tests': ['tp5n']}}, 06:34:23 INFO - 'talos.zip': {'path': '', 06:34:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:34:23 INFO - Running post-action listener: _resource_record_post_action 06:34:23 INFO - [mozharness: 2016-08-16 13:34:23.162990Z] Finished populate-webroot step (success) 06:34:23 INFO - [mozharness: 2016-08-16 13:34:23.163079Z] Running create-virtualenv step. 06:34:23 INFO - Running pre-action listener: _resource_record_pre_action 06:34:23 INFO - Running main action method: create_virtualenv 06:34:23 INFO - Creating virtualenv /builds/slave/test/build/venv 06:34:23 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 06:34:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:34:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:34:23 INFO - Using real prefix '/usr' 06:34:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:34:23 INFO - Installing distribute.............................................................................................................................................................................................done. 06:34:25 INFO - Installing pip.................done. 06:34:25 INFO - Return code: 0 06:34:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:34:25 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')]} 06:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:25 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')]} 06:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:25 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 0x297e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, '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': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', '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 06:34:25 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 06:34:25 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 06:34:25 INFO - Using env: {'DISPLAY': ':0', 06:34:25 INFO - 'HOME': '/home/cltbld', 06:34:25 INFO - 'LANG': 'en_US.UTF-8', 06:34:25 INFO - 'LANGUAGE': 'en_US:en', 06:34:25 INFO - 'LOGNAME': 'cltbld', 06:34:25 INFO - 'MAIL': '/var/mail/cltbld', 06:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:25 INFO - 'MOZ_NO_REMOTE': '1', 06:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:25 INFO - 'NO_EM_RESTART': '1', 06:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:25 INFO - 'PWD': '/builds/slave/test', 06:34:25 INFO - 'SHELL': '/bin/bash', 06:34:25 INFO - 'SHLVL': '1', 06:34:25 INFO - 'TERM': 'linux', 06:34:25 INFO - 'TMOUT': '86400', 06:34:25 INFO - 'USER': 'cltbld', 06:34:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:25 INFO - '_': '/tools/buildbot/bin/python'} 06:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:25 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 06:34:25 INFO - Cleaning up... 06:34:25 INFO - Return code: 0 06:34:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:34:25 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')]} 06:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:25 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')]} 06:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:25 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 0x297e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, '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': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', '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 06:34:25 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 06:34:25 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 06:34:25 INFO - Using env: {'DISPLAY': ':0', 06:34:25 INFO - 'HOME': '/home/cltbld', 06:34:25 INFO - 'LANG': 'en_US.UTF-8', 06:34:25 INFO - 'LANGUAGE': 'en_US:en', 06:34:25 INFO - 'LOGNAME': 'cltbld', 06:34:25 INFO - 'MAIL': '/var/mail/cltbld', 06:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:25 INFO - 'MOZ_NO_REMOTE': '1', 06:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:25 INFO - 'NO_EM_RESTART': '1', 06:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:25 INFO - 'PWD': '/builds/slave/test', 06:34:25 INFO - 'SHELL': '/bin/bash', 06:34:25 INFO - 'SHLVL': '1', 06:34:25 INFO - 'TERM': 'linux', 06:34:25 INFO - 'TMOUT': '86400', 06:34:25 INFO - 'USER': 'cltbld', 06:34:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:25 INFO - '_': '/tools/buildbot/bin/python'} 06:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:26 INFO - Downloading/unpacking psutil>=3.1.1 06:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:34:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:34:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:34:28 INFO - Installing collected packages: psutil 06:34:28 INFO - Running setup.py install for psutil 06:34:28 INFO - building 'psutil._psutil_linux' extension 06:34:28 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 06:34:28 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 06:34:28 INFO - building 'psutil._psutil_posix' extension 06:34:28 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 06:34:28 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 06:34:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:34:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:34:28 INFO - Successfully installed psutil 06:34:28 INFO - Cleaning up... 06:34:28 INFO - Return code: 0 06:34:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, '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': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', '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 06:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:34:28 INFO - Using env: {'DISPLAY': ':0', 06:34:28 INFO - 'HOME': '/home/cltbld', 06:34:28 INFO - 'LANG': 'en_US.UTF-8', 06:34:28 INFO - 'LANGUAGE': 'en_US:en', 06:34:28 INFO - 'LOGNAME': 'cltbld', 06:34:28 INFO - 'MAIL': '/var/mail/cltbld', 06:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:28 INFO - 'MOZ_NO_REMOTE': '1', 06:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:28 INFO - 'NO_EM_RESTART': '1', 06:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:28 INFO - 'PWD': '/builds/slave/test', 06:34:28 INFO - 'SHELL': '/bin/bash', 06:34:28 INFO - 'SHLVL': '1', 06:34:28 INFO - 'TERM': 'linux', 06:34:28 INFO - 'TMOUT': '86400', 06:34:28 INFO - 'USER': 'cltbld', 06:34:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:28 INFO - '_': '/tools/buildbot/bin/python'} 06:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:34:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:34:30 INFO - Installing collected packages: mozsystemmonitor 06:34:30 INFO - Running setup.py install for mozsystemmonitor 06:34:30 INFO - Successfully installed mozsystemmonitor 06:34:30 INFO - Cleaning up... 06:34:31 INFO - Return code: 0 06:34:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x297e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, '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': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', '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 06:34:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:34:31 INFO - Using env: {'DISPLAY': ':0', 06:34:31 INFO - 'HOME': '/home/cltbld', 06:34:31 INFO - 'LANG': 'en_US.UTF-8', 06:34:31 INFO - 'LANGUAGE': 'en_US:en', 06:34:31 INFO - 'LOGNAME': 'cltbld', 06:34:31 INFO - 'MAIL': '/var/mail/cltbld', 06:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:31 INFO - 'MOZ_NO_REMOTE': '1', 06:34:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:31 INFO - 'NO_EM_RESTART': '1', 06:34:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:31 INFO - 'PWD': '/builds/slave/test', 06:34:31 INFO - 'SHELL': '/bin/bash', 06:34:31 INFO - 'SHLVL': '1', 06:34:31 INFO - 'TERM': 'linux', 06:34:31 INFO - 'TMOUT': '86400', 06:34:31 INFO - 'USER': 'cltbld', 06:34:31 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:31 INFO - '_': '/tools/buildbot/bin/python'} 06:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:31 INFO - Downloading/unpacking jsonschema==2.5.1 06:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:34:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:33 INFO - Downloading functools32-3.2.3-2.tar.gz 06:34:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:34:33 INFO - warning: no files found matching '*.txt' 06:34:33 INFO - no previously-included directories found matching 'build' 06:34:33 INFO - no previously-included directories found matching 'dist' 06:34:33 INFO - no previously-included directories found matching '.git*' 06:34:33 INFO - Installing collected packages: jsonschema, functools32 06:34:33 INFO - Running setup.py install for functools32 06:34:33 INFO - warning: no files found matching '*.txt' 06:34:33 INFO - no previously-included directories found matching 'build' 06:34:33 INFO - no previously-included directories found matching 'dist' 06:34:33 INFO - no previously-included directories found matching '.git*' 06:34:33 INFO - Successfully installed jsonschema functools32 06:34:33 INFO - Cleaning up... 06:34:33 INFO - Return code: 0 06:34:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x297e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, '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': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', '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 06:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:34:33 INFO - Using env: {'DISPLAY': ':0', 06:34:33 INFO - 'HOME': '/home/cltbld', 06:34:33 INFO - 'LANG': 'en_US.UTF-8', 06:34:33 INFO - 'LANGUAGE': 'en_US:en', 06:34:33 INFO - 'LOGNAME': 'cltbld', 06:34:33 INFO - 'MAIL': '/var/mail/cltbld', 06:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:33 INFO - 'MOZ_NO_REMOTE': '1', 06:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:33 INFO - 'NO_EM_RESTART': '1', 06:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:33 INFO - 'PWD': '/builds/slave/test', 06:34:33 INFO - 'SHELL': '/bin/bash', 06:34:33 INFO - 'SHLVL': '1', 06:34:33 INFO - 'TERM': 'linux', 06:34:33 INFO - 'TMOUT': '86400', 06:34:33 INFO - 'USER': 'cltbld', 06:34:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:33 INFO - '_': '/tools/buildbot/bin/python'} 06:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:34:33 INFO - Cleaning up... 06:34:33 INFO - Return code: 0 06:34:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x297e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, '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': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', '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 06:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:34:33 INFO - Using env: {'DISPLAY': ':0', 06:34:33 INFO - 'HOME': '/home/cltbld', 06:34:33 INFO - 'LANG': 'en_US.UTF-8', 06:34:33 INFO - 'LANGUAGE': 'en_US:en', 06:34:33 INFO - 'LOGNAME': 'cltbld', 06:34:33 INFO - 'MAIL': '/var/mail/cltbld', 06:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:33 INFO - 'MOZ_NO_REMOTE': '1', 06:34:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:33 INFO - 'NO_EM_RESTART': '1', 06:34:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:33 INFO - 'PWD': '/builds/slave/test', 06:34:33 INFO - 'SHELL': '/bin/bash', 06:34:33 INFO - 'SHLVL': '1', 06:34:33 INFO - 'TERM': 'linux', 06:34:33 INFO - 'TMOUT': '86400', 06:34:33 INFO - 'USER': 'cltbld', 06:34:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:33 INFO - '_': '/tools/buildbot/bin/python'} 06:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:34 INFO - Downloading/unpacking blobuploader==1.2.4 06:34: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 06:34: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 06:34: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 06:34: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 06:34: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 06:34: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 06:34:39 INFO - Downloading blobuploader-1.2.4.tar.gz 06:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:34:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:34:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:34:40 INFO - Downloading docopt-0.6.1.tar.gz 06:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:34:40 INFO - Installing collected packages: blobuploader, requests, docopt 06:34:40 INFO - Running setup.py install for blobuploader 06:34:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:34:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:34:40 INFO - Running setup.py install for requests 06:34:41 INFO - Running setup.py install for docopt 06:34:41 INFO - Successfully installed blobuploader requests docopt 06:34:41 INFO - Cleaning up... 06:34:41 INFO - Return code: 0 06:34:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:41 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 0x297e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, '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': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', '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 06:34:41 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 06:34:41 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 06:34:41 INFO - Using env: {'DISPLAY': ':0', 06:34:41 INFO - 'HOME': '/home/cltbld', 06:34:41 INFO - 'LANG': 'en_US.UTF-8', 06:34:41 INFO - 'LANGUAGE': 'en_US:en', 06:34:41 INFO - 'LOGNAME': 'cltbld', 06:34:41 INFO - 'MAIL': '/var/mail/cltbld', 06:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:41 INFO - 'MOZ_NO_REMOTE': '1', 06:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:41 INFO - 'NO_EM_RESTART': '1', 06:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:41 INFO - 'PWD': '/builds/slave/test', 06:34:41 INFO - 'SHELL': '/bin/bash', 06:34:41 INFO - 'SHLVL': '1', 06:34:41 INFO - 'TERM': 'linux', 06:34:41 INFO - 'TMOUT': '86400', 06:34:41 INFO - 'USER': 'cltbld', 06:34:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:41 INFO - '_': '/tools/buildbot/bin/python'} 06:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:34:41 INFO - Running setup.py (path:/tmp/pip-nFERSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:34:41 INFO - Running setup.py (path:/tmp/pip-S0UosK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:34:41 INFO - Running setup.py (path:/tmp/pip-vcLGzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:34:41 INFO - Running setup.py (path:/tmp/pip-YT0sud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:34:41 INFO - Running setup.py (path:/tmp/pip-V8WHZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:34:41 INFO - Running setup.py (path:/tmp/pip-L6_Mzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:34:41 INFO - Running setup.py (path:/tmp/pip-DixV3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:34:41 INFO - Running setup.py (path:/tmp/pip-NlGGgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:34:42 INFO - Running setup.py (path:/tmp/pip-6oaV0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:34:42 INFO - Running setup.py (path:/tmp/pip-ZQHcku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:34:42 INFO - Running setup.py (path:/tmp/pip-sQ_pjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:34:42 INFO - Running setup.py (path:/tmp/pip-DwDSnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:34:42 INFO - Running setup.py (path:/tmp/pip-z9g2QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:34:42 INFO - Running setup.py (path:/tmp/pip-Bu6NOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:42 INFO - Running setup.py (path:/tmp/pip-dxgzzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:34:42 INFO - Running setup.py (path:/tmp/pip-6M91ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:34:42 INFO - Running setup.py (path:/tmp/pip-zSaGvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:34:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:34:42 INFO - Running setup.py install for manifestparser 06:34:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:34:42 INFO - Running setup.py install for mozcrash 06:34:42 INFO - Running setup.py install for mozdebug 06:34:42 INFO - Running setup.py install for mozdevice 06:34:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:34:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:34:43 INFO - Running setup.py install for mozfile 06:34:43 INFO - Running setup.py install for mozhttpd 06:34:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:34:43 INFO - Running setup.py install for mozinfo 06:34:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:34:43 INFO - Running setup.py install for mozInstall 06:34:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:34:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:34:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:34:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:34:43 INFO - Running setup.py install for mozleak 06:34:43 INFO - Running setup.py install for mozlog 06:34:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:34:43 INFO - Running setup.py install for moznetwork 06:34:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:34:43 INFO - Running setup.py install for mozprocess 06:34:43 INFO - Running setup.py install for mozprofile 06:34:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:34:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:34:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:34:44 INFO - Running setup.py install for mozrunner 06:34:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:34:44 INFO - Running setup.py install for mozscreenshot 06:34:44 INFO - Running setup.py install for moztest 06:34:44 INFO - Running setup.py install for mozversion 06:34:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:34:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:34:44 INFO - Cleaning up... 06:34:44 INFO - Return code: 0 06:34:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:34:44 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')]} 06:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:44 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')]} 06:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:44 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 0x297e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, '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': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', '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 06:34:44 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 06:34:44 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 06:34:44 INFO - Using env: {'DISPLAY': ':0', 06:34:44 INFO - 'HOME': '/home/cltbld', 06:34:44 INFO - 'LANG': 'en_US.UTF-8', 06:34:44 INFO - 'LANGUAGE': 'en_US:en', 06:34:44 INFO - 'LOGNAME': 'cltbld', 06:34:44 INFO - 'MAIL': '/var/mail/cltbld', 06:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:44 INFO - 'MOZ_NO_REMOTE': '1', 06:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:44 INFO - 'NO_EM_RESTART': '1', 06:34:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:44 INFO - 'PWD': '/builds/slave/test', 06:34:44 INFO - 'SHELL': '/bin/bash', 06:34:44 INFO - 'SHLVL': '1', 06:34:44 INFO - 'TERM': 'linux', 06:34:44 INFO - 'TMOUT': '86400', 06:34:44 INFO - 'USER': 'cltbld', 06:34:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:44 INFO - '_': '/tools/buildbot/bin/python'} 06:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:34:44 INFO - Running setup.py (path:/tmp/pip-5OS24d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:34:44 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)) 06:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:34:44 INFO - Running setup.py (path:/tmp/pip-S88VQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:34:44 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)) 06:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:34:44 INFO - Running setup.py (path:/tmp/pip-3dZ9dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:34:44 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)) 06:34:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:34:44 INFO - Running setup.py (path:/tmp/pip-Wc73QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:34:45 INFO - Running setup.py (path:/tmp/pip-a5uua1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:34:45 INFO - Running setup.py (path:/tmp/pip-EVzQ3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:34:45 INFO - Running setup.py (path:/tmp/pip-fY67ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:34:45 INFO - Running setup.py (path:/tmp/pip-tpF8n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:34:45 INFO - Running setup.py (path:/tmp/pip-1KjiTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:34:45 INFO - Running setup.py (path:/tmp/pip-NKtWhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:34:45 INFO - Running setup.py (path:/tmp/pip-Q4gsjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:34:45 INFO - Running setup.py (path:/tmp/pip-EcAQVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:34:45 INFO - Running setup.py (path:/tmp/pip-2CXaMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:34:45 INFO - Running setup.py (path:/tmp/pip-kTaR0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:45 INFO - Running setup.py (path:/tmp/pip-qhPH9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:34:45 INFO - Running setup.py (path:/tmp/pip-Q9NV7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:34:45 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)) 06:34:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:34:45 INFO - Running setup.py (path:/tmp/pip-1mdz9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:34:45 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)) 06:34:45 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)) 06:34:45 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)) 06:34:45 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)) 06:34:45 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)) 06:34:45 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)) 06:34:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:34:45 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 06:34:45 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 06:34:45 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 06:34:45 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 06:34:45 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 06:34:45 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 06:34:57 INFO - Downloading blessings-1.6.tar.gz 06:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:34:57 INFO - Installing collected packages: blessings 06:34:57 INFO - Running setup.py install for blessings 06:34:57 INFO - Successfully installed blessings 06:34:57 INFO - Cleaning up... 06:34:57 INFO - Return code: 0 06:34:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:34:58 INFO - Reading from file tmpfile_stdout 06:34:58 INFO - Current package versions: 06:34:58 INFO - argparse == 1.2.1 06:34:58 INFO - blessings == 1.6 06:34:58 INFO - blobuploader == 1.2.4 06:34:58 INFO - docopt == 0.6.1 06:34:58 INFO - functools32 == 3.2.3-2 06:34:58 INFO - jsonschema == 2.5.1 06:34:58 INFO - manifestparser == 1.1 06:34:58 INFO - mozInstall == 1.12 06:34:58 INFO - mozcrash == 0.17 06:34:58 INFO - mozdebug == 0.1 06:34:58 INFO - mozdevice == 0.48 06:34:58 INFO - mozfile == 1.2 06:34:58 INFO - mozhttpd == 0.7 06:34:58 INFO - mozinfo == 0.9 06:34:58 INFO - mozleak == 0.1 06:34:58 INFO - mozlog == 3.3 06:34:58 INFO - moznetwork == 0.27 06:34:58 INFO - mozprocess == 0.23 06:34:58 INFO - mozprofile == 0.28 06:34:58 INFO - mozrunner == 6.12 06:34:58 INFO - mozscreenshot == 0.1 06:34:58 INFO - mozsystemmonitor == 0.3 06:34:58 INFO - moztest == 0.7 06:34:58 INFO - mozversion == 1.4 06:34:58 INFO - psutil == 3.1.1 06:34:58 INFO - requests == 1.2.3 06:34:58 INFO - wsgiref == 0.1.2 06:34:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:58 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 0x297e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, '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': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', '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 06:34:58 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 06:34:58 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 06:34:58 INFO - Using env: {'DISPLAY': ':0', 06:34:58 INFO - 'HOME': '/home/cltbld', 06:34:58 INFO - 'LANG': 'en_US.UTF-8', 06:34:58 INFO - 'LANGUAGE': 'en_US:en', 06:34:58 INFO - 'LOGNAME': 'cltbld', 06:34:58 INFO - 'MAIL': '/var/mail/cltbld', 06:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:58 INFO - 'MOZ_NO_REMOTE': '1', 06:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:58 INFO - 'NO_EM_RESTART': '1', 06:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:58 INFO - 'PWD': '/builds/slave/test', 06:34:58 INFO - 'SHELL': '/bin/bash', 06:34:58 INFO - 'SHLVL': '1', 06:34:58 INFO - 'TERM': 'linux', 06:34:58 INFO - 'TMOUT': '86400', 06:34:58 INFO - 'USER': 'cltbld', 06:34:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:58 INFO - '_': '/tools/buildbot/bin/python'} 06:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:58 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)) 06:34:58 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)) 06:34:58 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)) 06:34:58 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)) 06:34:58 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)) 06:34:58 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)) 06:34:58 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)) 06:34:58 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)) 06:34:58 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)) 06:34:58 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)) 06:34:58 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)) 06:34:58 INFO - Cleaning up... 06:34:58 INFO - Return code: 0 06:34:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:34:58 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 0x297e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bad400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, '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': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', '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 06:34:58 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 06:34:58 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 06:34:58 INFO - Using env: {'DISPLAY': ':0', 06:34:58 INFO - 'HOME': '/home/cltbld', 06:34:58 INFO - 'LANG': 'en_US.UTF-8', 06:34:58 INFO - 'LANGUAGE': 'en_US:en', 06:34:58 INFO - 'LOGNAME': 'cltbld', 06:34:58 INFO - 'MAIL': '/var/mail/cltbld', 06:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:34:58 INFO - 'MOZ_NO_REMOTE': '1', 06:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:34:58 INFO - 'NO_EM_RESTART': '1', 06:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:34:58 INFO - 'PWD': '/builds/slave/test', 06:34:58 INFO - 'SHELL': '/bin/bash', 06:34:58 INFO - 'SHLVL': '1', 06:34:58 INFO - 'TERM': 'linux', 06:34:58 INFO - 'TMOUT': '86400', 06:34:58 INFO - 'USER': 'cltbld', 06:34:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:34:58 INFO - '_': '/tools/buildbot/bin/python'} 06:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:34:58 INFO - Cleaning up... 06:34:58 INFO - Return code: 0 06:34:58 INFO - Running post-action listener: _resource_record_post_action 06:34:58 INFO - Running post-action listener: _start_resource_monitoring 06:34:58 INFO - Starting resource monitoring. 06:34:58 INFO - [mozharness: 2016-08-16 13:34:58.643044Z] Finished create-virtualenv step (success) 06:34:58 INFO - [mozharness: 2016-08-16 13:34:58.643518Z] Running install step. 06:34:58 INFO - Running pre-action listener: _resource_record_pre_action 06:34:58 INFO - Running main action method: install 06:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:34:58 INFO - Reading from file tmpfile_stdout 06:34:58 INFO - Detecting whether we're running mozinstall >=1.0... 06:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:34:58 INFO - Reading from file tmpfile_stdout 06:34:58 INFO - Output received: 06:34:58 INFO - Usage: mozinstall [options] installer 06:34:58 INFO - Options: 06:34:58 INFO - -h, --help show this help message and exit 06:34:58 INFO - -d DEST, --destination=DEST 06:34:58 INFO - Directory to install application into. [default: 06:34:58 INFO - "/builds/slave/test"] 06:34:58 INFO - --app=APP Application being installed. [default: firefox] 06:34:58 INFO - mkdir: /builds/slave/test/build/application 06:34:58 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'] 06:34:58 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 06:35:14 INFO - Reading from file tmpfile_stdout 06:35:14 INFO - Output received: 06:35:14 INFO - /builds/slave/test/build/application/firefox/firefox 06:35:14 INFO - Running post-action listener: _resource_record_post_action 06:35:14 INFO - [mozharness: 2016-08-16 13:35:14.903015Z] Finished install step (success) 06:35:14 INFO - [mozharness: 2016-08-16 13:35:14.903291Z] Running run-tests step. 06:35:14 INFO - Running pre-action listener: _resource_record_pre_action 06:35:14 INFO - Running main action method: run_tests 06:35:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:35:14 INFO - Python 2.7.3 06:35:14 INFO - Return code: 0 06:35:14 INFO - grabbing minidump binary from tooltool 06:35:14 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')]} 06:35:14 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 0x2c3c570>, '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 0x2c3d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:35:14 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 06:35:14 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 06:35:14 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 06:35:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:35:14 INFO - Return code: 0 06:35:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:35:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:35:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:35:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:35:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:35:14 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/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 06:35:14 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/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 06:35:14 INFO - Using env: {'DISPLAY': ':0', 06:35:14 INFO - 'HOME': '/home/cltbld', 06:35:14 INFO - 'LANG': 'en_US.UTF-8', 06:35:14 INFO - 'LANGUAGE': 'en_US:en', 06:35:14 INFO - 'LOGNAME': 'cltbld', 06:35:14 INFO - 'MAIL': '/var/mail/cltbld', 06:35:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:35:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:14 INFO - 'MOZ_NO_REMOTE': '1', 06:35:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:14 INFO - 'NO_EM_RESTART': '1', 06:35:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:14 INFO - 'PWD': '/builds/slave/test', 06:35:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:35:14 INFO - 'SHELL': '/bin/bash', 06:35:14 INFO - 'SHLVL': '1', 06:35:14 INFO - 'TERM': 'linux', 06:35:14 INFO - 'TMOUT': '86400', 06:35:14 INFO - 'USER': 'cltbld', 06:35:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936', 06:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:14 INFO - '_': '/tools/buildbot/bin/python'} 06:35:14 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/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 06:35:15 INFO - mozversion application_buildid: 20160816032622 06:35:15 INFO - mozversion application_changeset: a609f6015009feea8362b149ec175f63a5b14cb8 06:35:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:35:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:35:15 INFO - mozversion application_name: Firefox 06:35:15 INFO - mozversion application_remotingname: firefox-dev 06:35:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:35:15 INFO - mozversion application_vendor: Mozilla 06:35:15 INFO - mozversion application_version: 50.0a2 06:35:15 INFO - mozversion platform_buildid: 20160816032622 06:35:15 INFO - mozversion platform_changeset: a609f6015009feea8362b149ec175f63a5b14cb8 06:35:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:35:15 INFO - mozversion platform_version: 50.0a2 06:35:15 INFO - using testdate: 1471354515 06:35:15 INFO - actual date: 1471354515 06:35:15 INFO - starting webserver on 'localhost:59900' 06:35:15 INFO - SUITE-START | Running 2 tests 06:35:15 INFO - TEST-START | dromaeo_css 06:35:15 INFO - operating with platform_type : linux_ 06:35:15 INFO - Initialising browser for dromaeo_css test... 06:35:15 INFO - TEST-INFO | started process 16658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1GpsB7/profile http://localhost:59900/getInfo.html) 06:35:19 INFO - PROCESS | 16658 | __metrics Screen width/height:1600/1200 06:35:19 INFO - PROCESS | 16658 | colorDepth:24 06:35:19 INFO - PROCESS | 16658 | Browser inner width/height: 1024/697 06:35:19 INFO - PROCESS | 16658 | __metrics 06:35:20 ERROR - PROCESS | 16658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:35:21 INFO - TEST-INFO | 16658: exit 0 06:35:21 INFO - Browser initialized. 06:35:21 INFO - Running cycle 1/1 for dromaeo_css test... 06:35:21 INFO - TEST-INFO | started process 16786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1GpsB7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:35:32 INFO - PROCESS | 16786 | RSS: Main: 152399872 06:35:32 INFO - PROCESS | 16786 | 06:36:22 INFO - PROCESS | 16786 | 1471354582413 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] 06:38:30 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59900/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59900/tests/dromaeo/cssquery-ext.html) 06:38:32 INFO - PROCESS | 16786 | RSS: Main: 157921280 06:38:32 INFO - PROCESS | 16786 | 06:41:34 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59900/tests/dromaeo/cssquery-ext.html (next: http://localhost:59900/tests/dromaeo/cssquery-jquery.html) 06:41:34 INFO - PROCESS | 16786 | RSS: Main: 154660864 06:41:34 INFO - PROCESS | 16786 | 06:44:36 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59900/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59900/tests/dromaeo/cssquery-mootools.html) 06:44:37 INFO - PROCESS | 16786 | RSS: Main: 153845760 06:44:37 INFO - PROCESS | 16786 | 06:47:38 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59900/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59900/tests/dromaeo/cssquery-prototype.html) 06:47:39 INFO - PROCESS | 16786 | RSS: Main: 152825856 06:47:39 INFO - PROCESS | 16786 | 06:50:42 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59900/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59900/tests/dromaeo/cssquery-yui.html) 06:50:42 INFO - PROCESS | 16786 | RSS: Main: 155308032 06:50:42 INFO - PROCESS | 16786 | 06:53:45 INFO - PROCESS | 16786 | Cycle 1(1): loaded http://localhost:59900/tests/dromaeo/cssquery-yui.html (next: http://localhost:59900/tests/dromaeo/cssquery-dojo.html) 06:53:45 INFO - PROCESS | 16786 | RSS: Main: 155213824 06:53:45 INFO - PROCESS | 16786 | 06:53:45 INFO - PROCESS | 16786 | __start_tp_report 06:53:45 INFO - PROCESS | 16786 | _x_x_mozilla_page_load 06:53:45 INFO - PROCESS | 16786 | _x_x_mozilla_page_load_details 06:53:45 INFO - PROCESS | 16786 | |i|pagename|runs| 06:53:45 INFO - PROCESS | 16786 | |0;dojo.html;3294.159989202754;3339.8664053437865;3352.111690402043;3366.3267346530683;3368.360011597798;5766.250387449636;5909.645421274716;5910;5911.763529458827;5949.315828679703;5746.798862039829;5748.856278593037;5774.913376299359;5799.681017544033;5813.33146688131;5250.107481728096;5250.7637156328055;5275.947240527603;5307;5326.547243484309;5082.034413461449;5124.820631277906;5172.586193104561;5174.042802081627;5184.1705327147665;5254.92117618236;5267.710275934822;5295.258663787073;5303.124984377573;5336.439673834249;5221.530062294392;5264.631475796696;5288.862894477667;5306.283651707047;5319.494648008433;4983;5086.9745651271505;5153.665011774223;5183.559397451221;5201.45384734605;5651.463111004448;5740.684262365568;5742.6841523716175;5743.282089738783;5756.913646295309;6144.41628045335;6174.598651087665;6185.969070154621;6202.596831205957;6206.131141640174;5993.190919225893;6005.219321488178;6210.565260431772;6227.782027629057;6246.25044994599;5634.859128521779;5696.031674615326;5714.828555143353;5733.655980641175;5739;6193.071039344044;6230.283517395467;6232.688365581703;6233.283172435137;6235.688215589294;5925.229720136354;5976.7908123215475;5976.850578735566;5989.460948514655;6030.246219222598;6090.543209259324;6224.564280500412;6230.7819226327765;6235.875282494325;6240.7503699852405;6160.260768707783;6231.096491008779;6234.844128896814;6238.157848690369;6264.373562643699;5998.340182579913;6091.086337049478;6196.504279657616;6203.193584834033;6206.813795586139;4672.789724462407;4730.432348118248;4730.787114579852;4756.904861902812;4759.048190361941;4206.151371495048;4218.388333691598;4227.704060715781;4246.915061698749;4251.404803327537;5690;5784.652920824764;5927.110933360031;5948.821535353946;5968.1644569760265;6145.016797312498;6262.342454042351;6262.624242545462;6302.243730752339;6309.432151106331;5953.702314884238;5969.403059693996;5972.820815375546;5987.970060149672;6013.308469525973;5179.04187725272;5293.285406470154;5367.436419176009;5373.032854086302;5379.6234263601955;6361.2048493938255;6478.4169424752;6481.805545833632;6484.5460817742305;6494.090827284184;6277.874442511033;6278.843028924222;6281.685915704105;6283.246010478589;6285.49716022708;6128.233970753656;6308.873822523616;6374.58565193261;6457.09600655918;6474;6043.335233124265;6137.60105593135;6148.938510614837;6166.445019948226;6167.599106058092;6268.843278918063;6277.18396608438;6278.058291256348;6280.403361680633;6300.401461861115;5846.298444186725;6019.6990150493175;6114.419130182626;6119.143319935123;6119.84700382494;5935.643861368331;6109.34393638171;6114.5672622304855;6121.727351053096;6122.326544080059;5998.940010599838;6003.909941350796;6050.152978582913;6084.634921904523;6114.816555503342;5870.911936321044;6058.212432383762;6168.691565421621;6182.783602574068;6230.034344676583;5929.822105336847;6014.338422773579;6033.547483938634;6053.878922421439;6061.7575296987625 06:53:45 INFO - PROCESS | 16786 | |1;ext.html;578.7395671947622;621.1397214857423;636.6021236727046;645.8772833161697;684.9760258390958;42723.35914961278;47178.528214717844;47702.52297477024;47759.522404775984;47941.76029119854;46759.76620116903;47412.762936185354;47970.28044579325;47973.760131199386;47978.52021479784;9240.722778316644;9302.395344302633;9374.718758437224;9385.249180065612;9398.248140148771;9178.862317065215;9208.309376796733;9257.981622021573;9281.164695177433;9291.25669946406;9288.21050210733;9288.907110928872;9313;9323.25413966881;9336.206422454066;9227.677031303905;9260.53697315135;9263;9270.026647202048;9271.490068046254;9145.634174633073;9273.582688778954;9278.768030799216;9295.2099071579;9317.347785655007;37248;37865.81067094675;37877.24245515074;37882.81058594689;37935;3238.4008958342547;3725.310817498744;3760.6615404613717;3829.253295607358;3869.361555343365;34072.31855362903;34087;34216;34381.6561834381;34548.481772773426;4509.233430316854;4510.391097201868;4518.344839998214;4541.591256786905;4552.863414097583;333294;334711;334743;335971;338481;39135.41296880549;39246.822595322184;39261.80369098136;39332.41001384982;39512.40731389031;39488.21023579512;40437.393439098436;40932.79533602372;40978.59021409748;42692.146157076684;17749.290028398977;17753.7336939946;17803.46589602314;17891.821081789276;17989.910050449664;13328.266945317906;13443.932780336036;13459.528916488072;13490.460381584626;13529.526466573623;20913.37259882206;21424.78575214259;21460.24889128873;21616.567668646538;21650.484466087222;7534.208908064684;7742.264484873928;7778.49439786412;7818;7862.253085956825;1042.3954106618144;1087.037971395321;1117.1063149480383;1133.4389477208833;1151.7293436042523;34678.306433871185;34698.47952280718;34777.30445391078;34923.30153396918;35243.4713479298;1169.771894480568;1183.8993685536825;1248.213625415982;1249.9125061245625;1252.3174869696038;18227.36204232872;18235.908820455814;18414.263429462673;18449.53876153107;18642.161102750408;570839;572815;576356;576890;579577;66038;66795;66830.66584667143;66940.33059669439;66986.66506667533;1445.5085271007697;1454.5999850041323;1464.736347457468;1467.068411558668;1494.880409567232;32677;34088.14779630529;34113.68231857989;34402.65597343994;34518.82740586281;58019.4198058014;58042;58342.4165758354;58598.7070064647;58685.41314586799;520258;521920;527798;528973.5885655388;531571;31911;32050.519242210918;32154;32160.83919580387;32491.675083248865;53638.19542706785;54240.18639720328;54871;55904.72047639736;55960.16059759026;45412.318815217135;47402;47427;47535.52464475311;48595.27107093326;46864.53135468602;46882.53117468918;47578.99545192796;47702.52297477119;47876;39767.60232397639;43804.78097609492;44639.330410044524;44676.32985505285;44958.325625116304;39454;39482.80258598689;40119.79940100398;40833.387499186945;41093.58906410898;30038.849805750833;30841.38317233598;31201.53197701991;31237.68762312348;31280.21799455032 06:53:45 INFO - PROCESS | 16786 | |2;jquery.html;425.7089968095741;426.47117574207994;429.6262251840898;435.33828580557554;446.3260476680212;19199.71200431993;20871.68692469612;20999;21328.4667883303;21549.56900861982;20315.898420507914;20678.586428271425;20858.895705521452;20994.89502552489;21099.68350474744;5714.228579141825;5869.383714709958;5944.138099975501;5956.255468066492;5968.462838344548;5753.367129615739;5790.420957904218;5851.882962340751;5891.057430811071;5905.173275741399;5830.4169583041785;5840.883182336351;5851;5854;5854.297484301868;5619.915701264464;5833.766649334021;5840.912386314188;5884.08796636522;5970.0746384310505;5738.569607279429;5757.884842303172;5781.710914454303;5793.565482588822;5811.738471768781;15021.624459388602;15288.617784555363;17197.398091066752;25357.366065848317;25498.490030199293;2473.727889932106;2474.6659201007815;2589.1585234798767;2687.046098634976;2735.439234956849;11060.834087488694;11177.552897884076;11281.661550153509;11318.490667919881;11560.421978901106;2011.4569066352003;2023.7571491420977;2123.1295168980646;2141;2182.6725991101302;83929;87079.56460217659;87112;87840;88159.11840881637;11341.546338146547;11341.603043893425;11705;11938.462769175409;11963.820542691867;16452.177391130397;16585.83414165867;16609.169541522875;16625.168741562873;16640.251188696297;8498;8590.87113693295;8645.654173832976;8867.778305542413;8899.73300800977;8356.540390278593;8427.873581896276;8429.4942303462;8537.573121344032;8593.742187734253;4811.903761924742;4885.877853053631;4899.314096026559;4962.528559786814;5070.138076527;2052.558699879533;2134.893255337227;2143.871367717942;2144.667576525641;2164.506490521567;1018.8879223285433;1101.5490533562759;1121.685927940178;1143.7941170589374;1183.8756930522343;21018;21259.68110478344;21272.149114035576;21477.57044859094;21507.56984860294;1056.841473778924;1070.5985255529176;1075.3601607043797;1084.1164450972433;1102.8841971593029;11041.33751974884;11786.58746943853;11953.40232988347;11954.462049207807;11969.102317326235;418387;420140;538979;567444;569616;59885.70057149686;80928.59535702284;103559;105649.47175264075;106417;1067.5622994572188;1074.7044562745307;1094.611412948392;1114.2256131988352;1130.4065365682918;15985;16583.585410364354;18546.979916104745;19030.14364353635;19196.71204931955;44670.77664611786;44908.326375105054;45180.322295164944;45248.547514524435;46360;62085.758284833144;62508;63289.36710633019;63642.36357636364;63698;8949.149830766068;9298.116678915492;9361.438313700928;9404.811903761749;9523.952380238332;12545.560905368267;13975.231362275172;14321.713565728418;14380.424783008562;14672.046316989361;12136.575219867262;12337;12486.250824950532;12652.746945061232;12665.87334126647;12125.27248365101;12134.453949572468;12427;12470.376481176087;12512.562060327844;12087.576934807239;12107.636770896886;12685.746285074063;12770.23378597287;12925.54760583375;7823.647935842787;7877.645505952131;8482.499937899098;8536.74389768308;8767.517786521803;12082.577109801116;12254.632361029184;12815.359232038547;12841.550545730855;12890 06:53:45 INFO - PROCESS | 16786 | |3;mootools.html;1489.3670190169178;1494.7234761569107;1668.4077152610823;1822.3986084592086;1846.1876774219343;8654.394192406535;9297.907020929788;9379.577918993644;10120.544575494103;10150.69547913563;9397.342186046979;9849.507524623757;9900.85148722768;9937.403755774658;9943.701688949324;2483.230198638423;2551.8596477193746;2556.5653838847443;2558.322044658167;2558.925251394419;2430.586800243954;2523.129520315488;2538.010176031349;2539.7079335876333;2539.7079335876424;2529.8355606885493;2533.240027991604;2540.8221424500293;2543.898244070235;2557.769800717935;2466.2231397109854;2479.070348619268;2479.615659572769;2489.4896546207983;2495.089292408276;2382.368672301824;2383.332666853284;2404.1104791227185;2409.168836751318;2477.182529765173;9734.756631084208;9804.264680148946;9841.360311579725;9898.554565044591;9943.8508422373;5682.431756824326;5877.235959325303;5879.706014699248;5881;5890.558208134407;3533.9293214135832;3661.6887564557046;3674.6876515495946;3756.229972855558;3818.885433437001;1190.7142285851419;1258.2387655468492;1274.8151518029833;2348.5420343033115;2428.3200703802963;13812.792808107886;13838.515651952133;13900.235487048209;13974;14033.368498417596;4886.242632391985;4948.356713627206;5099.796008159707;5111.514406131411;5150.896982060338;10748.247622666338;10805.783884322269;10822.729431764268;10844.13246940243;10876;5713.171590119409;5763.135529670499;5766.740496677659;5766.798162064391;5775.48020678141;4743.454502732161;5281.366236051698;5352.785888564414;5368.651037682538;5400.486953739389;4221.409002739619;4301.11827075455;4336.1978034063795;4360.127974405132;4376.868693939187;1197.3354788092518;1200.3278164227886;1218.1351240619083;1255.1590434408968;1268.1756858042347;1078.665613659768;1092.759592889563;1098.1379617000616;1118.1669656106253;1125.9887401125884;6614;6782.423494002966;6787.151606049244;6881.759138430131;6930.584164950119;483.4778439285563;487.8024400117958;494.658685506999;501.2806622496729;507.32272416323883;4639.420072490939;4670.346151538787;4694.765261736899;4789.760511974388;4795.520447955177;12033;12331.136820422484;12345.321007344683;12351.444185011696;12357.25856448616;11116.666500005012;12277.079219058427;12387.62837114888;12402.689932751573;12439.440225189706;8566.61450234741;8846.646134154691;9044.41211321262;9073.228775554151;9100.453972761523;6622.304658010839;6645.734170633121;6683.331666833278;6692.83267918306;6916.066331045245;10834.837477438003;11190.720231994264;11256.437178140897;11271.718207044889;11413.372264525531;11197.72005699864;11348.829767553658;11359.659210223706;11430.314181149157;11459.541618335174;9186.862197066916;9347.626094956126;9372.34393592442;9447.055294470772;9473.526323683926;9071.546422678708;9317.906820931705;9359.110884465965;9410.294227932796;9413.199878010446;8423.957880210559;8465;8601.569921504026;8617.569121544024;8691;8135.308498777434;8191.631376587949;8371.455855369382;8393.874091888505;8525.19010693983;7615.619219039137;7756.495827771177;7761.340286075521;7768.572728499987;7772.650230739518;5476.972615136899;5693;5700.857478563069;5728.398518155534;5796.710164491674;5933.584649074523;5958.285005799332;5999.970000149971;6008.309044459768;6039.909401359071 06:53:45 INFO - PROCESS | 16786 | |4;prototype.html;357.69238454928757;357.749575297292;358.48378335197316;359.68527538403896;359.9640035996401;5850.21022162008;5879.441453061958;5883.941160588392;5901.675407852577;5933.732982015809;5639.323281206251;5781.306243250805;5800.738966746496;5810.825675229739;5814.563907706928;4496.9775151124195;4505.932411013838;4545.52272011439;4552.361149986003;4572.5427457254345;4505.256632655608;4510.954890451103;4555.954440455586;4576.42794650667;4582.633389328862;4476.8880777980485;4548.135854187711;4548.431446069241;4551.180787458256;4568.954310456903;4451.5993560579545;4502.662300327472;4512.932306015379;4533.86398408045;4535.365048893158;4053.716239863211;4057.5942405759483;4062.7156099073077;4066.6210266993844;4074.2055299216663;5699.914501282484;5700.147452078091;5701.346609483245;5704.77180912763;5740.397258287861;4874.805007799684;5129.384473863123;5153.458886816868;5169.224616307546;5169.276301317818;5986.551008674323;6019.518438524908;6057.454829065406;6062.696865156725;6074.453299203093;4160.958390416087;4325.935110973338;4355.390245365651;4355.4337936068105;4358.411614432042;6125.805467933755;6234.844128896769;6267.310595834455;6337.130546488751;6343;4393.319035549495;4419.18245124653;4442.577955094261;4494.775261236925;4512.34570987205;4525.818967241339;4528.366028755977;4534.115847409789;4544.1593305237975;4557.134144512532;4941.975290123526;5139.434662187156;5169.147090730063;5177.508136727005;5191.870203244949;6040.395960403925;6086.2696476422225;6093.482054025458;6096.359882212392;6107.969460152671;1546.4767204303753;1567.185063766835;1568.7803707480962;1569.3565638088558;1569.5134508302463;958.9834775138376;990.2770977186694;992.2855544008303;993.7366597851575;1012.8075665623508;5188.844334669966;5209.6353255272525;5227;5257.292494365405;5306.044911915892;5520.1443776214755;5557.527610153102;5568.638038527482;5591.133374326986;5620.718964051781;4973.8010479581135;5171;5220.556252718486;5228.529432351107;5260.658057226268;2937.2069541224178;2948.601938738243;2956.965062228203;2962.7333539981505;2973.3904549567287;5627.296587926509;5689.374168841424;5703.429657034347;5706.3722990471015;5709.714514274269;6001.339852616209;6454.031520386234;6456.580322279036;6479.514036447285;6508.8047358579315;6598.175228096488;6601.570897891717;6607.240167380716;6614.536982411185;6620.470362370998;6190.783322583688;6348.587341822767;6364.586301890362;6370.77702280418;6380.894304879286;6202.5658203925295;6241.719122639583;6263.434141464634;6278.309385967631;6310.737852429441;6227.917180995436;6391.840203994937;6462.838429039311;6504.73981040772;6506.3493650634555;4456.420665313489;4505.459344878504;4507.864764057083;4507.90984180308;4513.458384993822;6116.3883611638485;6318.494520438446;6362.6818659067785;6377.96811015942;6402.903956440564;6128.295246046761;6142.218756560547;6161.907571386343;6165.766846630781;6185.597936134137;5921.85195370102;6116.694165291807;6148.262208535004;6152.692365381802;6179.783707570214;6024.759009639565;6062.636241825505;6062.696865156637;6082.574219804571;6141.785037523665;6140.92533806591;6170.007546339932;6182.567220294536;6190.907136392868;6201.441870231701;5764.07774756037;6001.219841420588;6007.279126504847;6017.338092809875;6064.666443345658 06:53:45 INFO - PROCESS | 16786 | |5;yui.html;818.4925346285304;821.671331467413;834.3033566971578;853.3727710133053;910.1171863292603;17476.30094796208;17992.820071799277;18102.728459073092;18186.5453363666;18193.545161370974;16420.507384778444;16695.248713807876;16698.081605511692;16701.415450459237;16703.415380461687;735.6910097758954;869.9565021748919;876.259560671235;896.2471523919907;902.733693560398;902;907.2923119966437;907.5235501361805;914.9496777677225;917.3716004536881;927.4759760735196;942.1191186240886;949.0556895888566;949.3022628368144;950.5722424908785;945.9479728614923;946.2146418472652;947.7109481608106;947.853082772168;947.8909925358603;699.3810477727197;699.8705239530652;700.0129816958065;703.2686006553179;704.077658267671;15835.049897006216;15871.60320991973;15926.203689815462;15969.600759980976;15992.12043337616;16405.91797041007;16588.336466541325;16693.784250506622;16924.746128808078;17381.391651292142;13299.933500332436;13448.529301474402;13469.663258418519;13665.453381864714;13814.861851381458;3879.463104668614;3922.5881282465502;3946.921061578781;3950.881473555798;3988.9828093836177;85644.57177714133;85691.57154214189;86792;86960;92035.53982230046;12255.387230638433;12371.13402061847;12605.243685378906;12663.746725065446;12723.745525089631;24537.509249815263;24553.140640077512;24619.507609847704;24768.380790480383;24779;9351.290304926799;9390.436573805593;9405.43567385959;9448;9733.513324333755;5387.515123638891;5395.757190926418;5405.000074986062;5414.512693857571;5493.066178749622;4001.7598944063448;4101.85643502476;4118.629323360912;4129.070959034193;4142.772147531854;681.6864242448529;683.7094234950225;689.5070024932097;700.5656492974286;703.4442790195791;708.4403321376158;793.1014022665681;803.3009089459412;815.6818840652151;837.6984285657159;10890.183236257313;10929.945350273198;10945.233833631728;11328.943355283336;11731.120165987584;700.4501466348892;725.6988349834864;732.578767208857;733.2410954662006;741.0810594862332;5257.8159764408065;5420.186971954238;5513;5648.124540696199;5668.744906479218;70756.64621676962;76422;119392;127704.36147819387;133238;90215.54892225628;92132.53933730423;92563;115896.42051789687;118069.81930180588;53198.468015320126;88610;90201.54899225463;91952.54023729972;93895;10550.947245263724;10912.345259284468;11314.434278286217;11572.132090093444;11661.6501504955;48152.759236203594;48916.510834891196;51233.23150152676;54337.72831135819;54696.726516368755;75367;78826.21173788188;80820.59589702013;81500;82566;13510.594682159552;13642.795358069836;13670.248136352198;13821.585352439442;13999.16005039701;14456.349464273922;14544.27278636085;15488.457903973307;16540.172991350624;16729.330826766793;13353.599392018255;14835.925820371262;15545.611359715645;16009.759853602438;16014.119223442356;14127.788083178555;14223.359948802536;14625.122492650475;14848.680614222618;15620.921895390451;14134.222617756122;14505.419783208976;14745.410183592965;15800.92099539495;16228.91885540612;12064.879351206375;12410.937945310216;12425.37873106359;12443.813342799684;12646.87353126457;12769.297688627215;13032.674183145496;13053.477860885838;13113;13164.47342106305 06:53:45 INFO - PROCESS | 16786 | __end_tp_report 06:53:45 INFO - PROCESS | 16786 | __start_cc_report 06:53:45 INFO - PROCESS | 16786 | _x_x_mozilla_cycle_collect,322 06:53:45 INFO - PROCESS | 16786 | __end_cc_report 06:53:45 INFO - PROCESS | 16786 | __startTimestamp1471355625250__endTimestamp 06:53:45 INFO - PROCESS | 16786 | 06:53:45 INFO - PROCESS | 16786 | ------- Summary: start ------- 06:53:45 INFO - PROCESS | 16786 | Number of tests: 6 06:53:45 INFO - PROCESS | 16786 | 06:53:45 INFO - PROCESS | 16786 | [#0] dojo.html Cycles:165 Average:5752.58 Median:5993.19 stddev:663.91 (11.1%) stddev-sans-first:637.31 06:53:45 INFO - PROCESS | 16786 | Values: 3294.2 3339.9 3352.1 3366.3 3368.4 5766.3 5909.6 5910.0 5911.8 5949.3 5746.8 5748.9 5774.9 5799.7 5813.3 5250.1 5250.8 5275.9 5307.0 5326.5 5082.0 5124.8 5172.6 5174.0 5184.2 5254.9 5267.7 5295.3 5303.1 5336.4 5221.5 5264.6 5288.9 5306.3 5319.5 4983.0 5087.0 5153.7 5183.6 5201.5 5651.5 5740.7 5742.7 5743.3 5756.9 6144.4 6174.6 6186.0 6202.6 6206.1 5993.2 6005.2 6210.6 6227.8 6246.3 5634.9 5696.0 5714.8 5733.7 5739.0 6193.1 6230.3 6232.7 6233.3 6235.7 5925.2 5976.8 5976.9 5989.5 6030.2 6090.5 6224.6 6230.8 6235.9 6240.8 6160.3 6231.1 6234.8 6238.2 6264.4 5998.3 6091.1 6196.5 6203.2 6206.8 4672.8 4730.4 4730.8 4756.9 4759.0 4206.2 4218.4 4227.7 4246.9 4251.4 5690.0 5784.7 5927.1 5948.8 5968.2 6145.0 6262.3 6262.6 6302.2 6309.4 5953.7 5969.4 5972.8 5988.0 6013.3 5179.0 5293.3 5367.4 5373.0 5379.6 6361.2 6478.4 6481.8 6484.5 6494.1 6277.9 6278.8 6281.7 6283.2 6285.5 6128.2 6308.9 6374.6 6457.1 6474.0 6043.3 6137.6 6148.9 6166.4 6167.6 6268.8 6277.2 6278.1 6280.4 6300.4 5846.3 6019.7 6114.4 6119.1 6119.8 5935.6 6109.3 6114.6 6121.7 6122.3 5998.9 6003.9 6050.2 6084.6 6114.8 5870.9 6058.2 6168.7 6182.8 6230.0 5929.8 6014.3 6033.5 6053.9 6061.8 06:53:45 INFO - PROCESS | 16786 | 06:53:45 INFO - PROCESS | 16786 | [#1] ext.html Cycles:180 Average:64209.37 Median:42707.75 stddev:130234.42 (304.9%) stddev-sans-first:130512.14 06:53:45 INFO - PROCESS | 16786 | Values: 578.7 621.1 636.6 645.9 685.0 42723.4 47178.5 47702.5 47759.5 47941.8 46759.8 47412.8 47970.3 47973.8 47978.5 9240.7 9302.4 9374.7 9385.2 9398.2 9178.9 9208.3 9258.0 9281.2 9291.3 9288.2 9288.9 9313.0 9323.3 9336.2 9227.7 9260.5 9263.0 9270.0 9271.5 9145.6 9273.6 9278.8 9295.2 9317.3 37248.0 37865.8 37877.2 37882.8 37935.0 3238.4 3725.3 3760.7 3829.3 3869.4 34072.3 34087.0 34216.0 34381.7 34548.5 4509.2 4510.4 4518.3 4541.6 4552.9 333294.0 334711.0 334743.0 335971.0 338481.0 39135.4 39246.8 39261.8 39332.4 39512.4 39488.2 40437.4 40932.8 40978.6 42692.1 17749.3 17753.7 17803.5 17891.8 17989.9 13328.3 13443.9 13459.5 13490.5 13529.5 20913.4 21424.8 21460.2 21616.6 21650.5 7534.2 7742.3 7778.5 7818.0 7862.3 1042.4 1087.0 1117.1 1133.4 1151.7 34678.3 34698.5 34777.3 34923.3 35243.5 1169.8 1183.9 1248.2 1249.9 1252.3 18227.4 18235.9 18414.3 18449.5 18642.2 570839.0 572815.0 576356.0 576890.0 579577.0 66038.0 66795.0 66830.7 66940.3 66986.7 1445.5 1454.6 1464.7 1467.1 1494.9 32677.0 34088.1 34113.7 34402.7 34518.8 58019.4 58042.0 58342.4 58598.7 58685.4 520258.0 521920.0 527798.0 528973.6 531571.0 31911.0 32050.5 32154.0 32160.8 32491.7 53638.2 54240.2 54871.0 55904.7 55960.2 45412.3 47402.0 47427.0 47535.5 48595.3 46864.5 46882.5 47579.0 47702.5 47876.0 39767.6 43804.8 44639.3 44676.3 44958.3 39454.0 39482.8 40119.8 40833.4 41093.6 30038.8 30841.4 31201.5 31237.7 31280.2 06:53:45 INFO - PROCESS | 16786 | 06:53:45 INFO - PROCESS | 16786 | [#2] jquery.html Cycles:180 Average:30119.79 Median:11811.12 stddev:83789.64 (709.4%) stddev-sans-first:83995.03 06:53:45 INFO - PROCESS | 16786 | Values: 425.7 426.5 429.6 435.3 446.3 19199.7 20871.7 20999.0 21328.5 21549.6 20315.9 20678.6 20858.9 20994.9 21099.7 5714.2 5869.4 5944.1 5956.3 5968.5 5753.4 5790.4 5851.9 5891.1 5905.2 5830.4 5840.9 5851.0 5854.0 5854.3 5619.9 5833.8 5840.9 5884.1 5970.1 5738.6 5757.9 5781.7 5793.6 5811.7 15021.6 15288.6 17197.4 25357.4 25498.5 2473.7 2474.7 2589.2 2687.0 2735.4 11060.8 11177.6 11281.7 11318.5 11560.4 2011.5 2023.8 2123.1 2141.0 2182.7 83929.0 87079.6 87112.0 87840.0 88159.1 11341.5 11341.6 11705.0 11938.5 11963.8 16452.2 16585.8 16609.2 16625.2 16640.3 8498.0 8590.9 8645.7 8867.8 8899.7 8356.5 8427.9 8429.5 8537.6 8593.7 4811.9 4885.9 4899.3 4962.5 5070.1 2052.6 2134.9 2143.9 2144.7 2164.5 1018.9 1101.5 1121.7 1143.8 1183.9 21018.0 21259.7 21272.1 21477.6 21507.6 1056.8 1070.6 1075.4 1084.1 1102.9 11041.3 11786.6 11953.4 11954.5 11969.1 418387.0 420140.0 538979.0 567444.0 569616.0 59885.7 80928.6 103559.0 105649.5 106417.0 1067.6 1074.7 1094.6 1114.2 1130.4 15985.0 16583.6 18547.0 19030.1 19196.7 44670.8 44908.3 45180.3 45248.5 46360.0 62085.8 62508.0 63289.4 63642.4 63698.0 8949.1 9298.1 9361.4 9404.8 9524.0 12545.6 13975.2 14321.7 14380.4 14672.0 12136.6 12337.0 12486.3 12652.7 12665.9 12125.3 12134.5 12427.0 12470.4 12512.6 12087.6 12107.6 12685.7 12770.2 12925.5 7823.6 7877.6 8482.5 8536.7 8767.5 12082.6 12254.6 12815.4 12841.6 12890.0 06:53:45 INFO - PROCESS | 16786 | 06:53:45 INFO - PROCESS | 16786 | [#3] mootools.html Cycles:180 Average:6431.67 Median:4766.61 stddev:3695.48 (77.5%) stddev-sans-first:3687.18 06:53:45 INFO - PROCESS | 16786 | Values: 1489.4 1494.7 1668.4 1822.4 1846.2 8654.4 9297.9 9379.6 10120.5 10150.7 9397.3 9849.5 9900.9 9937.4 9943.7 2483.2 2551.9 2556.6 2558.3 2558.9 2430.6 2523.1 2538.0 2539.7 2539.7 2529.8 2533.2 2540.8 2543.9 2557.8 2466.2 2479.1 2479.6 2489.5 2495.1 2382.4 2383.3 2404.1 2409.2 2477.2 9734.8 9804.3 9841.4 9898.6 9943.9 5682.4 5877.2 5879.7 5881.0 5890.6 3533.9 3661.7 3674.7 3756.2 3818.9 1190.7 1258.2 1274.8 2348.5 2428.3 13812.8 13838.5 13900.2 13974.0 14033.4 4886.2 4948.4 5099.8 5111.5 5150.9 10748.2 10805.8 10822.7 10844.1 10876.0 5713.2 5763.1 5766.7 5766.8 5775.5 4743.5 5281.4 5352.8 5368.7 5400.5 4221.4 4301.1 4336.2 4360.1 4376.9 1197.3 1200.3 1218.1 1255.2 1268.2 1078.7 1092.8 1098.1 1118.2 1126.0 6614.0 6782.4 6787.2 6881.8 6930.6 483.5 487.8 494.7 501.3 507.3 4639.4 4670.3 4694.8 4789.8 4795.5 12033.0 12331.1 12345.3 12351.4 12357.3 11116.7 12277.1 12387.6 12402.7 12439.4 8566.6 8846.6 9044.4 9073.2 9100.5 6622.3 6645.7 6683.3 6692.8 6916.1 10834.8 11190.7 11256.4 11271.7 11413.4 11197.7 11348.8 11359.7 11430.3 11459.5 9186.9 9347.6 9372.3 9447.1 9473.5 9071.5 9317.9 9359.1 9410.3 9413.2 8424.0 8465.0 8601.6 8617.6 8691.0 8135.3 8191.6 8371.5 8393.9 8525.2 7615.6 7756.5 7761.3 7768.6 7772.7 5477.0 5693.0 5700.9 5728.4 5796.7 5933.6 5958.3 6000.0 6008.3 6039.9 06:53:45 INFO - PROCESS | 16786 | 06:53:45 INFO - PROCESS | 16786 | [#4] prototype.html Cycles:180 Average:5063.91 Median:5700.75 stddev:1503.12 (26.4%) stddev-sans-first:1465.24 06:53:45 INFO - PROCESS | 16786 | Values: 357.7 357.7 358.5 359.7 360.0 5850.2 5879.4 5883.9 5901.7 5933.7 5639.3 5781.3 5800.7 5810.8 5814.6 4497.0 4505.9 4545.5 4552.4 4572.5 4505.3 4511.0 4556.0 4576.4 4582.6 4476.9 4548.1 4548.4 4551.2 4569.0 4451.6 4502.7 4512.9 4533.9 4535.4 4053.7 4057.6 4062.7 4066.6 4074.2 5699.9 5700.1 5701.3 5704.8 5740.4 4874.8 5129.4 5153.5 5169.2 5169.3 5986.6 6019.5 6057.5 6062.7 6074.5 4161.0 4325.9 4355.4 4355.4 4358.4 6125.8 6234.8 6267.3 6337.1 6343.0 4393.3 4419.2 4442.6 4494.8 4512.3 4525.8 4528.4 4534.1 4544.2 4557.1 4942.0 5139.4 5169.1 5177.5 5191.9 6040.4 6086.3 6093.5 6096.4 6108.0 1546.5 1567.2 1568.8 1569.4 1569.5 959.0 990.3 992.3 993.7 1012.8 5188.8 5209.6 5227.0 5257.3 5306.0 5520.1 5557.5 5568.6 5591.1 5620.7 4973.8 5171.0 5220.6 5228.5 5260.7 2937.2 2948.6 2957.0 2962.7 2973.4 5627.3 5689.4 5703.4 5706.4 5709.7 6001.3 6454.0 6456.6 6479.5 6508.8 6598.2 6601.6 6607.2 6614.5 6620.5 6190.8 6348.6 6364.6 6370.8 6380.9 6202.6 6241.7 6263.4 6278.3 6310.7 6227.9 6391.8 6462.8 6504.7 6506.3 4456.4 4505.5 4507.9 4507.9 4513.5 6116.4 6318.5 6362.7 6378.0 6402.9 6128.3 6142.2 6161.9 6165.8 6185.6 5921.9 6116.7 6148.3 6152.7 6179.8 6024.8 6062.6 6062.7 6082.6 6141.8 6140.9 6170.0 6182.6 6190.9 6201.4 5764.1 6001.2 6007.3 6017.3 6064.7 06:53:45 INFO - PROCESS | 16786 | 06:53:45 INFO - PROCESS | 16786 | [#5] yui.html Cycles:180 Average:21818.34 Median:4051.81 stddev:30388.74 (750.0%) stddev-sans-first:30433.08 06:53:45 INFO - PROCESS | 16786 | Values: 818.5 821.7 834.3 853.4 910.1 17476.3 17992.8 18102.7 18186.5 18193.5 16420.5 16695.2 16698.1 16701.4 16703.4 735.7 870.0 876.3 896.2 902.7 902.0 907.3 907.5 914.9 917.4 927.5 942.1 949.1 949.3 950.6 945.9 946.2 947.7 947.9 947.9 699.4 699.9 700.0 703.3 704.1 15835.0 15871.6 15926.2 15969.6 15992.1 16405.9 16588.3 16693.8 16924.7 17381.4 13299.9 13448.5 13469.7 13665.5 13814.9 3879.5 3922.6 3946.9 3950.9 3989.0 85644.6 85691.6 86792.0 86960.0 92035.5 12255.4 12371.1 12605.2 12663.7 12723.7 24537.5 24553.1 24619.5 24768.4 24779.0 9351.3 9390.4 9405.4 9448.0 9733.5 5387.5 5395.8 5405.0 5414.5 5493.1 4001.8 4101.9 4118.6 4129.1 4142.8 681.7 683.7 689.5 700.6 703.4 708.4 793.1 803.3 815.7 837.7 10890.2 10929.9 10945.2 11328.9 11731.1 700.5 725.7 732.6 733.2 741.1 5257.8 5420.2 5513.0 5648.1 5668.7 70756.6 76422.0 119392.0 127704.4 133238.0 90215.5 92132.5 92563.0 115896.4 118069.8 53198.5 88610.0 90201.5 91952.5 93895.0 10550.9 10912.3 11314.4 11572.1 11661.7 48152.8 48916.5 51233.2 54337.7 54696.7 75367.0 78826.2 80820.6 81500.0 82566.0 13510.6 13642.8 13670.2 13821.6 13999.2 14456.3 14544.3 15488.5 16540.2 16729.3 13353.6 14835.9 15545.6 16009.8 16014.1 14127.8 14223.4 14625.1 14848.7 15620.9 14134.2 14505.4 14745.4 15800.9 16228.9 12064.9 12410.9 12425.4 12443.8 12646.9 12769.3 13032.7 13053.5 13113.0 13164.5 06:53:45 INFO - PROCESS | 16786 | -------- Summary: end -------- 06:53:45 INFO - PROCESS | 16786 | 06:53:45 INFO - TEST-INFO | 16786: exit 0 06:53:45 INFO - TEST-OK | dromaeo_css | took 1110825ms 06:53:45 INFO - TEST-START | kraken 06:53:45 INFO - operating with platform_type : linux_ 06:53:45 INFO - Initialising browser for kraken test... 06:53:46 INFO - TEST-INFO | started process 17056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4il819/profile http://localhost:59900/getInfo.html) 06:53:50 INFO - PROCESS | 17056 | __metrics Screen width/height:1600/1200 06:53:50 INFO - PROCESS | 17056 | colorDepth:24 06:53:50 INFO - PROCESS | 17056 | Browser inner width/height: 1024/697 06:53:50 INFO - PROCESS | 17056 | __metrics 06:53:50 ERROR - PROCESS | 17056 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:53:51 INFO - TEST-INFO | 17056: exit 0 06:53:51 INFO - Browser initialized. 06:53:51 INFO - Running cycle 1/1 for kraken test... 06:53:51 INFO - TEST-INFO | started process 17185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4il819/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:54:03 INFO - PROCESS | 17185 | RSS: Main: 152797184 06:54:03 INFO - PROCESS | 17185 | 06:54:06 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59900/tests/kraken/driver.html?testName=audio-beat-detection) 06:54:06 INFO - PROCESS | 17185 | RSS: Main: 158466048 06:54:06 INFO - PROCESS | 17185 | 06:54:09 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59900/tests/kraken/driver.html?testName=audio-dft) 06:54:10 INFO - PROCESS | 17185 | RSS: Main: 156463104 06:54:10 INFO - PROCESS | 17185 | 06:54:13 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59900/tests/kraken/driver.html?testName=audio-fft) 06:54:13 INFO - PROCESS | 17185 | RSS: Main: 157769728 06:54:13 INFO - PROCESS | 17185 | 06:54:15 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59900/tests/kraken/driver.html?testName=audio-oscillator) 06:54:16 INFO - PROCESS | 17185 | RSS: Main: 157290496 06:54:16 INFO - PROCESS | 17185 | 06:54:18 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59900/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:54:19 INFO - PROCESS | 17185 | RSS: Main: 157036544 06:54:19 INFO - PROCESS | 17185 | 06:54:22 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59900/tests/kraken/driver.html?testName=imaging-darkroom) 06:54:22 INFO - PROCESS | 17185 | RSS: Main: 156975104 06:54:22 INFO - PROCESS | 17185 | 06:54:26 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59900/tests/kraken/driver.html?testName=imaging-desaturate) 06:54:26 INFO - PROCESS | 17185 | RSS: Main: 156725248 06:54:26 INFO - PROCESS | 17185 | 06:54:29 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59900/tests/kraken/driver.html?testName=json-parse-financial) 06:54:30 INFO - PROCESS | 17185 | RSS: Main: 158220288 06:54:30 INFO - PROCESS | 17185 | 06:54:31 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59900/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:54:32 INFO - PROCESS | 17185 | RSS: Main: 157364224 06:54:32 INFO - PROCESS | 17185 | 06:54:34 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59900/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:54:34 INFO - PROCESS | 17185 | RSS: Main: 157564928 06:54:34 INFO - PROCESS | 17185 | 06:54:36 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59900/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:54:37 INFO - PROCESS | 17185 | RSS: Main: 158261248 06:54:37 INFO - PROCESS | 17185 | 06:54:40 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:54:40 INFO - PROCESS | 17185 | RSS: Main: 158064640 06:54:40 INFO - PROCESS | 17185 | 06:54:43 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:54:44 INFO - PROCESS | 17185 | RSS: Main: 158302208 06:54:44 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | Cycle 1(1): loaded http://localhost:59900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59900/tests/kraken/driver.html?testName=ai-astar) 06:54:45 INFO - PROCESS | 17185 | RSS: Main: 158887936 06:54:45 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | __start_tp_report 06:54:45 INFO - PROCESS | 17185 | _x_x_mozilla_page_load 06:54:45 INFO - PROCESS | 17185 | _x_x_mozilla_page_load_details 06:54:45 INFO - PROCESS | 17185 | |i|pagename|runs| 06:54:45 INFO - PROCESS | 17185 | |0;ai-astar;100;113;104;110;110;112;110;110;110;111 06:54:45 INFO - PROCESS | 17185 | |1;audio-beat-detection;139;116;146;193;120;145;142;119;175;114 06:54:45 INFO - PROCESS | 17185 | |2;audio-dft;163;161;164;160;161;162;163;162;161;161 06:54:45 INFO - PROCESS | 17185 | |3;audio-fft;77;75;75;178;75;77;76;74;178;75 06:54:45 INFO - PROCESS | 17185 | |4;audio-oscillator;84;87;149;84;83;83;133;85;84;143 06:54:45 INFO - PROCESS | 17185 | |5;imaging-gaussian-blur;118;118;117;118;118;117;118;117;118;117 06:54:45 INFO - PROCESS | 17185 | |6;imaging-darkroom;147;149;147;147;147;148;148;148;148;147 06:54:45 INFO - PROCESS | 17185 | |7;imaging-desaturate;95;96;96;96;96;96;95;96;95;96 06:54:45 INFO - PROCESS | 17185 | |8;json-parse-financial;63;56;53;53;52;59;52;54;52;54 06:54:45 INFO - PROCESS | 17185 | |9;json-stringify-tinderbox;65;60;60;60;65;60;59;60;61;61 06:54:45 INFO - PROCESS | 17185 | |10;stanford-crypto-aes;72;74;72;72;74;72;72;71;77;81 06:54:45 INFO - PROCESS | 17185 | |11;stanford-crypto-ccm;128;119;133;134;123;130;138;126;152;123 06:54:45 INFO - PROCESS | 17185 | |12;stanford-crypto-pbkdf2;152;154;158;155;157;157;155;155;157;155 06:54:45 INFO - PROCESS | 17185 | |13;stanford-crypto-sha256-iterative;64;63;62;62;65;63;61;62;64;60 06:54:45 INFO - PROCESS | 17185 | __end_tp_report 06:54:45 INFO - PROCESS | 17185 | __start_cc_report 06:54:45 INFO - PROCESS | 17185 | _x_x_mozilla_cycle_collect,843 06:54:45 INFO - PROCESS | 17185 | __end_cc_report 06:54:45 INFO - PROCESS | 17185 | __startTimestamp1471355685977__endTimestamp 06:54:45 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | ------- Summary: start ------- 06:54:45 INFO - PROCESS | 17185 | Number of tests: 14 06:54:45 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:3.94 (3.6%) stddev-sans-first:2.50 06:54:45 INFO - PROCESS | 17185 | Values: 100.0 113.0 104.0 110.0 110.0 112.0 110.0 110.0 110.0 111.0 06:54:45 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:143.50 stddev:26.21 (18.3%) stddev-sans-first:27.80 06:54:45 INFO - PROCESS | 17185 | Values: 139.0 116.0 146.0 193.0 120.0 145.0 142.0 119.0 175.0 114.0 06:54:45 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 06:54:45 INFO - PROCESS | 17185 | Values: 163.0 161.0 164.0 160.0 161.0 162.0 163.0 162.0 161.0 161.0 06:54:45 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | [#3] audio-fft Cycles:10 Average:96.00 Median:75.00 stddev:43.23 (57.6%) stddev-sans-first:45.30 06:54:45 INFO - PROCESS | 17185 | Values: 77.0 75.0 75.0 178.0 75.0 77.0 76.0 74.0 178.0 75.0 06:54:45 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:84.00 stddev:28.00 (33.3%) stddev-sans-first:28.97 06:54:45 INFO - PROCESS | 17185 | Values: 84.0 87.0 149.0 84.0 83.0 83.0 133.0 85.0 84.0 143.0 06:54:45 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:54:45 INFO - PROCESS | 17185 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 06:54:45 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 06:54:45 INFO - PROCESS | 17185 | Values: 147.0 149.0 147.0 147.0 147.0 148.0 148.0 148.0 148.0 147.0 06:54:45 INFO - PROCESS | 17185 | 06:54:45 INFO - PROCESS | 17185 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 06:54:45 INFO - PROCESS | 17185 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 06:54:46 INFO - PROCESS | 17185 | 06:54:46 INFO - PROCESS | 17185 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.61 (6.7%) stddev-sans-first:2.32 06:54:46 INFO - PROCESS | 17185 | Values: 63.0 56.0 53.0 53.0 52.0 59.0 52.0 54.0 52.0 54.0 06:54:46 INFO - PROCESS | 17185 | 06:54:46 INFO - PROCESS | 17185 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:60.50 stddev:2.13 (3.5%) stddev-sans-first:1.73 06:54:46 INFO - PROCESS | 17185 | Values: 65.0 60.0 60.0 60.0 65.0 60.0 59.0 60.0 61.0 61.0 06:54:46 INFO - PROCESS | 17185 | 06:54:46 INFO - PROCESS | 17185 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:73.00 stddev:3.09 (4.2%) stddev-sans-first:3.22 06:54:46 INFO - PROCESS | 17185 | Values: 72.0 74.0 72.0 72.0 74.0 72.0 72.0 71.0 77.0 81.0 06:54:46 INFO - PROCESS | 17185 | 06:54:46 INFO - PROCESS | 17185 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:131.50 stddev:9.48 (7.2%) stddev-sans-first:10.01 06:54:46 INFO - PROCESS | 17185 | Values: 128.0 119.0 133.0 134.0 123.0 130.0 138.0 126.0 152.0 123.0 06:54:46 INFO - PROCESS | 17185 | 06:54:46 INFO - PROCESS | 17185 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:156.00 stddev:1.78 (1.1%) stddev-sans-first:1.36 06:54:46 INFO - PROCESS | 17185 | Values: 152.0 154.0 158.0 155.0 157.0 157.0 155.0 155.0 157.0 155.0 06:54:46 INFO - PROCESS | 17185 | 06:54:46 INFO - PROCESS | 17185 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.51 (2.4%) stddev-sans-first:1.51 06:54:46 INFO - PROCESS | 17185 | Values: 64.0 63.0 62.0 62.0 65.0 63.0 61.0 62.0 64.0 60.0 06:54:46 INFO - PROCESS | 17185 | -------- Summary: end -------- 06:54:46 INFO - PROCESS | 17185 | 06:54:46 INFO - TEST-INFO | 17185: exit 0 06:54:46 INFO - TEST-OK | kraken | took 60944ms 06:54:46 INFO - SUITE-END | took 1171s 06:54:47 INFO - Completed test suite (00:19:31) 06:54:47 INFO - javascript benchmark 06:54:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7803.2176176654875, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.159989202754, 3339.8664053437865, 3352.111690402043, 3366.3267346530683, 3368.360011597798, 5766.250387449636, 5909.645421274716, 5910.0, 5911.763529458827, 5949.315828679703, 5746.798862039829, 5748.856278593037, 5774.913376299359, 5799.681017544033, 5813.33146688131, 5250.107481728096, 5250.7637156328055, 5275.947240527603, 5307.0, 5326.547243484309, 5082.034413461449, 5124.820631277906, 5172.586193104561, 5174.042802081627, 5184.1705327147665, 5254.92117618236, 5267.710275934822, 5295.258663787073, 5303.124984377573, 5336.439673834249, 5221.530062294392, 5264.631475796696, 5288.862894477667, 5306.283651707047, 5319.494648008433, 4983.0, 5086.9745651271505, 5153.665011774223, 5183.559397451221, 5201.45384734605, 5651.463111004448, 5740.684262365568, 5742.6841523716175, 5743.282089738783, 5756.913646295309, 6144.41628045335, 6174.598651087665, 6185.969070154621, 6202.596831205957, 6206.131141640174, 5993.190919225893, 6005.219321488178, 6210.565260431772, 6227.782027629057, 6246.25044994599, 5634.859128521779, 5696.031674615326, 5714.828555143353, 5733.655980641175, 5739.0, 6193.071039344044, 6230.283517395467, 6232.688365581703, 6233.283172435137, 6235.688215589294, 5925.229720136354, 5976.7908123215475, 5976.850578735566, 5989.460948514655, 6030.246219222598, 6090.543209259324, 6224.564280500412, 6230.7819226327765, 6235.875282494325, 6240.7503699852405, 6160.260768707783, 6231.096491008779, 6234.844128896814, 6238.157848690369, 6264.373562643699, 5998.340182579913, 6091.086337049478, 6196.504279657616, 6203.193584834033, 6206.813795586139, 4672.789724462407, 4730.432348118248, 4730.787114579852, 4756.904861902812, 4759.048190361941, 4206.151371495048, 4218.388333691598, 4227.704060715781, 4246.915061698749, 4251.404803327537, 5690.0, 5784.652920824764, 5927.110933360031, 5948.821535353946, 5968.1644569760265, 6145.016797312498, 6262.342454042351, 6262.624242545462, 6302.243730752339, 6309.432151106331, 5953.702314884238, 5969.403059693996, 5972.820815375546, 5987.970060149672, 6013.308469525973, 5179.04187725272, 5293.285406470154, 5367.436419176009, 5373.032854086302, 5379.6234263601955, 6361.2048493938255, 6478.4169424752, 6481.805545833632, 6484.5460817742305, 6494.090827284184, 6277.874442511033, 6278.843028924222, 6281.685915704105, 6283.246010478589, 6285.49716022708, 6128.233970753656, 6308.873822523616, 6374.58565193261, 6457.09600655918, 6474.0, 6043.335233124265, 6137.60105593135, 6148.938510614837, 6166.445019948226, 6167.599106058092, 6268.843278918063, 6277.18396608438, 6278.058291256348, 6280.403361680633, 6300.401461861115, 5846.298444186725, 6019.6990150493175, 6114.419130182626, 6119.143319935123, 6119.84700382494, 5935.643861368331, 6109.34393638171, 6114.5672622304855, 6121.727351053096, 6122.326544080059, 5998.940010599838, 6003.909941350796, 6050.152978582913, 6084.634921904523, 6114.816555503342, 5870.911936321044, 6058.212432383762, 6168.691565421621, 6182.783602574068, 6230.034344676583, 5929.822105336847, 6014.338422773579, 6033.547483938634, 6053.878922421439, 6061.7575296987625], "value": 5707.20772823792, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.7395671947622, 621.1397214857423, 636.6021236727046, 645.8772833161697, 684.9760258390958, 42723.35914961278, 47178.528214717844, 47702.52297477024, 47759.522404775984, 47941.76029119854, 46759.76620116903, 47412.762936185354, 47970.28044579325, 47973.760131199386, 47978.52021479784, 9240.722778316644, 9302.395344302633, 9374.718758437224, 9385.249180065612, 9398.248140148771, 9178.862317065215, 9208.309376796733, 9257.981622021573, 9281.164695177433, 9291.25669946406, 9288.21050210733, 9288.907110928872, 9313.0, 9323.25413966881, 9336.206422454066, 9227.677031303905, 9260.53697315135, 9263.0, 9270.026647202048, 9271.490068046254, 9145.634174633073, 9273.582688778954, 9278.768030799216, 9295.2099071579, 9317.347785655007, 37248.0, 37865.81067094675, 37877.24245515074, 37882.81058594689, 37935.0, 3238.4008958342547, 3725.310817498744, 3760.6615404613717, 3829.253295607358, 3869.361555343365, 34072.31855362903, 34087.0, 34216.0, 34381.6561834381, 34548.481772773426, 4509.233430316854, 4510.391097201868, 4518.344839998214, 4541.591256786905, 4552.863414097583, 333294.0, 334711.0, 334743.0, 335971.0, 338481.0, 39135.41296880549, 39246.822595322184, 39261.80369098136, 39332.41001384982, 39512.40731389031, 39488.21023579512, 40437.393439098436, 40932.79533602372, 40978.59021409748, 42692.146157076684, 17749.290028398977, 17753.7336939946, 17803.46589602314, 17891.821081789276, 17989.910050449664, 13328.266945317906, 13443.932780336036, 13459.528916488072, 13490.460381584626, 13529.526466573623, 20913.37259882206, 21424.78575214259, 21460.24889128873, 21616.567668646538, 21650.484466087222, 7534.208908064684, 7742.264484873928, 7778.49439786412, 7818.0, 7862.253085956825, 1042.3954106618144, 1087.037971395321, 1117.1063149480383, 1133.4389477208833, 1151.7293436042523, 34678.306433871185, 34698.47952280718, 34777.30445391078, 34923.30153396918, 35243.4713479298, 1169.771894480568, 1183.8993685536825, 1248.213625415982, 1249.9125061245625, 1252.3174869696038, 18227.36204232872, 18235.908820455814, 18414.263429462673, 18449.53876153107, 18642.161102750408, 570839.0, 572815.0, 576356.0, 576890.0, 579577.0, 66038.0, 66795.0, 66830.66584667143, 66940.33059669439, 66986.66506667533, 1445.5085271007697, 1454.5999850041323, 1464.736347457468, 1467.068411558668, 1494.880409567232, 32677.0, 34088.14779630529, 34113.68231857989, 34402.65597343994, 34518.82740586281, 58019.4198058014, 58042.0, 58342.4165758354, 58598.7070064647, 58685.41314586799, 520258.0, 521920.0, 527798.0, 528973.5885655388, 531571.0, 31911.0, 32050.519242210918, 32154.0, 32160.83919580387, 32491.675083248865, 53638.19542706785, 54240.18639720328, 54871.0, 55904.72047639736, 55960.16059759026, 45412.318815217135, 47402.0, 47427.0, 47535.52464475311, 48595.27107093326, 46864.53135468602, 46882.53117468918, 47578.99545192796, 47702.52297477119, 47876.0, 39767.60232397639, 43804.78097609492, 44639.330410044524, 44676.32985505285, 44958.325625116304, 39454.0, 39482.80258598689, 40119.79940100398, 40833.387499186945, 41093.58906410898, 30038.849805750833, 30841.38317233598, 31201.53197701991, 31237.68762312348, 31280.21799455032], "value": 21122.41830764201, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.7089968095741, 426.47117574207994, 429.6262251840898, 435.33828580557554, 446.3260476680212, 19199.71200431993, 20871.68692469612, 20999.0, 21328.4667883303, 21549.56900861982, 20315.898420507914, 20678.586428271425, 20858.895705521452, 20994.89502552489, 21099.68350474744, 5714.228579141825, 5869.383714709958, 5944.138099975501, 5956.255468066492, 5968.462838344548, 5753.367129615739, 5790.420957904218, 5851.882962340751, 5891.057430811071, 5905.173275741399, 5830.4169583041785, 5840.883182336351, 5851.0, 5854.0, 5854.297484301868, 5619.915701264464, 5833.766649334021, 5840.912386314188, 5884.08796636522, 5970.0746384310505, 5738.569607279429, 5757.884842303172, 5781.710914454303, 5793.565482588822, 5811.738471768781, 15021.624459388602, 15288.617784555363, 17197.398091066752, 25357.366065848317, 25498.490030199293, 2473.727889932106, 2474.6659201007815, 2589.1585234798767, 2687.046098634976, 2735.439234956849, 11060.834087488694, 11177.552897884076, 11281.661550153509, 11318.490667919881, 11560.421978901106, 2011.4569066352003, 2023.7571491420977, 2123.1295168980646, 2141.0, 2182.6725991101302, 83929.0, 87079.56460217659, 87112.0, 87840.0, 88159.11840881637, 11341.546338146547, 11341.603043893425, 11705.0, 11938.462769175409, 11963.820542691867, 16452.177391130397, 16585.83414165867, 16609.169541522875, 16625.168741562873, 16640.251188696297, 8498.0, 8590.87113693295, 8645.654173832976, 8867.778305542413, 8899.73300800977, 8356.540390278593, 8427.873581896276, 8429.4942303462, 8537.573121344032, 8593.742187734253, 4811.903761924742, 4885.877853053631, 4899.314096026559, 4962.528559786814, 5070.138076527, 2052.558699879533, 2134.893255337227, 2143.871367717942, 2144.667576525641, 2164.506490521567, 1018.8879223285433, 1101.5490533562759, 1121.685927940178, 1143.7941170589374, 1183.8756930522343, 21018.0, 21259.68110478344, 21272.149114035576, 21477.57044859094, 21507.56984860294, 1056.841473778924, 1070.5985255529176, 1075.3601607043797, 1084.1164450972433, 1102.8841971593029, 11041.33751974884, 11786.58746943853, 11953.40232988347, 11954.462049207807, 11969.102317326235, 418387.0, 420140.0, 538979.0, 567444.0, 569616.0, 59885.70057149686, 80928.59535702284, 103559.0, 105649.47175264075, 106417.0, 1067.5622994572188, 1074.7044562745307, 1094.611412948392, 1114.2256131988352, 1130.4065365682918, 15985.0, 16583.585410364354, 18546.979916104745, 19030.14364353635, 19196.71204931955, 44670.77664611786, 44908.326375105054, 45180.322295164944, 45248.547514524435, 46360.0, 62085.758284833144, 62508.0, 63289.36710633019, 63642.36357636364, 63698.0, 8949.149830766068, 9298.116678915492, 9361.438313700928, 9404.811903761749, 9523.952380238332, 12545.560905368267, 13975.231362275172, 14321.713565728418, 14380.424783008562, 14672.046316989361, 12136.575219867262, 12337.0, 12486.250824950532, 12652.746945061232, 12665.87334126647, 12125.27248365101, 12134.453949572468, 12427.0, 12470.376481176087, 12512.562060327844, 12087.576934807239, 12107.636770896886, 12685.746285074063, 12770.23378597287, 12925.54760583375, 7823.647935842787, 7877.645505952131, 8482.499937899098, 8536.74389768308, 8767.517786521803, 12082.577109801116, 12254.632361029184, 12815.359232038547, 12841.550545730855, 12890.0], "value": 9749.084596791366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.3670190169178, 1494.7234761569107, 1668.4077152610823, 1822.3986084592086, 1846.1876774219343, 8654.394192406535, 9297.907020929788, 9379.577918993644, 10120.544575494103, 10150.69547913563, 9397.342186046979, 9849.507524623757, 9900.85148722768, 9937.403755774658, 9943.701688949324, 2483.230198638423, 2551.8596477193746, 2556.5653838847443, 2558.322044658167, 2558.925251394419, 2430.586800243954, 2523.129520315488, 2538.010176031349, 2539.7079335876333, 2539.7079335876424, 2529.8355606885493, 2533.240027991604, 2540.8221424500293, 2543.898244070235, 2557.769800717935, 2466.2231397109854, 2479.070348619268, 2479.615659572769, 2489.4896546207983, 2495.089292408276, 2382.368672301824, 2383.332666853284, 2404.1104791227185, 2409.168836751318, 2477.182529765173, 9734.756631084208, 9804.264680148946, 9841.360311579725, 9898.554565044591, 9943.8508422373, 5682.431756824326, 5877.235959325303, 5879.706014699248, 5881.0, 5890.558208134407, 3533.9293214135832, 3661.6887564557046, 3674.6876515495946, 3756.229972855558, 3818.885433437001, 1190.7142285851419, 1258.2387655468492, 1274.8151518029833, 2348.5420343033115, 2428.3200703802963, 13812.792808107886, 13838.515651952133, 13900.235487048209, 13974.0, 14033.368498417596, 4886.242632391985, 4948.356713627206, 5099.796008159707, 5111.514406131411, 5150.896982060338, 10748.247622666338, 10805.783884322269, 10822.729431764268, 10844.13246940243, 10876.0, 5713.171590119409, 5763.135529670499, 5766.740496677659, 5766.798162064391, 5775.48020678141, 4743.454502732161, 5281.366236051698, 5352.785888564414, 5368.651037682538, 5400.486953739389, 4221.409002739619, 4301.11827075455, 4336.1978034063795, 4360.127974405132, 4376.868693939187, 1197.3354788092518, 1200.3278164227886, 1218.1351240619083, 1255.1590434408968, 1268.1756858042347, 1078.665613659768, 1092.759592889563, 1098.1379617000616, 1118.1669656106253, 1125.9887401125884, 6614.0, 6782.423494002966, 6787.151606049244, 6881.759138430131, 6930.584164950119, 483.4778439285563, 487.8024400117958, 494.658685506999, 501.2806622496729, 507.32272416323883, 4639.420072490939, 4670.346151538787, 4694.765261736899, 4789.760511974388, 4795.520447955177, 12033.0, 12331.136820422484, 12345.321007344683, 12351.444185011696, 12357.25856448616, 11116.666500005012, 12277.079219058427, 12387.62837114888, 12402.689932751573, 12439.440225189706, 8566.61450234741, 8846.646134154691, 9044.41211321262, 9073.228775554151, 9100.453972761523, 6622.304658010839, 6645.734170633121, 6683.331666833278, 6692.83267918306, 6916.066331045245, 10834.837477438003, 11190.720231994264, 11256.437178140897, 11271.718207044889, 11413.372264525531, 11197.72005699864, 11348.829767553658, 11359.659210223706, 11430.314181149157, 11459.541618335174, 9186.862197066916, 9347.626094956126, 9372.34393592442, 9447.055294470772, 9473.526323683926, 9071.546422678708, 9317.906820931705, 9359.110884465965, 9410.294227932796, 9413.199878010446, 8423.957880210559, 8465.0, 8601.569921504026, 8617.569121544024, 8691.0, 8135.308498777434, 8191.631376587949, 8371.455855369382, 8393.874091888505, 8525.19010693983, 7615.619219039137, 7756.495827771177, 7761.340286075521, 7768.572728499987, 7772.650230739518, 5476.972615136899, 5693.0, 5700.857478563069, 5728.398518155534, 5796.710164491674, 5933.584649074523, 5958.285005799332, 5999.970000149971, 6008.309044459768, 6039.909401359071], "value": 5054.4517248321945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.69238454928757, 357.749575297292, 358.48378335197316, 359.68527538403896, 359.9640035996401, 5850.21022162008, 5879.441453061958, 5883.941160588392, 5901.675407852577, 5933.732982015809, 5639.323281206251, 5781.306243250805, 5800.738966746496, 5810.825675229739, 5814.563907706928, 4496.9775151124195, 4505.932411013838, 4545.52272011439, 4552.361149986003, 4572.5427457254345, 4505.256632655608, 4510.954890451103, 4555.954440455586, 4576.42794650667, 4582.633389328862, 4476.8880777980485, 4548.135854187711, 4548.431446069241, 4551.180787458256, 4568.954310456903, 4451.5993560579545, 4502.662300327472, 4512.932306015379, 4533.86398408045, 4535.365048893158, 4053.716239863211, 4057.5942405759483, 4062.7156099073077, 4066.6210266993844, 4074.2055299216663, 5699.914501282484, 5700.147452078091, 5701.346609483245, 5704.77180912763, 5740.397258287861, 4874.805007799684, 5129.384473863123, 5153.458886816868, 5169.224616307546, 5169.276301317818, 5986.551008674323, 6019.518438524908, 6057.454829065406, 6062.696865156725, 6074.453299203093, 4160.958390416087, 4325.935110973338, 4355.390245365651, 4355.4337936068105, 4358.411614432042, 6125.805467933755, 6234.844128896769, 6267.310595834455, 6337.130546488751, 6343.0, 4393.319035549495, 4419.18245124653, 4442.577955094261, 4494.775261236925, 4512.34570987205, 4525.818967241339, 4528.366028755977, 4534.115847409789, 4544.1593305237975, 4557.134144512532, 4941.975290123526, 5139.434662187156, 5169.147090730063, 5177.508136727005, 5191.870203244949, 6040.395960403925, 6086.2696476422225, 6093.482054025458, 6096.359882212392, 6107.969460152671, 1546.4767204303753, 1567.185063766835, 1568.7803707480962, 1569.3565638088558, 1569.5134508302463, 958.9834775138376, 990.2770977186694, 992.2855544008303, 993.7366597851575, 1012.8075665623508, 5188.844334669966, 5209.6353255272525, 5227.0, 5257.292494365405, 5306.044911915892, 5520.1443776214755, 5557.527610153102, 5568.638038527482, 5591.133374326986, 5620.718964051781, 4973.8010479581135, 5171.0, 5220.556252718486, 5228.529432351107, 5260.658057226268, 2937.2069541224178, 2948.601938738243, 2956.965062228203, 2962.7333539981505, 2973.3904549567287, 5627.296587926509, 5689.374168841424, 5703.429657034347, 5706.3722990471015, 5709.714514274269, 6001.339852616209, 6454.031520386234, 6456.580322279036, 6479.514036447285, 6508.8047358579315, 6598.175228096488, 6601.570897891717, 6607.240167380716, 6614.536982411185, 6620.470362370998, 6190.783322583688, 6348.587341822767, 6364.586301890362, 6370.77702280418, 6380.894304879286, 6202.5658203925295, 6241.719122639583, 6263.434141464634, 6278.309385967631, 6310.737852429441, 6227.917180995436, 6391.840203994937, 6462.838429039311, 6504.73981040772, 6506.3493650634555, 4456.420665313489, 4505.459344878504, 4507.864764057083, 4507.90984180308, 4513.458384993822, 6116.3883611638485, 6318.494520438446, 6362.6818659067785, 6377.96811015942, 6402.903956440564, 6128.295246046761, 6142.218756560547, 6161.907571386343, 6165.766846630781, 6185.597936134137, 5921.85195370102, 6116.694165291807, 6148.262208535004, 6152.692365381802, 6179.783707570214, 6024.759009639565, 6062.636241825505, 6062.696865156637, 6082.574219804571, 6141.785037523665, 6140.92533806591, 6170.007546339932, 6182.567220294536, 6190.907136392868, 6201.441870231701, 5764.07774756037, 6001.219841420588, 6007.279126504847, 6017.338092809875, 6064.666443345658], "value": 4582.606888612401, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.4925346285304, 821.671331467413, 834.3033566971578, 853.3727710133053, 910.1171863292603, 17476.30094796208, 17992.820071799277, 18102.728459073092, 18186.5453363666, 18193.545161370974, 16420.507384778444, 16695.248713807876, 16698.081605511692, 16701.415450459237, 16703.415380461687, 735.6910097758954, 869.9565021748919, 876.259560671235, 896.2471523919907, 902.733693560398, 902.0, 907.2923119966437, 907.5235501361805, 914.9496777677225, 917.3716004536881, 927.4759760735196, 942.1191186240886, 949.0556895888566, 949.3022628368144, 950.5722424908785, 945.9479728614923, 946.2146418472652, 947.7109481608106, 947.853082772168, 947.8909925358603, 699.3810477727197, 699.8705239530652, 700.0129816958065, 703.2686006553179, 704.077658267671, 15835.049897006216, 15871.60320991973, 15926.203689815462, 15969.600759980976, 15992.12043337616, 16405.91797041007, 16588.336466541325, 16693.784250506622, 16924.746128808078, 17381.391651292142, 13299.933500332436, 13448.529301474402, 13469.663258418519, 13665.453381864714, 13814.861851381458, 3879.463104668614, 3922.5881282465502, 3946.921061578781, 3950.881473555798, 3988.9828093836177, 85644.57177714133, 85691.57154214189, 86792.0, 86960.0, 92035.53982230046, 12255.387230638433, 12371.13402061847, 12605.243685378906, 12663.746725065446, 12723.745525089631, 24537.509249815263, 24553.140640077512, 24619.507609847704, 24768.380790480383, 24779.0, 9351.290304926799, 9390.436573805593, 9405.43567385959, 9448.0, 9733.513324333755, 5387.515123638891, 5395.757190926418, 5405.000074986062, 5414.512693857571, 5493.066178749622, 4001.7598944063448, 4101.85643502476, 4118.629323360912, 4129.070959034193, 4142.772147531854, 681.6864242448529, 683.7094234950225, 689.5070024932097, 700.5656492974286, 703.4442790195791, 708.4403321376158, 793.1014022665681, 803.3009089459412, 815.6818840652151, 837.6984285657159, 10890.183236257313, 10929.945350273198, 10945.233833631728, 11328.943355283336, 11731.120165987584, 700.4501466348892, 725.6988349834864, 732.578767208857, 733.2410954662006, 741.0810594862332, 5257.8159764408065, 5420.186971954238, 5513.0, 5648.124540696199, 5668.744906479218, 70756.64621676962, 76422.0, 119392.0, 127704.36147819387, 133238.0, 90215.54892225628, 92132.53933730423, 92563.0, 115896.42051789687, 118069.81930180588, 53198.468015320126, 88610.0, 90201.54899225463, 91952.54023729972, 93895.0, 10550.947245263724, 10912.345259284468, 11314.434278286217, 11572.132090093444, 11661.6501504955, 48152.759236203594, 48916.510834891196, 51233.23150152676, 54337.72831135819, 54696.726516368755, 75367.0, 78826.21173788188, 80820.59589702013, 81500.0, 82566.0, 13510.594682159552, 13642.795358069836, 13670.248136352198, 13821.585352439442, 13999.16005039701, 14456.349464273922, 14544.27278636085, 15488.457903973307, 16540.172991350624, 16729.330826766793, 13353.599392018255, 14835.925820371262, 15545.611359715645, 16009.759853602438, 16014.119223442356, 14127.788083178555, 14223.359948802536, 14625.122492650475, 14848.680614222618, 15620.921895390451, 14134.222617756122, 14505.419783208976, 14745.410183592965, 15800.92099539495, 16228.91885540612, 12064.879351206375, 12410.937945310216, 12425.37873106359, 12443.813342799684, 12646.87353126457, 12769.297688627215, 13032.674183145496, 13053.477860885838, 13113.0, 13164.47342106305], "value": 8292.47505181669, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 104.0, 110.0, 110.0, 112.0, 110.0, 110.0, 110.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 116.0, 146.0, 193.0, 120.0, 145.0, 142.0, 119.0, 175.0, 114.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 160.0, 161.0, 162.0, 163.0, 162.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 178.0, 75.0, 77.0, 76.0, 74.0, 178.0, 75.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 149.0, 84.0, 83.0, 83.0, 133.0, 85.0, 84.0, 143.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 56.0, 53.0, 53.0, 52.0, 59.0, 52.0, 54.0, 52.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 60.0, 60.0, 65.0, 60.0, 59.0, 60.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 72.0, 72.0, 74.0, 72.0, 72.0, 71.0, 77.0, 81.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 119.0, 133.0, 134.0, 123.0, 130.0, 138.0, 126.0, 152.0, 123.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 154.0, 158.0, 155.0, 157.0, 157.0, 155.0, 155.0, 157.0, 155.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 62.0, 65.0, 63.0, 61.0, 62.0, 64.0, 60.0], "value": 62.6, "unit": "score"}]}]} 06:54:47 INFO - Return code: 0 06:54:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:54:47 ERROR - # TBPL SUCCESS # 06:54:47 INFO - Running post-action listener: _resource_record_post_action 06:54:47 INFO - [mozharness: 2016-08-16 13:54:47.287936Z] Finished run-tests step (success) 06:54:47 INFO - Running post-run listener: _resource_record_post_run 06:54:47 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 602112; Write bytes: 250073088; Read time: 88; Write time: 141408 06:54:47 INFO - TinderboxPrint: CPU usage
13.3% 06:54:47 INFO - TinderboxPrint: I/O read bytes / time
602,112 / 88 06:54:47 INFO - TinderboxPrint: I/O write bytes / time
250,073,088 / 141,408 06:54:47 INFO - TinderboxPrint: CPU idle
8,222.3 (86.7%) 06:54:47 INFO - TinderboxPrint: CPU user
1,200.4 (12.7%) 06:54:47 INFO - TinderboxPrint: Swap in / out
0 / 0 06:54:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 4141056; Read time: 0; Write time: 368 06:54:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 598016; Write bytes: 245579776; Read time: 80; Write time: 141036 06:54:47 INFO - Running post-run listener: _upload_blobber_files 06:54:47 INFO - Blob upload gear active. 06:54:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:54:47 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 06:54:47 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'] 06:54:47 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 06:54:48 INFO - (blobuploader) - INFO - Open directory for files ... 06:54:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:54:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:54:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:49 INFO - (blobuploader) - INFO - Done attempting. 06:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:54:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:49 INFO - (blobuploader) - INFO - Done attempting. 06:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:54:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:54:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:54:53 INFO - (blobuploader) - INFO - Done attempting. 06:54:53 INFO - (blobuploader) - INFO - Iteration through files over. 06:54:53 INFO - Return code: 0 06:54:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:54:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:54:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dff8e42fec3667c9ddc8336175f1f61d9284abac155a15ffe022b04070b3c7f52f0b756bb4ed6e93a9ca74d9901f28603f6fd413319b6513cf90bc025c83ff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d999b67ff3eab1778dd8db4c80aa116009dd666ca8dfb00ac793869aa2f497a53ff4e415834f228a699183d71b136c9e79506c17f20502465597003ac82c92ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3bb2c7b484adf55cf01bc03318f6b368dc9c2d6e07655fd35ceb45704f42241354cc5cb6678a5207f20737947cd817d03525594f997669fbdd31d78ffb548c2"} 06:54:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:54:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:54:53 INFO - Contents: 06:54:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dff8e42fec3667c9ddc8336175f1f61d9284abac155a15ffe022b04070b3c7f52f0b756bb4ed6e93a9ca74d9901f28603f6fd413319b6513cf90bc025c83ff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d999b67ff3eab1778dd8db4c80aa116009dd666ca8dfb00ac793869aa2f497a53ff4e415834f228a699183d71b136c9e79506c17f20502465597003ac82c92ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3bb2c7b484adf55cf01bc03318f6b368dc9c2d6e07655fd35ceb45704f42241354cc5cb6678a5207f20737947cd817d03525594f997669fbdd31d78ffb548c2"} 06:54:53 INFO - Running post-run listener: copy_logs_to_upload_dir 06:54:53 INFO - Copying logs to upload dir... 06:54:53 INFO - mkdir: /builds/slave/test/build/upload/logs 06:54:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1690.408535 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 10 secs) (at 2016-08-16 06:54:53.967304) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 06:54:53.970496) ========= 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=523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936 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/8dff8e42fec3667c9ddc8336175f1f61d9284abac155a15ffe022b04070b3c7f52f0b756bb4ed6e93a9ca74d9901f28603f6fd413319b6513cf90bc025c83ff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d999b67ff3eab1778dd8db4c80aa116009dd666ca8dfb00ac793869aa2f497a53ff4e415834f228a699183d71b136c9e79506c17f20502465597003ac82c92ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3bb2c7b484adf55cf01bc03318f6b368dc9c2d6e07655fd35ceb45704f42241354cc5cb6678a5207f20737947cd817d03525594f997669fbdd31d78ffb548c2"} build_url:https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/INZJ-VwfTGKlb4O9ejOpIw/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/8dff8e42fec3667c9ddc8336175f1f61d9284abac155a15ffe022b04070b3c7f52f0b756bb4ed6e93a9ca74d9901f28603f6fd413319b6513cf90bc025c83ff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d999b67ff3eab1778dd8db4c80aa116009dd666ca8dfb00ac793869aa2f497a53ff4e415834f228a699183d71b136c9e79506c17f20502465597003ac82c92ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3bb2c7b484adf55cf01bc03318f6b368dc9c2d6e07655fd35ceb45704f42241354cc5cb6678a5207f20737947cd817d03525594f997669fbdd31d78ffb548c2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 06:54:53.995306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 06:54:53.995595) ========= 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=523ca41ca1e0623de333ad52000001bf-1471353775.385388-902952936 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 06:54:54.077654) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 06:54:54.077956) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 06:54:54.078270) ========= ========= Total master_lag: 0.19 =========