builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1460996173.34 results: success (0) buildid: 20160418064120 builduid: 22cf9637479640e3be23e5e1b1adb86e revision: ae136454b6b76b79a5bf9498fe262c75bd03c763 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:13.344703) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:13.346709) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:13.347107) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:13.365666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:13.365952) ========= 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-1460995857.633464-2050000368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 09:16:13-- 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% 226M=0s 2016-04-18 09:16:13 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087057 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:13.466143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:13.466435) ========= 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-1460995857.633464-2050000368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014868 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:13.550601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 09:16:13.550941) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae136454b6b76b79a5bf9498fe262c75bd03c763 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ae136454b6b76b79a5bf9498fe262c75bd03c763 --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-1460995857.633464-2050000368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 09:16:13,791 truncating revision to first 12 chars 2016-04-18 09:16:13,791 Setting DEBUG logging. 2016-04-18 09:16:13,791 attempt 1/10 2016-04-18 09:16:13,791 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ae136454b6b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 09:16:14,521 unpacking tar archive at: mozilla-aurora-ae136454b6b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.026134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 09:16:14.593919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:14.594821) ========= script_repo_revision: ae136454b6b76b79a5bf9498fe262c75bd03c763 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:14.595631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:14.595957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 09:16:14.606864) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-18 09:16:14.607451) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:16:14 INFO - MultiFileLogger online at 20160418 09:16:14 in /builds/slave/test 09:16:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:16:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:16:14 INFO - {'append_to_log': False, 09:16:14 INFO - 'base_work_dir': '/builds/slave/test', 09:16:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:16:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:16:14 INFO - 'branch': 'Mozilla-Aurora', 09:16:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:14 INFO - 'config_files': ('talos/linux_config.py',), 09:16:14 INFO - 'default_actions': ('clobber', 09:16:14 INFO - 'read-buildbot-config', 09:16:14 INFO - 'download-and-extract', 09:16:14 INFO - 'populate-webroot', 09:16:14 INFO - 'create-virtualenv', 09:16:14 INFO - 'install', 09:16:14 INFO - 'run-tests'), 09:16:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:14 INFO - 'download_minidump_stackwalk': True, 09:16:14 INFO - 'download_symbols': 'ondemand', 09:16:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:16:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:16:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:16:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:16:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:14 INFO - 'installer_path': 'installer.exe', 09:16:14 INFO - 'log_level': 'info', 09:16:14 INFO - 'log_name': 'talos', 09:16:14 INFO - 'log_to_console': True, 09:16:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:16:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:16:14 INFO - 'opt_config_files': (), 09:16:14 INFO - 'pip_index': False, 09:16:14 INFO - 'sps_profile': False, 09:16:14 INFO - 'sps_profile_interval': 0, 09:16:14 INFO - 'suite': 'dromaeojs', 09:16:14 INFO - 'system_bits': '32', 09:16:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:14 INFO - 'title': 'talos-linux64-ix-040', 09:16:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:14 INFO - 'use_talos_json': True, 09:16:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:16:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:14 INFO - 'work_dir': 'build'} 09:16:14 INFO - ##### 09:16:14 INFO - ##### Running clobber step. 09:16:14 INFO - ##### 09:16:14 INFO - Running pre-action listener: _resource_record_pre_action 09:16:14 INFO - Running main action method: clobber 09:16:14 INFO - rmtree: /builds/slave/test/build 09:16:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:16:15 INFO - Running post-action listener: _resource_record_post_action 09:16:15 INFO - ##### 09:16:15 INFO - ##### Running read-buildbot-config step. 09:16:15 INFO - ##### 09:16:15 INFO - Running pre-action listener: _resource_record_pre_action 09:16:15 INFO - Running main action method: read_buildbot_config 09:16:15 INFO - Using buildbot properties: 09:16:15 INFO - { 09:16:15 INFO - "project": "", 09:16:15 INFO - "product": "firefox", 09:16:15 INFO - "script_repo_revision": "production", 09:16:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:16:15 INFO - "repository": "", 09:16:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:16:15 INFO - "buildid": "20160418064120", 09:16:15 INFO - "pgo_build": "True", 09:16:15 INFO - "basedir": "/builds/slave/test", 09:16:15 INFO - "buildnumber": 442, 09:16:15 INFO - "slavename": "talos-linux64-ix-040", 09:16:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:16:15 INFO - "platform": "ubuntu64_hw", 09:16:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:16:15 INFO - "branch": "mozilla-aurora", 09:16:15 INFO - "repo_path": "releases/mozilla-aurora", 09:16:15 INFO - "revision": "ae136454b6b76b79a5bf9498fe262c75bd03c763", 09:16:15 INFO - "stage_platform": "linux64-pgo", 09:16:15 INFO - "builduid": "22cf9637479640e3be23e5e1b1adb86e", 09:16:15 INFO - "slavebuilddir": "test" 09:16:15 INFO - } 09:16:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 09:16:15 INFO - Running post-action listener: _resource_record_post_action 09:16:15 INFO - ##### 09:16:15 INFO - ##### Running download-and-extract step. 09:16:15 INFO - ##### 09:16:15 INFO - Running pre-action listener: _resource_record_pre_action 09:16:15 INFO - Running main action method: download_and_extract 09:16:15 INFO - mkdir: /builds/slave/test/build/tests 09:16:15 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')]} 09:16:15 INFO - https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:16:16 INFO - Downloaded 1448 bytes. 09:16:16 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:16:16 INFO - Using the following test package requirements: 09:16:16 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:16:16 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:16:16 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:16:16 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:16 INFO - u'jsshell-linux-x86_64.zip'], 09:16:16 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:16:16 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:16:16 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:16:16 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:16:16 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:16:16 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:16:16 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:16:16 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:16:16 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')]} 09:16:16 INFO - https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:16:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:16:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:16:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:16:19 INFO - Downloaded 23352303 bytes. 09:16:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:16:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:16:20 INFO - Return code: 0 09:16:20 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:20 INFO - https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:16:24 INFO - Downloaded 23352303 bytes. 09:16:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:16:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:16:25 INFO - Return code: 0 09:16: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')]} 09:16:25 INFO - https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:16:26 INFO - Downloaded 10845168 bytes. 09:16:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:16:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:16:27 INFO - Return code: 0 09:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:27 INFO - https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:16:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:16:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:16:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:16:28 INFO - Downloaded 60593294 bytes. 09:16:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:16:28 INFO - mkdir: /builds/slave/test/properties 09:16:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:28 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:28 INFO - Contents: 09:16:28 INFO - build_url:https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:16:30 INFO - Running post-action listener: _resource_record_post_action 09:16:30 INFO - Running post-action listener: set_extra_try_arguments 09:16:30 INFO - ##### 09:16:30 INFO - ##### Running populate-webroot step. 09:16:30 INFO - ##### 09:16:30 INFO - Running pre-action listener: _resource_record_pre_action 09:16:30 INFO - Running main action method: populate_webroot 09:16:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:30 INFO - '--tppagecycles', 09:16:30 INFO - '7'], 09:16:30 INFO - 'tests': ['tsvgm']}}, 09:16:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:16:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:16:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:16:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:16:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:30 INFO - 'talos_options': ['--e10s'], 09:16:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:30 INFO - 'tests': ['damp', 'tps']}, 09:16:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:30 INFO - 'talos_options': ['--e10s'], 09:16:30 INFO - 'tests': ['damp', 'tps']}, 09:16:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:16:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:30 INFO - 'other': {'tests': ['a11yr', 09:16:30 INFO - 'ts_paint', 09:16:30 INFO - 'tpaint', 09:16:30 INFO - 'sessionrestore', 09:16:30 INFO - 'sessionrestore_no_auto_restore', 09:16:30 INFO - 'tabpaint']}, 09:16:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:16:30 INFO - 'tests': ['a11yr', 09:16:30 INFO - 'ts_paint', 09:16:30 INFO - 'tpaint', 09:16:30 INFO - 'sessionrestore', 09:16:30 INFO - 'sessionrestore_no_auto_restore', 09:16:30 INFO - 'tabpaint']}, 09:16:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:16:30 INFO - 'tests': ['a11yr', 09:16:30 INFO - 'ts_paint', 09:16:30 INFO - 'tpaint', 09:16:30 INFO - 'sessionrestore', 09:16:30 INFO - 'sessionrestore_no_auto_restore', 09:16:30 INFO - 'tabpaint']}, 09:16:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:16:30 INFO - 'tests': ['a11yr', 09:16:30 INFO - 'ts_paint', 09:16:30 INFO - 'tpaint', 09:16:30 INFO - 'sessionrestore', 09:16:30 INFO - 'sessionrestore_no_auto_restore', 09:16:30 INFO - 'tabpaint']}, 09:16:30 INFO - 'other_l64': {'tests': ['a11yr', 09:16:30 INFO - 'ts_paint', 09:16:30 INFO - 'tpaint', 09:16:30 INFO - 'sessionrestore', 09:16:30 INFO - 'sessionrestore_no_auto_restore', 09:16:30 INFO - 'tabpaint']}, 09:16:30 INFO - 'other_nol64': {'tests': ['a11yr', 09:16:30 INFO - 'ts_paint', 09:16:30 INFO - 'tpaint', 09:16:30 INFO - 'sessionrestore', 09:16:30 INFO - 'sessionrestore_no_auto_restore', 09:16:30 INFO - 'tabpaint']}, 09:16:30 INFO - 'svgr': {'tests': ['tsvgx', 09:16:30 INFO - 'tsvgr_opacity', 09:16:30 INFO - 'tart', 09:16:30 INFO - 'tscrollx', 09:16:30 INFO - 'cart']}, 09:16:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:16:30 INFO - 'tests': ['tsvgx', 09:16:30 INFO - 'tsvgr_opacity', 09:16:30 INFO - 'tart', 09:16:30 INFO - 'tscrollx', 09:16:30 INFO - 'cart']}, 09:16:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:30 INFO - 'tests': ['tp5o']}, 09:16:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:30 INFO - 'talos_options': ['--e10s'], 09:16:30 INFO - 'tests': ['tp5o']}, 09:16:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:30 INFO - 'talos_options': ['--xperf_path', 09:16:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:30 INFO - 'tests': ['tp5n']}, 09:16:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:30 INFO - 'talos_options': ['--e10s', 09:16:30 INFO - '--xperf_path', 09:16:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:30 INFO - 'tests': ['tp5n']}}, 09:16:30 INFO - 'talos.zip': {'path': '', 09:16:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:30 INFO - Running post-action listener: _resource_record_post_action 09:16:30 INFO - ##### 09:16:30 INFO - ##### Running create-virtualenv step. 09:16:30 INFO - ##### 09:16:30 INFO - Running pre-action listener: _resource_record_pre_action 09:16:30 INFO - Running main action method: create_virtualenv 09:16:30 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:30 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 09:16:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:30 INFO - Using real prefix '/usr' 09:16:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:30 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:32 INFO - Installing pip.................done. 09:16:32 INFO - Return code: 0 09:16:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3965f87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a0160>, '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 0x29a1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a14f0>, '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-1460995857.633464-2050000368', '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 09:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:16:32 INFO - Using env: {'DISPLAY': ':0', 09:16:32 INFO - 'HOME': '/home/cltbld', 09:16:32 INFO - 'LANG': 'en_US.UTF-8', 09:16:32 INFO - 'LANGUAGE': 'en_US:en', 09:16:32 INFO - 'LOGNAME': 'cltbld', 09:16:32 INFO - 'MAIL': '/var/mail/cltbld', 09:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:32 INFO - 'MOZ_NO_REMOTE': '1', 09:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:32 INFO - 'NO_EM_RESTART': '1', 09:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:32 INFO - 'PWD': '/builds/slave/test', 09:16:32 INFO - 'SHELL': '/bin/bash', 09:16:32 INFO - 'SHLVL': '1', 09:16:32 INFO - 'TERM': 'linux', 09:16:32 INFO - 'TMOUT': '86400', 09:16:32 INFO - 'USER': 'cltbld', 09:16:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368', 09:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:32 INFO - '_': '/tools/buildbot/bin/python'} 09:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:32 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 09:16:32 INFO - Cleaning up... 09:16:32 INFO - Return code: 0 09:16:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3965f87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a0160>, '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 0x29a1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a14f0>, '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-1460995857.633464-2050000368', '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 09:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:16:32 INFO - Using env: {'DISPLAY': ':0', 09:16:32 INFO - 'HOME': '/home/cltbld', 09:16:32 INFO - 'LANG': 'en_US.UTF-8', 09:16:32 INFO - 'LANGUAGE': 'en_US:en', 09:16:32 INFO - 'LOGNAME': 'cltbld', 09:16:32 INFO - 'MAIL': '/var/mail/cltbld', 09:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:32 INFO - 'MOZ_NO_REMOTE': '1', 09:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:32 INFO - 'NO_EM_RESTART': '1', 09:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:32 INFO - 'PWD': '/builds/slave/test', 09:16:32 INFO - 'SHELL': '/bin/bash', 09:16:32 INFO - 'SHLVL': '1', 09:16:32 INFO - 'TERM': 'linux', 09:16:32 INFO - 'TMOUT': '86400', 09:16:32 INFO - 'USER': 'cltbld', 09:16:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368', 09:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:32 INFO - '_': '/tools/buildbot/bin/python'} 09:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:33 INFO - Downloading/unpacking psutil>=0.7.1 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:35 INFO - Installing collected packages: psutil 09:16:35 INFO - Running setup.py install for psutil 09:16:35 INFO - building 'psutil._psutil_linux' extension 09:16:35 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 09:16:35 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 09:16:35 INFO - building 'psutil._psutil_posix' extension 09:16:35 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 09:16:35 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 09:16:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:35 INFO - Successfully installed psutil 09:16:35 INFO - Cleaning up... 09:16:35 INFO - Return code: 0 09:16:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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', '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 0x7f3965f87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a0160>, '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 0x29a1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a14f0>, '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-1460995857.633464-2050000368', '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 09:16: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:16: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 mozsystemmonitor==0.0.0 09:16:35 INFO - Using env: {'DISPLAY': ':0', 09:16:35 INFO - 'HOME': '/home/cltbld', 09:16:35 INFO - 'LANG': 'en_US.UTF-8', 09:16:35 INFO - 'LANGUAGE': 'en_US:en', 09:16:35 INFO - 'LOGNAME': 'cltbld', 09:16:35 INFO - 'MAIL': '/var/mail/cltbld', 09:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:35 INFO - 'MOZ_NO_REMOTE': '1', 09:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:35 INFO - 'NO_EM_RESTART': '1', 09:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:35 INFO - 'PWD': '/builds/slave/test', 09:16:35 INFO - 'SHELL': '/bin/bash', 09:16:35 INFO - 'SHLVL': '1', 09:16:35 INFO - 'TERM': 'linux', 09:16:35 INFO - 'TMOUT': '86400', 09:16:35 INFO - 'USER': 'cltbld', 09:16:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368', 09:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:35 INFO - '_': '/tools/buildbot/bin/python'} 09:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:16:37 INFO - Installing collected packages: mozsystemmonitor 09:16:37 INFO - Running setup.py install for mozsystemmonitor 09:16:37 INFO - Successfully installed mozsystemmonitor 09:16:37 INFO - Cleaning up... 09:16:38 INFO - Return code: 0 09:16:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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', '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 0x7f3965f87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a0160>, '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 0x29a1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a14f0>, '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-1460995857.633464-2050000368', '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 09:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:16: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 blobuploader==1.2.4 09:16:38 INFO - Using env: {'DISPLAY': ':0', 09:16:38 INFO - 'HOME': '/home/cltbld', 09:16:38 INFO - 'LANG': 'en_US.UTF-8', 09:16:38 INFO - 'LANGUAGE': 'en_US:en', 09:16:38 INFO - 'LOGNAME': 'cltbld', 09:16:38 INFO - 'MAIL': '/var/mail/cltbld', 09:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:38 INFO - 'MOZ_NO_REMOTE': '1', 09:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:38 INFO - 'NO_EM_RESTART': '1', 09:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:38 INFO - 'PWD': '/builds/slave/test', 09:16:38 INFO - 'SHELL': '/bin/bash', 09:16:38 INFO - 'SHLVL': '1', 09:16:38 INFO - 'TERM': 'linux', 09:16:38 INFO - 'TMOUT': '86400', 09:16:38 INFO - 'USER': 'cltbld', 09:16:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368', 09:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:38 INFO - '_': '/tools/buildbot/bin/python'} 09:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:38 INFO - Downloading/unpacking blobuploader==1.2.4 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:40 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:40 INFO - Downloading docopt-0.6.1.tar.gz 09:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:40 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:40 INFO - Running setup.py install for blobuploader 09:16:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:40 INFO - Running setup.py install for requests 09:16:41 INFO - Running setup.py install for docopt 09:16:41 INFO - Successfully installed blobuploader requests docopt 09:16:41 INFO - Cleaning up... 09:16:41 INFO - Return code: 0 09:16:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3965f87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a0160>, '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 0x29a1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a14f0>, '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-1460995857.633464-2050000368', '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 09:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:41 INFO - Using env: {'DISPLAY': ':0', 09:16:41 INFO - 'HOME': '/home/cltbld', 09:16:41 INFO - 'LANG': 'en_US.UTF-8', 09:16:41 INFO - 'LANGUAGE': 'en_US:en', 09:16:41 INFO - 'LOGNAME': 'cltbld', 09:16:41 INFO - 'MAIL': '/var/mail/cltbld', 09:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:41 INFO - 'MOZ_NO_REMOTE': '1', 09:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:41 INFO - 'NO_EM_RESTART': '1', 09:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:41 INFO - 'PWD': '/builds/slave/test', 09:16:41 INFO - 'SHELL': '/bin/bash', 09:16:41 INFO - 'SHLVL': '1', 09:16:41 INFO - 'TERM': 'linux', 09:16:41 INFO - 'TMOUT': '86400', 09:16:41 INFO - 'USER': 'cltbld', 09:16:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368', 09:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:41 INFO - '_': '/tools/buildbot/bin/python'} 09:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:41 INFO - Running setup.py (path:/tmp/pip-UBHML3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:41 INFO - Running setup.py (path:/tmp/pip-oymCuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:41 INFO - Running setup.py (path:/tmp/pip-7hfbZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:41 INFO - Running setup.py (path:/tmp/pip-_FZBPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:41 INFO - Running setup.py (path:/tmp/pip-jLFhUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:42 INFO - Running setup.py (path:/tmp/pip-cPNBbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:42 INFO - Running setup.py (path:/tmp/pip-U_8eSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:42 INFO - Running setup.py (path:/tmp/pip-mSLUAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:42 INFO - Running setup.py (path:/tmp/pip-IaSxca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:42 INFO - Running setup.py (path:/tmp/pip-i_R6fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:42 INFO - Running setup.py (path:/tmp/pip-V4j1Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:42 INFO - Running setup.py (path:/tmp/pip-k3KwuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:42 INFO - Running setup.py (path:/tmp/pip-a5jViz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:42 INFO - Running setup.py (path:/tmp/pip-DBzw5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:42 INFO - Running setup.py (path:/tmp/pip-aF35bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:42 INFO - Running setup.py (path:/tmp/pip-Rhzb0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:42 INFO - Running setup.py (path:/tmp/pip-PWvCx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:42 INFO - Running setup.py install for manifestparser 09:16:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:42 INFO - Running setup.py install for mozcrash 09:16:43 INFO - Running setup.py install for mozdebug 09:16:43 INFO - Running setup.py install for mozdevice 09:16:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:16:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:43 INFO - Running setup.py install for mozfile 09:16:43 INFO - Running setup.py install for mozhttpd 09:16:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:43 INFO - Running setup.py install for mozinfo 09:16:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:43 INFO - Running setup.py install for mozInstall 09:16:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:43 INFO - Running setup.py install for mozleak 09:16:43 INFO - Running setup.py install for mozlog 09:16:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:43 INFO - Running setup.py install for moznetwork 09:16:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:44 INFO - Running setup.py install for mozprocess 09:16:44 INFO - Running setup.py install for mozprofile 09:16:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:44 INFO - Running setup.py install for mozrunner 09:16:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:44 INFO - Running setup.py install for mozscreenshot 09:16:44 INFO - Running setup.py install for moztest 09:16:44 INFO - Running setup.py install for mozversion 09:16:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:44 INFO - Cleaning up... 09:16:44 INFO - Return code: 0 09:16:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3965f87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a0160>, '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 0x29a1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a14f0>, '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-1460995857.633464-2050000368', '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 09:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:44 INFO - Using env: {'DISPLAY': ':0', 09:16:44 INFO - 'HOME': '/home/cltbld', 09:16:44 INFO - 'LANG': 'en_US.UTF-8', 09:16:44 INFO - 'LANGUAGE': 'en_US:en', 09:16:44 INFO - 'LOGNAME': 'cltbld', 09:16:44 INFO - 'MAIL': '/var/mail/cltbld', 09:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:44 INFO - 'MOZ_NO_REMOTE': '1', 09:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:44 INFO - 'NO_EM_RESTART': '1', 09:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:44 INFO - 'PWD': '/builds/slave/test', 09:16:44 INFO - 'SHELL': '/bin/bash', 09:16:44 INFO - 'SHLVL': '1', 09:16:44 INFO - 'TERM': 'linux', 09:16:44 INFO - 'TMOUT': '86400', 09:16:44 INFO - 'USER': 'cltbld', 09:16:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368', 09:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:44 INFO - '_': '/tools/buildbot/bin/python'} 09:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:44 INFO - Running setup.py (path:/tmp/pip-9CnYU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:44 INFO - Running setup.py (path:/tmp/pip-R7UIDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:45 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)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:45 INFO - Running setup.py (path:/tmp/pip-gkgles-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:45 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)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:45 INFO - Running setup.py (path:/tmp/pip-NNSp_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:45 INFO - Running setup.py (path:/tmp/pip-8bm3ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:45 INFO - Running setup.py (path:/tmp/pip-dMA0GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:45 INFO - Running setup.py (path:/tmp/pip-bgbJ5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:45 INFO - Running setup.py (path:/tmp/pip-1OZvEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:45 INFO - Running setup.py (path:/tmp/pip-WyoQ1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:45 INFO - Running setup.py (path:/tmp/pip-w_ERcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:45 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)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:45 INFO - Running setup.py (path:/tmp/pip-5nc3s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:45 INFO - Running setup.py (path:/tmp/pip-mx2P62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:45 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)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:45 INFO - Running setup.py (path:/tmp/pip-nZiWK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:45 INFO - Running setup.py (path:/tmp/pip-Hcj58w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:45 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)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:45 INFO - Running setup.py (path:/tmp/pip-62ZLMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:45 INFO - Running setup.py (path:/tmp/pip-oNjXe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:46 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)) 09:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:46 INFO - Running setup.py (path:/tmp/pip-yGxI2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:46 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)) 09:16:46 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)) 09:16:46 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)) 09:16:46 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)) 09:16:46 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)) 09:16:46 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)) 09:16:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:46 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 09:16:46 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 09:16:46 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 09:16:46 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 09:16:46 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 09:16:46 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 09:16:47 INFO - Downloading blessings-1.6.tar.gz 09:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:48 INFO - Installing collected packages: blessings 09:16:48 INFO - Running setup.py install for blessings 09:16:48 INFO - Successfully installed blessings 09:16:48 INFO - Cleaning up... 09:16:48 INFO - Return code: 0 09:16:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:48 INFO - Reading from file tmpfile_stdout 09:16:48 INFO - Current package versions: 09:16:48 INFO - argparse == 1.2.1 09:16:48 INFO - blessings == 1.6 09:16:48 INFO - blobuploader == 1.2.4 09:16:48 INFO - docopt == 0.6.1 09:16:48 INFO - manifestparser == 1.1 09:16:48 INFO - mozInstall == 1.12 09:16:48 INFO - mozcrash == 0.17 09:16:48 INFO - mozdebug == 0.1 09:16:48 INFO - mozdevice == 0.48 09:16:48 INFO - mozfile == 1.2 09:16:48 INFO - mozhttpd == 0.7 09:16:48 INFO - mozinfo == 0.9 09:16:48 INFO - mozleak == 0.1 09:16:48 INFO - mozlog == 3.1 09:16:48 INFO - moznetwork == 0.27 09:16:48 INFO - mozprocess == 0.22 09:16:48 INFO - mozprofile == 0.28 09:16:48 INFO - mozrunner == 6.11 09:16:48 INFO - mozscreenshot == 0.1 09:16:48 INFO - mozsystemmonitor == 0.0 09:16:48 INFO - moztest == 0.7 09:16:48 INFO - mozversion == 1.4 09:16:48 INFO - psutil == 3.1.1 09:16:48 INFO - requests == 1.2.3 09:16:48 INFO - wsgiref == 0.1.2 09:16:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:48 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 0x7f3965f87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a0160>, '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 0x29a1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a14f0>, '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-1460995857.633464-2050000368', '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 09:16:48 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 09:16:48 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 09:16:48 INFO - Using env: {'DISPLAY': ':0', 09:16:48 INFO - 'HOME': '/home/cltbld', 09:16:48 INFO - 'LANG': 'en_US.UTF-8', 09:16:48 INFO - 'LANGUAGE': 'en_US:en', 09:16:48 INFO - 'LOGNAME': 'cltbld', 09:16:48 INFO - 'MAIL': '/var/mail/cltbld', 09:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:48 INFO - 'MOZ_NO_REMOTE': '1', 09:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:48 INFO - 'NO_EM_RESTART': '1', 09:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:48 INFO - 'PWD': '/builds/slave/test', 09:16:48 INFO - 'SHELL': '/bin/bash', 09:16:48 INFO - 'SHLVL': '1', 09:16:48 INFO - 'TERM': 'linux', 09:16:48 INFO - 'TMOUT': '86400', 09:16:48 INFO - 'USER': 'cltbld', 09:16:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368', 09:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:48 INFO - '_': '/tools/buildbot/bin/python'} 09:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:48 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)) 09:16:48 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)) 09:16:48 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)) 09:16:48 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)) 09:16:48 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)) 09:16:48 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)) 09:16:48 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)) 09:16:48 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)) 09:16:48 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)) 09:16:48 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)) 09:16:48 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)) 09:16:48 INFO - Cleaning up... 09:16:48 INFO - Return code: 0 09:16:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:48 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 0x7f3965f87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a0160>, '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 0x29a1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a14f0>, '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-1460995857.633464-2050000368', '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 09:16:48 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 09:16:48 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 09:16:48 INFO - Using env: {'DISPLAY': ':0', 09:16:48 INFO - 'HOME': '/home/cltbld', 09:16:48 INFO - 'LANG': 'en_US.UTF-8', 09:16:48 INFO - 'LANGUAGE': 'en_US:en', 09:16:48 INFO - 'LOGNAME': 'cltbld', 09:16:48 INFO - 'MAIL': '/var/mail/cltbld', 09:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:48 INFO - 'MOZ_NO_REMOTE': '1', 09:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:48 INFO - 'NO_EM_RESTART': '1', 09:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:48 INFO - 'PWD': '/builds/slave/test', 09:16:48 INFO - 'SHELL': '/bin/bash', 09:16:48 INFO - 'SHLVL': '1', 09:16:48 INFO - 'TERM': 'linux', 09:16:48 INFO - 'TMOUT': '86400', 09:16:48 INFO - 'USER': 'cltbld', 09:16:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368', 09:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:48 INFO - '_': '/tools/buildbot/bin/python'} 09:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:48 INFO - Downloading/unpacking jsonschema 09:16:48 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 09:16:48 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 09:16:48 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 09:16:48 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 09:16:48 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 09:16:48 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 09:16:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:50 INFO - Downloading/unpacking functools32 (from jsonschema) 09:16:50 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 09:16:50 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 09:16:50 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 09:16:50 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 09:16:50 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 09:16:50 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 09:16:50 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:51 INFO - warning: no files found matching '*.txt' 09:16:51 INFO - no previously-included directories found matching 'build' 09:16:51 INFO - no previously-included directories found matching 'dist' 09:16:51 INFO - no previously-included directories found matching '.git*' 09:16:51 INFO - Installing collected packages: jsonschema, functools32 09:16:51 INFO - Running setup.py install for functools32 09:16:51 INFO - warning: no files found matching '*.txt' 09:16:51 INFO - no previously-included directories found matching 'build' 09:16:51 INFO - no previously-included directories found matching 'dist' 09:16:51 INFO - no previously-included directories found matching '.git*' 09:16:51 INFO - Successfully installed jsonschema functools32 09:16:51 INFO - Cleaning up... 09:16:51 INFO - Return code: 0 09:16:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:16:51 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')]} 09:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:51 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')]} 09:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:51 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 0x7f3965f87f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2911410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a0160>, '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 0x29a1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a14f0>, '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-1460995857.633464-2050000368', '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 09:16:51 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 09:16:51 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 09:16:51 INFO - Using env: {'DISPLAY': ':0', 09:16:51 INFO - 'HOME': '/home/cltbld', 09:16:51 INFO - 'LANG': 'en_US.UTF-8', 09:16:51 INFO - 'LANGUAGE': 'en_US:en', 09:16:51 INFO - 'LOGNAME': 'cltbld', 09:16:51 INFO - 'MAIL': '/var/mail/cltbld', 09:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:51 INFO - 'MOZ_NO_REMOTE': '1', 09:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:51 INFO - 'NO_EM_RESTART': '1', 09:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:51 INFO - 'PWD': '/builds/slave/test', 09:16:51 INFO - 'SHELL': '/bin/bash', 09:16:51 INFO - 'SHLVL': '1', 09:16:51 INFO - 'TERM': 'linux', 09:16:51 INFO - 'TMOUT': '86400', 09:16:51 INFO - 'USER': 'cltbld', 09:16:51 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368', 09:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:51 INFO - '_': '/tools/buildbot/bin/python'} 09:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:51 INFO - Downloading/unpacking flake8 09:16:51 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 09:16:51 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 09:16:51 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 09:16:51 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 09:16:51 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 09:16:51 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 09:16:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:16:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:16:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 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 09:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:16:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:16:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:16:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:16:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:16:54 INFO - no previously-included directories found matching 'docs/_build' 09:16:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:16:54 INFO - Running setup.py install for pep8 09:16:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:16:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:16:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:16:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:16:54 INFO - no previously-included directories found matching 'docs/_build' 09:16:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:16:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:16:54 INFO - Cleaning up... 09:16:54 INFO - Return code: 0 09:16:54 INFO - Running post-action listener: _resource_record_post_action 09:16:54 INFO - Running post-action listener: _start_resource_monitoring 09:16:54 INFO - Starting resource monitoring. 09:16:54 INFO - ##### 09:16:54 INFO - ##### Running install step. 09:16:54 INFO - ##### 09:16:54 INFO - Running pre-action listener: _resource_record_pre_action 09:16:54 INFO - Running main action method: install 09:16:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:54 INFO - Reading from file tmpfile_stdout 09:16:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:54 INFO - Reading from file tmpfile_stdout 09:16:54 INFO - Output received: 09:16:54 INFO - Usage: mozinstall [options] installer 09:16:54 INFO - Options: 09:16:54 INFO - -h, --help show this help message and exit 09:16:54 INFO - -d DEST, --destination=DEST 09:16:54 INFO - Directory to install application into. [default: 09:16:54 INFO - "/builds/slave/test"] 09:16:54 INFO - --app=APP Application being installed. [default: firefox] 09:16:54 INFO - mkdir: /builds/slave/test/build/application 09:16:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:17:09 INFO - Reading from file tmpfile_stdout 09:17:09 INFO - Output received: 09:17:09 INFO - /builds/slave/test/build/application/firefox/firefox 09:17:09 INFO - Running post-action listener: _resource_record_post_action 09:17:09 INFO - ##### 09:17:09 INFO - ##### Running run-tests step. 09:17:09 INFO - ##### 09:17:09 INFO - Running pre-action listener: _resource_record_pre_action 09:17:09 INFO - Running main action method: run_tests 09:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:17:09 INFO - Python 2.7.3 09:17:09 INFO - Return code: 0 09:17:09 INFO - grabbing minidump binary from tooltool 09:17: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')]} 09:17:09 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 0x29a0160>, '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 0x29a1060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29a14f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:17:09 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 09:17:09 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 09:17:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:09 INFO - Return code: 0 09:17:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:17:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:17:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:17:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:17:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:17:10 INFO - Return code: 0 09:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.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 09:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.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 09:17:10 INFO - Using env: {'DISPLAY': ':0', 09:17:10 INFO - 'HOME': '/home/cltbld', 09:17:10 INFO - 'LANG': 'en_US.UTF-8', 09:17:10 INFO - 'LANGUAGE': 'en_US:en', 09:17:10 INFO - 'LOGNAME': 'cltbld', 09:17:10 INFO - 'MAIL': '/var/mail/cltbld', 09:17:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:10 INFO - 'MOZ_NO_REMOTE': '1', 09:17:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:10 INFO - 'NO_EM_RESTART': '1', 09:17:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:10 INFO - 'PWD': '/builds/slave/test', 09:17:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:10 INFO - 'SHELL': '/bin/bash', 09:17:10 INFO - 'SHLVL': '1', 09:17:10 INFO - 'TERM': 'linux', 09:17:10 INFO - 'TMOUT': '86400', 09:17:10 INFO - 'USER': 'cltbld', 09:17:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460995857.633464-2050000368', 09:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:10 INFO - '_': '/tools/buildbot/bin/python'} 09:17:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.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 09:17:11 INFO - mozversion application_buildid: 20160418064120 09:17:11 INFO - mozversion application_changeset: ae136454b6b76b79a5bf9498fe262c75bd03c763 09:17:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:17:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:11 INFO - mozversion application_name: Firefox 09:17:11 INFO - mozversion application_remotingname: firefox-dev 09:17:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:11 INFO - mozversion application_vendor: Mozilla 09:17:11 INFO - mozversion application_version: 47.0a2 09:17:11 INFO - mozversion platform_buildid: 20160418064120 09:17:11 INFO - mozversion platform_changeset: ae136454b6b76b79a5bf9498fe262c75bd03c763 09:17:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:11 INFO - mozversion platform_version: 47.0a2 09:17:11 INFO - using testdate: 1460996231 09:17:11 INFO - actual date: 1460996231 09:17:11 INFO - starting webserver on 'localhost:35866' 09:17:11 INFO - SUITE-START | Running 2 tests 09:17:11 INFO - TEST-START | dromaeo_css 09:17:11 INFO - operating with platform_type : linux_ 09:17:11 INFO - Initialising browser for dromaeo_css test... 09:17:11 INFO - TEST-INFO | started process 8333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDTWpnb/profile http://localhost:35866/getInfo.html) 09:17:15 INFO - PROCESS | 8333 | __metrics Screen width/height:1600/1200 09:17:15 INFO - PROCESS | 8333 | colorDepth:24 09:17:15 INFO - PROCESS | 8333 | Browser inner width/height: 1024/697 09:17:15 INFO - PROCESS | 8333 | __metrics 09:17:16 INFO - PROCESS | 8333 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:17:17 INFO - TEST-INFO | 8333: exit 0 09:17:17 INFO - Browser initialized. 09:17:17 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:17 INFO - TEST-INFO | started process 8422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDTWpnb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:29 INFO - PROCESS | 8422 | RSS: Main: 141799424 09:17:29 INFO - PROCESS | 8422 | 09:18:19 INFO - PROCESS | 8422 | 1460996299931 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] 09:20:27 INFO - PROCESS | 8422 | Cycle 1(1): loaded http://localhost:35866/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35866/tests/dromaeo/cssquery-ext.html) 09:20:28 INFO - PROCESS | 8422 | RSS: Main: 248119296 09:20:28 INFO - PROCESS | 8422 | 09:23:30 INFO - PROCESS | 8422 | Cycle 1(1): loaded http://localhost:35866/tests/dromaeo/cssquery-ext.html (next: http://localhost:35866/tests/dromaeo/cssquery-jquery.html) 09:23:31 INFO - PROCESS | 8422 | RSS: Main: 218583040 09:23:31 INFO - PROCESS | 8422 | 09:26:33 INFO - PROCESS | 8422 | Cycle 1(1): loaded http://localhost:35866/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35866/tests/dromaeo/cssquery-mootools.html) 09:26:33 INFO - PROCESS | 8422 | RSS: Main: 233877504 09:26:33 INFO - PROCESS | 8422 | 09:29:35 INFO - PROCESS | 8422 | Cycle 1(1): loaded http://localhost:35866/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35866/tests/dromaeo/cssquery-prototype.html) 09:29:36 INFO - PROCESS | 8422 | RSS: Main: 190070784 09:29:36 INFO - PROCESS | 8422 | 09:32:38 INFO - PROCESS | 8422 | Cycle 1(1): loaded http://localhost:35866/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35866/tests/dromaeo/cssquery-yui.html) 09:32:39 INFO - PROCESS | 8422 | RSS: Main: 208080896 09:32:39 INFO - PROCESS | 8422 | 09:35:41 INFO - PROCESS | 8422 | Cycle 1(1): loaded http://localhost:35866/tests/dromaeo/cssquery-yui.html (next: http://localhost:35866/tests/dromaeo/cssquery-dojo.html) 09:35:41 INFO - PROCESS | 8422 | RSS: Main: 250998784 09:35:41 INFO - PROCESS | 8422 | 09:35:41 INFO - PROCESS | 8422 | __start_tp_report 09:35:41 INFO - PROCESS | 8422 | _x_x_mozilla_page_load 09:35:41 INFO - PROCESS | 8422 | _x_x_mozilla_page_load_details 09:35:41 INFO - PROCESS | 8422 | |i|pagename|runs| 09:35:41 INFO - PROCESS | 8422 | |0;dojo.html;3240.627327857296;3271.4275001874666;3280.015995201439;3293.7859039162468;3347.0628224097245;5329.147336426173;5348.679079255247;5353.346839788826;5368.838934831956;5390.110631745767;5306.8407947761625;5315.123004704229;5327.227552004957;5334.199870019499;5347.6256662033675;4798.0643774464;4849.733264670442;4868.026394721052;4890.951090489085;4919.040787046527;4846.030793841228;4884.706917584938;4924.285978533128;4977.3529441172595;5001.074801161779;4941.332920055783;5029.924551131736;5030.06943715412;5034.09386310464;5035.244713292998;4934.309196712463;4970.6520543561965;5000.399952005746;5004.249362595603;5013.47358527353;4768.666193366465;4832;4916.992016636616;4917.655764096515;4939.407271127488;5302.151655735102;5316.707581083039;5318.627696061278;5319.521243088141;5333.493318134771;5775.971120144414;5803.7968671096305;5804.709764511757;5806.245188125559;5813.941860581383;5599.63602365849;5683.204351390808;5711.257536520267;5786.421357864222;5790.652560846321;5417.187421886709;5444.564434845242;5448.782048718046;5449.809256675997;5455.672659640434;5712.428757124254;5839.795607153729;5897.5871688982215;5912.260967379078;5916.852078698067;5629.296337957755;5683.857903552362;5702.486776190163;5710.65736055838;5736.741846616912;5734.655920644775;5747.971260143756;5751.827445176651;5752.884942301214;5766.942330576724;5650.491455769001;5651.971740141273;5717.628354156966;5731.713414329267;5739.368669446358;5774.364819869811;5775.624584402;5779.988502012216;5784.971075144597;5812.883742325214;4336.653067754635;4345;4369.563043695605;4372.825086996548;4391.385206071152;3875.244327356195;3911.3741801311653;3946;3963.583823698528;3986.8405263789705;5473.562115030788;5490.588205884575;5493.038718224295;5496.450354964471;5503.147012213033;5806.274215723035;5816.592838501264;5816.738246778905;5823.970880145657;5828.76684932598;5354.9196762048605;5457.972710136424;5474.698891561003;5531.115021596525;5542.224088627595;4930.038642464757;4970.329005584272;4975.701457912537;4975.701457912537;5001.174806156943;5887.587868849225;5924.6149000314845;5940.34656187819;5945.791897283661;5955.553333499918;5664.8867022659315;5720.3707592164;5797.217375654402;5812.505936995402;5817.912731308949;5897.203877476486;5899;5905.616134951214;5932.970335148297;5934.228550288435;5654.321481422256;5730.369659337386;5735.770569177186;5742.196092546963;5744.42555744439;5792.797252096157;5845.678487683218;5854.4730974212525;5854.765809367748;5882.705864706833;5666.801661941812;5675.829725108253;5690.914636280542;5693.8861222774485;5702.914456283242;5517.310336207974;5648.71756412186;5656.3495198051105;5666.093425051972;5684.9431505684415;5496.642718223303;5524.889502210013;5527.226188333556;5545.639533430314;5578.023845826883;5610.102383618601;5647.632903861236;5652;5653.604247702621;5657.688827114548;5452.04589196881;5546.112621980626;5562.054450743302;5584.525315348241;5649.745761440663 09:35:41 INFO - PROCESS | 8422 | |1;ext.html;519.9532042116209;548.9725513724313;551.5284431810802;567.2682239910515;571.7198572699378;31327.99999999997;31855;31872.20319492008;31913.52129718056;38640.8407747768;42255.366169507404;42800.57199428005;42812.571874281246;42831.571684283146;42873.35689964653;8831.205191532777;9046.095390460934;9083.273338132967;9088.50013249271;9092.681756138536;8801.823963520726;8922.375433719642;8945.95527022364;8946.552672366388;8947.776305592348;8928.37501374904;9180.357374983754;9207.815843683122;9222.21611163052;9231.169194772468;9018.774530636754;9078.909210907872;9114.635414583408;9117.45295282282;9118.86321705175;9029.638814447415;9167.12912273333;9180.586873590704;9184.770380740469;9193.862092068624;41353.793231033655;41658.79170604158;41841.79079104585;41898.1620367594;41947;3544.5392099027217;3809;3824.3307421201457;3824.598417166213;4250.234957707611;29039.56440653392;29164.41671166586;29660.110196693917;29688.70311296881;30269.545956810445;4074.694397920168;4106.7535947842925;4121.949757179696;4129.339305711072;4209.7895105244925;283309;286883;287418;287814;288062;44461.55538444574;64509.35490645033;65789;65948.34051659518;65950;47453;47648.76175619169;47694;47731.76134119307;47770.76114619405;15707.921460392625;15780.210989450712;15855.207239637972;15952.20238988046;16017.359305627644;12584.748305033849;12616.495340186473;12627.179233349803;12629.115961882764;12647.988160947101;15673.137977411125;15731;15750.291236894367;15756.527304180892;15770.605734856721;6002.879942401128;6139.171211886427;6187.133801267826;6241.095041218998;6262.937370626327;1084.8481212630238;1089.6676513663408;1092.781443711245;1144.2676686920377;1151.4818331750746;29462.852685736434;29985.250368740955;30039;30295.697043029286;30538.389232215675;1152.8443660105945;1155.8150695888617;1179.5046080645977;1181.7459246261924;1202.7353982123918;12409.62771116868;15258.465953691568;15420.537383878502;15821.208939552977;15844.366225351087;272532;275118;275836;276180;276974;52360;53314.46685533095;53354.19968700472;53437;53439.73280133575;1284.5118854835102;1463.5170393770031;1491.7240310542584;1497.3187199824054;1556.3152213026233;27450.45099097967;27551.586726199523;29267;29900.551491728078;30178.54732179063;46002.30996534988;46165;46449;46450;46530.30204547002;199954;214909;215773;216800;217229;29611.40777184487;33666.15834604154;34128.14679633029;34167.82916085404;34246.14384640404;40360;40448.59551404566;40513.39229911612;41317.793411032755;41673.166536669705;34462.310753785285;34679.13302167365;34679.306413871076;34825;35129.64870351264;37142;37180.81409593043;37262.813685931396;37335;37381.813090934374;36995.815020924725;37280.62719372771;37343.2531349366;37881;38173.61826381701;32703.18242043968;33303.83348083244;34200;34254.48618270778;34425;25885.35286617774;26104.8694756525;26118.73881261163;26119.996026622088;26280.349531328065 09:35:41 INFO - PROCESS | 8422 | |2;jquery.html;381.5345278759912;384.16252569398716;385.55275879979223;389.4722650808155;390.77335145615547;17755;19353.516162095937;19392.612147757038;19978.100985455654;20019.399418017445;18492.72260916087;18590.34933777318;18693.252269909222;18768.43694689158;18885.150168242428;5601.831945041656;5837.50381217597;5866.735996880129;5885.411458854123;5890.352061273256;4307.935380969272;6147.139400483936;6413.102165696806;6422.903656445157;6430.324815894311;5248.239005344223;6320.241571011485;6348.047792831089;6384.808455746335;6385.744570217185;5477.3427188737205;5492.780288788444;5531.1426728857095;5549.445055494439;5556.777728890839;3911.5501717302304;5404.4595540446035;5651.897879913418;5657.349404818417;5665;13211.537596184184;13877;14116.223607701573;14197.929010354985;14214.85785142156;2386.785189332951;2394.4013996500876;2416.673749043874;2746.8214566053143;3039.574459575661;9794;10189.184865210766;10264.94867525665;10398.168146548334;10536.736581585445;1823.179569193868;1915.52111972007;1931.2371613212842;1938.7382703335152;1955.4036019014195;65844.70776461158;67004.99492507665;67449.32550674479;67457.32542674559;67499.66250168766;10381.740456488647;10632.46837658114;10686.51910664022;10698.144148468104;10730.19523535738;15027.699446011018;15095.924520377328;15110;15137;15141.697166056618;7788.805279868048;7977.840443191104;8084.717034903751;8087.555184464911;8138.877916831252;7375.8156046099275;7492.625368731542;7492.962535187289;7524.247575242542;7699.730509432143;4653.7207767534055;4724.929126063112;4782.641301902302;4860.68405553645;4890.755462226874;1703.3867807589259;1740.1473278093642;1795.5152108930515;1830.4234166237593;1932.690769476905;983.5573991703762;1048.3290693955873;1081.329575663094;1107.3300653104754;1114.2200459678259;16706.164691765607;17334;17937.730934036;18293.63412731738;18300.63398732018;1001.279079063088;1004.3622299839654;1030.6650338639972;1035.1977217656377;1050.76883085721;10166.135878450266;10370.170386369073;10378.273520853469;10408.947712547817;10546;398279;410418;410718;411082;422120;75241.62379188069;78452.60773696209;78561.21438785539;78616.60691696504;79764;1011.1152741351318;1011.5953618552638;1020.4795554267229;1024.7694268789462;1047.9476026198658;16030.358785648443;16088.27602757902;16117.677646446771;16128.596785080466;16160.757588635945;34202.31595368128;34319.4852077214;34464.65535344614;34885;35085;46778;47748.2837757427;47861;47960.7601961988;48011.519884800706;8481.91518084836;8549.487030778173;8742.868856967278;8879.156480134377;8935.553222338987;10312.381257124296;11704.590339338083;12201.352817369896;12207.816882746589;12863.163894346837;10530.78938421212;10580.89419105799;10874.07570356497;11063.336199827714;11296.152788541056;10677.679669609925;11576.826347604625;11634.825477618011;11874;12116.394180291127;11515.596954106566;11611.419429028683;11761.470733816828;11831.40842957866;12048.216865903689;8580.184882436159;8713.128687131237;8730.65077396897;8881.42270752399;8988.32587555949;10227.795444091225;10566.577336906745;10770.084542813634;10793.838092428463;10868 09:35:41 INFO - PROCESS | 8422 | |3;mootools.html;1480.3338497676048;1580.7944967154272;1636.263681343395;1901.961960760785;1991;7658.578778167205;7970.721024764127;8063.113057563678;8064.153263907293;8095.838083238332;8236.876446853286;8410.57947102644;8417.158284171595;8420.031696354921;8426.410151289398;2139.1657253671083;2195.5938151442033;2402.315340128064;2431.914882979096;2471.851688898663;2450.803935685141;2460.7047154341412;2460.8769561521854;2461.0770960889668;2461.520003599299;2368.751281115484;2408.759124087595;2423.4910668759494;2428.3322086426197;2432.902683892642;2102.0855927671437;2294.724633044037;2342.297310806768;2348.894299756498;2419.2742177346813;2364.3498038039506;2369.82226333024;2398.0887262840183;2399.016403274649;2399.1003373734848;8322.20939010793;8352.331813454908;8355.289800366976;8362.121977192368;8363.414560980735;4949.752512374403;5022.42242142151;5033.496650334974;5037.848864534069;5074.162763144077;3199.744020478356;3209.518572214163;3213.0521496158453;3213.2288250819634;3279.426100432415;981.4062492192193;1018.9694309170736;1028.444639894456;1042.2547878267;1055.1506037639697;12148.939255303667;12174.939125304405;12188.695282618006;12197.512099516098;12203.511859525697;4554.590086892129;4629.189891768927;4665.626749860003;4757.119932812441;4760.33355330254;10312.123469505175;10334.224933129895;10366.896331036744;10375.118114960313;10379.01399367059;5415.160650099241;5439.619226654097;5447.428020057837;5449.891002180014;5451.700156491352;4226.408302837605;4695.624350051988;4732.2428411454;4736.715797052188;4775.450823155382;3931.5085614298214;4007.2586571484367;4016.6385025347276;4021.8592349267633;4031.496062992126;1255.221762507233;1301.4273719563362;1302.9804552931714;1324.3312127375614;1334.3395019465427;1424.302091974925;1452.0634190946992;1457.5554455891056;1479.7484427647325;1481.6147801571453;8250.422470427133;8285;8311.709090181814;8354.164583541718;8370.665173392996;1216.1730023584048;1336.9933150334186;1344.2442991866828;1375.5858468387914;1381.716748066644;5977.22296101504;6030.879382412415;6048.848778780566;6067.302260240041;6105.48103411215;9819.950900245452;10420.32267902599;10425.165986721197;10565.524551395205;10579.735506612242;10050.145737612385;10317.865034846162;10349.379037257788;10351.378917264989;10356.482175891175;7751.224877512203;7930.206979302024;7946.205379462008;8034.839303213903;8151.103378628465;7540.245975402635;7589.279018493235;7684.65419056155;7689.42329325314;7826.2173782621285;8972.596233169392;9137.177654011171;9196.172344489029;9233.399829011092;9371;9373.390729602554;9385.01457346996;9431.481268530297;9555.522223888916;9720.902790971999;6283.8114856554375;6441.645709486023;6729.831754205989;7070.929290707027;7159.57042577447;8109.351251899951;8122.7157049502985;8140.308073813792;8165.79585510367;8174.264316211569;7122.893156602551;7316.414686825147;7328.083989501312;7351.522151060164;7429.777106686808;7314.378277846443;7400.740974065882;7401.33387995083;7443.813904652427;7458.776236712907;7686.192949740197;7697.499662521918;7730.458867879194;7741.264579864904;7753.4960227585025;7138.678759455733;7159.64201789898;7193.856122877618;7213.3868621167785;7215.170255420694;7251.601161936144;7316.414686825147;7317.12194536659;7319.048523691886;7331.560106393634 09:35:41 INFO - PROCESS | 8422 | |4;prototype.html;340.86876552527275;343.59799035128896;343.96044454887664;344.7397215102597;350.14739110266487;5965.791197308095;5995.2805663320405;5997.2803263608375;6027.728752206151;6061.878762424749;5905.527557795377;5953.464188223059;5962.135490353896;5972.820815375535;5974.8805023899495;4425.645948324126;4492.10157968406;4604.424446944132;4646.535346465352;4662.347271382009;4628.629709623222;4638.443386793572;4641.837535686252;4643.698159619631;4654.208784506642;4579.793909274091;4599.310103484488;4604.746738929358;4606.746628935407;4615.723056616597;4433.933490997638;4476.060027394267;4573.062522182944;4580.885477863047;4597.264437689953;4042.302233062121;4045.7572545647063;4047.97976010121;4049.493813273341;4050.8379664813374;5718.571107166979;5733.082706766939;5733.827985160452;5734.483896449298;5737.483626473596;5342.492463215988;5343.759530821122;5349.786008559653;5351.759170837322;5352.812651557177;6294.905576416358;6308.369163083701;6312.968435157794;6315.842103947392;6317.4946004319545;4402;4490.3488994096;4498.392716983198;4500.909981800379;4505.256632655608;6523.380278873499;6546.509011824132;6551.967240163769;6556.541042127053;6559.2128944526485;4611.538846115362;4616;4618.930716039262;4618.95381046192;4630.282306242538;4680.297955306732;4683.648726345537;4689.038747056845;4689.038747056845;4690.929636055462;5347.064263753828;5350.705711185844;5352.036633405946;5357.035733567917;5357.11607584752;6119.602225855305;6335.271443783931;6344.777932772331;6350.33321501245;6369.299377068519;1571.7720930465018;1589.4436947068664;1596.928138233759;1597.400974634512;1601.111383182345;1002.734275417015;1033.194108595297;1039.4646756920192;1044.984325235122;1059.7668512927298;6026.096085587197;6026.728797204137;6030.246219222598;6030.819075427744;6121.296050954197;6505.707243174069;6506.4469520091325;6511.088447617338;6517.9348206517325;6527.673616319165;6043.969780151071;6044.607100538451;6046.062860256668;6053.4551890330085;6067.575269731076;3486.9825650871585;3492.231709024011;3500.5974312954336;3523.2601153757487;3523.788572685647;6593.175853018372;6679.398854103154;6815.829604259933;6896.034555162281;6902.482313826483;6776.28848970851;6782.898256526156;6787.321267873173;6791.524593278423;6813.046173535709;6778.389944904884;6781.220159681699;6787.083743694538;6795.728170873209;6796.558223715443;6620.5034622402545;6624.403803657694;6626.668666566556;6631.270560238467;6636.668166591748;6269.216347956505;6498.090267362668;6513.957766757296;6527.5757075789925;6530.379613936669;6742.123523941857;6749.696263668048;6764.154480689914;6767.560108592926;6782.118324617768;4484.798184081789;4525.162844873709;4532.27483602622;4535.365048893092;4537.727736335831;6614.801555953329;6616.933830661632;6617.602943823386;6621.900671490028;6623.503237257129;6233.2208473940755;6440.9033864493;6441.710123044568;6450.387213214737;6454.709538070892;6394.392532709385;6424.229092508929;6425.710843012169;6431.389018043278;6468.676566171578;6260.593061450991;6285.465735412541;6314.905276420765;6325.304216536269;6340.1440805490665;6477.384648458389;6480.675966201766;6483.967580162069;6484.416402523795;6493.577917435352;6048.84877878039;6154.723037463415;6164.753409863734;6324.367563243639;6344.238691357066 09:35:41 INFO - PROCESS | 8422 | |5;yui.html;911.3802614222328;922.2253307221932;922.9077092290776;927.1748144151702;945.5461378538304;14833.480828171016;14940;15007.024543404685;15043.924780376083;15047.699046019074;14712.705745885103;14763.26183690814;14879.40482380706;14925.552233433014;14934.850651493482;784.9764507064797;931.585444477208;937.7889974755676;952.6570434643558;959.0361686505053;963.2294164668273;964.599691128181;966.5650457294246;967.1150896929302;968.9951550242239;995.1093771074884;999.5701848205268;1006.2955930848435;1008.3143462445535;1008.329460908495;825.8265764189528;981.0973904008293;985.0395864032582;991.6677912899188;994.5773046455264;726.7383741852929;735.1472292141144;736.2379936765476;737;737.277468081278;14825.406983720639;14948.103113813097;14948.103113813097;14984.775228371474;15016.24918754058;14573.48992785258;14815.18516481593;14955.700885982329;15058.849411505855;15127.394904203818;11832.290062596272;11861.11041671878;11886;11950.04399648026;12138.696532586668;3853.7109716771356;3908.452816605649;3948.960510394888;3975.7216994810374;4055.898602534931;50669.49330506685;50764.746176269255;50794.746026270004;51017.74491127558;51134;10617.787644247226;11559.826602600968;11642.476088576035;11685.707857303465;11701.648950531498;20020.399388018384;20050.197992080153;20062.398128056182;20097.095630696655;20142.496437589176;7935;8015.198480152055;8042.517448953082;8066.395020373496;8252.298554622805;4672.159011377917;4697.154512187839;4742.834000809955;4759.4764575896625;4807.879803004883;3455.671711187433;3478.721702263813;3501.264734405803;3502.194495266103;3505;594.3313772006493;620.0358442621766;620.3579295429209;623.3330336539859;627.7018416252243;664.1167247560733;685.9794206173823;704.8414106825924;751.812046988253;754.1741792736944;8601.268892144239;9295.90704092964;9337.97700483198;9516.857247141299;9549.427034377959;619.7459041792844;693.0609024771463;710.74057968841;761.6306091545596;766.4864540757706;4290.549492303326;4351.521332653406;4374.300111982131;4416.492103408085;4461.375407442961;61468;62019.069713954326;63329.683351583866;63844.680776596746;64103.679481602296;53925.73037134789;54973.725131374085;55711.72144139335;58143;58178.41821581815;50318.496815032115;50650.746746266035;51017.99999999926;51549.74225128925;51640.48359516432;8724.825503490021;8888.60001299956;8967.820643587222;9088.818223635622;9131.954340228256;38175.80912095533;38202.42696359501;38260.426093609174;39188.6081139185;39981;45278.773606131756;48990.51009489859;49237.75381123215;49399.50600493949;50281.24578131404;12367.196132251735;12497.750044999231;12648.43082061291;12694.619161425171;12817.359132043546;12846.229226246454;13407.597772066854;13497.803345711774;13739.313034348042;14285.928570357082;13169.670758231121;13360.532381366605;13363.866361336652;13591.320433978459;13657.658558535719;12672.6831829205;13078.149920255153;13105.41025653867;13113.606591802261;13234.66913327136;12290.631281061582;12808.423620937267;12852.742945141232;13215.933920330337;13416.39626216842;10382.636607718694;10434.478276086316;10504.78990420172;10671.626493073016;10781.19141064439;10095.529308311943;10314.690559283234;10349.482525873827;10433.26967112295;10778.568857245622 09:35:41 INFO - PROCESS | 8422 | __end_tp_report 09:35:41 INFO - PROCESS | 8422 | __start_cc_report 09:35:41 INFO - PROCESS | 8422 | _x_x_mozilla_cycle_collect,825 09:35:41 INFO - PROCESS | 8422 | __end_cc_report 09:35:41 INFO - PROCESS | 8422 | __startTimestamp1460997341812__endTimestamp 09:35:41 INFO - PROCESS | 8422 | 09:35:41 INFO - PROCESS | 8422 | ------- Summary: start ------- 09:35:41 INFO - PROCESS | 8422 | Number of tests: 6 09:35:41 INFO - PROCESS | 8422 | 09:35:41 INFO - PROCESS | 8422 | [#0] dojo.html Cycles:165 Average:5363.07 Median:5562.05 stddev:587.40 (10.6%) stddev-sans-first:565.11 09:35:41 INFO - PROCESS | 8422 | Values: 3240.6 3271.4 3280.0 3293.8 3347.1 5329.1 5348.7 5353.3 5368.8 5390.1 5306.8 5315.1 5327.2 5334.2 5347.6 4798.1 4849.7 4868.0 4891.0 4919.0 4846.0 4884.7 4924.3 4977.4 5001.1 4941.3 5029.9 5030.1 5034.1 5035.2 4934.3 4970.7 5000.4 5004.2 5013.5 4768.7 4832.0 4917.0 4917.7 4939.4 5302.2 5316.7 5318.6 5319.5 5333.5 5776.0 5803.8 5804.7 5806.2 5813.9 5599.6 5683.2 5711.3 5786.4 5790.7 5417.2 5444.6 5448.8 5449.8 5455.7 5712.4 5839.8 5897.6 5912.3 5916.9 5629.3 5683.9 5702.5 5710.7 5736.7 5734.7 5748.0 5751.8 5752.9 5766.9 5650.5 5652.0 5717.6 5731.7 5739.4 5774.4 5775.6 5780.0 5785.0 5812.9 4336.7 4345.0 4369.6 4372.8 4391.4 3875.2 3911.4 3946.0 3963.6 3986.8 5473.6 5490.6 5493.0 5496.5 5503.1 5806.3 5816.6 5816.7 5824.0 5828.8 5354.9 5458.0 5474.7 5531.1 5542.2 4930.0 4970.3 4975.7 4975.7 5001.2 5887.6 5924.6 5940.3 5945.8 5955.6 5664.9 5720.4 5797.2 5812.5 5817.9 5897.2 5899.0 5905.6 5933.0 5934.2 5654.3 5730.4 5735.8 5742.2 5744.4 5792.8 5845.7 5854.5 5854.8 5882.7 5666.8 5675.8 5690.9 5693.9 5702.9 5517.3 5648.7 5656.3 5666.1 5684.9 5496.6 5524.9 5527.2 5545.6 5578.0 5610.1 5647.6 5652.0 5653.6 5657.7 5452.0 5546.1 5562.1 5584.5 5649.7 09:35:41 INFO - PROCESS | 8422 | 09:35:41 INFO - PROCESS | 8422 | [#1] ext.html Cycles:180 Average:43220.31 Median:37068.91 stddev:67781.19 (182.9%) stddev-sans-first:67895.50 09:35:41 INFO - PROCESS | 8422 | Values: 520.0 549.0 551.5 567.3 571.7 31328.0 31855.0 31872.2 31913.5 38640.8 42255.4 42800.6 42812.6 42831.6 42873.4 8831.2 9046.1 9083.3 9088.5 9092.7 8801.8 8922.4 8946.0 8946.6 8947.8 8928.4 9180.4 9207.8 9222.2 9231.2 9018.8 9078.9 9114.6 9117.5 9118.9 9029.6 9167.1 9180.6 9184.8 9193.9 41353.8 41658.8 41841.8 41898.2 41947.0 3544.5 3809.0 3824.3 3824.6 4250.2 29039.6 29164.4 29660.1 29688.7 30269.5 4074.7 4106.8 4121.9 4129.3 4209.8 283309.0 286883.0 287418.0 287814.0 288062.0 44461.6 64509.4 65789.0 65948.3 65950.0 47453.0 47648.8 47694.0 47731.8 47770.8 15707.9 15780.2 15855.2 15952.2 16017.4 12584.7 12616.5 12627.2 12629.1 12648.0 15673.1 15731.0 15750.3 15756.5 15770.6 6002.9 6139.2 6187.1 6241.1 6262.9 1084.8 1089.7 1092.8 1144.3 1151.5 29462.9 29985.3 30039.0 30295.7 30538.4 1152.8 1155.8 1179.5 1181.7 1202.7 12409.6 15258.5 15420.5 15821.2 15844.4 272532.0 275118.0 275836.0 276180.0 276974.0 52360.0 53314.5 53354.2 53437.0 53439.7 1284.5 1463.5 1491.7 1497.3 1556.3 27450.5 27551.6 29267.0 29900.6 30178.5 46002.3 46165.0 46449.0 46450.0 46530.3 199954.0 214909.0 215773.0 216800.0 217229.0 29611.4 33666.2 34128.1 34167.8 34246.1 40360.0 40448.6 40513.4 41317.8 41673.2 34462.3 34679.1 34679.3 34825.0 35129.6 37142.0 37180.8 37262.8 37335.0 37381.8 36995.8 37280.6 37343.3 37881.0 38173.6 32703.2 33303.8 34200.0 34254.5 34425.0 25885.4 26104.9 26118.7 26120.0 26280.3 09:35:41 INFO - PROCESS | 8422 | 09:35:41 INFO - PROCESS | 8422 | [#2] jquery.html Cycles:180 Average:25084.30 Median:10966.75 stddev:67512.74 (615.6%) stddev-sans-first:67676.65 09:35:41 INFO - PROCESS | 8422 | Values: 381.5 384.2 385.6 389.5 390.8 17755.0 19353.5 19392.6 19978.1 20019.4 18492.7 18590.3 18693.3 18768.4 18885.2 5601.8 5837.5 5866.7 5885.4 5890.4 4307.9 6147.1 6413.1 6422.9 6430.3 5248.2 6320.2 6348.0 6384.8 6385.7 5477.3 5492.8 5531.1 5549.4 5556.8 3911.6 5404.5 5651.9 5657.3 5665.0 13211.5 13877.0 14116.2 14197.9 14214.9 2386.8 2394.4 2416.7 2746.8 3039.6 9794.0 10189.2 10264.9 10398.2 10536.7 1823.2 1915.5 1931.2 1938.7 1955.4 65844.7 67005.0 67449.3 67457.3 67499.7 10381.7 10632.5 10686.5 10698.1 10730.2 15027.7 15095.9 15110.0 15137.0 15141.7 7788.8 7977.8 8084.7 8087.6 8138.9 7375.8 7492.6 7493.0 7524.2 7699.7 4653.7 4724.9 4782.6 4860.7 4890.8 1703.4 1740.1 1795.5 1830.4 1932.7 983.6 1048.3 1081.3 1107.3 1114.2 16706.2 17334.0 17937.7 18293.6 18300.6 1001.3 1004.4 1030.7 1035.2 1050.8 10166.1 10370.2 10378.3 10408.9 10546.0 398279.0 410418.0 410718.0 411082.0 422120.0 75241.6 78452.6 78561.2 78616.6 79764.0 1011.1 1011.6 1020.5 1024.8 1047.9 16030.4 16088.3 16117.7 16128.6 16160.8 34202.3 34319.5 34464.7 34885.0 35085.0 46778.0 47748.3 47861.0 47960.8 48011.5 8481.9 8549.5 8742.9 8879.2 8935.6 10312.4 11704.6 12201.4 12207.8 12863.2 10530.8 10580.9 10874.1 11063.3 11296.2 10677.7 11576.8 11634.8 11874.0 12116.4 11515.6 11611.4 11761.5 11831.4 12048.2 8580.2 8713.1 8730.7 8881.4 8988.3 10227.8 10566.6 10770.1 10793.8 10868.0 09:35:41 INFO - PROCESS | 8422 | 09:35:41 INFO - PROCESS | 8422 | [#3] mootools.html Cycles:180 Average:5946.60 Median:5035.67 stddev:3122.27 (62.0%) stddev-sans-first:3112.98 09:35:41 INFO - PROCESS | 8422 | Values: 1480.3 1580.8 1636.3 1902.0 1991.0 7658.6 7970.7 8063.1 8064.2 8095.8 8236.9 8410.6 8417.2 8420.0 8426.4 2139.2 2195.6 2402.3 2431.9 2471.9 2450.8 2460.7 2460.9 2461.1 2461.5 2368.8 2408.8 2423.5 2428.3 2432.9 2102.1 2294.7 2342.3 2348.9 2419.3 2364.3 2369.8 2398.1 2399.0 2399.1 8322.2 8352.3 8355.3 8362.1 8363.4 4949.8 5022.4 5033.5 5037.8 5074.2 3199.7 3209.5 3213.1 3213.2 3279.4 981.4 1019.0 1028.4 1042.3 1055.2 12148.9 12174.9 12188.7 12197.5 12203.5 4554.6 4629.2 4665.6 4757.1 4760.3 10312.1 10334.2 10366.9 10375.1 10379.0 5415.2 5439.6 5447.4 5449.9 5451.7 4226.4 4695.6 4732.2 4736.7 4775.5 3931.5 4007.3 4016.6 4021.9 4031.5 1255.2 1301.4 1303.0 1324.3 1334.3 1424.3 1452.1 1457.6 1479.7 1481.6 8250.4 8285.0 8311.7 8354.2 8370.7 1216.2 1337.0 1344.2 1375.6 1381.7 5977.2 6030.9 6048.8 6067.3 6105.5 9820.0 10420.3 10425.2 10565.5 10579.7 10050.1 10317.9 10349.4 10351.4 10356.5 7751.2 7930.2 7946.2 8034.8 8151.1 7540.2 7589.3 7684.7 7689.4 7826.2 8972.6 9137.2 9196.2 9233.4 9371.0 9373.4 9385.0 9431.5 9555.5 9720.9 6283.8 6441.6 6729.8 7070.9 7159.6 8109.4 8122.7 8140.3 8165.8 8174.3 7122.9 7316.4 7328.1 7351.5 7429.8 7314.4 7400.7 7401.3 7443.8 7458.8 7686.2 7697.5 7730.5 7741.3 7753.5 7138.7 7159.6 7193.9 7213.4 7215.2 7251.6 7316.4 7317.1 7319.0 7331.6 09:35:41 INFO - PROCESS | 8422 | 09:35:41 INFO - PROCESS | 8422 | [#4] prototype.html Cycles:180 Average:5333.44 Median:6028.99 stddev:1604.22 (26.6%) stddev-sans-first:1564.34 09:35:41 INFO - PROCESS | 8422 | Values: 340.9 343.6 344.0 344.7 350.1 5965.8 5995.3 5997.3 6027.7 6061.9 5905.5 5953.5 5962.1 5972.8 5974.9 4425.6 4492.1 4604.4 4646.5 4662.3 4628.6 4638.4 4641.8 4643.7 4654.2 4579.8 4599.3 4604.7 4606.7 4615.7 4433.9 4476.1 4573.1 4580.9 4597.3 4042.3 4045.8 4048.0 4049.5 4050.8 5718.6 5733.1 5733.8 5734.5 5737.5 5342.5 5343.8 5349.8 5351.8 5352.8 6294.9 6308.4 6313.0 6315.8 6317.5 4402.0 4490.3 4498.4 4500.9 4505.3 6523.4 6546.5 6552.0 6556.5 6559.2 4611.5 4616.0 4618.9 4619.0 4630.3 4680.3 4683.6 4689.0 4689.0 4690.9 5347.1 5350.7 5352.0 5357.0 5357.1 6119.6 6335.3 6344.8 6350.3 6369.3 1571.8 1589.4 1596.9 1597.4 1601.1 1002.7 1033.2 1039.5 1045.0 1059.8 6026.1 6026.7 6030.2 6030.8 6121.3 6505.7 6506.4 6511.1 6517.9 6527.7 6044.0 6044.6 6046.1 6053.5 6067.6 3487.0 3492.2 3500.6 3523.3 3523.8 6593.2 6679.4 6815.8 6896.0 6902.5 6776.3 6782.9 6787.3 6791.5 6813.0 6778.4 6781.2 6787.1 6795.7 6796.6 6620.5 6624.4 6626.7 6631.3 6636.7 6269.2 6498.1 6514.0 6527.6 6530.4 6742.1 6749.7 6764.2 6767.6 6782.1 4484.8 4525.2 4532.3 4535.4 4537.7 6614.8 6616.9 6617.6 6621.9 6623.5 6233.2 6440.9 6441.7 6450.4 6454.7 6394.4 6424.2 6425.7 6431.4 6468.7 6260.6 6285.5 6314.9 6325.3 6340.1 6477.4 6480.7 6484.0 6484.4 6493.6 6048.8 6154.7 6164.8 6324.4 6344.2 09:35:41 INFO - PROCESS | 8422 | 09:35:41 INFO - PROCESS | 8422 | [#5] yui.html Cycles:180 Average:15234.38 Median:4395.40 stddev:17358.63 (394.9%) stddev-sans-first:17374.00 09:35:41 INFO - PROCESS | 8422 | Values: 911.4 922.2 922.9 927.2 945.5 14833.5 14940.0 15007.0 15043.9 15047.7 14712.7 14763.3 14879.4 14925.6 14934.9 785.0 931.6 937.8 952.7 959.0 963.2 964.6 966.6 967.1 969.0 995.1 999.6 1006.3 1008.3 1008.3 825.8 981.1 985.0 991.7 994.6 726.7 735.1 736.2 737.0 737.3 14825.4 14948.1 14948.1 14984.8 15016.2 14573.5 14815.2 14955.7 15058.8 15127.4 11832.3 11861.1 11886.0 11950.0 12138.7 3853.7 3908.5 3949.0 3975.7 4055.9 50669.5 50764.7 50794.7 51017.7 51134.0 10617.8 11559.8 11642.5 11685.7 11701.6 20020.4 20050.2 20062.4 20097.1 20142.5 7935.0 8015.2 8042.5 8066.4 8252.3 4672.2 4697.2 4742.8 4759.5 4807.9 3455.7 3478.7 3501.3 3502.2 3505.0 594.3 620.0 620.4 623.3 627.7 664.1 686.0 704.8 751.8 754.2 8601.3 9295.9 9338.0 9516.9 9549.4 619.7 693.1 710.7 761.6 766.5 4290.5 4351.5 4374.3 4416.5 4461.4 61468.0 62019.1 63329.7 63844.7 64103.7 53925.7 54973.7 55711.7 58143.0 58178.4 50318.5 50650.7 51018.0 51549.7 51640.5 8724.8 8888.6 8967.8 9088.8 9132.0 38175.8 38202.4 38260.4 39188.6 39981.0 45278.8 48990.5 49237.8 49399.5 50281.2 12367.2 12497.8 12648.4 12694.6 12817.4 12846.2 13407.6 13497.8 13739.3 14285.9 13169.7 13360.5 13363.9 13591.3 13657.7 12672.7 13078.1 13105.4 13113.6 13234.7 12290.6 12808.4 12852.7 13215.9 13416.4 10382.6 10434.5 10504.8 10671.6 10781.2 10095.5 10314.7 10349.5 10433.3 10778.6 09:35:41 INFO - PROCESS | 8422 | -------- Summary: end -------- 09:35:41 INFO - PROCESS | 8422 | 09:35:42 INFO - TEST-INFO | 8422: exit 0 09:35:42 INFO - TEST-OK | dromaeo_css | took 1111338ms 09:35:42 INFO - TEST-START | kraken 09:35:42 INFO - operating with platform_type : linux_ 09:35:42 INFO - Initialising browser for kraken test... 09:35:42 INFO - TEST-INFO | started process 8614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqL2I9C/profile http://localhost:35866/getInfo.html) 09:35:46 INFO - PROCESS | 8614 | __metrics Screen width/height:1600/1200 09:35:46 INFO - PROCESS | 8614 | colorDepth:24 09:35:46 INFO - PROCESS | 8614 | Browser inner width/height: 1024/697 09:35:46 INFO - PROCESS | 8614 | __metrics 09:35:47 INFO - PROCESS | 8614 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:35:48 INFO - TEST-INFO | 8614: exit 0 09:35:48 INFO - Browser initialized. 09:35:48 INFO - Running cycle 1/1 for kraken test... 09:35:48 INFO - TEST-INFO | started process 8703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqL2I9C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:00 INFO - PROCESS | 8703 | RSS: Main: 141959168 09:36:00 INFO - PROCESS | 8703 | 09:36:02 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35866/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:03 INFO - PROCESS | 8703 | RSS: Main: 177876992 09:36:03 INFO - PROCESS | 8703 | 09:36:06 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35866/tests/kraken/driver.html?testName=audio-dft) 09:36:06 INFO - PROCESS | 8703 | RSS: Main: 176336896 09:36:06 INFO - PROCESS | 8703 | 09:36:09 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35866/tests/kraken/driver.html?testName=audio-fft) 09:36:10 INFO - PROCESS | 8703 | RSS: Main: 173203456 09:36:10 INFO - PROCESS | 8703 | 09:36:12 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35866/tests/kraken/driver.html?testName=audio-oscillator) 09:36:12 INFO - PROCESS | 8703 | RSS: Main: 173871104 09:36:12 INFO - PROCESS | 8703 | 09:36:14 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35866/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:15 INFO - PROCESS | 8703 | RSS: Main: 172118016 09:36:15 INFO - PROCESS | 8703 | 09:36:18 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35866/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:18 INFO - PROCESS | 8703 | RSS: Main: 171831296 09:36:18 INFO - PROCESS | 8703 | 09:36:22 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35866/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:22 INFO - PROCESS | 8703 | RSS: Main: 172163072 09:36:22 INFO - PROCESS | 8703 | 09:36:25 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35866/tests/kraken/driver.html?testName=json-parse-financial) 09:36:26 INFO - PROCESS | 8703 | RSS: Main: 171642880 09:36:26 INFO - PROCESS | 8703 | 09:36:27 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35866/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:28 INFO - PROCESS | 8703 | RSS: Main: 176611328 09:36:28 INFO - PROCESS | 8703 | 09:36:30 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35866/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:30 INFO - PROCESS | 8703 | RSS: Main: 175333376 09:36:30 INFO - PROCESS | 8703 | 09:36:32 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35866/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:33 INFO - PROCESS | 8703 | RSS: Main: 180666368 09:36:33 INFO - PROCESS | 8703 | 09:36:35 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:36 INFO - PROCESS | 8703 | RSS: Main: 187998208 09:36:36 INFO - PROCESS | 8703 | 09:36:38 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:39 INFO - PROCESS | 8703 | RSS: Main: 187568128 09:36:39 INFO - PROCESS | 8703 | 09:36:40 INFO - PROCESS | 8703 | Cycle 1(1): loaded http://localhost:35866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35866/tests/kraken/driver.html?testName=ai-astar) 09:36:41 INFO - PROCESS | 8703 | RSS: Main: 249221120 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | __start_tp_report 09:36:41 INFO - PROCESS | 8703 | _x_x_mozilla_page_load 09:36:41 INFO - PROCESS | 8703 | _x_x_mozilla_page_load_details 09:36:41 INFO - PROCESS | 8703 | |i|pagename|runs| 09:36:41 INFO - PROCESS | 8703 | |0;ai-astar;109;111;105;110;111;110;99;110;109;109 09:36:41 INFO - PROCESS | 8703 | |1;audio-beat-detection;158;128;159;172;129;156;157;129;184;135 09:36:41 INFO - PROCESS | 8703 | |2;audio-dft;161;162;162;162;160;159;162;167;161;160 09:36:41 INFO - PROCESS | 8703 | |3;audio-fft;73;74;77;169;77;76;74;76;163;76 09:36:41 INFO - PROCESS | 8703 | |4;audio-oscillator;94;93;142;93;94;94;147;92;93;142 09:36:41 INFO - PROCESS | 8703 | |5;imaging-gaussian-blur;116;116;117;116;117;117;117;116;116;117 09:36:41 INFO - PROCESS | 8703 | |6;imaging-darkroom;146;146;146;145;146;146;145;146;145;146 09:36:41 INFO - PROCESS | 8703 | |7;imaging-desaturate;95;98;95;96;96;97;95;96;96;96 09:36:41 INFO - PROCESS | 8703 | |8;json-parse-financial;53;54;54;53;54;54;54;62;54;52 09:36:41 INFO - PROCESS | 8703 | |9;json-stringify-tinderbox;63;64;65;64;64;64;65;63;64;63 09:36:41 INFO - PROCESS | 8703 | |10;stanford-crypto-aes;76;77;78;78;78;83;78;77;78;78 09:36:41 INFO - PROCESS | 8703 | |11;stanford-crypto-ccm;112;111;110;109;116;112;114;112;110;112 09:36:41 INFO - PROCESS | 8703 | |12;stanford-crypto-pbkdf2;137;126;137;135;136;127;142;137;134;144 09:36:41 INFO - PROCESS | 8703 | |13;stanford-crypto-sha256-iterative;66;67;67;64;64;65;65;70;65;64 09:36:41 INFO - PROCESS | 8703 | __end_tp_report 09:36:41 INFO - PROCESS | 8703 | __start_cc_report 09:36:41 INFO - PROCESS | 8703 | _x_x_mozilla_cycle_collect,1064 09:36:41 INFO - PROCESS | 8703 | __end_cc_report 09:36:41 INFO - PROCESS | 8703 | __startTimestamp1460997401008__endTimestamp 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | ------- Summary: start ------- 09:36:41 INFO - PROCESS | 8703 | Number of tests: 14 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.68 (3.3%) stddev-sans-first:3.90 09:36:41 INFO - PROCESS | 8703 | Values: 109.0 111.0 105.0 110.0 111.0 110.0 99.0 110.0 109.0 109.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:157.50 stddev:19.60 (12.4%) stddev-sans-first:20.61 09:36:41 INFO - PROCESS | 8703 | Values: 158.0 128.0 159.0 172.0 129.0 156.0 157.0 129.0 184.0 135.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:2.17 (1.3%) stddev-sans-first:2.29 09:36:41 INFO - PROCESS | 8703 | Values: 161.0 162.0 162.0 162.0 160.0 159.0 162.0 167.0 161.0 160.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:38.26 (50.3%) stddev-sans-first:39.86 09:36:41 INFO - PROCESS | 8703 | Values: 73.0 74.0 77.0 169.0 77.0 76.0 74.0 76.0 163.0 76.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:24.38 (26.2%) stddev-sans-first:25.30 09:36:41 INFO - PROCESS | 8703 | Values: 94.0 93.0 142.0 93.0 94.0 94.0 147.0 92.0 93.0 142.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:36:41 INFO - PROCESS | 8703 | Values: 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:36:41 INFO - PROCESS | 8703 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.94 (1.0%) stddev-sans-first:0.93 09:36:41 INFO - PROCESS | 8703 | Values: 95.0 98.0 95.0 96.0 96.0 97.0 95.0 96.0 96.0 96.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:2.76 (5.1%) stddev-sans-first:2.88 09:36:41 INFO - PROCESS | 8703 | Values: 53.0 54.0 54.0 53.0 54.0 54.0 54.0 62.0 54.0 52.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 09:36:41 INFO - PROCESS | 8703 | Values: 63.0 64.0 65.0 64.0 64.0 64.0 65.0 63.0 64.0 63.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:1.85 (2.4%) stddev-sans-first:1.80 09:36:41 INFO - PROCESS | 8703 | Values: 76.0 77.0 78.0 78.0 78.0 83.0 78.0 77.0 78.0 78.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#11] stanford-crypto-ccm Cycles:10 Average:111.80 Median:112.00 stddev:2.04 (1.8%) stddev-sans-first:2.17 09:36:41 INFO - PROCESS | 8703 | Values: 112.0 111.0 110.0 109.0 116.0 112.0 114.0 112.0 110.0 112.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:137.00 stddev:5.64 (4.1%) stddev-sans-first:5.96 09:36:41 INFO - PROCESS | 8703 | Values: 137.0 126.0 137.0 135.0 136.0 127.0 142.0 137.0 134.0 144.0 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - PROCESS | 8703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:1.89 (2.9%) stddev-sans-first:2.00 09:36:41 INFO - PROCESS | 8703 | Values: 66.0 67.0 67.0 64.0 64.0 65.0 65.0 70.0 65.0 64.0 09:36:41 INFO - PROCESS | 8703 | -------- Summary: end -------- 09:36:41 INFO - PROCESS | 8703 | 09:36:41 INFO - TEST-INFO | 8703: exit 0 09:36:41 INFO - TEST-OK | kraken | took 59455ms 09:36:41 INFO - SUITE-END | took 1170s 09:36:42 INFO - Completed test suite (00:19:31) 09:36:42 INFO - javascript benchmark 09:36:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3240.627327857296, 3271.4275001874666, 3280.015995201439, 3293.7859039162468, 3347.0628224097245, 5329.147336426173, 5348.679079255247, 5353.346839788826, 5368.838934831956, 5390.110631745767, 5306.8407947761625, 5315.123004704229, 5327.227552004957, 5334.199870019499, 5347.6256662033675, 4798.0643774464, 4849.733264670442, 4868.026394721052, 4890.951090489085, 4919.040787046527, 4846.030793841228, 4884.706917584938, 4924.285978533128, 4977.3529441172595, 5001.074801161779, 4941.332920055783, 5029.924551131736, 5030.06943715412, 5034.09386310464, 5035.244713292998, 4934.309196712463, 4970.6520543561965, 5000.399952005746, 5004.249362595603, 5013.47358527353, 4768.666193366465, 4832.0, 4916.992016636616, 4917.655764096515, 4939.407271127488, 5302.151655735102, 5316.707581083039, 5318.627696061278, 5319.521243088141, 5333.493318134771, 5775.971120144414, 5803.7968671096305, 5804.709764511757, 5806.245188125559, 5813.941860581383, 5599.63602365849, 5683.204351390808, 5711.257536520267, 5786.421357864222, 5790.652560846321, 5417.187421886709, 5444.564434845242, 5448.782048718046, 5449.809256675997, 5455.672659640434, 5712.428757124254, 5839.795607153729, 5897.5871688982215, 5912.260967379078, 5916.852078698067, 5629.296337957755, 5683.857903552362, 5702.486776190163, 5710.65736055838, 5736.741846616912, 5734.655920644775, 5747.971260143756, 5751.827445176651, 5752.884942301214, 5766.942330576724, 5650.491455769001, 5651.971740141273, 5717.628354156966, 5731.713414329267, 5739.368669446358, 5774.364819869811, 5775.624584402, 5779.988502012216, 5784.971075144597, 5812.883742325214, 4336.653067754635, 4345.0, 4369.563043695605, 4372.825086996548, 4391.385206071152, 3875.244327356195, 3911.3741801311653, 3946.0, 3963.583823698528, 3986.8405263789705, 5473.562115030788, 5490.588205884575, 5493.038718224295, 5496.450354964471, 5503.147012213033, 5806.274215723035, 5816.592838501264, 5816.738246778905, 5823.970880145657, 5828.76684932598, 5354.9196762048605, 5457.972710136424, 5474.698891561003, 5531.115021596525, 5542.224088627595, 4930.038642464757, 4970.329005584272, 4975.701457912537, 4975.701457912537, 5001.174806156943, 5887.587868849225, 5924.6149000314845, 5940.34656187819, 5945.791897283661, 5955.553333499918, 5664.8867022659315, 5720.3707592164, 5797.217375654402, 5812.505936995402, 5817.912731308949, 5897.203877476486, 5899.0, 5905.616134951214, 5932.970335148297, 5934.228550288435, 5654.321481422256, 5730.369659337386, 5735.770569177186, 5742.196092546963, 5744.42555744439, 5792.797252096157, 5845.678487683218, 5854.4730974212525, 5854.765809367748, 5882.705864706833, 5666.801661941812, 5675.829725108253, 5690.914636280542, 5693.8861222774485, 5702.914456283242, 5517.310336207974, 5648.71756412186, 5656.3495198051105, 5666.093425051972, 5684.9431505684415, 5496.642718223303, 5524.889502210013, 5527.226188333556, 5545.639533430314, 5578.023845826883, 5610.102383618601, 5647.632903861236, 5652.0, 5653.604247702621, 5657.688827114548, 5452.04589196881, 5546.112621980626, 5562.054450743302, 5584.525315348241, 5649.745761440663], "unit": "score", "name": "dojo.html", "value": 5325.431905249364}, {"lowerIsBetter": false, "replicates": [519.9532042116209, 548.9725513724313, 551.5284431810802, 567.2682239910515, 571.7198572699378, 31327.99999999997, 31855.0, 31872.20319492008, 31913.52129718056, 38640.8407747768, 42255.366169507404, 42800.57199428005, 42812.571874281246, 42831.571684283146, 42873.35689964653, 8831.205191532777, 9046.095390460934, 9083.273338132967, 9088.50013249271, 9092.681756138536, 8801.823963520726, 8922.375433719642, 8945.95527022364, 8946.552672366388, 8947.776305592348, 8928.37501374904, 9180.357374983754, 9207.815843683122, 9222.21611163052, 9231.169194772468, 9018.774530636754, 9078.909210907872, 9114.635414583408, 9117.45295282282, 9118.86321705175, 9029.638814447415, 9167.12912273333, 9180.586873590704, 9184.770380740469, 9193.862092068624, 41353.793231033655, 41658.79170604158, 41841.79079104585, 41898.1620367594, 41947.0, 3544.5392099027217, 3809.0, 3824.3307421201457, 3824.598417166213, 4250.234957707611, 29039.56440653392, 29164.41671166586, 29660.110196693917, 29688.70311296881, 30269.545956810445, 4074.694397920168, 4106.7535947842925, 4121.949757179696, 4129.339305711072, 4209.7895105244925, 283309.0, 286883.0, 287418.0, 287814.0, 288062.0, 44461.55538444574, 64509.35490645033, 65789.0, 65948.34051659518, 65950.0, 47453.0, 47648.76175619169, 47694.0, 47731.76134119307, 47770.76114619405, 15707.921460392625, 15780.210989450712, 15855.207239637972, 15952.20238988046, 16017.359305627644, 12584.748305033849, 12616.495340186473, 12627.179233349803, 12629.115961882764, 12647.988160947101, 15673.137977411125, 15731.0, 15750.291236894367, 15756.527304180892, 15770.605734856721, 6002.879942401128, 6139.171211886427, 6187.133801267826, 6241.095041218998, 6262.937370626327, 1084.8481212630238, 1089.6676513663408, 1092.781443711245, 1144.2676686920377, 1151.4818331750746, 29462.852685736434, 29985.250368740955, 30039.0, 30295.697043029286, 30538.389232215675, 1152.8443660105945, 1155.8150695888617, 1179.5046080645977, 1181.7459246261924, 1202.7353982123918, 12409.62771116868, 15258.465953691568, 15420.537383878502, 15821.208939552977, 15844.366225351087, 272532.0, 275118.0, 275836.0, 276180.0, 276974.0, 52360.0, 53314.46685533095, 53354.19968700472, 53437.0, 53439.73280133575, 1284.5118854835102, 1463.5170393770031, 1491.7240310542584, 1497.3187199824054, 1556.3152213026233, 27450.45099097967, 27551.586726199523, 29267.0, 29900.551491728078, 30178.54732179063, 46002.30996534988, 46165.0, 46449.0, 46450.0, 46530.30204547002, 199954.0, 214909.0, 215773.0, 216800.0, 217229.0, 29611.40777184487, 33666.15834604154, 34128.14679633029, 34167.82916085404, 34246.14384640404, 40360.0, 40448.59551404566, 40513.39229911612, 41317.793411032755, 41673.166536669705, 34462.310753785285, 34679.13302167365, 34679.306413871076, 34825.0, 35129.64870351264, 37142.0, 37180.81409593043, 37262.813685931396, 37335.0, 37381.813090934374, 36995.815020924725, 37280.62719372771, 37343.2531349366, 37881.0, 38173.61826381701, 32703.18242043968, 33303.83348083244, 34200.0, 34254.48618270778, 34425.0, 25885.35286617774, 26104.8694756525, 26118.73881261163, 26119.996026622088, 26280.349531328065], "unit": "score", "name": "ext.html", "value": 18364.089233804192}, {"lowerIsBetter": false, "replicates": [381.5345278759912, 384.16252569398716, 385.55275879979223, 389.4722650808155, 390.77335145615547, 17755.0, 19353.516162095937, 19392.612147757038, 19978.100985455654, 20019.399418017445, 18492.72260916087, 18590.34933777318, 18693.252269909222, 18768.43694689158, 18885.150168242428, 5601.831945041656, 5837.50381217597, 5866.735996880129, 5885.411458854123, 5890.352061273256, 4307.935380969272, 6147.139400483936, 6413.102165696806, 6422.903656445157, 6430.324815894311, 5248.239005344223, 6320.241571011485, 6348.047792831089, 6384.808455746335, 6385.744570217185, 5477.3427188737205, 5492.780288788444, 5531.1426728857095, 5549.445055494439, 5556.777728890839, 3911.5501717302304, 5404.4595540446035, 5651.897879913418, 5657.349404818417, 5665.0, 13211.537596184184, 13877.0, 14116.223607701573, 14197.929010354985, 14214.85785142156, 2386.785189332951, 2394.4013996500876, 2416.673749043874, 2746.8214566053143, 3039.574459575661, 9794.0, 10189.184865210766, 10264.94867525665, 10398.168146548334, 10536.736581585445, 1823.179569193868, 1915.52111972007, 1931.2371613212842, 1938.7382703335152, 1955.4036019014195, 65844.70776461158, 67004.99492507665, 67449.32550674479, 67457.32542674559, 67499.66250168766, 10381.740456488647, 10632.46837658114, 10686.51910664022, 10698.144148468104, 10730.19523535738, 15027.699446011018, 15095.924520377328, 15110.0, 15137.0, 15141.697166056618, 7788.805279868048, 7977.840443191104, 8084.717034903751, 8087.555184464911, 8138.877916831252, 7375.8156046099275, 7492.625368731542, 7492.962535187289, 7524.247575242542, 7699.730509432143, 4653.7207767534055, 4724.929126063112, 4782.641301902302, 4860.68405553645, 4890.755462226874, 1703.3867807589259, 1740.1473278093642, 1795.5152108930515, 1830.4234166237593, 1932.690769476905, 983.5573991703762, 1048.3290693955873, 1081.329575663094, 1107.3300653104754, 1114.2200459678259, 16706.164691765607, 17334.0, 17937.730934036, 18293.63412731738, 18300.63398732018, 1001.279079063088, 1004.3622299839654, 1030.6650338639972, 1035.1977217656377, 1050.76883085721, 10166.135878450266, 10370.170386369073, 10378.273520853469, 10408.947712547817, 10546.0, 398279.0, 410418.0, 410718.0, 411082.0, 422120.0, 75241.62379188069, 78452.60773696209, 78561.21438785539, 78616.60691696504, 79764.0, 1011.1152741351318, 1011.5953618552638, 1020.4795554267229, 1024.7694268789462, 1047.9476026198658, 16030.358785648443, 16088.27602757902, 16117.677646446771, 16128.596785080466, 16160.757588635945, 34202.31595368128, 34319.4852077214, 34464.65535344614, 34885.0, 35085.0, 46778.0, 47748.2837757427, 47861.0, 47960.7601961988, 48011.519884800706, 8481.91518084836, 8549.487030778173, 8742.868856967278, 8879.156480134377, 8935.553222338987, 10312.381257124296, 11704.590339338083, 12201.352817369896, 12207.816882746589, 12863.163894346837, 10530.78938421212, 10580.89419105799, 10874.07570356497, 11063.336199827714, 11296.152788541056, 10677.679669609925, 11576.826347604625, 11634.825477618011, 11874.0, 12116.394180291127, 11515.596954106566, 11611.419429028683, 11761.470733816828, 11831.40842957866, 12048.216865903689, 8580.184882436159, 8713.128687131237, 8730.65077396897, 8881.42270752399, 8988.32587555949, 10227.795444091225, 10566.577336906745, 10770.084542813634, 10793.838092428463, 10868.0], "unit": "score", "name": "jquery.html", "value": 8760.479882536694}, {"lowerIsBetter": false, "replicates": [1480.3338497676048, 1580.7944967154272, 1636.263681343395, 1901.961960760785, 1991.0, 7658.578778167205, 7970.721024764127, 8063.113057563678, 8064.153263907293, 8095.838083238332, 8236.876446853286, 8410.57947102644, 8417.158284171595, 8420.031696354921, 8426.410151289398, 2139.1657253671083, 2195.5938151442033, 2402.315340128064, 2431.914882979096, 2471.851688898663, 2450.803935685141, 2460.7047154341412, 2460.8769561521854, 2461.0770960889668, 2461.520003599299, 2368.751281115484, 2408.759124087595, 2423.4910668759494, 2428.3322086426197, 2432.902683892642, 2102.0855927671437, 2294.724633044037, 2342.297310806768, 2348.894299756498, 2419.2742177346813, 2364.3498038039506, 2369.82226333024, 2398.0887262840183, 2399.016403274649, 2399.1003373734848, 8322.20939010793, 8352.331813454908, 8355.289800366976, 8362.121977192368, 8363.414560980735, 4949.752512374403, 5022.42242142151, 5033.496650334974, 5037.848864534069, 5074.162763144077, 3199.744020478356, 3209.518572214163, 3213.0521496158453, 3213.2288250819634, 3279.426100432415, 981.4062492192193, 1018.9694309170736, 1028.444639894456, 1042.2547878267, 1055.1506037639697, 12148.939255303667, 12174.939125304405, 12188.695282618006, 12197.512099516098, 12203.511859525697, 4554.590086892129, 4629.189891768927, 4665.626749860003, 4757.119932812441, 4760.33355330254, 10312.123469505175, 10334.224933129895, 10366.896331036744, 10375.118114960313, 10379.01399367059, 5415.160650099241, 5439.619226654097, 5447.428020057837, 5449.891002180014, 5451.700156491352, 4226.408302837605, 4695.624350051988, 4732.2428411454, 4736.715797052188, 4775.450823155382, 3931.5085614298214, 4007.2586571484367, 4016.6385025347276, 4021.8592349267633, 4031.496062992126, 1255.221762507233, 1301.4273719563362, 1302.9804552931714, 1324.3312127375614, 1334.3395019465427, 1424.302091974925, 1452.0634190946992, 1457.5554455891056, 1479.7484427647325, 1481.6147801571453, 8250.422470427133, 8285.0, 8311.709090181814, 8354.164583541718, 8370.665173392996, 1216.1730023584048, 1336.9933150334186, 1344.2442991866828, 1375.5858468387914, 1381.716748066644, 5977.22296101504, 6030.879382412415, 6048.848778780566, 6067.302260240041, 6105.48103411215, 9819.950900245452, 10420.32267902599, 10425.165986721197, 10565.524551395205, 10579.735506612242, 10050.145737612385, 10317.865034846162, 10349.379037257788, 10351.378917264989, 10356.482175891175, 7751.224877512203, 7930.206979302024, 7946.205379462008, 8034.839303213903, 8151.103378628465, 7540.245975402635, 7589.279018493235, 7684.65419056155, 7689.42329325314, 7826.2173782621285, 8972.596233169392, 9137.177654011171, 9196.172344489029, 9233.399829011092, 9371.0, 9373.390729602554, 9385.01457346996, 9431.481268530297, 9555.522223888916, 9720.902790971999, 6283.8114856554375, 6441.645709486023, 6729.831754205989, 7070.929290707027, 7159.57042577447, 8109.351251899951, 8122.7157049502985, 8140.308073813792, 8165.79585510367, 8174.264316211569, 7122.893156602551, 7316.414686825147, 7328.083989501312, 7351.522151060164, 7429.777106686808, 7314.378277846443, 7400.740974065882, 7401.33387995083, 7443.813904652427, 7458.776236712907, 7686.192949740197, 7697.499662521918, 7730.458867879194, 7741.264579864904, 7753.4960227585025, 7138.678759455733, 7159.64201789898, 7193.856122877618, 7213.3868621167785, 7215.170255420694, 7251.601161936144, 7316.414686825147, 7317.12194536659, 7319.048523691886, 7331.560106393634], "unit": "score", "name": "mootools.html", "value": 4883.918965036561}, {"lowerIsBetter": false, "replicates": [340.86876552527275, 343.59799035128896, 343.96044454887664, 344.7397215102597, 350.14739110266487, 5965.791197308095, 5995.2805663320405, 5997.2803263608375, 6027.728752206151, 6061.878762424749, 5905.527557795377, 5953.464188223059, 5962.135490353896, 5972.820815375535, 5974.8805023899495, 4425.645948324126, 4492.10157968406, 4604.424446944132, 4646.535346465352, 4662.347271382009, 4628.629709623222, 4638.443386793572, 4641.837535686252, 4643.698159619631, 4654.208784506642, 4579.793909274091, 4599.310103484488, 4604.746738929358, 4606.746628935407, 4615.723056616597, 4433.933490997638, 4476.060027394267, 4573.062522182944, 4580.885477863047, 4597.264437689953, 4042.302233062121, 4045.7572545647063, 4047.97976010121, 4049.493813273341, 4050.8379664813374, 5718.571107166979, 5733.082706766939, 5733.827985160452, 5734.483896449298, 5737.483626473596, 5342.492463215988, 5343.759530821122, 5349.786008559653, 5351.759170837322, 5352.812651557177, 6294.905576416358, 6308.369163083701, 6312.968435157794, 6315.842103947392, 6317.4946004319545, 4402.0, 4490.3488994096, 4498.392716983198, 4500.909981800379, 4505.256632655608, 6523.380278873499, 6546.509011824132, 6551.967240163769, 6556.541042127053, 6559.2128944526485, 4611.538846115362, 4616.0, 4618.930716039262, 4618.95381046192, 4630.282306242538, 4680.297955306732, 4683.648726345537, 4689.038747056845, 4689.038747056845, 4690.929636055462, 5347.064263753828, 5350.705711185844, 5352.036633405946, 5357.035733567917, 5357.11607584752, 6119.602225855305, 6335.271443783931, 6344.777932772331, 6350.33321501245, 6369.299377068519, 1571.7720930465018, 1589.4436947068664, 1596.928138233759, 1597.400974634512, 1601.111383182345, 1002.734275417015, 1033.194108595297, 1039.4646756920192, 1044.984325235122, 1059.7668512927298, 6026.096085587197, 6026.728797204137, 6030.246219222598, 6030.819075427744, 6121.296050954197, 6505.707243174069, 6506.4469520091325, 6511.088447617338, 6517.9348206517325, 6527.673616319165, 6043.969780151071, 6044.607100538451, 6046.062860256668, 6053.4551890330085, 6067.575269731076, 3486.9825650871585, 3492.231709024011, 3500.5974312954336, 3523.2601153757487, 3523.788572685647, 6593.175853018372, 6679.398854103154, 6815.829604259933, 6896.034555162281, 6902.482313826483, 6776.28848970851, 6782.898256526156, 6787.321267873173, 6791.524593278423, 6813.046173535709, 6778.389944904884, 6781.220159681699, 6787.083743694538, 6795.728170873209, 6796.558223715443, 6620.5034622402545, 6624.403803657694, 6626.668666566556, 6631.270560238467, 6636.668166591748, 6269.216347956505, 6498.090267362668, 6513.957766757296, 6527.5757075789925, 6530.379613936669, 6742.123523941857, 6749.696263668048, 6764.154480689914, 6767.560108592926, 6782.118324617768, 4484.798184081789, 4525.162844873709, 4532.27483602622, 4535.365048893092, 4537.727736335831, 6614.801555953329, 6616.933830661632, 6617.602943823386, 6621.900671490028, 6623.503237257129, 6233.2208473940755, 6440.9033864493, 6441.710123044568, 6450.387213214737, 6454.709538070892, 6394.392532709385, 6424.229092508929, 6425.710843012169, 6431.389018043278, 6468.676566171578, 6260.593061450991, 6285.465735412541, 6314.905276420765, 6325.304216536269, 6340.1440805490665, 6477.384648458389, 6480.675966201766, 6483.967580162069, 6484.416402523795, 6493.577917435352, 6048.84877878039, 6154.723037463415, 6164.753409863734, 6324.367563243639, 6344.238691357066], "unit": "score", "name": "prototype.html", "value": 4808.838111582334}, {"lowerIsBetter": false, "replicates": [911.3802614222328, 922.2253307221932, 922.9077092290776, 927.1748144151702, 945.5461378538304, 14833.480828171016, 14940.0, 15007.024543404685, 15043.924780376083, 15047.699046019074, 14712.705745885103, 14763.26183690814, 14879.40482380706, 14925.552233433014, 14934.850651493482, 784.9764507064797, 931.585444477208, 937.7889974755676, 952.6570434643558, 959.0361686505053, 963.2294164668273, 964.599691128181, 966.5650457294246, 967.1150896929302, 968.9951550242239, 995.1093771074884, 999.5701848205268, 1006.2955930848435, 1008.3143462445535, 1008.329460908495, 825.8265764189528, 981.0973904008293, 985.0395864032582, 991.6677912899188, 994.5773046455264, 726.7383741852929, 735.1472292141144, 736.2379936765476, 737.0, 737.277468081278, 14825.406983720639, 14948.103113813097, 14948.103113813097, 14984.775228371474, 15016.24918754058, 14573.48992785258, 14815.18516481593, 14955.700885982329, 15058.849411505855, 15127.394904203818, 11832.290062596272, 11861.11041671878, 11886.0, 11950.04399648026, 12138.696532586668, 3853.7109716771356, 3908.452816605649, 3948.960510394888, 3975.7216994810374, 4055.898602534931, 50669.49330506685, 50764.746176269255, 50794.746026270004, 51017.74491127558, 51134.0, 10617.787644247226, 11559.826602600968, 11642.476088576035, 11685.707857303465, 11701.648950531498, 20020.399388018384, 20050.197992080153, 20062.398128056182, 20097.095630696655, 20142.496437589176, 7935.0, 8015.198480152055, 8042.517448953082, 8066.395020373496, 8252.298554622805, 4672.159011377917, 4697.154512187839, 4742.834000809955, 4759.4764575896625, 4807.879803004883, 3455.671711187433, 3478.721702263813, 3501.264734405803, 3502.194495266103, 3505.0, 594.3313772006493, 620.0358442621766, 620.3579295429209, 623.3330336539859, 627.7018416252243, 664.1167247560733, 685.9794206173823, 704.8414106825924, 751.812046988253, 754.1741792736944, 8601.268892144239, 9295.90704092964, 9337.97700483198, 9516.857247141299, 9549.427034377959, 619.7459041792844, 693.0609024771463, 710.74057968841, 761.6306091545596, 766.4864540757706, 4290.549492303326, 4351.521332653406, 4374.300111982131, 4416.492103408085, 4461.375407442961, 61468.0, 62019.069713954326, 63329.683351583866, 63844.680776596746, 64103.679481602296, 53925.73037134789, 54973.725131374085, 55711.72144139335, 58143.0, 58178.41821581815, 50318.496815032115, 50650.746746266035, 51017.99999999926, 51549.74225128925, 51640.48359516432, 8724.825503490021, 8888.60001299956, 8967.820643587222, 9088.818223635622, 9131.954340228256, 38175.80912095533, 38202.42696359501, 38260.426093609174, 39188.6081139185, 39981.0, 45278.773606131756, 48990.51009489859, 49237.75381123215, 49399.50600493949, 50281.24578131404, 12367.196132251735, 12497.750044999231, 12648.43082061291, 12694.619161425171, 12817.359132043546, 12846.229226246454, 13407.597772066854, 13497.803345711774, 13739.313034348042, 14285.928570357082, 13169.670758231121, 13360.532381366605, 13363.866361336652, 13591.320433978459, 13657.658558535719, 12672.6831829205, 13078.149920255153, 13105.41025653867, 13113.606591802261, 13234.66913327136, 12290.631281061582, 12808.423620937267, 12852.742945141232, 13215.933920330337, 13416.39626216842, 10382.636607718694, 10434.478276086316, 10504.78990420172, 10671.626493073016, 10781.19141064439, 10095.529308311943, 10314.690559283234, 10349.482525873827, 10433.26967112295, 10778.568857245622], "unit": "score", "name": "yui.html", "value": 7051.321899757148}], "name": "dromaeo_css", "value": 7222.058629890482}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 110.0, 111.0, 110.0, 99.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [158.0, 128.0, 159.0, 172.0, 129.0, 156.0, 157.0, 129.0, 184.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 162.0, 160.0, 159.0, 162.0, 167.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 77.0, 169.0, 77.0, 76.0, 74.0, 76.0, 163.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 142.0, 93.0, 94.0, 94.0, 147.0, 92.0, 93.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 95.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 62.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 63.0, 64.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 78.0, 78.0, 78.0, 83.0, 78.0, 77.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.1}, {"lowerIsBetter": true, "replicates": [112.0, 111.0, 110.0, 109.0, 116.0, 112.0, 114.0, 112.0, 110.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.8}, {"lowerIsBetter": true, "replicates": [137.0, 126.0, 137.0, 135.0, 136.0, 127.0, 142.0, 137.0, 134.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 64.0, 64.0, 65.0, 65.0, 70.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.7}], "name": "kraken", "value": 1490.1000000000001}]} 09:36:42 INFO - Return code: 0 09:36:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:36:42 INFO - # TBPL SUCCESS # 09:36:42 INFO - Running post-action listener: _resource_record_post_action 09:36:42 INFO - Running post-run listener: _resource_record_post_run 09:36:43 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 278528; Write bytes: 487903232; Read time: 52; Write time: 373116 09:36:43 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 244445184; Read time: 0; Write time: 235740 09:36:43 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 278528; Write bytes: 242860032; Read time: 52; Write time: 137372 09:36:43 INFO - Running post-run listener: _upload_blobber_files 09:36:43 INFO - Blob upload gear active. 09:36:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:43 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 09:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:36:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:36:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:36:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:44 INFO - (blobuploader) - INFO - Done attempting. 09:36:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:36:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:45 INFO - (blobuploader) - INFO - Done attempting. 09:36:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:45 INFO - Return code: 0 09:36:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ef897669c236782b2f75539f7e219dd699070a8b61ba72ab7fa24327d5f679ba9d7410dcd2b2455da09bb03953cdc7308d51afea10ea14475727d3b029f0501", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c2311330deeeb7f59295ca6b5043a06f9ab393924d4a47a2af09f860dfe78a17e85d3852dfe0007c66aa7da622b8a380f9ab86b18b167b1e14895898c0eb44"} 09:36:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:45 INFO - Contents: 09:36:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ef897669c236782b2f75539f7e219dd699070a8b61ba72ab7fa24327d5f679ba9d7410dcd2b2455da09bb03953cdc7308d51afea10ea14475727d3b029f0501", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c2311330deeeb7f59295ca6b5043a06f9ab393924d4a47a2af09f860dfe78a17e85d3852dfe0007c66aa7da622b8a380f9ab86b18b167b1e14895898c0eb44"} 09:36:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:45 INFO - Copying logs to upload dir... 09:36:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.497250 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-18 09:36:45.121244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 09:36:45.124536) ========= 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-1460995857.633464-2050000368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ef897669c236782b2f75539f7e219dd699070a8b61ba72ab7fa24327d5f679ba9d7410dcd2b2455da09bb03953cdc7308d51afea10ea14475727d3b029f0501", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c2311330deeeb7f59295ca6b5043a06f9ab393924d4a47a2af09f860dfe78a17e85d3852dfe0007c66aa7da622b8a380f9ab86b18b167b1e14895898c0eb44"} build_url:https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/WssWYmx_Tgmm0cvpNhn0gA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7ef897669c236782b2f75539f7e219dd699070a8b61ba72ab7fa24327d5f679ba9d7410dcd2b2455da09bb03953cdc7308d51afea10ea14475727d3b029f0501", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4c2311330deeeb7f59295ca6b5043a06f9ab393924d4a47a2af09f860dfe78a17e85d3852dfe0007c66aa7da622b8a380f9ab86b18b167b1e14895898c0eb44"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 09:36:45.149730) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 09:36:45.150091) ========= 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-1460995857.633464-2050000368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 09:36:45.233130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 09:36:45.233478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 09:36:45.233778) ========= ========= Total master_lag: 0.21 =========