builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1467326406.85 results: success (0) buildid: 20160630132027 builduid: 1325bdc5482144bda9ee6efe5b013cfb revision: 889eeaa0392862a345767a4427caf3bb08e46aaa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:06.847913) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:06.848566) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:06.848987) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:06.866034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:06.866592) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 15:40:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-06-30 15:40:07 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164279 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:07.047378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:07.047880) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017363 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:07.099477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:07.100048) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 889eeaa0392862a345767a4427caf3bb08e46aaa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 889eeaa0392862a345767a4427caf3bb08e46aaa --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=9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 15:40:07,166 truncating revision to first 12 chars 2016-06-30 15:40:07,166 Setting DEBUG logging. 2016-06-30 15:40:07,166 attempt 1/10 2016-06-30 15:40:07,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/889eeaa03928?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 15:40:07,485 unpacking tar archive at: larch-889eeaa03928/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676135 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:07.790826) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:07.791147) ========= script_repo_revision: 889eeaa0392862a345767a4427caf3bb08e46aaa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:07.791548) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:07.791820) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 15:40:07.801786) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-30 15:40:07.802185) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 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', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] 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=9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:40:07 INFO - MultiFileLogger online at 20160630 15:40:07 in /builds/slave/test 15:40:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 15:40:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:40:07 INFO - {'append_to_log': False, 15:40:07 INFO - 'base_work_dir': '/builds/slave/test', 15:40:07 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 15:40:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:40:07 INFO - 'branch': 'Larch-Non-PGO', 15:40:07 INFO - 'buildbot_json_path': 'buildprops.json', 15:40:07 INFO - 'config_files': ('talos/linux_config.py',), 15:40:07 INFO - 'default_actions': ('clobber', 15:40:07 INFO - 'read-buildbot-config', 15:40:07 INFO - 'download-and-extract', 15:40:07 INFO - 'populate-webroot', 15:40:07 INFO - 'create-virtualenv', 15:40:07 INFO - 'install', 15:40:07 INFO - 'run-tests'), 15:40:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:40:07 INFO - 'download_minidump_stackwalk': True, 15:40:07 INFO - 'download_symbols': 'ondemand', 15:40:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:40:07 INFO - 'tooltool.py': '/tools/tooltool.py', 15:40:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:40:07 INFO - '/tools/misc-python/virtualenv.py')}, 15:40:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:40:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:40:07 INFO - 'installer_path': 'installer.exe', 15:40:07 INFO - 'log_level': 'info', 15:40:07 INFO - 'log_name': 'talos', 15:40:07 INFO - 'log_to_console': True, 15:40:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:40:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:40:07 INFO - 'opt_config_files': (), 15:40:07 INFO - 'pip_index': False, 15:40:07 INFO - 'sps_profile': False, 15:40:07 INFO - 'sps_profile_interval': 0, 15:40:07 INFO - 'suite': 'dromaeojs', 15:40:07 INFO - 'system_bits': '32', 15:40:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:40:07 INFO - 'title': 'talos-linux64-ix-040', 15:40:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:40:07 INFO - 'use_talos_json': True, 15:40:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:40:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:40:07 INFO - 'work_dir': 'build'} 15:40:07 INFO - ##### 15:40:07 INFO - ##### Running clobber step. 15:40:07 INFO - ##### 15:40:07 INFO - Running pre-action listener: _resource_record_pre_action 15:40:07 INFO - Running main action method: clobber 15:40:07 INFO - rmtree: /builds/slave/test/build 15:40:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:40:08 INFO - Running post-action listener: _resource_record_post_action 15:40:08 INFO - ##### 15:40:08 INFO - ##### Running read-buildbot-config step. 15:40:08 INFO - ##### 15:40:08 INFO - Running pre-action listener: _resource_record_pre_action 15:40:08 INFO - Running main action method: read_buildbot_config 15:40:08 INFO - Using buildbot properties: 15:40:08 INFO - { 15:40:08 INFO - "project": "", 15:40:08 INFO - "product": "firefox", 15:40:08 INFO - "script_repo_revision": "production", 15:40:08 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 15:40:08 INFO - "repository": "", 15:40:08 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 15:40:08 INFO - "buildid": "20160630132027", 15:40:08 INFO - "pgo_build": "False", 15:40:08 INFO - "basedir": "/builds/slave/test", 15:40:08 INFO - "buildnumber": 2, 15:40:08 INFO - "slavename": "talos-linux64-ix-040", 15:40:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:40:08 INFO - "platform": "ubuntu64_hw", 15:40:08 INFO - "scheduler": "tests-larch-linux64-talos", 15:40:08 INFO - "branch": "larch", 15:40:08 INFO - "repo_path": "projects/larch", 15:40:08 INFO - "revision": "889eeaa0392862a345767a4427caf3bb08e46aaa", 15:40:08 INFO - "stage_platform": "linux64", 15:40:08 INFO - "builduid": "1325bdc5482144bda9ee6efe5b013cfb", 15:40:08 INFO - "slavebuilddir": "test" 15:40:08 INFO - } 15:40:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2. 15:40:08 INFO - Running post-action listener: _resource_record_post_action 15:40:08 INFO - ##### 15:40:08 INFO - ##### Running download-and-extract step. 15:40:08 INFO - ##### 15:40:08 INFO - Running pre-action listener: _resource_record_pre_action 15:40:08 INFO - Running main action method: download_and_extract 15:40:08 INFO - mkdir: /builds/slave/test/build/tests 15:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:08 INFO - https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:40:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 15:40:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 15:40:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 15:40:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:40:09 INFO - Downloaded 1448 bytes. 15:40:09 INFO - Reading from file /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 15:40:09 INFO - Using the following test package requirements: 15:40:09 INFO - {u'common': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'], 15:40:09 INFO - u'cppunittest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 15:40:09 INFO - u'firefox-47.0.2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:40:09 INFO - u'gtest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 15:40:09 INFO - u'firefox-47.0.2.en-US.linux-x86_64.gtest.tests.zip'], 15:40:09 INFO - u'jittest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 15:40:09 INFO - u'jsshell-linux-x86_64.zip'], 15:40:09 INFO - u'mochitest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 15:40:09 INFO - u'firefox-47.0.2.en-US.linux-x86_64.mochitest.tests.zip'], 15:40:09 INFO - u'mozbase': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'], 15:40:09 INFO - u'reftest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 15:40:09 INFO - u'firefox-47.0.2.en-US.linux-x86_64.reftest.tests.zip'], 15:40:09 INFO - u'talos': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 15:40:09 INFO - u'firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip'], 15:40:09 INFO - u'web-platform': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 15:40:09 INFO - u'firefox-47.0.2.en-US.linux-x86_64.web-platform.tests.zip'], 15:40:09 INFO - u'webapprt': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'], 15:40:09 INFO - u'xpcshell': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 15:40:09 INFO - u'firefox-47.0.2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:40:09 INFO - Downloading packages: [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:09 INFO - https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:40:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 15:40:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 15:40:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 15:40:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:40:10 INFO - Downloaded 22140718 bytes. 15:40:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:40:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:40:11 INFO - Return code: 0 15:40:11 INFO - Downloading packages: [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:40:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:11 INFO - https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:40:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 15:40:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 15:40:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 15:40:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:40:12 INFO - Downloaded 22140718 bytes. 15:40:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:40:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:40:13 INFO - Return code: 0 15:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:13 INFO - https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:40:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip 15:40:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip 15:40:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip 15:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:40:14 INFO - Downloaded 10845194 bytes. 15:40:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:40:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:40:14 INFO - Return code: 0 15:40: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')]} 15:40:14 INFO - https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:40:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 15:40:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 15:40:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 15:40:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:40:16 INFO - Downloaded 59001646 bytes. 15:40:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 15:40:16 INFO - mkdir: /builds/slave/test/properties 15:40:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:40:16 INFO - Writing to file /builds/slave/test/properties/build_url 15:40:16 INFO - Contents: 15:40:16 INFO - build_url:https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 15:40:17 INFO - Running post-action listener: _resource_record_post_action 15:40:17 INFO - Running post-action listener: set_extra_try_arguments 15:40:17 INFO - ##### 15:40:17 INFO - ##### Running populate-webroot step. 15:40:17 INFO - ##### 15:40:17 INFO - Running pre-action listener: _resource_record_pre_action 15:40:17 INFO - Running main action method: populate_webroot 15:40:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:40:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:40:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:40:17 INFO - '--tppagecycles', 15:40:17 INFO - '7'], 15:40:17 INFO - 'tests': ['tsvgm']}}, 15:40:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:40:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:40:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:40:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:40:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:40:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:40:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:40:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:17 INFO - 'talos_options': ['--e10s'], 15:40:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:40:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:17 INFO - 'tests': ['damp', 'tps']}, 15:40:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:17 INFO - 'talos_options': ['--e10s'], 15:40:17 INFO - 'tests': ['damp', 'tps']}, 15:40:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:40:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:40:17 INFO - 'other': {'tests': ['a11yr', 15:40:17 INFO - 'ts_paint', 15:40:17 INFO - 'tpaint', 15:40:17 INFO - 'sessionrestore', 15:40:17 INFO - 'sessionrestore_no_auto_restore', 15:40:17 INFO - 'tabpaint']}, 15:40:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:40:17 INFO - 'tests': ['a11yr', 15:40:17 INFO - 'ts_paint', 15:40:17 INFO - 'tpaint', 15:40:17 INFO - 'sessionrestore', 15:40:17 INFO - 'sessionrestore_no_auto_restore', 15:40:17 INFO - 'tabpaint']}, 15:40:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:40:17 INFO - 'tests': ['a11yr', 15:40:17 INFO - 'ts_paint', 15:40:17 INFO - 'tpaint', 15:40:17 INFO - 'sessionrestore', 15:40:17 INFO - 'sessionrestore_no_auto_restore', 15:40:17 INFO - 'tabpaint']}, 15:40:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:40:17 INFO - 'tests': ['a11yr', 15:40:17 INFO - 'ts_paint', 15:40:17 INFO - 'tpaint', 15:40:17 INFO - 'sessionrestore', 15:40:17 INFO - 'sessionrestore_no_auto_restore', 15:40:17 INFO - 'tabpaint']}, 15:40:17 INFO - 'other_l64': {'tests': ['a11yr', 15:40:17 INFO - 'ts_paint', 15:40:17 INFO - 'tpaint', 15:40:17 INFO - 'sessionrestore', 15:40:17 INFO - 'sessionrestore_no_auto_restore', 15:40:17 INFO - 'tabpaint']}, 15:40:17 INFO - 'other_nol64': {'tests': ['a11yr', 15:40:17 INFO - 'ts_paint', 15:40:17 INFO - 'tpaint', 15:40:17 INFO - 'sessionrestore', 15:40:17 INFO - 'sessionrestore_no_auto_restore', 15:40:17 INFO - 'tabpaint']}, 15:40:17 INFO - 'svgr': {'tests': ['tsvgx', 15:40:17 INFO - 'tsvgr_opacity', 15:40:17 INFO - 'tart', 15:40:17 INFO - 'tscrollx', 15:40:17 INFO - 'cart']}, 15:40:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:40:17 INFO - 'tests': ['tsvgx', 15:40:17 INFO - 'tsvgr_opacity', 15:40:17 INFO - 'tart', 15:40:17 INFO - 'tscrollx', 15:40:17 INFO - 'cart']}, 15:40:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:17 INFO - 'tests': ['tp5o']}, 15:40:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:17 INFO - 'talos_options': ['--e10s'], 15:40:17 INFO - 'tests': ['tp5o']}, 15:40:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:17 INFO - 'talos_options': ['--xperf_path', 15:40:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:40:17 INFO - 'tests': ['tp5n']}, 15:40:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:40:17 INFO - 'talos_options': ['--e10s', 15:40:17 INFO - '--xperf_path', 15:40:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:40:17 INFO - 'tests': ['tp5n']}}, 15:40:17 INFO - 'talos.zip': {'path': '', 15:40:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:40:17 INFO - Running post-action listener: _resource_record_post_action 15:40:17 INFO - ##### 15:40:17 INFO - ##### Running create-virtualenv step. 15:40:17 INFO - ##### 15:40:17 INFO - Running pre-action listener: _resource_record_pre_action 15:40:17 INFO - Running main action method: create_virtualenv 15:40:17 INFO - Creating virtualenv /builds/slave/test/build/venv 15:40:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:40:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:40:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:40:17 INFO - Using real prefix '/usr' 15:40:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:40:17 INFO - Installing distribute.............................................................................................................................................................................................done. 15:40:19 INFO - Installing pip.................done. 15:40:19 INFO - Return code: 0 15:40:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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')]} 15:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:19 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 0x7f8ee65bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1723410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b2160>, '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 0x17b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b34f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:40:19 INFO - Using env: {'DISPLAY': ':0', 15:40:19 INFO - 'HOME': '/home/cltbld', 15:40:19 INFO - 'LANG': 'en_US.UTF-8', 15:40:19 INFO - 'LANGUAGE': 'en_US:en', 15:40:19 INFO - 'LOGNAME': 'cltbld', 15:40:19 INFO - 'MAIL': '/var/mail/cltbld', 15:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:19 INFO - 'MOZ_NO_REMOTE': '1', 15:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:19 INFO - 'NO_EM_RESTART': '1', 15:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:19 INFO - 'PWD': '/builds/slave/test', 15:40:19 INFO - 'SHELL': '/bin/bash', 15:40:19 INFO - 'SHLVL': '1', 15:40:19 INFO - 'TERM': 'linux', 15:40:19 INFO - 'TMOUT': '86400', 15:40:19 INFO - 'USER': 'cltbld', 15:40:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 15:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:19 INFO - '_': '/tools/buildbot/bin/python'} 15:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:40:19 INFO - Cleaning up... 15:40:19 INFO - Return code: 0 15:40:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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')]} 15:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:19 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee65bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1723410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b2160>, '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 0x17b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b34f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:19 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>=0.7.1'] in /builds/slave/test/build 15:40:19 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>=0.7.1 15:40:19 INFO - Using env: {'DISPLAY': ':0', 15:40:19 INFO - 'HOME': '/home/cltbld', 15:40:19 INFO - 'LANG': 'en_US.UTF-8', 15:40:19 INFO - 'LANGUAGE': 'en_US:en', 15:40:19 INFO - 'LOGNAME': 'cltbld', 15:40:19 INFO - 'MAIL': '/var/mail/cltbld', 15:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:19 INFO - 'MOZ_NO_REMOTE': '1', 15:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:19 INFO - 'NO_EM_RESTART': '1', 15:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:19 INFO - 'PWD': '/builds/slave/test', 15:40:19 INFO - 'SHELL': '/bin/bash', 15:40:19 INFO - 'SHLVL': '1', 15:40:19 INFO - 'TERM': 'linux', 15:40:19 INFO - 'TMOUT': '86400', 15:40:19 INFO - 'USER': 'cltbld', 15:40:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 15:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:19 INFO - '_': '/tools/buildbot/bin/python'} 15:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:20 INFO - Downloading/unpacking psutil>=0.7.1 15:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:40:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:40:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:40:22 INFO - Installing collected packages: psutil 15:40:22 INFO - Running setup.py install for psutil 15:40:22 INFO - building 'psutil._psutil_linux' extension 15:40:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:40:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:40:22 INFO - building 'psutil._psutil_posix' extension 15:40:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:40:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:40:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:40:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:40:22 INFO - Successfully installed psutil 15:40:22 INFO - Cleaning up... 15:40:22 INFO - Return code: 0 15:40:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee65bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1723410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b2160>, '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 0x17b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b34f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:40:22 INFO - Using env: {'DISPLAY': ':0', 15:40:22 INFO - 'HOME': '/home/cltbld', 15:40:22 INFO - 'LANG': 'en_US.UTF-8', 15:40:22 INFO - 'LANGUAGE': 'en_US:en', 15:40:22 INFO - 'LOGNAME': 'cltbld', 15:40:22 INFO - 'MAIL': '/var/mail/cltbld', 15:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:22 INFO - 'MOZ_NO_REMOTE': '1', 15:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:22 INFO - 'NO_EM_RESTART': '1', 15:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:22 INFO - 'PWD': '/builds/slave/test', 15:40:22 INFO - 'SHELL': '/bin/bash', 15:40:22 INFO - 'SHLVL': '1', 15:40:22 INFO - 'TERM': 'linux', 15:40:22 INFO - 'TMOUT': '86400', 15:40:22 INFO - 'USER': 'cltbld', 15:40:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 15:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:22 INFO - '_': '/tools/buildbot/bin/python'} 15:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:40:24 INFO - Installing collected packages: mozsystemmonitor 15:40:24 INFO - Running setup.py install for mozsystemmonitor 15:40:24 INFO - Successfully installed mozsystemmonitor 15:40:24 INFO - Cleaning up... 15:40:25 INFO - Return code: 0 15:40:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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')]} 15:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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', '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 0x7f8ee65bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1723410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b2160>, '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 0x17b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b34f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:40: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 blobuploader==1.2.4 15:40:25 INFO - Using env: {'DISPLAY': ':0', 15:40:25 INFO - 'HOME': '/home/cltbld', 15:40:25 INFO - 'LANG': 'en_US.UTF-8', 15:40:25 INFO - 'LANGUAGE': 'en_US:en', 15:40:25 INFO - 'LOGNAME': 'cltbld', 15:40:25 INFO - 'MAIL': '/var/mail/cltbld', 15:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:25 INFO - 'MOZ_NO_REMOTE': '1', 15:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:25 INFO - 'NO_EM_RESTART': '1', 15:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:25 INFO - 'PWD': '/builds/slave/test', 15:40:25 INFO - 'SHELL': '/bin/bash', 15:40:25 INFO - 'SHLVL': '1', 15:40:25 INFO - 'TERM': 'linux', 15:40:25 INFO - 'TMOUT': '86400', 15:40:25 INFO - 'USER': 'cltbld', 15:40:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 15:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:25 INFO - '_': '/tools/buildbot/bin/python'} 15:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:25 INFO - Downloading/unpacking blobuploader==1.2.4 15:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:27 INFO - Downloading blobuploader-1.2.4.tar.gz 15:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:40:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:40:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:27 INFO - Downloading docopt-0.6.1.tar.gz 15:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:40:27 INFO - Installing collected packages: blobuploader, requests, docopt 15:40:27 INFO - Running setup.py install for blobuploader 15:40:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:40:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:40:27 INFO - Running setup.py install for requests 15:40:28 INFO - Running setup.py install for docopt 15:40:28 INFO - Successfully installed blobuploader requests docopt 15:40:28 INFO - Cleaning up... 15:40:28 INFO - Return code: 0 15:40:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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')]} 15:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:28 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 0x7f8ee65bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1723410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b2160>, '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 0x17b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b34f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:40:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:40:28 INFO - Using env: {'DISPLAY': ':0', 15:40:28 INFO - 'HOME': '/home/cltbld', 15:40:28 INFO - 'LANG': 'en_US.UTF-8', 15:40:28 INFO - 'LANGUAGE': 'en_US:en', 15:40:28 INFO - 'LOGNAME': 'cltbld', 15:40:28 INFO - 'MAIL': '/var/mail/cltbld', 15:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:28 INFO - 'MOZ_NO_REMOTE': '1', 15:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:28 INFO - 'NO_EM_RESTART': '1', 15:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:28 INFO - 'PWD': '/builds/slave/test', 15:40:28 INFO - 'SHELL': '/bin/bash', 15:40:28 INFO - 'SHLVL': '1', 15:40:28 INFO - 'TERM': 'linux', 15:40:28 INFO - 'TMOUT': '86400', 15:40:28 INFO - 'USER': 'cltbld', 15:40:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 15:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:28 INFO - '_': '/tools/buildbot/bin/python'} 15:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:28 INFO - Running setup.py (path:/tmp/pip-6347nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:28 INFO - Running setup.py (path:/tmp/pip-ZeAwXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:28 INFO - Running setup.py (path:/tmp/pip-dlHxNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:28 INFO - Running setup.py (path:/tmp/pip-woX8dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:28 INFO - Running setup.py (path:/tmp/pip-94nxHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:29 INFO - Running setup.py (path:/tmp/pip-MscD5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:29 INFO - Running setup.py (path:/tmp/pip-ny_pJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:29 INFO - Running setup.py (path:/tmp/pip-Q03TJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:29 INFO - Running setup.py (path:/tmp/pip-PRUa9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:29 INFO - Running setup.py (path:/tmp/pip-7sRpFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:29 INFO - Running setup.py (path:/tmp/pip-x4vQ6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:29 INFO - Running setup.py (path:/tmp/pip-MH81qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:29 INFO - Running setup.py (path:/tmp/pip-BiR4tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:29 INFO - Running setup.py (path:/tmp/pip-eDm8kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:29 INFO - Running setup.py (path:/tmp/pip-O8j6A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:29 INFO - Running setup.py (path:/tmp/pip-HbITuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:29 INFO - Running setup.py (path:/tmp/pip-p7hAcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:40:29 INFO - Running setup.py install for manifestparser 15:40:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:40:30 INFO - Running setup.py install for mozcrash 15:40:30 INFO - Running setup.py install for mozdebug 15:40:30 INFO - Running setup.py install for mozdevice 15:40:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:40:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:40:30 INFO - Running setup.py install for mozfile 15:40:30 INFO - Running setup.py install for mozhttpd 15:40:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:40:30 INFO - Running setup.py install for mozinfo 15:40:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:40:30 INFO - Running setup.py install for mozInstall 15:40:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:40:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:40:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:40:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:40:30 INFO - Running setup.py install for mozleak 15:40:30 INFO - Running setup.py install for mozlog 15:40:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:40:30 INFO - Running setup.py install for moznetwork 15:40:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:40:31 INFO - Running setup.py install for mozprocess 15:40:31 INFO - Running setup.py install for mozprofile 15:40:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:40:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:40:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:40:31 INFO - Running setup.py install for mozrunner 15:40:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:40:31 INFO - Running setup.py install for mozscreenshot 15:40:31 INFO - Running setup.py install for moztest 15:40:31 INFO - Running setup.py install for mozversion 15:40:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:40:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:40:31 INFO - Cleaning up... 15:40:31 INFO - Return code: 0 15:40:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40: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')]} 15:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:31 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 0x7f8ee65bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1723410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b2160>, '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 0x17b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b34f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:40:31 INFO - Using env: {'DISPLAY': ':0', 15:40:31 INFO - 'HOME': '/home/cltbld', 15:40:31 INFO - 'LANG': 'en_US.UTF-8', 15:40:31 INFO - 'LANGUAGE': 'en_US:en', 15:40:31 INFO - 'LOGNAME': 'cltbld', 15:40:31 INFO - 'MAIL': '/var/mail/cltbld', 15:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:31 INFO - 'MOZ_NO_REMOTE': '1', 15:40:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:31 INFO - 'NO_EM_RESTART': '1', 15:40:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:31 INFO - 'PWD': '/builds/slave/test', 15:40:31 INFO - 'SHELL': '/bin/bash', 15:40:31 INFO - 'SHLVL': '1', 15:40:31 INFO - 'TERM': 'linux', 15:40:31 INFO - 'TMOUT': '86400', 15:40:31 INFO - 'USER': 'cltbld', 15:40:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 15:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:31 INFO - '_': '/tools/buildbot/bin/python'} 15:40:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:31 INFO - Running setup.py (path:/tmp/pip-QqjPHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:40:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:31 INFO - Running setup.py (path:/tmp/pip-tXU5c4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:32 INFO - Running setup.py (path:/tmp/pip-RDTrwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:32 INFO - Running setup.py (path:/tmp/pip-0ChSBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:32 INFO - Running setup.py (path:/tmp/pip-L5ANl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:32 INFO - Running setup.py (path:/tmp/pip-_wkw1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:32 INFO - Running setup.py (path:/tmp/pip-IBuByh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:32 INFO - Running setup.py (path:/tmp/pip-zsQF80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:32 INFO - Running setup.py (path:/tmp/pip-srYzF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:32 INFO - Running setup.py (path:/tmp/pip-vgPrS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:32 INFO - Running setup.py (path:/tmp/pip-vO7wQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:32 INFO - Running setup.py (path:/tmp/pip-7biJXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:32 INFO - Running setup.py (path:/tmp/pip-3FfWZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:32 INFO - Running setup.py (path:/tmp/pip-RNDVM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:32 INFO - Running setup.py (path:/tmp/pip-KhyCai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:33 INFO - Running setup.py (path:/tmp/pip-Fm5X1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:33 INFO - Running setup.py (path:/tmp/pip-xB1b0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:40:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:40: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 15:40: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 15:40: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 15:40: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 15:40: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 15:40: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 15:40:35 INFO - Downloading blessings-1.6.tar.gz 15:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:40:35 INFO - Installing collected packages: blessings 15:40:35 INFO - Running setup.py install for blessings 15:40:35 INFO - Successfully installed blessings 15:40:35 INFO - Cleaning up... 15:40:35 INFO - Return code: 0 15:40:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:35 INFO - Reading from file tmpfile_stdout 15:40:35 INFO - Current package versions: 15:40:35 INFO - argparse == 1.2.1 15:40:35 INFO - blessings == 1.6 15:40:35 INFO - blobuploader == 1.2.4 15:40:35 INFO - docopt == 0.6.1 15:40:35 INFO - manifestparser == 1.1 15:40:35 INFO - mozInstall == 1.12 15:40:35 INFO - mozcrash == 0.17 15:40:35 INFO - mozdebug == 0.1 15:40:35 INFO - mozdevice == 0.48 15:40:35 INFO - mozfile == 1.2 15:40:35 INFO - mozhttpd == 0.7 15:40:35 INFO - mozinfo == 0.9 15:40:35 INFO - mozleak == 0.1 15:40:35 INFO - mozlog == 3.1 15:40:35 INFO - moznetwork == 0.27 15:40:35 INFO - mozprocess == 0.22 15:40:35 INFO - mozprofile == 0.28 15:40:35 INFO - mozrunner == 6.11 15:40:35 INFO - mozscreenshot == 0.1 15:40:35 INFO - mozsystemmonitor == 0.0 15:40:35 INFO - moztest == 0.7 15:40:35 INFO - mozversion == 1.4 15:40:35 INFO - psutil == 3.1.1 15:40:35 INFO - requests == 1.2.3 15:40:35 INFO - wsgiref == 0.1.2 15:40:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:35 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 0x7f8ee65bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1723410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b2160>, '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 0x17b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b34f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:40:35 INFO - Using env: {'DISPLAY': ':0', 15:40:35 INFO - 'HOME': '/home/cltbld', 15:40:35 INFO - 'LANG': 'en_US.UTF-8', 15:40:35 INFO - 'LANGUAGE': 'en_US:en', 15:40:35 INFO - 'LOGNAME': 'cltbld', 15:40:35 INFO - 'MAIL': '/var/mail/cltbld', 15:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:35 INFO - 'MOZ_NO_REMOTE': '1', 15:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:35 INFO - 'NO_EM_RESTART': '1', 15:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:35 INFO - 'PWD': '/builds/slave/test', 15:40:35 INFO - 'SHELL': '/bin/bash', 15:40:35 INFO - 'SHLVL': '1', 15:40:35 INFO - 'TERM': 'linux', 15:40:35 INFO - 'TMOUT': '86400', 15:40:35 INFO - 'USER': 'cltbld', 15:40:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 15:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:35 INFO - '_': '/tools/buildbot/bin/python'} 15:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:40:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:40:35 INFO - Cleaning up... 15:40:35 INFO - Return code: 0 15:40:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee65bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1723410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b2160>, '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 0x17b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b34f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:40:35 INFO - Using env: {'DISPLAY': ':0', 15:40:35 INFO - 'HOME': '/home/cltbld', 15:40:35 INFO - 'LANG': 'en_US.UTF-8', 15:40:35 INFO - 'LANGUAGE': 'en_US:en', 15:40:35 INFO - 'LOGNAME': 'cltbld', 15:40:35 INFO - 'MAIL': '/var/mail/cltbld', 15:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:35 INFO - 'MOZ_NO_REMOTE': '1', 15:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:35 INFO - 'NO_EM_RESTART': '1', 15:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:35 INFO - 'PWD': '/builds/slave/test', 15:40:35 INFO - 'SHELL': '/bin/bash', 15:40:35 INFO - 'SHLVL': '1', 15:40:35 INFO - 'TERM': 'linux', 15:40:35 INFO - 'TMOUT': '86400', 15:40:35 INFO - 'USER': 'cltbld', 15:40:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 15:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:35 INFO - '_': '/tools/buildbot/bin/python'} 15:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:35 INFO - Downloading/unpacking jsonschema 15:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:40:37 INFO - Downloading/unpacking functools32 (from jsonschema) 15:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:38 INFO - Downloading functools32-3.2.3-2.tar.gz 15:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:40:38 INFO - warning: no files found matching '*.txt' 15:40:38 INFO - no previously-included directories found matching 'build' 15:40:38 INFO - no previously-included directories found matching 'dist' 15:40:38 INFO - no previously-included directories found matching '.git*' 15:40:38 INFO - Installing collected packages: jsonschema, functools32 15:40:38 INFO - Running setup.py install for functools32 15:40:38 INFO - warning: no files found matching '*.txt' 15:40:38 INFO - no previously-included directories found matching 'build' 15:40:38 INFO - no previously-included directories found matching 'dist' 15:40:38 INFO - no previously-included directories found matching '.git*' 15:40:38 INFO - Successfully installed jsonschema functools32 15:40:38 INFO - Cleaning up... 15:40:38 INFO - Return code: 0 15:40:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:40:38 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ee65bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1723410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b2160>, '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 0x17b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b34f0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:38 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', 'flake8'] in /builds/slave/test/build 15:40:38 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 flake8 15:40:38 INFO - Using env: {'DISPLAY': ':0', 15:40:38 INFO - 'HOME': '/home/cltbld', 15:40:38 INFO - 'LANG': 'en_US.UTF-8', 15:40:38 INFO - 'LANGUAGE': 'en_US:en', 15:40:38 INFO - 'LOGNAME': 'cltbld', 15:40:38 INFO - 'MAIL': '/var/mail/cltbld', 15:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:38 INFO - 'MOZ_NO_REMOTE': '1', 15:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:38 INFO - 'NO_EM_RESTART': '1', 15:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:38 INFO - 'PWD': '/builds/slave/test', 15:40:38 INFO - 'SHELL': '/bin/bash', 15:40:38 INFO - 'SHLVL': '1', 15:40:38 INFO - 'TERM': 'linux', 15:40:38 INFO - 'TMOUT': '86400', 15:40:38 INFO - 'USER': 'cltbld', 15:40:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 15:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:38 INFO - '_': '/tools/buildbot/bin/python'} 15:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:38 INFO - Downloading/unpacking flake8 15:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:40:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:40: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 15:40: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 15:40: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 15:40: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 15:40: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 15:40: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 15:40:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:40:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:40: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 15:40: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 15:40: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 15:40: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 15:40: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 15:40: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 15:40:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:40: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 15:40: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 15:40: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 15:40: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 15:40: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 15:40: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 15:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:40:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:40:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:40:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:40:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:40:41 INFO - no previously-included directories found matching 'docs/_build' 15:40:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:40:41 INFO - Running setup.py install for pep8 15:40:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:40:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:40:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:40:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:40:41 INFO - no previously-included directories found matching 'docs/_build' 15:40:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:40:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:40:41 INFO - Cleaning up... 15:40:41 INFO - Return code: 0 15:40:41 INFO - Running post-action listener: _resource_record_post_action 15:40:41 INFO - Running post-action listener: _start_resource_monitoring 15:40:41 INFO - Starting resource monitoring. 15:40:41 INFO - ##### 15:40:41 INFO - ##### Running install step. 15:40:41 INFO - ##### 15:40:41 INFO - Running pre-action listener: _resource_record_pre_action 15:40:41 INFO - Running main action method: install 15:40:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:41 INFO - Reading from file tmpfile_stdout 15:40:41 INFO - Detecting whether we're running mozinstall >=1.0... 15:40:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:40:41 INFO - Reading from file tmpfile_stdout 15:40:41 INFO - Output received: 15:40:41 INFO - Usage: mozinstall [options] installer 15:40:41 INFO - Options: 15:40:41 INFO - -h, --help show this help message and exit 15:40:41 INFO - -d DEST, --destination=DEST 15:40:41 INFO - Directory to install application into. [default: 15:40:41 INFO - "/builds/slave/test"] 15:40:41 INFO - --app=APP Application being installed. [default: firefox] 15:40:41 INFO - mkdir: /builds/slave/test/build/application 15:40:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:40:56 INFO - Reading from file tmpfile_stdout 15:40:56 INFO - Output received: 15:40:56 INFO - /builds/slave/test/build/application/firefox/firefox 15:40:56 INFO - Running post-action listener: _resource_record_post_action 15:40:56 INFO - ##### 15:40:56 INFO - ##### Running run-tests step. 15:40:56 INFO - ##### 15:40:56 INFO - Running pre-action listener: _resource_record_pre_action 15:40:56 INFO - Running main action method: run_tests 15:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:40:56 INFO - Python 2.7.3 15:40:56 INFO - Return code: 0 15:40:56 INFO - grabbing minidump binary from tooltool 15:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:56 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b2160>, '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 0x17b3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b34f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:40:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:40:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:40:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:40:56 INFO - Return code: 0 15:40:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:40:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:40:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:40:57 INFO - Return code: 0 15:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:40:57 INFO - Using env: {'DISPLAY': ':0', 15:40:57 INFO - 'HOME': '/home/cltbld', 15:40:57 INFO - 'LANG': 'en_US.UTF-8', 15:40:57 INFO - 'LANGUAGE': 'en_US:en', 15:40:57 INFO - 'LOGNAME': 'cltbld', 15:40:57 INFO - 'MAIL': '/var/mail/cltbld', 15:40:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:57 INFO - 'MOZ_NO_REMOTE': '1', 15:40:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:57 INFO - 'NO_EM_RESTART': '1', 15:40:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:57 INFO - 'PWD': '/builds/slave/test', 15:40:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:57 INFO - 'SHELL': '/bin/bash', 15:40:57 INFO - 'SHLVL': '1', 15:40:57 INFO - 'TERM': 'linux', 15:40:57 INFO - 'TMOUT': '86400', 15:40:57 INFO - 'USER': 'cltbld', 15:40:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321', 15:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:57 INFO - '_': '/tools/buildbot/bin/python'} 15:40:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:40:57 INFO - mozversion application_buildid: 20160630132027 15:40:57 INFO - mozversion application_changeset: 889eeaa0392862a345767a4427caf3bb08e46aaa 15:40:57 INFO - mozversion application_display_name: Nightly 15:40:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:57 INFO - mozversion application_name: Firefox 15:40:57 INFO - mozversion application_remotingname: firefox 15:40:57 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 15:40:57 INFO - mozversion application_vendor: Mozilla 15:40:57 INFO - mozversion application_version: 47.0.2 15:40:57 INFO - mozversion platform_buildid: 20160630132027 15:40:57 INFO - mozversion platform_changeset: 889eeaa0392862a345767a4427caf3bb08e46aaa 15:40:57 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 15:40:57 INFO - mozversion platform_version: 47.0.2 15:40:57 INFO - using testdate: 1467326457 15:40:57 INFO - actual date: 1467326457 15:40:57 INFO - starting webserver on 'localhost:44997' 15:40:57 INFO - SUITE-START | Running 2 tests 15:40:57 INFO - TEST-START | dromaeo_css 15:40:57 INFO - operating with platform_type : linux_ 15:40:57 INFO - Initialising browser for dromaeo_css test... 15:40:57 INFO - TEST-INFO | started process 13173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpByvfnV/profile http://localhost:44997/getInfo.html) 15:41:02 INFO - PROCESS | 13173 | __metrics Screen width/height:1600/1200 15:41:02 INFO - PROCESS | 13173 | colorDepth:24 15:41:02 INFO - PROCESS | 13173 | Browser inner width/height: 1024/697 15:41:02 INFO - PROCESS | 13173 | __metrics 15:41:03 INFO - PROCESS | 13173 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:41:04 INFO - TEST-INFO | 13173: exit 0 15:41:04 INFO - Browser initialized. 15:41:04 INFO - Running cycle 1/1 for dromaeo_css test... 15:41:04 INFO - TEST-INFO | started process 13259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpByvfnV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:41:16 INFO - PROCESS | 13259 | RSS: Main: 138756096 15:41:16 INFO - PROCESS | 13259 | 15:42:07 INFO - PROCESS | 13259 | 1467326527451 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:44:18 INFO - PROCESS | 13259 | Cycle 1(1): loaded http://localhost:44997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44997/tests/dromaeo/cssquery-ext.html) 15:44:19 INFO - PROCESS | 13259 | RSS: Main: 235372544 15:44:19 INFO - PROCESS | 13259 | 15:47:21 INFO - PROCESS | 13259 | Cycle 1(1): loaded http://localhost:44997/tests/dromaeo/cssquery-ext.html (next: http://localhost:44997/tests/dromaeo/cssquery-jquery.html) 15:47:22 INFO - PROCESS | 13259 | RSS: Main: 223997952 15:47:22 INFO - PROCESS | 13259 | 15:50:23 INFO - PROCESS | 13259 | Cycle 1(1): loaded http://localhost:44997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44997/tests/dromaeo/cssquery-mootools.html) 15:50:24 INFO - PROCESS | 13259 | RSS: Main: 221560832 15:50:24 INFO - PROCESS | 13259 | 15:53:26 INFO - PROCESS | 13259 | Cycle 1(1): loaded http://localhost:44997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44997/tests/dromaeo/cssquery-prototype.html) 15:53:26 INFO - PROCESS | 13259 | RSS: Main: 206270464 15:53:26 INFO - PROCESS | 13259 | 15:56:29 INFO - PROCESS | 13259 | Cycle 1(1): loaded http://localhost:44997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44997/tests/dromaeo/cssquery-yui.html) 15:56:30 INFO - PROCESS | 13259 | RSS: Main: 189644800 15:56:30 INFO - PROCESS | 13259 | 15:59:32 INFO - PROCESS | 13259 | Cycle 1(1): loaded http://localhost:44997/tests/dromaeo/cssquery-yui.html (next: http://localhost:44997/tests/dromaeo/cssquery-dojo.html) 15:59:32 INFO - PROCESS | 13259 | RSS: Main: 250744832 15:59:32 INFO - PROCESS | 13259 | 15:59:32 INFO - PROCESS | 13259 | __start_tp_report 15:59:32 INFO - PROCESS | 13259 | _x_x_mozilla_page_load 15:59:32 INFO - PROCESS | 13259 | _x_x_mozilla_page_load_details 15:59:32 INFO - PROCESS | 13259 | |i|pagename|runs| 15:59:32 INFO - PROCESS | 13259 | |0;dojo.html;2793.2597861566687;2852.7147285271467;2856.5001124803152;2882.596436498889;2896.36280018396;4655.32497787821;4658.32454294128;4663.137319595873;4672.719636821793;4712.622990160788;4677.602403795673;4681.39141911551;4698.365720627714;4699.036697477018;4712.740799256039;4262.296721041024;4339.913201735963;4347.695661303702;4364.214441400547;4369.257226271526;4333.220020396343;4338.652907767387;4361.171377438277;4369.584889435499;4375.234333991555;4355.673324500659;4364.301711726124;4426.535213802553;4448.199324121657;4476.1271552047365;4394.582514661102;4399.560043995607;4400.185965596343;4401.6478681705385;4402.40567523385;4178.310578754502;4288.44250247469;4305.483341998949;4330.415393921811;4333.1766964277;4635.281531362644;4637.86086417408;4640.303954406832;4644.373009643722;4661.347411362412;4814.78333474991;4968.776405061781;4987.401511818605;4992.375953005874;5031.169856973595;4858.708477491362;5053.924191137099;5118.411382691001;5120.871978200537;5156.8968620627375;4652.185867473178;4654.4414670239785;4659.021605462857;4671.5094915034115;4696.835610753607;4865.9756701216265;5111.335526381621;5117.974410127926;5123.462036486189;5143.099957507496;4826.855194344175;4876.707397556158;4891.315215869781;4898.877528061756;4927.1131196384995;5052.520010598987;5064.49355064498;5073.644844860898;5076.238564215398;5105.132127538327;4798.304245884327;4912.459629440758;5045.142325804622;5064.063148317573;5091.210862316347;4990.925136122961;5002;5007.023630392111;5011.674241174312;5031.572316353151;4287.892802679958;4288.356746488052;4290.184864875664;4312.460942382202;4317.244482215599;3647.1611529348397;3730.5336832895887;3791.5829258781514;3795.3358162321483;3818.420842960714;4454.710443821141;4456.175607512556;4460.710053846489;4461.7992190351515;4487.394201782783;5031.6729412588065;5077.009983053269;5078.873028174251;5081.898362032739;5112.488751124858;4277.764722940268;4371.672124590668;4387.5393083726385;4405.405270288534;4431.135928493913;4472.038511719996;4487.326900964816;4488.4165058542185;4520.367148599199;4533.9319910201375;4863.781129849165;4863.975680121577;4867.537583929521;4869.0261947611325;4897.069556784199;4724.244120940633;4942.159832828356;5005;5026.0199261143725;5039.067772462106;4848.515148485123;4855.223164293696;4879.4876537963;4882.707037577757;4908.803647854046;4830.7826147822725;4968.155413579628;4976.203807390945;4987.3017777511905;4991.6006719463085;4994.300797888226;5041.19340905468;5054.924176137288;5079.441261461162;5088.821891233937;4786.784594693317;4789.425268967746;4790.377250957354;4795.664303498722;4816.735079570657;4643.117807616677;4776.5701086902345;4796.664233503621;4801.831935882367;4831.51684831514;4793.376861008047;4796.448408433075;4816.060868130681;4821.710697358169;4848.151573474698;4952.455229924777;4956.330895329229;4958.801647934042;4960.751962401938;4973.776180071978;4654;4680.4851466338;4749.477557468606;4804.543568361;4851 15:59:32 INFO - PROCESS | 13259 | |1;ext.html;522.6367674466247;537.1003569021889;552.1496894782036;558.9916151257731;569.9886002279954;27864.16407507773;28314.71685283149;35828;35914.10214744626;35918.820405898;38321.23357532848;38754.80622596883;38789;38805.80597097018;38828;8020.799480012988;8210.425270231086;8217.137200593941;8218.260356567907;8250.917490825104;8282.17178282173;8430;8452.8732069019;8455.746327610152;8458.957705211496;8327.708530201444;8406.873896891551;8437.114103019187;8448.662053517852;8463;8359;8412.705555305534;8439.071702112731;8442.577871106481;8444.197801208875;8329.958350208271;8441.155884411572;8448.662053517852;8449.324054075722;8454.070052294304;39911.8004409979;40271.59728402737;40297.194056119006;40389.79805100985;40497.79751101226;2714.470678217748;2750.724927507253;2818.168640251131;2915.8104723192923;3207.5028370602595;30985;31174.37651246985;31695;31817.363652727046;31943.201419964455;3097.9380412391624;3118.3919135768533;3147.35479226758;3152.6059242594674;3203.343314620497;193714;194095;194829;194926;195375.0231248849;41071.383929241085;41361.586384136375;54580.18129728057;54816;54985.1752223717;39825.60174398277;39845.80077099596;39971.80014099911;40007;40019.79990100031;12556;12662.240265584094;12669.239845609292;12684.238945663104;12685.302308373128;9688.176504997013;9765.755856103655;9769.267304952156;9813.607455701835;9815.607375705034;13830.37763300654;14134.293285335692;14241.430342786172;14257.572272831832;14352.138871667734;5502.394736578973;5505.394406615269;5586.35756887955;5691.743871525791;5744.535143538455;882.2941646682629;939.7885475767897;961.9326647134774;1026.071405378134;1039.6153423233452;27595.86202068977;27668.72331276702;27872.024479143132;28111.71888281091;28554.571681424793;941.9105185007413;997.3168379659957;1011.6206422591529;1018.8879223285433;1034.1364960258268;14480.927595362167;14953.850461495464;14977.326020329112;15192.46826361072;15308.770368444482;280281;284021;285046;285599;287680;48902;50270.24594631083;50467.49532504701;50488.495115048376;50579;1171.9296842189497;1203.6088271311683;1206.1376116077047;1286.9511348251144;1316.493150137185;26343.341416463976;29973.250668733457;30082.548761768154;30800.229994250323;30873;44493.33260001038;44970.77514612406;44974;45070.32394514151;45121.09757804891;221465;222556;223032;224110;224290;31769;32820.671793282716;33020.1744956378;33060.66939330576;33065.834670826494;42934.35598465963;43688.56311436845;43883.341749873136;44090.55909440993;44369.55630443654;35522.467162993096;35704.82147589245;35913.64086359103;36031.63968360283;36808.44787328246;31166.688333116377;31244.531332030492;31541.053768386984;31747.04758857238;31840.203994899388;27436.588451173648;30670.693293067678;30732.84633576818;37042.8147859259;37058.814705927376;23551.882240588686;28587.14238572846;28925.710742893145;28970.42059158847;29116.854415727787;22821;22834.657480138143;23092.96081676295;23178.76821231766;23276.76723232746 15:59:32 INFO - PROCESS | 13259 | |2;jquery.html;356.0813102196334;360.57812359539344;360.67719391144925;364.32417864860685;370.9962900370995;14027.649308767286;15709.84290157098;15749.370025198992;17182.914085429555;17644.206010729533;14413.207273599948;14877.702445951074;14882.925585372084;15127.84872151278;15820.367185312602;5624.409437009116;5772.30732312121;5799.246098007275;5814.912776308359;5815.505682017012;5566.86082847928;5787.421257874221;5838.591298609099;5849;5850.824475265727;5803.680797556154;5810.448007439308;5818.6217895836635;5820.505257053155;5823.06830907055;5628.577856660746;5945.078512830497;5945.464908158287;5947.732352044169;5952.791652292149;5710.857228569277;5713.485786279255;5719.885602287931;5722.713864306809;5724.341700704431;22349.553008939893;22812.31563053111;23031.193908213132;23041.53916921652;23046.884765576233;1866.1322485044384;1953.687410014391;2040.2960978462406;2104.726385569866;2626.6585343905363;13371;13712.862871371359;13803.930980345134;13827.377768000464;14366.35351409189;1887.8300952914167;1906.3327835257687;1913.550315675815;1920.9039548022683;2069.4722845674255;62223;67148.32851671519;67537.66231168812;67681.66159169222;67692;14645.194514301817;14869.18219497938;15245.695086098438;15360.769588456182;15505.689886202214;20440;25134.874325628254;25259.74740252574;25310.240692779247;25357.492850142895;7659.655315510815;8093.3929955252415;8179.509229446252;8209.38429617781;8225.177482251727;6674.966625166843;6772.559783614148;6804.693788779517;6837.453003759687;6953.478489113337;7497.587632680146;7502.474826762074;7661.310482056641;7680;7729.922700773032;2869.684334723179;2983.6568794588466;3014.3217776000665;3094.8297843618816;3205.7275131613605;793.9444238903221;847.809242920338;922.1884741427635;941.4915945389413;953.3374304858057;15776.447824326093;15970.76043859343;16057.839421605868;16920.91539542319;17051.829481705274;892.8438268996467;902.039328115568;932.3100905330007;934.8457504511815;940.3605548227134;9198.586063627154;9402.247820174369;9582.185514231229;9735.221182305399;9827.901720982842;389588;390536;390978;402212;408377;71020.64489677518;71686;72909.27090729131;72977.27022729811;73224.63387683028;954.7231302922214;957.9521023948914;968.7142293023434;977.5385798231689;981.5043403081398;14799.704005920037;14802.703945921237;14808.407663693331;14879;15118.244087795787;32462.675373245966;32917.17707057343;33158.33683326368;33287.16782080467;33687;44807.551924480336;46938.530614693416;46987.530124698314;47232.7638361806;47673;7521.8871716923195;7691.653875575725;7801.45389822707;7852.411069169721;7882.211778822072;9233.630654773733;11047.392393418439;11435.885641143483;11572.768544628892;11746.236494627821;9803.774528183976;10229.74425639365;10422.009909058628;10463.162946964072;10510.579576816841;10289.691309260734;10391.116755075904;10405.427701476492;10405.843912341472;10479.10927571165;10123.949380253052;10305.484725763832;10370.27408081427;10401.739956500845;10664.07180872195;7657.119431265476;7887.44787864844;7913.881291780743;8071.23323284287;8091.919080809352;8190.426670133033;9524.380915240765;10564.577416903237;10753.085987691135;10883.836742449028 15:59:32 INFO - PROCESS | 13259 | |3;mootools.html;1318.0378323823602;1433.8566143385663;1463.1440607244758;1628.6742651469708;1830.725391191322;6715.966420167899;7476.663550140243;7586.355159811423;7636.427267954912;7642.121156067061;7597.2402759724;7703.114141873686;7752.651130699118;7771.572563509018;7778.727744528943;2184.737831460227;2216.002798740565;2217.9001944912516;2219.323106452531;2219.87790671513;2157.4390658428842;2196.2093646287403;2204.371754050096;2216.8115710164657;2218.92233771818;2172.587208430401;2183.5632873425297;2190.539986602815;2200.3948914048683;2202.0201010550313;2165.945851353713;2169.262450766731;2169.631162702344;2170.934871953844;2172.8370372222066;2189.4088596079127;2215.235743668432;2220.8667479951255;2223.6442169253005;2228.74369447514;7916.52500849945;7957.244061814118;7980.04239491259;7983.12185659577;7983.760487185394;4507.842225522091;4592.035672508777;4627.8611641650805;4637.930431043537;4645.744484053375;2894;2895.290653789835;3017.6529699084667;3024.1381206356305;3024.2892920163963;895.9507227102507;923.584387025841;928.4104593583056;962.831504486712;967.1537404770826;9876.308658393915;9922.404655720607;9923.255755818342;9929.50352482373;9958.90041099587;4082.9387559186634;4096.078382364004;4105.67154627629;4169.666426685919;4201.936970945439;8111.06722726894;8115.3913456491;8116.310113640288;8118.472299300644;8123.471974321768;4440.666949978699;4469.7318160910445;4471.083427897273;4474.284114541658;4509.684322097487;3568.6074531801482;3866.5360156781367;3978.6817054635558;4113.095119073799;4130.194612050621;3244.1240864966326;3302.5871766029245;3308.8841890533718;3373.7469689772875;3386.441237195835;975.8389865672226;981.66623348062;986.0730912941812;997.0079770628271;1023.1150055202196;1217.4399776102914;1219.4939100273286;1224.2470880408484;1247.089624574066;1247.681841130506;7357.043584334002;7385.29839665231;7421.777346679608;7429.219931907072;7433.331000210007;1072.1904961753826;1084.7830433913248;1086.9510872010778;1093.1746531368924;1102.3441052573705;5754.827355179351;5852.502537284378;5879;5898.793542226087;5902.704864756831;9263.629454821867;9386.15524602789;9509.476978766095;9621.90378096224;9638.373505722106;9289.34974551775;9435.056494350647;9491.715248542554;9496.097870702271;9527.475988820543;6998.580085194904;7081.964590177016;7162.570245785269;7215.711371545184;7226.927730722626;7099.574025558483;7101.644917754195;7108.431325493844;7126.786196414116;7176.856462870818;8309.709160179365;8382.37132215074;8557;8565.657373704982;8577.914220857712;8642.524661143447;8712.91287087121;8749.6937607186;8787.5166865823;8788.2529984952;5493.121100623881;6226.533010024175;6381.202349706286;6383.648899310582;6908.3091690832525;7010.824729381806;7160.10498687664;7171.748988785367;7215.891761623475;7228.060352154396;5745.396733342939;6179.752809887734;6226.066090086523;6288.937110629018;6306.905396419149;6071.210742603434;6146.846328841814;6152.354002829818;6236.158118653923;6259.34276900937;6747.898781518379;6857.55425897315;6893.0694356261265;6939.132608423947;6971.093757811452;6147.877042459037;6195.628262304276;6215.223097112861;6221.440070393686;6225.533085018551;6291.087792270187;6371.7132729028235;6469.159009328757;6475.579087359307;6486.481081513373 15:59:32 INFO - PROCESS | 13259 | |4;prototype.html;329.42186462757854;333.6996702967329;333.7580254315621;334.9430596798544;339.14535370865434;5392.2181283713835;5394.757235924383;5415.26893869328;5492.945070549294;5504.036793561121;5392.110301800208;5395.460453954603;5398.190271459283;5412.296401467804;5417.404085550586;4036.374361973899;4181.477315335583;4258.53156152823;4279.507856596492;4303.591158839905;4271.402003719466;4286.03564198056;4286.614204721574;4287.978560107195;4300.548442413548;4217.514985776645;4243.257429949762;4245.492850038238;4256.127493863766;4262.46719160105;4027.09390387162;4150.647194988414;4262.488501379823;4262.722923009995;4272.316429371285;3777.565579958285;3781.5840257571645;3786.659200671925;3789.147441825595;3791.6587507124214;5167.276581278624;5171.482851714836;5173.301604283449;5176.352955880515;5178.870528236786;4910.705357678551;4918.803247870117;4919.704817710913;4921;4925.014997000579;5695.316562012544;5699.145128230799;5706.1440783882335;5710.543156547466;5710.628809127394;3840.7311488195837;4143.97928010361;4150.605692459211;4151;4154.1068670236045;5878.177055212273;5920.141579470953;5947.940520594782;5954.315253745788;5957.523398128139;4106.137711080647;4107.8973025674;4109.794510274534;4110.116324990141;4116.176764647083;4170.249355116108;4170.791460426966;4171.645410140172;4171.687123465752;4173.83304667816;4767.308740232646;4770.522947705202;4773.639512738852;4783.378160839069;4788.04239152171;5683.460071293221;5694.914576281359;5696.487316141567;5699.74351154199;5703.9429605704245;1404.4663028049276;1452.8038714773581;1472.3153733513968;1475.9409623614936;1478.6303424143964;932;955.6798472511647;977.5747549815853;991.5587563534302;994.6021591363368;5042.117629414838;5067.366579177603;5071.670341427795;5078.4413714491375;5081.212412076134;5824.970875145682;5833.4749872511675;5837.7664893404635;5843.795467158629;5852.619579727304;5048.343715316985;5056.570191533688;5065.189569668835;5066.417362003417;5079.034983353151;3094.5512900629283;3128.6402063762503;3134.874605015774;3135.451296023187;3139.199504126433;5623.859403514863;5625.71871406428;5628.605997580212;5633.521150702236;5636.379998200195;5889.234399528034;6113.908291375633;6116.327204007555;6123.112148738497;6123.2652081750475;5686.09022556389;5727.427257274239;5730.484256416859;5738.626989245686;5744.655320680606;5944.940550594439;5950.5239580834295;5953.166556681981;5962.880742385215;5967.671778052075;5838.503727183237;5840.445157710011;5845.941540584539;5850.561207909339;5856.882862342814;5548.639338442988;5688.260526131577;5705.942940570707;5707.971460142673;5709.714514274353;4087.7751723654296;4109.773962432095;4117.032497363058;4126.979365103155;4130.772807495617;5946.702664866652;5960.3443621202505;5976.073708575178;5988.311344195473;6006.129111278928;5719.28508936383;5725.627834190765;5729.083346664514;5730.971345143247;5733.741981610754;5711.628744131618;5715.971420142872;5717;5720.628159169641;5733.856653583527;5401.945980540144;5561.499465048003;5608.747606357805;5625.381208067028;5629.324481062299;5732.57005724564;5764.423557644202;5769.105788602773;5770.567207459541;5779.537636988946;5567.2762540871045;5591.608587398843;5611.775528978795;5612.438756124355;5615.915761263666 15:59:32 INFO - PROCESS | 13259 | |5;yui.html;564.7458643610375;593.0274350065895;595.351067336603;602.4096385542168;616.5191448027043;11592;11715.062794976402;11744.588939387124;11745.70635734106;11757.118216133782;9897.91122976472;10750.03249707526;10852.348859068461;10883.292585981926;10903.073238774694;847.2501835875264;861.8448679237766;865.1305438034766;865.519636601689;869.1829680100685;854.2141230068321;862.5773371048173;862.5988915154452;863.1196179896501;863.5250612163317;893.4683863101444;896.4979611417594;897.5063714956748;898.1916275352203;898.3038145437273;888.6889588643987;889.0620395482763;889.8798662180587;890.0343127706446;891.0243283604443;665.9733610655617;667.0860920538893;667.5127157175241;668.0146783494356;668.729164688302;10491.42297173655;10550.947245263802;10555.102816260627;10558.841617375745;10563.471826408726;9535.141837234612;9572.66495672655;9637.518124093838;9734.951325243399;9852.359596626196;8935.374523783337;9036.141566551232;9565.186959108483;10928.617498387597;11042.171837112248;4123.154753275601;4185.121124563845;4199.370094485821;4233.301505251629;4254.212970600418;38058;38461.03847403809;44187.77906110481;46088.769556152;46996.29505557419;9630.662926797528;9664.516774161264;9884.11043006133;9890.258230632731;9930.453825039693;14840.332185051482;17231;17289.82710172907;17292.04893730832;17326.39357622477;6258.812235632939;6281.654509001957;6335.461485773761;6342.778002769973;6376.521760867953;3401.217719924431;3433.8111403873027;3566.7681600695873;3687.4284485904727;3722.218334149805;2680.9061682841007;2684.4765270772014;2689.1260340389063;2703.6079768433465;2720.8911643534434;506.79981407343894;507.9085764562414;512.3800201755917;512.469593970239;514.8635611562938;531.44994930247;539.6060875560784;540.2005032551767;541.8672425255837;553.5571542765771;7096.50324477292;7260.96369518149;7276.7453139140935;7284.781456556312;7317.853642927218;410.5429007390764;461.2274440312463;501.1755661936095;513.8715321169708;520.5601266929439;3392.8133952632843;3429.331280400298;3433.725301975886;3476.913077173091;3518.5777706674853;53192.73403632957;53289;53511.732441337546;53607;53933.191002135;45107;45219.32171017437;45636.543634563895;45835;45844.54155458469;35554.8222258887;42801;43447.13105737931;45040.77479612581;45268.320975186056;8310.501369917823;8343.332533397192;8385.371097167616;8391.916080839113;8597.441166324168;31378.52932205973;32250.838745806122;32315;32850;33420.498692520116;36219.63780362163;39104.608953910094;40797;41639.37540936828;41746.791266043474;9493.66772162971;9532.95233523828;9638.325317228007;9886.85169722469;10033.598656053677;10420.531076101443;10577.894221057692;11355.205135640426;11686.532538698357;12114.697132571757;10440.321379110334;10480.790384192425;10621.628243011457;11083.612073577386;11295.7740845181;10135.391876487434;10393.064624183557;10449.84325235107;10560.630377936735;10962.616308429167;10555.736106597396;10785.298955567863;10822.945885270523;11011.229213954946;11260.662180134608;8957.686480973134;9408.623655053721;9607.895597371977;9787.804243915225;9836.508174591385;9165.862512062191;9180.632774688938;9270.44377337362;9294.054123672942;9357.251419886528 15:59:32 INFO - PROCESS | 13259 | __end_tp_report 15:59:32 INFO - PROCESS | 13259 | __start_cc_report 15:59:32 INFO - PROCESS | 13259 | _x_x_mozilla_cycle_collect,880 15:59:32 INFO - PROCESS | 13259 | __end_cc_report 15:59:32 INFO - PROCESS | 13259 | __startTimestamp1467327572775__endTimestamp 15:59:32 INFO - PROCESS | 13259 | 15:59:32 INFO - PROCESS | 13259 | ------- Summary: start ------- 15:59:32 INFO - PROCESS | 13259 | Number of tests: 6 15:59:32 INFO - PROCESS | 13259 | 15:59:32 INFO - PROCESS | 13259 | [#0] dojo.html Cycles:165 Average:4655.35 Median:4789.43 stddev:445.32 (9.3%) stddev-sans-first:422.05 15:59:32 INFO - PROCESS | 13259 | Values: 2793.3 2852.7 2856.5 2882.6 2896.4 4655.3 4658.3 4663.1 4672.7 4712.6 4677.6 4681.4 4698.4 4699.0 4712.7 4262.3 4339.9 4347.7 4364.2 4369.3 4333.2 4338.7 4361.2 4369.6 4375.2 4355.7 4364.3 4426.5 4448.2 4476.1 4394.6 4399.6 4400.2 4401.6 4402.4 4178.3 4288.4 4305.5 4330.4 4333.2 4635.3 4637.9 4640.3 4644.4 4661.3 4814.8 4968.8 4987.4 4992.4 5031.2 4858.7 5053.9 5118.4 5120.9 5156.9 4652.2 4654.4 4659.0 4671.5 4696.8 4866.0 5111.3 5118.0 5123.5 5143.1 4826.9 4876.7 4891.3 4898.9 4927.1 5052.5 5064.5 5073.6 5076.2 5105.1 4798.3 4912.5 5045.1 5064.1 5091.2 4990.9 5002.0 5007.0 5011.7 5031.6 4287.9 4288.4 4290.2 4312.5 4317.2 3647.2 3730.5 3791.6 3795.3 3818.4 4454.7 4456.2 4460.7 4461.8 4487.4 5031.7 5077.0 5078.9 5081.9 5112.5 4277.8 4371.7 4387.5 4405.4 4431.1 4472.0 4487.3 4488.4 4520.4 4533.9 4863.8 4864.0 4867.5 4869.0 4897.1 4724.2 4942.2 5005.0 5026.0 5039.1 4848.5 4855.2 4879.5 4882.7 4908.8 4830.8 4968.2 4976.2 4987.3 4991.6 4994.3 5041.2 5054.9 5079.4 5088.8 4786.8 4789.4 4790.4 4795.7 4816.7 4643.1 4776.6 4796.7 4801.8 4831.5 4793.4 4796.4 4816.1 4821.7 4848.2 4952.5 4956.3 4958.8 4960.8 4973.8 4654.0 4680.5 4749.5 4804.5 4851.0 15:59:32 INFO - PROCESS | 13259 | 15:59:32 INFO - PROCESS | 13259 | [#1] ext.html Cycles:180 Average:39547.97 Median:35613.64 stddev:61751.34 (173.4%) stddev-sans-first:61855.04 15:59:32 INFO - PROCESS | 13259 | Values: 522.6 537.1 552.1 559.0 570.0 27864.2 28314.7 35828.0 35914.1 35918.8 38321.2 38754.8 38789.0 38805.8 38828.0 8020.8 8210.4 8217.1 8218.3 8250.9 8282.2 8430.0 8452.9 8455.7 8459.0 8327.7 8406.9 8437.1 8448.7 8463.0 8359.0 8412.7 8439.1 8442.6 8444.2 8330.0 8441.2 8448.7 8449.3 8454.1 39911.8 40271.6 40297.2 40389.8 40497.8 2714.5 2750.7 2818.2 2915.8 3207.5 30985.0 31174.4 31695.0 31817.4 31943.2 3097.9 3118.4 3147.4 3152.6 3203.3 193714.0 194095.0 194829.0 194926.0 195375.0 41071.4 41361.6 54580.2 54816.0 54985.2 39825.6 39845.8 39971.8 40007.0 40019.8 12556.0 12662.2 12669.2 12684.2 12685.3 9688.2 9765.8 9769.3 9813.6 9815.6 13830.4 14134.3 14241.4 14257.6 14352.1 5502.4 5505.4 5586.4 5691.7 5744.5 882.3 939.8 961.9 1026.1 1039.6 27595.9 27668.7 27872.0 28111.7 28554.6 941.9 997.3 1011.6 1018.9 1034.1 14480.9 14953.9 14977.3 15192.5 15308.8 280281.0 284021.0 285046.0 285599.0 287680.0 48902.0 50270.2 50467.5 50488.5 50579.0 1171.9 1203.6 1206.1 1287.0 1316.5 26343.3 29973.3 30082.5 30800.2 30873.0 44493.3 44970.8 44974.0 45070.3 45121.1 221465.0 222556.0 223032.0 224110.0 224290.0 31769.0 32820.7 33020.2 33060.7 33065.8 42934.4 43688.6 43883.3 44090.6 44369.6 35522.5 35704.8 35913.6 36031.6 36808.4 31166.7 31244.5 31541.1 31747.0 31840.2 27436.6 30670.7 30732.8 37042.8 37058.8 23551.9 28587.1 28925.7 28970.4 29116.9 22821.0 22834.7 23093.0 23178.8 23276.8 15:59:32 INFO - PROCESS | 13259 | 15:59:32 INFO - PROCESS | 13259 | [#2] jquery.html Cycles:180 Average:24788.07 Median:226592.28 stddev:65071.38 (28.7%) stddev-sans-first:65228.06 15:59:32 INFO - PROCESS | 13259 | Values: 356.1 360.6 360.7 364.3 371.0 14027.6 15709.8 15749.4 17182.9 17644.2 14413.2 14877.7 14882.9 15127.8 15820.4 5624.4 5772.3 5799.2 5814.9 5815.5 5566.9 5787.4 5838.6 5849.0 5850.8 5803.7 5810.4 5818.6 5820.5 5823.1 5628.6 5945.1 5945.5 5947.7 5952.8 5710.9 5713.5 5719.9 5722.7 5724.3 22349.6 22812.3 23031.2 23041.5 23046.9 1866.1 1953.7 2040.3 2104.7 2626.7 13371.0 13712.9 13803.9 13827.4 14366.4 1887.8 1906.3 1913.6 1920.9 2069.5 62223.0 67148.3 67537.7 67681.7 67692.0 14645.2 14869.2 15245.7 15360.8 15505.7 20440.0 25134.9 25259.7 25310.2 25357.5 7659.7 8093.4 8179.5 8209.4 8225.2 6675.0 6772.6 6804.7 6837.5 6953.5 7497.6 7502.5 7661.3 7680.0 7729.9 2869.7 2983.7 3014.3 3094.8 3205.7 793.9 847.8 922.2 941.5 953.3 15776.4 15970.8 16057.8 16920.9 17051.8 892.8 902.0 932.3 934.8 940.4 9198.6 9402.2 9582.2 9735.2 9827.9 389588.0 390536.0 390978.0 402212.0 408377.0 71020.6 71686.0 72909.3 72977.3 73224.6 954.7 958.0 968.7 977.5 981.5 14799.7 14802.7 14808.4 14879.0 15118.2 32462.7 32917.2 33158.3 33287.2 33687.0 44807.6 46938.5 46987.5 47232.8 47673.0 7521.9 7691.7 7801.5 7852.4 7882.2 9233.6 11047.4 11435.9 11572.8 11746.2 9803.8 10229.7 10422.0 10463.2 10510.6 10289.7 10391.1 10405.4 10405.8 10479.1 10123.9 10305.5 10370.3 10401.7 10664.1 7657.1 7887.4 7913.9 8071.2 8091.9 8190.4 9524.4 10564.6 10753.1 10883.8 15:59:32 INFO - PROCESS | 13259 | 15:59:32 INFO - PROCESS | 13259 | [#3] mootools.html Cycles:180 Average:5285.13 Median:6274.14 stddev:2765.15 (44.1%) stddev-sans-first:2756.83 15:59:32 INFO - PROCESS | 13259 | Values: 1318.0 1433.9 1463.1 1628.7 1830.7 6716.0 7476.7 7586.4 7636.4 7642.1 7597.2 7703.1 7752.7 7771.6 7778.7 2184.7 2216.0 2217.9 2219.3 2219.9 2157.4 2196.2 2204.4 2216.8 2218.9 2172.6 2183.6 2190.5 2200.4 2202.0 2165.9 2169.3 2169.6 2170.9 2172.8 2189.4 2215.2 2220.9 2223.6 2228.7 7916.5 7957.2 7980.0 7983.1 7983.8 4507.8 4592.0 4627.9 4637.9 4645.7 2894.0 2895.3 3017.7 3024.1 3024.3 896.0 923.6 928.4 962.8 967.2 9876.3 9922.4 9923.3 9929.5 9958.9 4082.9 4096.1 4105.7 4169.7 4201.9 8111.1 8115.4 8116.3 8118.5 8123.5 4440.7 4469.7 4471.1 4474.3 4509.7 3568.6 3866.5 3978.7 4113.1 4130.2 3244.1 3302.6 3308.9 3373.7 3386.4 975.8 981.7 986.1 997.0 1023.1 1217.4 1219.5 1224.2 1247.1 1247.7 7357.0 7385.3 7421.8 7429.2 7433.3 1072.2 1084.8 1087.0 1093.2 1102.3 5754.8 5852.5 5879.0 5898.8 5902.7 9263.6 9386.2 9509.5 9621.9 9638.4 9289.3 9435.1 9491.7 9496.1 9527.5 6998.6 7082.0 7162.6 7215.7 7226.9 7099.6 7101.6 7108.4 7126.8 7176.9 8309.7 8382.4 8557.0 8565.7 8577.9 8642.5 8712.9 8749.7 8787.5 8788.3 5493.1 6226.5 6381.2 6383.6 6908.3 7010.8 7160.1 7171.7 7215.9 7228.1 5745.4 6179.8 6226.1 6288.9 6306.9 6071.2 6146.8 6152.4 6236.2 6259.3 6747.9 6857.6 6893.1 6939.1 6971.1 6147.9 6195.6 6215.2 6221.4 6225.5 6291.1 6371.7 6469.2 6475.6 6486.5 15:59:32 INFO - PROCESS | 13259 | 15:59:32 INFO - PROCESS | 13259 | [#4] prototype.html Cycles:180 Average:4760.10 Median:5407.12 stddev:1392.31 (25.7%) stddev-sans-first:1355.92 15:59:32 INFO - PROCESS | 13259 | Values: 329.4 333.7 333.8 334.9 339.1 5392.2 5394.8 5415.3 5492.9 5504.0 5392.1 5395.5 5398.2 5412.3 5417.4 4036.4 4181.5 4258.5 4279.5 4303.6 4271.4 4286.0 4286.6 4288.0 4300.5 4217.5 4243.3 4245.5 4256.1 4262.5 4027.1 4150.6 4262.5 4262.7 4272.3 3777.6 3781.6 3786.7 3789.1 3791.7 5167.3 5171.5 5173.3 5176.4 5178.9 4910.7 4918.8 4919.7 4921.0 4925.0 5695.3 5699.1 5706.1 5710.5 5710.6 3840.7 4144.0 4150.6 4151.0 4154.1 5878.2 5920.1 5947.9 5954.3 5957.5 4106.1 4107.9 4109.8 4110.1 4116.2 4170.2 4170.8 4171.6 4171.7 4173.8 4767.3 4770.5 4773.6 4783.4 4788.0 5683.5 5694.9 5696.5 5699.7 5703.9 1404.5 1452.8 1472.3 1475.9 1478.6 932.0 955.7 977.6 991.6 994.6 5042.1 5067.4 5071.7 5078.4 5081.2 5825.0 5833.5 5837.8 5843.8 5852.6 5048.3 5056.6 5065.2 5066.4 5079.0 3094.6 3128.6 3134.9 3135.5 3139.2 5623.9 5625.7 5628.6 5633.5 5636.4 5889.2 6113.9 6116.3 6123.1 6123.3 5686.1 5727.4 5730.5 5738.6 5744.7 5944.9 5950.5 5953.2 5962.9 5967.7 5838.5 5840.4 5845.9 5850.6 5856.9 5548.6 5688.3 5705.9 5708.0 5709.7 4087.8 4109.8 4117.0 4127.0 4130.8 5946.7 5960.3 5976.1 5988.3 6006.1 5719.3 5725.6 5729.1 5731.0 5733.7 5711.6 5716.0 5717.0 5720.6 5733.9 5401.9 5561.5 5608.7 5625.4 5629.3 5732.6 5764.4 5769.1 5770.6 5779.5 5567.3 5591.6 5611.8 5612.4 5615.9 15:59:32 INFO - PROCESS | 13259 | 15:59:32 INFO - PROCESS | 13259 | [#5] yui.html Cycles:180 Average:12492.07 Median:507.35 stddev:14489.43 (2855.9%) stddev-sans-first:14502.39 15:59:32 INFO - PROCESS | 13259 | Values: 564.7 593.0 595.4 602.4 616.5 11592.0 11715.1 11744.6 11745.7 11757.1 9897.9 10750.0 10852.3 10883.3 10903.1 847.3 861.8 865.1 865.5 869.2 854.2 862.6 862.6 863.1 863.5 893.5 896.5 897.5 898.2 898.3 888.7 889.1 889.9 890.0 891.0 666.0 667.1 667.5 668.0 668.7 10491.4 10550.9 10555.1 10558.8 10563.5 9535.1 9572.7 9637.5 9735.0 9852.4 8935.4 9036.1 9565.2 10928.6 11042.2 4123.2 4185.1 4199.4 4233.3 4254.2 38058.0 38461.0 44187.8 46088.8 46996.3 9630.7 9664.5 9884.1 9890.3 9930.5 14840.3 17231.0 17289.8 17292.0 17326.4 6258.8 6281.7 6335.5 6342.8 6376.5 3401.2 3433.8 3566.8 3687.4 3722.2 2680.9 2684.5 2689.1 2703.6 2720.9 506.8 507.9 512.4 512.5 514.9 531.4 539.6 540.2 541.9 553.6 7096.5 7261.0 7276.7 7284.8 7317.9 410.5 461.2 501.2 513.9 520.6 3392.8 3429.3 3433.7 3476.9 3518.6 53192.7 53289.0 53511.7 53607.0 53933.2 45107.0 45219.3 45636.5 45835.0 45844.5 35554.8 42801.0 43447.1 45040.8 45268.3 8310.5 8343.3 8385.4 8391.9 8597.4 31378.5 32250.8 32315.0 32850.0 33420.5 36219.6 39104.6 40797.0 41639.4 41746.8 9493.7 9533.0 9638.3 9886.9 10033.6 10420.5 10577.9 11355.2 11686.5 12114.7 10440.3 10480.8 10621.6 11083.6 11295.8 10135.4 10393.1 10449.8 10560.6 10962.6 10555.7 10785.3 10822.9 11011.2 11260.7 8957.7 9408.6 9607.9 9787.8 9836.5 9165.9 9180.6 9270.4 9294.1 9357.3 15:59:32 INFO - PROCESS | 13259 | -------- Summary: end -------- 15:59:32 INFO - PROCESS | 13259 | 15:59:33 INFO - TEST-INFO | 13259: exit 0 15:59:33 INFO - TEST-OK | dromaeo_css | took 1115405ms 15:59:33 INFO - TEST-START | kraken 15:59:33 INFO - operating with platform_type : linux_ 15:59:33 INFO - Initialising browser for kraken test... 15:59:33 INFO - TEST-INFO | started process 13455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbBBdQ2/profile http://localhost:44997/getInfo.html) 15:59:37 INFO - PROCESS | 13455 | __metrics Screen width/height:1600/1200 15:59:37 INFO - PROCESS | 13455 | colorDepth:24 15:59:37 INFO - PROCESS | 13455 | Browser inner width/height: 1024/697 15:59:37 INFO - PROCESS | 13455 | __metrics 15:59:38 INFO - PROCESS | 13455 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:59:39 INFO - TEST-INFO | 13455: exit 0 15:59:39 INFO - Browser initialized. 15:59:39 INFO - Running cycle 1/1 for kraken test... 15:59:39 INFO - TEST-INFO | started process 13544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbBBdQ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:51 INFO - PROCESS | 13544 | RSS: Main: 138846208 15:59:51 INFO - PROCESS | 13544 | 15:59:53 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44997/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:54 INFO - PROCESS | 13544 | RSS: Main: 183246848 15:59:54 INFO - PROCESS | 13544 | 15:59:56 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44997/tests/kraken/driver.html?testName=audio-dft) 15:59:57 INFO - PROCESS | 13544 | RSS: Main: 175484928 15:59:57 INFO - PROCESS | 13544 | 16:00:00 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44997/tests/kraken/driver.html?testName=audio-fft) 16:00:00 INFO - PROCESS | 13544 | RSS: Main: 175333376 16:00:00 INFO - PROCESS | 13544 | 16:00:03 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44997/tests/kraken/driver.html?testName=audio-oscillator) 16:00:03 INFO - PROCESS | 13544 | RSS: Main: 176599040 16:00:03 INFO - PROCESS | 13544 | 16:00:05 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:00:06 INFO - PROCESS | 13544 | RSS: Main: 175828992 16:00:06 INFO - PROCESS | 13544 | 16:00:09 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44997/tests/kraken/driver.html?testName=imaging-darkroom) 16:00:10 INFO - PROCESS | 13544 | RSS: Main: 174571520 16:00:10 INFO - PROCESS | 13544 | 16:00:13 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44997/tests/kraken/driver.html?testName=imaging-desaturate) 16:00:14 INFO - PROCESS | 13544 | RSS: Main: 176406528 16:00:14 INFO - PROCESS | 13544 | 16:00:16 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44997/tests/kraken/driver.html?testName=json-parse-financial) 16:00:17 INFO - PROCESS | 13544 | RSS: Main: 174383104 16:00:17 INFO - PROCESS | 13544 | 16:00:19 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:00:19 INFO - PROCESS | 13544 | RSS: Main: 180277248 16:00:19 INFO - PROCESS | 13544 | 16:00:21 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44997/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:00:22 INFO - PROCESS | 13544 | RSS: Main: 178774016 16:00:22 INFO - PROCESS | 13544 | 16:00:24 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:00:24 INFO - PROCESS | 13544 | RSS: Main: 183169024 16:00:24 INFO - PROCESS | 13544 | 16:00:27 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:00:27 INFO - PROCESS | 13544 | RSS: Main: 187392000 16:00:27 INFO - PROCESS | 13544 | 16:00:30 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:00:30 INFO - PROCESS | 13544 | RSS: Main: 186155008 16:00:30 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | Cycle 1(1): loaded http://localhost:44997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44997/tests/kraken/driver.html?testName=ai-astar) 16:00:32 INFO - PROCESS | 13544 | RSS: Main: 247713792 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | __start_tp_report 16:00:32 INFO - PROCESS | 13544 | _x_x_mozilla_page_load 16:00:32 INFO - PROCESS | 13544 | _x_x_mozilla_page_load_details 16:00:32 INFO - PROCESS | 13544 | |i|pagename|runs| 16:00:32 INFO - PROCESS | 13544 | |0;ai-astar;113;113;116;115;114;114;113;112;113;124 16:00:32 INFO - PROCESS | 13544 | |1;audio-beat-detection;165;132;154;169;131;159;151;133;166;133 16:00:32 INFO - PROCESS | 13544 | |2;audio-dft;161;162;161;161;161;160;160;158;160;159 16:00:32 INFO - PROCESS | 13544 | |3;audio-fft;73;77;77;163;77;72;76;75;163;86 16:00:32 INFO - PROCESS | 13544 | |4;audio-oscillator;94;94;146;94;95;94;136;95;94;135 16:00:32 INFO - PROCESS | 13544 | |5;imaging-gaussian-blur;117;118;117;117;117;117;116;117;117;116 16:00:32 INFO - PROCESS | 13544 | |6;imaging-darkroom;146;146;147;147;146;145;148;146;146;146 16:00:32 INFO - PROCESS | 13544 | |7;imaging-desaturate;96;96;95;96;95;95;95;95;95;96 16:00:32 INFO - PROCESS | 13544 | |8;json-parse-financial;66;68;67;68;68;67;66;68;77;66 16:00:32 INFO - PROCESS | 13544 | |9;json-stringify-tinderbox;65;65;65;65;65;69;65;65;65;66 16:00:32 INFO - PROCESS | 13544 | |10;stanford-crypto-aes;80;82;82;82;91;82;82;81;81;81 16:00:32 INFO - PROCESS | 13544 | |11;stanford-crypto-ccm;117;125;120;125;116;119;117;128;120;117 16:00:32 INFO - PROCESS | 13544 | |12;stanford-crypto-pbkdf2;135;134;149;142;146;133;143;143;142;144 16:00:32 INFO - PROCESS | 13544 | |13;stanford-crypto-sha256-iterative;69;74;69;66;67;67;67;69;71;67 16:00:32 INFO - PROCESS | 13544 | __end_tp_report 16:00:32 INFO - PROCESS | 13544 | __start_cc_report 16:00:32 INFO - PROCESS | 13544 | _x_x_mozilla_cycle_collect,1086 16:00:32 INFO - PROCESS | 13544 | __end_cc_report 16:00:32 INFO - PROCESS | 13544 | __startTimestamp1467327632953__endTimestamp 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | ------- Summary: start ------- 16:00:32 INFO - PROCESS | 13544 | Number of tests: 14 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.00 stddev:3.47 (3.0%) stddev-sans-first:3.62 16:00:32 INFO - PROCESS | 13544 | Values: 113.0 113.0 116.0 115.0 114.0 114.0 113.0 112.0 113.0 124.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:156.50 stddev:15.63 (10.0%) stddev-sans-first:15.51 16:00:32 INFO - PROCESS | 13544 | Values: 165.0 132.0 154.0 169.0 131.0 159.0 151.0 133.0 166.0 133.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 16:00:32 INFO - PROCESS | 13544 | Values: 161.0 162.0 161.0 161.0 161.0 160.0 160.0 158.0 160.0 159.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.50 stddev:36.61 (47.9%) stddev-sans-first:38.04 16:00:32 INFO - PROCESS | 13544 | Values: 73.0 77.0 77.0 163.0 77.0 72.0 76.0 75.0 163.0 86.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:94.00 stddev:21.79 (23.2%) stddev-sans-first:22.54 16:00:32 INFO - PROCESS | 13544 | Values: 94.0 94.0 146.0 94.0 95.0 94.0 136.0 95.0 94.0 135.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:00:32 INFO - PROCESS | 13544 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 16:00:32 INFO - PROCESS | 13544 | Values: 146.0 146.0 147.0 147.0 146.0 145.0 148.0 146.0 146.0 146.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:00:32 INFO - PROCESS | 13544 | Values: 96.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:68.00 stddev:3.25 (4.8%) stddev-sans-first:3.35 16:00:32 INFO - PROCESS | 13544 | Values: 66.0 68.0 67.0 68.0 68.0 67.0 66.0 68.0 77.0 66.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:1.27 (2.0%) stddev-sans-first:1.33 16:00:32 INFO - PROCESS | 13544 | Values: 65.0 65.0 65.0 65.0 65.0 69.0 65.0 65.0 65.0 66.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:3.10 (3.8%) stddev-sans-first:3.16 16:00:32 INFO - PROCESS | 13544 | Values: 80.0 82.0 82.0 82.0 91.0 82.0 82.0 81.0 81.0 81.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:120.00 stddev:4.17 (3.5%) stddev-sans-first:4.24 16:00:32 INFO - PROCESS | 13544 | Values: 117.0 125.0 120.0 125.0 116.0 119.0 117.0 128.0 120.0 117.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:143.00 stddev:5.34 (3.7%) stddev-sans-first:5.19 16:00:32 INFO - PROCESS | 13544 | Values: 135.0 134.0 149.0 142.0 146.0 133.0 143.0 143.0 142.0 144.0 16:00:32 INFO - PROCESS | 13544 | 16:00:32 INFO - PROCESS | 13544 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:2.41 (3.5%) stddev-sans-first:2.55 16:00:32 INFO - PROCESS | 13544 | Values: 69.0 74.0 69.0 66.0 67.0 67.0 67.0 69.0 71.0 67.0 16:00:32 INFO - PROCESS | 13544 | -------- Summary: end -------- 16:00:32 INFO - PROCESS | 13544 | 16:00:33 INFO - TEST-INFO | 13544: exit 0 16:00:33 INFO - TEST-OK | kraken | took 60455ms 16:00:33 INFO - SUITE-END | took 1175s 16:00:34 INFO - Completed test suite (00:19:36) 16:00:34 INFO - javascript benchmark 16:00:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2793.2597861566687, 2852.7147285271467, 2856.5001124803152, 2882.596436498889, 2896.36280018396, 4655.32497787821, 4658.32454294128, 4663.137319595873, 4672.719636821793, 4712.622990160788, 4677.602403795673, 4681.39141911551, 4698.365720627714, 4699.036697477018, 4712.740799256039, 4262.296721041024, 4339.913201735963, 4347.695661303702, 4364.214441400547, 4369.257226271526, 4333.220020396343, 4338.652907767387, 4361.171377438277, 4369.584889435499, 4375.234333991555, 4355.673324500659, 4364.301711726124, 4426.535213802553, 4448.199324121657, 4476.1271552047365, 4394.582514661102, 4399.560043995607, 4400.185965596343, 4401.6478681705385, 4402.40567523385, 4178.310578754502, 4288.44250247469, 4305.483341998949, 4330.415393921811, 4333.1766964277, 4635.281531362644, 4637.86086417408, 4640.303954406832, 4644.373009643722, 4661.347411362412, 4814.78333474991, 4968.776405061781, 4987.401511818605, 4992.375953005874, 5031.169856973595, 4858.708477491362, 5053.924191137099, 5118.411382691001, 5120.871978200537, 5156.8968620627375, 4652.185867473178, 4654.4414670239785, 4659.021605462857, 4671.5094915034115, 4696.835610753607, 4865.9756701216265, 5111.335526381621, 5117.974410127926, 5123.462036486189, 5143.099957507496, 4826.855194344175, 4876.707397556158, 4891.315215869781, 4898.877528061756, 4927.1131196384995, 5052.520010598987, 5064.49355064498, 5073.644844860898, 5076.238564215398, 5105.132127538327, 4798.304245884327, 4912.459629440758, 5045.142325804622, 5064.063148317573, 5091.210862316347, 4990.925136122961, 5002.0, 5007.023630392111, 5011.674241174312, 5031.572316353151, 4287.892802679958, 4288.356746488052, 4290.184864875664, 4312.460942382202, 4317.244482215599, 3647.1611529348397, 3730.5336832895887, 3791.5829258781514, 3795.3358162321483, 3818.420842960714, 4454.710443821141, 4456.175607512556, 4460.710053846489, 4461.7992190351515, 4487.394201782783, 5031.6729412588065, 5077.009983053269, 5078.873028174251, 5081.898362032739, 5112.488751124858, 4277.764722940268, 4371.672124590668, 4387.5393083726385, 4405.405270288534, 4431.135928493913, 4472.038511719996, 4487.326900964816, 4488.4165058542185, 4520.367148599199, 4533.9319910201375, 4863.781129849165, 4863.975680121577, 4867.537583929521, 4869.0261947611325, 4897.069556784199, 4724.244120940633, 4942.159832828356, 5005.0, 5026.0199261143725, 5039.067772462106, 4848.515148485123, 4855.223164293696, 4879.4876537963, 4882.707037577757, 4908.803647854046, 4830.7826147822725, 4968.155413579628, 4976.203807390945, 4987.3017777511905, 4991.6006719463085, 4994.300797888226, 5041.19340905468, 5054.924176137288, 5079.441261461162, 5088.821891233937, 4786.784594693317, 4789.425268967746, 4790.377250957354, 4795.664303498722, 4816.735079570657, 4643.117807616677, 4776.5701086902345, 4796.664233503621, 4801.831935882367, 4831.51684831514, 4793.376861008047, 4796.448408433075, 4816.060868130681, 4821.710697358169, 4848.151573474698, 4952.455229924777, 4956.330895329229, 4958.801647934042, 4960.751962401938, 4973.776180071978, 4654.0, 4680.4851466338, 4749.477557468606, 4804.543568361, 4851.0], "unit": "score", "name": "dojo.html", "value": 4630.435496942877}, {"lowerIsBetter": false, "replicates": [522.6367674466247, 537.1003569021889, 552.1496894782036, 558.9916151257731, 569.9886002279954, 27864.16407507773, 28314.71685283149, 35828.0, 35914.10214744626, 35918.820405898, 38321.23357532848, 38754.80622596883, 38789.0, 38805.80597097018, 38828.0, 8020.799480012988, 8210.425270231086, 8217.137200593941, 8218.260356567907, 8250.917490825104, 8282.17178282173, 8430.0, 8452.8732069019, 8455.746327610152, 8458.957705211496, 8327.708530201444, 8406.873896891551, 8437.114103019187, 8448.662053517852, 8463.0, 8359.0, 8412.705555305534, 8439.071702112731, 8442.577871106481, 8444.197801208875, 8329.958350208271, 8441.155884411572, 8448.662053517852, 8449.324054075722, 8454.070052294304, 39911.8004409979, 40271.59728402737, 40297.194056119006, 40389.79805100985, 40497.79751101226, 2714.470678217748, 2750.724927507253, 2818.168640251131, 2915.8104723192923, 3207.5028370602595, 30985.0, 31174.37651246985, 31695.0, 31817.363652727046, 31943.201419964455, 3097.9380412391624, 3118.3919135768533, 3147.35479226758, 3152.6059242594674, 3203.343314620497, 193714.0, 194095.0, 194829.0, 194926.0, 195375.0231248849, 41071.383929241085, 41361.586384136375, 54580.18129728057, 54816.0, 54985.1752223717, 39825.60174398277, 39845.80077099596, 39971.80014099911, 40007.0, 40019.79990100031, 12556.0, 12662.240265584094, 12669.239845609292, 12684.238945663104, 12685.302308373128, 9688.176504997013, 9765.755856103655, 9769.267304952156, 9813.607455701835, 9815.607375705034, 13830.37763300654, 14134.293285335692, 14241.430342786172, 14257.572272831832, 14352.138871667734, 5502.394736578973, 5505.394406615269, 5586.35756887955, 5691.743871525791, 5744.535143538455, 882.2941646682629, 939.7885475767897, 961.9326647134774, 1026.071405378134, 1039.6153423233452, 27595.86202068977, 27668.72331276702, 27872.024479143132, 28111.71888281091, 28554.571681424793, 941.9105185007413, 997.3168379659957, 1011.6206422591529, 1018.8879223285433, 1034.1364960258268, 14480.927595362167, 14953.850461495464, 14977.326020329112, 15192.46826361072, 15308.770368444482, 280281.0, 284021.0, 285046.0, 285599.0, 287680.0, 48902.0, 50270.24594631083, 50467.49532504701, 50488.495115048376, 50579.0, 1171.9296842189497, 1203.6088271311683, 1206.1376116077047, 1286.9511348251144, 1316.493150137185, 26343.341416463976, 29973.250668733457, 30082.548761768154, 30800.229994250323, 30873.0, 44493.33260001038, 44970.77514612406, 44974.0, 45070.32394514151, 45121.09757804891, 221465.0, 222556.0, 223032.0, 224110.0, 224290.0, 31769.0, 32820.671793282716, 33020.1744956378, 33060.66939330576, 33065.834670826494, 42934.35598465963, 43688.56311436845, 43883.341749873136, 44090.55909440993, 44369.55630443654, 35522.467162993096, 35704.82147589245, 35913.64086359103, 36031.63968360283, 36808.44787328246, 31166.688333116377, 31244.531332030492, 31541.053768386984, 31747.04758857238, 31840.203994899388, 27436.588451173648, 30670.693293067678, 30732.84633576818, 37042.8147859259, 37058.814705927376, 23551.882240588686, 28587.14238572846, 28925.710742893145, 28970.42059158847, 29116.854415727787, 22821.0, 22834.657480138143, 23092.96081676295, 23178.76821231766, 23276.76723232746], "unit": "score", "name": "ext.html", "value": 16632.36669321432}, {"lowerIsBetter": false, "replicates": [356.0813102196334, 360.57812359539344, 360.67719391144925, 364.32417864860685, 370.9962900370995, 14027.649308767286, 15709.84290157098, 15749.370025198992, 17182.914085429555, 17644.206010729533, 14413.207273599948, 14877.702445951074, 14882.925585372084, 15127.84872151278, 15820.367185312602, 5624.409437009116, 5772.30732312121, 5799.246098007275, 5814.912776308359, 5815.505682017012, 5566.86082847928, 5787.421257874221, 5838.591298609099, 5849.0, 5850.824475265727, 5803.680797556154, 5810.448007439308, 5818.6217895836635, 5820.505257053155, 5823.06830907055, 5628.577856660746, 5945.078512830497, 5945.464908158287, 5947.732352044169, 5952.791652292149, 5710.857228569277, 5713.485786279255, 5719.885602287931, 5722.713864306809, 5724.341700704431, 22349.553008939893, 22812.31563053111, 23031.193908213132, 23041.53916921652, 23046.884765576233, 1866.1322485044384, 1953.687410014391, 2040.2960978462406, 2104.726385569866, 2626.6585343905363, 13371.0, 13712.862871371359, 13803.930980345134, 13827.377768000464, 14366.35351409189, 1887.8300952914167, 1906.3327835257687, 1913.550315675815, 1920.9039548022683, 2069.4722845674255, 62223.0, 67148.32851671519, 67537.66231168812, 67681.66159169222, 67692.0, 14645.194514301817, 14869.18219497938, 15245.695086098438, 15360.769588456182, 15505.689886202214, 20440.0, 25134.874325628254, 25259.74740252574, 25310.240692779247, 25357.492850142895, 7659.655315510815, 8093.3929955252415, 8179.509229446252, 8209.38429617781, 8225.177482251727, 6674.966625166843, 6772.559783614148, 6804.693788779517, 6837.453003759687, 6953.478489113337, 7497.587632680146, 7502.474826762074, 7661.310482056641, 7680.0, 7729.922700773032, 2869.684334723179, 2983.6568794588466, 3014.3217776000665, 3094.8297843618816, 3205.7275131613605, 793.9444238903221, 847.809242920338, 922.1884741427635, 941.4915945389413, 953.3374304858057, 15776.447824326093, 15970.76043859343, 16057.839421605868, 16920.91539542319, 17051.829481705274, 892.8438268996467, 902.039328115568, 932.3100905330007, 934.8457504511815, 940.3605548227134, 9198.586063627154, 9402.247820174369, 9582.185514231229, 9735.221182305399, 9827.901720982842, 389588.0, 390536.0, 390978.0, 402212.0, 408377.0, 71020.64489677518, 71686.0, 72909.27090729131, 72977.27022729811, 73224.63387683028, 954.7231302922214, 957.9521023948914, 968.7142293023434, 977.5385798231689, 981.5043403081398, 14799.704005920037, 14802.703945921237, 14808.407663693331, 14879.0, 15118.244087795787, 32462.675373245966, 32917.17707057343, 33158.33683326368, 33287.16782080467, 33687.0, 44807.551924480336, 46938.530614693416, 46987.530124698314, 47232.7638361806, 47673.0, 7521.8871716923195, 7691.653875575725, 7801.45389822707, 7852.411069169721, 7882.211778822072, 9233.630654773733, 11047.392393418439, 11435.885641143483, 11572.768544628892, 11746.236494627821, 9803.774528183976, 10229.74425639365, 10422.009909058628, 10463.162946964072, 10510.579576816841, 10289.691309260734, 10391.116755075904, 10405.427701476492, 10405.843912341472, 10479.10927571165, 10123.949380253052, 10305.484725763832, 10370.27408081427, 10401.739956500845, 10664.07180872195, 7657.119431265476, 7887.44787864844, 7913.881291780743, 8071.23323284287, 8091.919080809352, 8190.426670133033, 9524.380915240765, 10564.577416903237, 10753.085987691135, 10883.836742449028], "unit": "score", "name": "jquery.html", "value": 8884.606383255366}, {"lowerIsBetter": false, "replicates": [1318.0378323823602, 1433.8566143385663, 1463.1440607244758, 1628.6742651469708, 1830.725391191322, 6715.966420167899, 7476.663550140243, 7586.355159811423, 7636.427267954912, 7642.121156067061, 7597.2402759724, 7703.114141873686, 7752.651130699118, 7771.572563509018, 7778.727744528943, 2184.737831460227, 2216.002798740565, 2217.9001944912516, 2219.323106452531, 2219.87790671513, 2157.4390658428842, 2196.2093646287403, 2204.371754050096, 2216.8115710164657, 2218.92233771818, 2172.587208430401, 2183.5632873425297, 2190.539986602815, 2200.3948914048683, 2202.0201010550313, 2165.945851353713, 2169.262450766731, 2169.631162702344, 2170.934871953844, 2172.8370372222066, 2189.4088596079127, 2215.235743668432, 2220.8667479951255, 2223.6442169253005, 2228.74369447514, 7916.52500849945, 7957.244061814118, 7980.04239491259, 7983.12185659577, 7983.760487185394, 4507.842225522091, 4592.035672508777, 4627.8611641650805, 4637.930431043537, 4645.744484053375, 2894.0, 2895.290653789835, 3017.6529699084667, 3024.1381206356305, 3024.2892920163963, 895.9507227102507, 923.584387025841, 928.4104593583056, 962.831504486712, 967.1537404770826, 9876.308658393915, 9922.404655720607, 9923.255755818342, 9929.50352482373, 9958.90041099587, 4082.9387559186634, 4096.078382364004, 4105.67154627629, 4169.666426685919, 4201.936970945439, 8111.06722726894, 8115.3913456491, 8116.310113640288, 8118.472299300644, 8123.471974321768, 4440.666949978699, 4469.7318160910445, 4471.083427897273, 4474.284114541658, 4509.684322097487, 3568.6074531801482, 3866.5360156781367, 3978.6817054635558, 4113.095119073799, 4130.194612050621, 3244.1240864966326, 3302.5871766029245, 3308.8841890533718, 3373.7469689772875, 3386.441237195835, 975.8389865672226, 981.66623348062, 986.0730912941812, 997.0079770628271, 1023.1150055202196, 1217.4399776102914, 1219.4939100273286, 1224.2470880408484, 1247.089624574066, 1247.681841130506, 7357.043584334002, 7385.29839665231, 7421.777346679608, 7429.219931907072, 7433.331000210007, 1072.1904961753826, 1084.7830433913248, 1086.9510872010778, 1093.1746531368924, 1102.3441052573705, 5754.827355179351, 5852.502537284378, 5879.0, 5898.793542226087, 5902.704864756831, 9263.629454821867, 9386.15524602789, 9509.476978766095, 9621.90378096224, 9638.373505722106, 9289.34974551775, 9435.056494350647, 9491.715248542554, 9496.097870702271, 9527.475988820543, 6998.580085194904, 7081.964590177016, 7162.570245785269, 7215.711371545184, 7226.927730722626, 7099.574025558483, 7101.644917754195, 7108.431325493844, 7126.786196414116, 7176.856462870818, 8309.709160179365, 8382.37132215074, 8557.0, 8565.657373704982, 8577.914220857712, 8642.524661143447, 8712.91287087121, 8749.6937607186, 8787.5166865823, 8788.2529984952, 5493.121100623881, 6226.533010024175, 6381.202349706286, 6383.648899310582, 6908.3091690832525, 7010.824729381806, 7160.10498687664, 7171.748988785367, 7215.891761623475, 7228.060352154396, 5745.396733342939, 6179.752809887734, 6226.066090086523, 6288.937110629018, 6306.905396419149, 6071.210742603434, 6146.846328841814, 6152.354002829818, 6236.158118653923, 6259.34276900937, 6747.898781518379, 6857.55425897315, 6893.0694356261265, 6939.132608423947, 6971.093757811452, 6147.877042459037, 6195.628262304276, 6215.223097112861, 6221.440070393686, 6225.533085018551, 6291.087792270187, 6371.7132729028235, 6469.159009328757, 6475.579087359307, 6486.481081513373], "unit": "score", "name": "mootools.html", "value": 4328.905024938413}, {"lowerIsBetter": false, "replicates": [329.42186462757854, 333.6996702967329, 333.7580254315621, 334.9430596798544, 339.14535370865434, 5392.2181283713835, 5394.757235924383, 5415.26893869328, 5492.945070549294, 5504.036793561121, 5392.110301800208, 5395.460453954603, 5398.190271459283, 5412.296401467804, 5417.404085550586, 4036.374361973899, 4181.477315335583, 4258.53156152823, 4279.507856596492, 4303.591158839905, 4271.402003719466, 4286.03564198056, 4286.614204721574, 4287.978560107195, 4300.548442413548, 4217.514985776645, 4243.257429949762, 4245.492850038238, 4256.127493863766, 4262.46719160105, 4027.09390387162, 4150.647194988414, 4262.488501379823, 4262.722923009995, 4272.316429371285, 3777.565579958285, 3781.5840257571645, 3786.659200671925, 3789.147441825595, 3791.6587507124214, 5167.276581278624, 5171.482851714836, 5173.301604283449, 5176.352955880515, 5178.870528236786, 4910.705357678551, 4918.803247870117, 4919.704817710913, 4921.0, 4925.014997000579, 5695.316562012544, 5699.145128230799, 5706.1440783882335, 5710.543156547466, 5710.628809127394, 3840.7311488195837, 4143.97928010361, 4150.605692459211, 4151.0, 4154.1068670236045, 5878.177055212273, 5920.141579470953, 5947.940520594782, 5954.315253745788, 5957.523398128139, 4106.137711080647, 4107.8973025674, 4109.794510274534, 4110.116324990141, 4116.176764647083, 4170.249355116108, 4170.791460426966, 4171.645410140172, 4171.687123465752, 4173.83304667816, 4767.308740232646, 4770.522947705202, 4773.639512738852, 4783.378160839069, 4788.04239152171, 5683.460071293221, 5694.914576281359, 5696.487316141567, 5699.74351154199, 5703.9429605704245, 1404.4663028049276, 1452.8038714773581, 1472.3153733513968, 1475.9409623614936, 1478.6303424143964, 932.0, 955.6798472511647, 977.5747549815853, 991.5587563534302, 994.6021591363368, 5042.117629414838, 5067.366579177603, 5071.670341427795, 5078.4413714491375, 5081.212412076134, 5824.970875145682, 5833.4749872511675, 5837.7664893404635, 5843.795467158629, 5852.619579727304, 5048.343715316985, 5056.570191533688, 5065.189569668835, 5066.417362003417, 5079.034983353151, 3094.5512900629283, 3128.6402063762503, 3134.874605015774, 3135.451296023187, 3139.199504126433, 5623.859403514863, 5625.71871406428, 5628.605997580212, 5633.521150702236, 5636.379998200195, 5889.234399528034, 6113.908291375633, 6116.327204007555, 6123.112148738497, 6123.2652081750475, 5686.09022556389, 5727.427257274239, 5730.484256416859, 5738.626989245686, 5744.655320680606, 5944.940550594439, 5950.5239580834295, 5953.166556681981, 5962.880742385215, 5967.671778052075, 5838.503727183237, 5840.445157710011, 5845.941540584539, 5850.561207909339, 5856.882862342814, 5548.639338442988, 5688.260526131577, 5705.942940570707, 5707.971460142673, 5709.714514274353, 4087.7751723654296, 4109.773962432095, 4117.032497363058, 4126.979365103155, 4130.772807495617, 5946.702664866652, 5960.3443621202505, 5976.073708575178, 5988.311344195473, 6006.129111278928, 5719.28508936383, 5725.627834190765, 5729.083346664514, 5730.971345143247, 5733.741981610754, 5711.628744131618, 5715.971420142872, 5717.0, 5720.628159169641, 5733.856653583527, 5401.945980540144, 5561.499465048003, 5608.747606357805, 5625.381208067028, 5629.324481062299, 5732.57005724564, 5764.423557644202, 5769.105788602773, 5770.567207459541, 5779.537636988946, 5567.2762540871045, 5591.608587398843, 5611.775528978795, 5612.438756124355, 5615.915761263666], "unit": "score", "name": "prototype.html", "value": 4315.970118033548}, {"lowerIsBetter": false, "replicates": [564.7458643610375, 593.0274350065895, 595.351067336603, 602.4096385542168, 616.5191448027043, 11592.0, 11715.062794976402, 11744.588939387124, 11745.70635734106, 11757.118216133782, 9897.91122976472, 10750.03249707526, 10852.348859068461, 10883.292585981926, 10903.073238774694, 847.2501835875264, 861.8448679237766, 865.1305438034766, 865.519636601689, 869.1829680100685, 854.2141230068321, 862.5773371048173, 862.5988915154452, 863.1196179896501, 863.5250612163317, 893.4683863101444, 896.4979611417594, 897.5063714956748, 898.1916275352203, 898.3038145437273, 888.6889588643987, 889.0620395482763, 889.8798662180587, 890.0343127706446, 891.0243283604443, 665.9733610655617, 667.0860920538893, 667.5127157175241, 668.0146783494356, 668.729164688302, 10491.42297173655, 10550.947245263802, 10555.102816260627, 10558.841617375745, 10563.471826408726, 9535.141837234612, 9572.66495672655, 9637.518124093838, 9734.951325243399, 9852.359596626196, 8935.374523783337, 9036.141566551232, 9565.186959108483, 10928.617498387597, 11042.171837112248, 4123.154753275601, 4185.121124563845, 4199.370094485821, 4233.301505251629, 4254.212970600418, 38058.0, 38461.03847403809, 44187.77906110481, 46088.769556152, 46996.29505557419, 9630.662926797528, 9664.516774161264, 9884.11043006133, 9890.258230632731, 9930.453825039693, 14840.332185051482, 17231.0, 17289.82710172907, 17292.04893730832, 17326.39357622477, 6258.812235632939, 6281.654509001957, 6335.461485773761, 6342.778002769973, 6376.521760867953, 3401.217719924431, 3433.8111403873027, 3566.7681600695873, 3687.4284485904727, 3722.218334149805, 2680.9061682841007, 2684.4765270772014, 2689.1260340389063, 2703.6079768433465, 2720.8911643534434, 506.79981407343894, 507.9085764562414, 512.3800201755917, 512.469593970239, 514.8635611562938, 531.44994930247, 539.6060875560784, 540.2005032551767, 541.8672425255837, 553.5571542765771, 7096.50324477292, 7260.96369518149, 7276.7453139140935, 7284.781456556312, 7317.853642927218, 410.5429007390764, 461.2274440312463, 501.1755661936095, 513.8715321169708, 520.5601266929439, 3392.8133952632843, 3429.331280400298, 3433.725301975886, 3476.913077173091, 3518.5777706674853, 53192.73403632957, 53289.0, 53511.732441337546, 53607.0, 53933.191002135, 45107.0, 45219.32171017437, 45636.543634563895, 45835.0, 45844.54155458469, 35554.8222258887, 42801.0, 43447.13105737931, 45040.77479612581, 45268.320975186056, 8310.501369917823, 8343.332533397192, 8385.371097167616, 8391.916080839113, 8597.441166324168, 31378.52932205973, 32250.838745806122, 32315.0, 32850.0, 33420.498692520116, 36219.63780362163, 39104.608953910094, 40797.0, 41639.37540936828, 41746.791266043474, 9493.66772162971, 9532.95233523828, 9638.325317228007, 9886.85169722469, 10033.598656053677, 10420.531076101443, 10577.894221057692, 11355.205135640426, 11686.532538698357, 12114.697132571757, 10440.321379110334, 10480.790384192425, 10621.628243011457, 11083.612073577386, 11295.7740845181, 10135.391876487434, 10393.064624183557, 10449.84325235107, 10560.630377936735, 10962.616308429167, 10555.736106597396, 10785.298955567863, 10822.945885270523, 11011.229213954946, 11260.662180134608, 8957.686480973134, 9408.623655053721, 9607.895597371977, 9787.804243915225, 9836.508174591385, 9165.862512062191, 9180.632774688938, 9270.44377337362, 9294.054123672942, 9357.251419886528], "unit": "score", "name": "yui.html", "value": 5760.496944527175}], "name": "dromaeo_css", "value": 6474.340349359625}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 116.0, 115.0, 114.0, 114.0, 113.0, 112.0, 113.0, 124.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [165.0, 132.0, 154.0, 169.0, 131.0, 159.0, 151.0, 133.0, 166.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 160.0, 158.0, 160.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 77.0, 163.0, 77.0, 72.0, 76.0, 75.0, 163.0, 86.0], "unit": "score", "name": "audio-fft", "value": 93.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 146.0, 94.0, 95.0, 94.0, 136.0, 95.0, 94.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 145.0, 148.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 68.0, 68.0, 67.0, 66.0, 68.0, 77.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 69.0, 65.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.5}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 82.0, 91.0, 82.0, 82.0, 81.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [117.0, 125.0, 120.0, 125.0, 116.0, 119.0, 117.0, 128.0, 120.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [135.0, 134.0, 149.0, 142.0, 146.0, 133.0, 143.0, 143.0, 142.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [69.0, 74.0, 69.0, 66.0, 67.0, 67.0, 67.0, 69.0, 71.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1530.6000000000001}]} 16:00:34 INFO - Return code: 0 16:00:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:00:34 INFO - # TBPL SUCCESS # 16:00:34 INFO - Running post-action listener: _resource_record_post_action 16:00:34 INFO - Running post-run listener: _resource_record_post_run 16:00:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 16384; Write bytes: 489017344; Read time: 44; Write time: 425300 16:00:35 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 238338048; Read time: 0; Write time: 258788 16:00:35 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 16384; Write bytes: 250679296; Read time: 44; Write time: 166512 16:00:35 INFO - Running post-run listener: _upload_blobber_files 16:00:35 INFO - Blob upload gear active. 16:00:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:00:35 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 16:00:35 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:00:35 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:00:35 INFO - (blobuploader) - INFO - Open directory for files ... 16:00:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:00:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:00:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:36 INFO - (blobuploader) - INFO - Done attempting. 16:00:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:00:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:00:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:37 INFO - (blobuploader) - INFO - Done attempting. 16:00:37 INFO - (blobuploader) - INFO - Iteration through files over. 16:00:37 INFO - Return code: 0 16:00:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:00:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:00:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e12d19dc02e4a20accc2783e61b64f49957d557061aa09d48218bb380d5e30f8ade930e8bf3291f1c3b385e08b59ca9c1d357a19ad3f365d9932f0780106d73a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/6d79068de2acf3ab437a5fc86dae2d12c49327761cade76049692d941e4e85e65094f21ef4851d9f3e0be35ca846d77308a3444cc187abb099dbc3f9167fcb96"} 16:00:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:00:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:00:37 INFO - Contents: 16:00:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e12d19dc02e4a20accc2783e61b64f49957d557061aa09d48218bb380d5e30f8ade930e8bf3291f1c3b385e08b59ca9c1d357a19ad3f365d9932f0780106d73a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/6d79068de2acf3ab437a5fc86dae2d12c49327761cade76049692d941e4e85e65094f21ef4851d9f3e0be35ca846d77308a3444cc187abb099dbc3f9167fcb96"} 16:00:37 INFO - Running post-run listener: copy_logs_to_upload_dir 16:00:37 INFO - Copying logs to upload dir... 16:00:37 INFO - mkdir: /builds/slave/test/build/upload/logs 16:00:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.524047 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-30 16:00:37.357031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:00:37.361252) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e12d19dc02e4a20accc2783e61b64f49957d557061aa09d48218bb380d5e30f8ade930e8bf3291f1c3b385e08b59ca9c1d357a19ad3f365d9932f0780106d73a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/6d79068de2acf3ab437a5fc86dae2d12c49327761cade76049692d941e4e85e65094f21ef4851d9f3e0be35ca846d77308a3444cc187abb099dbc3f9167fcb96"} build_url:https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/KJtE8-ejR7q7T5qoOOFm_A/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/e12d19dc02e4a20accc2783e61b64f49957d557061aa09d48218bb380d5e30f8ade930e8bf3291f1c3b385e08b59ca9c1d357a19ad3f365d9932f0780106d73a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/6d79068de2acf3ab437a5fc86dae2d12c49327761cade76049692d941e4e85e65094f21ef4851d9f3e0be35ca846d77308a3444cc187abb099dbc3f9167fcb96"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:00:37.394489) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:00:37.395086) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1467326399.961117-231842321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:00:37.475433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:00:37.475766) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:00:37.476104) ========= ========= Total master_lag: 0.19 =========