builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1461600636.14 results: success (0) buildid: 20160425062348 builduid: abe90fc74b164da98c10377025c22763 revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:36.143830) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:36.144484) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:36.144867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:36.189510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:36.189818) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 09:10:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-04-25 09:10:36 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166929 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:36.405416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:36.405739) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016326 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:36.456145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:36.456637) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8551b253f4061db31e4be7829c2f70c2610caf42 --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 8551b253f4061db31e4be7829c2f70c2610caf42 --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=e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 09:10:36,508 truncating revision to first 12 chars 2016-04-25 09:10:36,508 Setting DEBUG logging. 2016-04-25 09:10:36,508 attempt 1/10 2016-04-25 09:10:36,508 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8551b253f406?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 09:10:36,757 unpacking tar archive at: mozilla-aurora-8551b253f406/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:37.010272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:37.010568) ========= script_repo_revision: 8551b253f4061db31e4be7829c2f70c2610caf42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:37.010971) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:37.011239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 09:10:37.018736) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-25 09:10:37.019030) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:10:37 INFO - MultiFileLogger online at 20160425 09:10:37 in /builds/slave/test 09:10:37 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:10:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:10:37 INFO - {'append_to_log': False, 09:10:37 INFO - 'base_work_dir': '/builds/slave/test', 09:10:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:10:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:10:37 INFO - 'branch': 'Mozilla-Aurora', 09:10:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:10:37 INFO - 'config_files': ('talos/linux_config.py',), 09:10:37 INFO - 'default_actions': ('clobber', 09:10:37 INFO - 'read-buildbot-config', 09:10:37 INFO - 'download-and-extract', 09:10:37 INFO - 'populate-webroot', 09:10:37 INFO - 'create-virtualenv', 09:10:37 INFO - 'install', 09:10:37 INFO - 'run-tests'), 09:10:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:10:37 INFO - 'download_minidump_stackwalk': True, 09:10:37 INFO - 'download_symbols': 'ondemand', 09:10:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:10:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:10:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:10:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:10:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:10:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:10:37 INFO - 'installer_path': 'installer.exe', 09:10:37 INFO - 'log_level': 'info', 09:10:37 INFO - 'log_name': 'talos', 09:10:37 INFO - 'log_to_console': True, 09:10:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:10:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:10:37 INFO - 'opt_config_files': (), 09:10:37 INFO - 'pip_index': False, 09:10:37 INFO - 'sps_profile': False, 09:10:37 INFO - 'sps_profile_interval': 0, 09:10:37 INFO - 'suite': 'dromaeojs', 09:10:37 INFO - 'system_bits': '32', 09:10:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:10:37 INFO - 'title': 'talos-linux64-ix-067', 09:10:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:10:37 INFO - 'use_talos_json': True, 09:10:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:10:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:10:37 INFO - 'work_dir': 'build'} 09:10:37 INFO - ##### 09:10:37 INFO - ##### Running clobber step. 09:10:37 INFO - ##### 09:10:37 INFO - Running pre-action listener: _resource_record_pre_action 09:10:37 INFO - Running main action method: clobber 09:10:37 INFO - rmtree: /builds/slave/test/build 09:10:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:10:37 INFO - Running post-action listener: _resource_record_post_action 09:10:37 INFO - ##### 09:10:37 INFO - ##### Running read-buildbot-config step. 09:10:37 INFO - ##### 09:10:37 INFO - Running pre-action listener: _resource_record_pre_action 09:10:37 INFO - Running main action method: read_buildbot_config 09:10:37 INFO - Using buildbot properties: 09:10:37 INFO - { 09:10:37 INFO - "project": "", 09:10:37 INFO - "product": "firefox", 09:10:37 INFO - "script_repo_revision": "production", 09:10:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:10:37 INFO - "repository": "", 09:10:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:10:37 INFO - "buildid": "20160425062348", 09:10:37 INFO - "pgo_build": "True", 09:10:37 INFO - "basedir": "/builds/slave/test", 09:10:37 INFO - "buildnumber": 285, 09:10:37 INFO - "slavename": "talos-linux64-ix-067", 09:10:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:10:37 INFO - "platform": "ubuntu64_hw", 09:10:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:10:37 INFO - "branch": "mozilla-aurora", 09:10:37 INFO - "repo_path": "releases/mozilla-aurora", 09:10:37 INFO - "revision": "8551b253f4061db31e4be7829c2f70c2610caf42", 09:10:37 INFO - "stage_platform": "linux64-pgo", 09:10:37 INFO - "builduid": "abe90fc74b164da98c10377025c22763", 09:10:37 INFO - "slavebuilddir": "test" 09:10:37 INFO - } 09:10:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 09:10:37 INFO - Running post-action listener: _resource_record_post_action 09:10:37 INFO - ##### 09:10:37 INFO - ##### Running download-and-extract step. 09:10:37 INFO - ##### 09:10:37 INFO - Running pre-action listener: _resource_record_pre_action 09:10:37 INFO - Running main action method: download_and_extract 09:10:37 INFO - mkdir: /builds/slave/test/build/tests 09:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:37 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:10:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:10:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:10:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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:10:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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:10:50 INFO - Downloaded 1448 bytes. 09:10:50 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 09:10:50 INFO - Using the following test package requirements: 09:10:50 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:10:50 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:10:50 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:10:50 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:10:50 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:10:50 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:10:50 INFO - u'jsshell-linux-x86_64.zip'], 09:10:50 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:10:50 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:10:50 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:10:50 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:10:50 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:10:50 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:10:50 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:10:50 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:10:50 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:10:50 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 09:10:50 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 09:10:50 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:10:50 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:50 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:10:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:10:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:10:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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:10:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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:10:57 INFO - Downloaded 23359918 bytes. 09:10:57 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:10:57 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:10:58 INFO - Return code: 0 09:10:58 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:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:58 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:10:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:10:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 09:10:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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:10:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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:11:00 INFO - Downloaded 23359918 bytes. 09:11:00 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:11:00 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:11:02 INFO - Return code: 0 09:11:02 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:11:02 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 09:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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:11:03 INFO - Downloaded 10845194 bytes. 09:11:03 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:11:03 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:11:04 INFO - Return code: 0 09:11:04 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:11:04 INFO - https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:11:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:11:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:11:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZpuBLsfqRea_aIl5YentDQ/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:11:06 INFO - Downloaded 60835591 bytes. 09:11:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:11:06 INFO - mkdir: /builds/slave/test/properties 09:11:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:11:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:11:06 INFO - Contents: 09:11:06 INFO - build_url:https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 09:11:06 INFO - Running post-action listener: _resource_record_post_action 09:11:06 INFO - Running post-action listener: set_extra_try_arguments 09:11:06 INFO - ##### 09:11:06 INFO - ##### Running populate-webroot step. 09:11:06 INFO - ##### 09:11:06 INFO - Running pre-action listener: _resource_record_pre_action 09:11:06 INFO - Running main action method: populate_webroot 09:11:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:11:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:11:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:11:06 INFO - '--tppagecycles', 09:11:06 INFO - '7'], 09:11:06 INFO - 'tests': ['tsvgm']}}, 09:11:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:11:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:11:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:11:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:11:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:11:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:11:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:06 INFO - 'talos_options': ['--e10s'], 09:11:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:11:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:06 INFO - 'tests': ['damp', 'tps']}, 09:11:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:06 INFO - 'talos_options': ['--e10s'], 09:11:06 INFO - 'tests': ['damp', 'tps']}, 09:11:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:11:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:11:06 INFO - 'other': {'tests': ['a11yr', 09:11:06 INFO - 'ts_paint', 09:11:06 INFO - 'tpaint', 09:11:06 INFO - 'sessionrestore', 09:11:06 INFO - 'sessionrestore_no_auto_restore', 09:11:06 INFO - 'tabpaint']}, 09:11:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:11:06 INFO - 'tests': ['a11yr', 09:11:06 INFO - 'ts_paint', 09:11:06 INFO - 'tpaint', 09:11:06 INFO - 'sessionrestore', 09:11:06 INFO - 'sessionrestore_no_auto_restore', 09:11:06 INFO - 'tabpaint']}, 09:11:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:11:06 INFO - 'tests': ['a11yr', 09:11:06 INFO - 'ts_paint', 09:11:06 INFO - 'tpaint', 09:11:06 INFO - 'sessionrestore', 09:11:06 INFO - 'sessionrestore_no_auto_restore', 09:11:06 INFO - 'tabpaint']}, 09:11:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:11:06 INFO - 'tests': ['a11yr', 09:11:06 INFO - 'ts_paint', 09:11:06 INFO - 'tpaint', 09:11:06 INFO - 'sessionrestore', 09:11:06 INFO - 'sessionrestore_no_auto_restore', 09:11:06 INFO - 'tabpaint']}, 09:11:06 INFO - 'other_l64': {'tests': ['a11yr', 09:11:06 INFO - 'ts_paint', 09:11:06 INFO - 'tpaint', 09:11:06 INFO - 'sessionrestore', 09:11:06 INFO - 'sessionrestore_no_auto_restore', 09:11:06 INFO - 'tabpaint']}, 09:11:06 INFO - 'other_nol64': {'tests': ['a11yr', 09:11:06 INFO - 'ts_paint', 09:11:06 INFO - 'tpaint', 09:11:06 INFO - 'sessionrestore', 09:11:06 INFO - 'sessionrestore_no_auto_restore', 09:11:06 INFO - 'tabpaint']}, 09:11:06 INFO - 'svgr': {'tests': ['tsvgx', 09:11:06 INFO - 'tsvgr_opacity', 09:11:06 INFO - 'tart', 09:11:06 INFO - 'tscrollx', 09:11:06 INFO - 'cart']}, 09:11:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:11:06 INFO - 'tests': ['tsvgx', 09:11:06 INFO - 'tsvgr_opacity', 09:11:06 INFO - 'tart', 09:11:06 INFO - 'tscrollx', 09:11:06 INFO - 'cart']}, 09:11:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:06 INFO - 'tests': ['tp5o']}, 09:11:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:06 INFO - 'talos_options': ['--e10s'], 09:11:06 INFO - 'tests': ['tp5o']}, 09:11:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:06 INFO - 'talos_options': ['--xperf_path', 09:11:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:06 INFO - 'tests': ['tp5n']}, 09:11:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:11:06 INFO - 'talos_options': ['--e10s', 09:11:06 INFO - '--xperf_path', 09:11:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:11:06 INFO - 'tests': ['tp5n']}}, 09:11:06 INFO - 'talos.zip': {'path': '', 09:11:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:11:06 INFO - Running post-action listener: _resource_record_post_action 09:11:06 INFO - ##### 09:11:06 INFO - ##### Running create-virtualenv step. 09:11:06 INFO - ##### 09:11:06 INFO - Running pre-action listener: _resource_record_pre_action 09:11:06 INFO - Running main action method: create_virtualenv 09:11:06 INFO - Creating virtualenv /builds/slave/test/build/venv 09:11:06 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:11:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:11:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:11:06 INFO - Using real prefix '/usr' 09:11:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:11:07 INFO - Installing distribute.............................................................................................................................................................................................done. 09:11:09 INFO - Installing pip.................done. 09:11:09 INFO - Return code: 0 09:11:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:11: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:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:09 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 0x7fdadaee6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b77160>, '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 0x1b78060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b784f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', '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:11:09 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:11:09 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:11:09 INFO - Using env: {'DISPLAY': ':0', 09:11:09 INFO - 'HOME': '/home/cltbld', 09:11:09 INFO - 'LANG': 'en_US.UTF-8', 09:11:09 INFO - 'LANGUAGE': 'en_US:en', 09:11:09 INFO - 'LOGNAME': 'cltbld', 09:11:09 INFO - 'MAIL': '/var/mail/cltbld', 09:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:09 INFO - 'MOZ_NO_REMOTE': '1', 09:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:09 INFO - 'NO_EM_RESTART': '1', 09:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:09 INFO - 'PWD': '/builds/slave/test', 09:11:09 INFO - 'SHELL': '/bin/bash', 09:11:09 INFO - 'SHLVL': '1', 09:11:09 INFO - 'TERM': 'linux', 09:11:09 INFO - 'TMOUT': '86400', 09:11:09 INFO - 'USER': 'cltbld', 09:11:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', 09:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:09 INFO - '_': '/tools/buildbot/bin/python'} 09:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:09 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:11:09 INFO - Cleaning up... 09:11:09 INFO - Return code: 0 09:11:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:11: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:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:09 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 0x7fdadaee6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b77160>, '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 0x1b78060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b784f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', '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:11:09 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:11:09 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:11:09 INFO - Using env: {'DISPLAY': ':0', 09:11:09 INFO - 'HOME': '/home/cltbld', 09:11:09 INFO - 'LANG': 'en_US.UTF-8', 09:11:09 INFO - 'LANGUAGE': 'en_US:en', 09:11:09 INFO - 'LOGNAME': 'cltbld', 09:11:09 INFO - 'MAIL': '/var/mail/cltbld', 09:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:09 INFO - 'MOZ_NO_REMOTE': '1', 09:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:09 INFO - 'NO_EM_RESTART': '1', 09:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:09 INFO - 'PWD': '/builds/slave/test', 09:11:09 INFO - 'SHELL': '/bin/bash', 09:11:09 INFO - 'SHLVL': '1', 09:11:09 INFO - 'TERM': 'linux', 09:11:09 INFO - 'TMOUT': '86400', 09:11:09 INFO - 'USER': 'cltbld', 09:11:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', 09:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:09 INFO - '_': '/tools/buildbot/bin/python'} 09:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:10 INFO - Downloading/unpacking psutil>=0.7.1 09:11:10 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:11:10 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:11:10 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:11:10 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:11:10 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:11:10 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:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:11:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:12 INFO - Installing collected packages: psutil 09:11:12 INFO - Running setup.py install for psutil 09:11:12 INFO - building 'psutil._psutil_linux' extension 09:11:12 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:11:13 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:11:13 INFO - building 'psutil._psutil_posix' extension 09:11:13 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:11:13 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:11:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:11:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:11:13 INFO - Successfully installed psutil 09:11:13 INFO - Cleaning up... 09:11:13 INFO - Return code: 0 09:11:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:13 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 0x7fdadaee6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b77160>, '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 0x1b78060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b784f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', '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:11:13 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:11:13 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:11:13 INFO - Using env: {'DISPLAY': ':0', 09:11:13 INFO - 'HOME': '/home/cltbld', 09:11:13 INFO - 'LANG': 'en_US.UTF-8', 09:11:13 INFO - 'LANGUAGE': 'en_US:en', 09:11:13 INFO - 'LOGNAME': 'cltbld', 09:11:13 INFO - 'MAIL': '/var/mail/cltbld', 09:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:13 INFO - 'MOZ_NO_REMOTE': '1', 09:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:13 INFO - 'NO_EM_RESTART': '1', 09:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:13 INFO - 'PWD': '/builds/slave/test', 09:11:13 INFO - 'SHELL': '/bin/bash', 09:11:13 INFO - 'SHLVL': '1', 09:11:13 INFO - 'TERM': 'linux', 09:11:13 INFO - 'TMOUT': '86400', 09:11:13 INFO - 'USER': 'cltbld', 09:11:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', 09:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:13 INFO - '_': '/tools/buildbot/bin/python'} 09:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:11:13 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:11:13 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:11:13 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:11:13 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:11:13 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:11:13 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:11:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:11:15 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:11:15 INFO - Installing collected packages: mozsystemmonitor 09:11:15 INFO - Running setup.py install for mozsystemmonitor 09:11:15 INFO - Successfully installed mozsystemmonitor 09:11:15 INFO - Cleaning up... 09:11:16 INFO - Return code: 0 09:11:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:11: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:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:16 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 0x7fdadaee6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b77160>, '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 0x1b78060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b784f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', '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:11:16 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:11:16 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:11:16 INFO - Using env: {'DISPLAY': ':0', 09:11:16 INFO - 'HOME': '/home/cltbld', 09:11:16 INFO - 'LANG': 'en_US.UTF-8', 09:11:16 INFO - 'LANGUAGE': 'en_US:en', 09:11:16 INFO - 'LOGNAME': 'cltbld', 09:11:16 INFO - 'MAIL': '/var/mail/cltbld', 09:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:16 INFO - 'MOZ_NO_REMOTE': '1', 09:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:16 INFO - 'NO_EM_RESTART': '1', 09:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:16 INFO - 'PWD': '/builds/slave/test', 09:11:16 INFO - 'SHELL': '/bin/bash', 09:11:16 INFO - 'SHLVL': '1', 09:11:16 INFO - 'TERM': 'linux', 09:11:16 INFO - 'TMOUT': '86400', 09:11:16 INFO - 'USER': 'cltbld', 09:11:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', 09:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:16 INFO - '_': '/tools/buildbot/bin/python'} 09:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:16 INFO - Downloading/unpacking blobuploader==1.2.4 09:11:16 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:11:16 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:11:16 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:11:16 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:11:16 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:11:16 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:11:18 INFO - Downloading blobuploader-1.2.4.tar.gz 09:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:11:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:11:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:18 INFO - Downloading docopt-0.6.1.tar.gz 09:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:11:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:11:18 INFO - Running setup.py install for blobuploader 09:11:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:11:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:11:18 INFO - Running setup.py install for requests 09:11:19 INFO - Running setup.py install for docopt 09:11:19 INFO - Successfully installed blobuploader requests docopt 09:11:19 INFO - Cleaning up... 09:11:19 INFO - Return code: 0 09:11:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:19 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 0x7fdadaee6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b77160>, '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 0x1b78060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b784f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', '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:11:19 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:11:19 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:11:19 INFO - Using env: {'DISPLAY': ':0', 09:11:19 INFO - 'HOME': '/home/cltbld', 09:11:19 INFO - 'LANG': 'en_US.UTF-8', 09:11:19 INFO - 'LANGUAGE': 'en_US:en', 09:11:19 INFO - 'LOGNAME': 'cltbld', 09:11:19 INFO - 'MAIL': '/var/mail/cltbld', 09:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:19 INFO - 'MOZ_NO_REMOTE': '1', 09:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:19 INFO - 'NO_EM_RESTART': '1', 09:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:19 INFO - 'PWD': '/builds/slave/test', 09:11:19 INFO - 'SHELL': '/bin/bash', 09:11:19 INFO - 'SHLVL': '1', 09:11:19 INFO - 'TERM': 'linux', 09:11:19 INFO - 'TMOUT': '86400', 09:11:19 INFO - 'USER': 'cltbld', 09:11:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', 09:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:19 INFO - '_': '/tools/buildbot/bin/python'} 09:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:19 INFO - Running setup.py (path:/tmp/pip-ELn7H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:19 INFO - Running setup.py (path:/tmp/pip-7KQ_ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:19 INFO - Running setup.py (path:/tmp/pip-O6jnc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:19 INFO - Running setup.py (path:/tmp/pip-zCgGr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:19 INFO - Running setup.py (path:/tmp/pip-2YHstO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:20 INFO - Running setup.py (path:/tmp/pip-CDBnnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:20 INFO - Running setup.py (path:/tmp/pip-xPZP26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:20 INFO - Running setup.py (path:/tmp/pip-G1F2Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:20 INFO - Running setup.py (path:/tmp/pip-lsq6d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:20 INFO - Running setup.py (path:/tmp/pip-WiFH0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:20 INFO - Running setup.py (path:/tmp/pip-7YBNFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:20 INFO - Running setup.py (path:/tmp/pip-vRTvbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:20 INFO - Running setup.py (path:/tmp/pip-g53gm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:20 INFO - Running setup.py (path:/tmp/pip-k7SpZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:20 INFO - Running setup.py (path:/tmp/pip-KNRL43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:20 INFO - Running setup.py (path:/tmp/pip-d_2YXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:20 INFO - Running setup.py (path:/tmp/pip-yIWaru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:11:20 INFO - Running setup.py install for manifestparser 09:11:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:11:21 INFO - Running setup.py install for mozcrash 09:11:21 INFO - Running setup.py install for mozdebug 09:11:21 INFO - Running setup.py install for mozdevice 09:11:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:11:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:11:21 INFO - Running setup.py install for mozfile 09:11:21 INFO - Running setup.py install for mozhttpd 09:11:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:11:21 INFO - Running setup.py install for mozinfo 09:11:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:11:21 INFO - Running setup.py install for mozInstall 09:11:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:11:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:11:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:11:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:11:21 INFO - Running setup.py install for mozleak 09:11:21 INFO - Running setup.py install for mozlog 09:11:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:11:21 INFO - Running setup.py install for moznetwork 09:11:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:11:22 INFO - Running setup.py install for mozprocess 09:11:22 INFO - Running setup.py install for mozprofile 09:11:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:11:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:11:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:11:22 INFO - Running setup.py install for mozrunner 09:11:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:11:22 INFO - Running setup.py install for mozscreenshot 09:11:22 INFO - Running setup.py install for moztest 09:11:22 INFO - Running setup.py install for mozversion 09:11:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:11:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:11:22 INFO - Cleaning up... 09:11:22 INFO - Return code: 0 09:11:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:22 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 0x7fdadaee6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b77160>, '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 0x1b78060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b784f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', '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:11:22 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:11:22 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:11:22 INFO - Using env: {'DISPLAY': ':0', 09:11:22 INFO - 'HOME': '/home/cltbld', 09:11:22 INFO - 'LANG': 'en_US.UTF-8', 09:11:22 INFO - 'LANGUAGE': 'en_US:en', 09:11:22 INFO - 'LOGNAME': 'cltbld', 09:11:22 INFO - 'MAIL': '/var/mail/cltbld', 09:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:22 INFO - 'MOZ_NO_REMOTE': '1', 09:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:22 INFO - 'NO_EM_RESTART': '1', 09:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:22 INFO - 'PWD': '/builds/slave/test', 09:11:22 INFO - 'SHELL': '/bin/bash', 09:11:22 INFO - 'SHLVL': '1', 09:11:22 INFO - 'TERM': 'linux', 09:11:22 INFO - 'TMOUT': '86400', 09:11:22 INFO - 'USER': 'cltbld', 09:11:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', 09:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:22 INFO - '_': '/tools/buildbot/bin/python'} 09:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:22 INFO - Running setup.py (path:/tmp/pip-UAq92q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:22 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:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:22 INFO - Running setup.py (path:/tmp/pip-NlyFMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:23 INFO - Running setup.py (path:/tmp/pip-Pi6sis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:23 INFO - Running setup.py (path:/tmp/pip-n4omVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:23 INFO - Running setup.py (path:/tmp/pip-VVwjK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:23 INFO - Running setup.py (path:/tmp/pip-qmeHn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:23 INFO - Running setup.py (path:/tmp/pip-HmlUh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:23 INFO - Running setup.py (path:/tmp/pip-gXJmgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:23 INFO - Running setup.py (path:/tmp/pip-dK0Rp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:23 INFO - Running setup.py (path:/tmp/pip-VXhuhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:23 INFO - Running setup.py (path:/tmp/pip-apLnAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:23 INFO - Running setup.py (path:/tmp/pip-4ihvpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:23 INFO - Running setup.py (path:/tmp/pip-rFyMtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:23 INFO - Running setup.py (path:/tmp/pip-OibCkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:23 INFO - Running setup.py (path:/tmp/pip-Zl4LG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:23 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:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:23 INFO - Running setup.py (path:/tmp/pip-LB7uYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:24 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:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:24 INFO - Running setup.py (path:/tmp/pip-Y9E_Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:24 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:11:24 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:11:24 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:11:24 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:11:24 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:11:24 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:11:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:24 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:11:24 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:11:24 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:11:24 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:11:24 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:11:24 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:11:25 INFO - Downloading blessings-1.6.tar.gz 09:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:11:26 INFO - Installing collected packages: blessings 09:11:26 INFO - Running setup.py install for blessings 09:11:26 INFO - Successfully installed blessings 09:11:26 INFO - Cleaning up... 09:11:26 INFO - Return code: 0 09:11:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:26 INFO - Reading from file tmpfile_stdout 09:11:26 INFO - Current package versions: 09:11:26 INFO - argparse == 1.2.1 09:11:26 INFO - blessings == 1.6 09:11:26 INFO - blobuploader == 1.2.4 09:11:26 INFO - docopt == 0.6.1 09:11:26 INFO - manifestparser == 1.1 09:11:26 INFO - mozInstall == 1.12 09:11:26 INFO - mozcrash == 0.17 09:11:26 INFO - mozdebug == 0.1 09:11:26 INFO - mozdevice == 0.48 09:11:26 INFO - mozfile == 1.2 09:11:26 INFO - mozhttpd == 0.7 09:11:26 INFO - mozinfo == 0.9 09:11:26 INFO - mozleak == 0.1 09:11:26 INFO - mozlog == 3.1 09:11:26 INFO - moznetwork == 0.27 09:11:26 INFO - mozprocess == 0.22 09:11:26 INFO - mozprofile == 0.28 09:11:26 INFO - mozrunner == 6.11 09:11:26 INFO - mozscreenshot == 0.1 09:11:26 INFO - mozsystemmonitor == 0.0 09:11:26 INFO - moztest == 0.7 09:11:26 INFO - mozversion == 1.4 09:11:26 INFO - psutil == 3.1.1 09:11:26 INFO - requests == 1.2.3 09:11:26 INFO - wsgiref == 0.1.2 09:11:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:26 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 0x7fdadaee6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b77160>, '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 0x1b78060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b784f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', '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:11:26 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:11:26 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:11:26 INFO - Using env: {'DISPLAY': ':0', 09:11:26 INFO - 'HOME': '/home/cltbld', 09:11:26 INFO - 'LANG': 'en_US.UTF-8', 09:11:26 INFO - 'LANGUAGE': 'en_US:en', 09:11:26 INFO - 'LOGNAME': 'cltbld', 09:11:26 INFO - 'MAIL': '/var/mail/cltbld', 09:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:26 INFO - 'MOZ_NO_REMOTE': '1', 09:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:26 INFO - 'NO_EM_RESTART': '1', 09:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:26 INFO - 'PWD': '/builds/slave/test', 09:11:26 INFO - 'SHELL': '/bin/bash', 09:11:26 INFO - 'SHLVL': '1', 09:11:26 INFO - 'TERM': 'linux', 09:11:26 INFO - 'TMOUT': '86400', 09:11:26 INFO - 'USER': 'cltbld', 09:11:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', 09:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:26 INFO - '_': '/tools/buildbot/bin/python'} 09:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 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:11:26 INFO - Cleaning up... 09:11:26 INFO - Return code: 0 09:11:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdadaee6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b77160>, '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 0x1b78060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b784f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', '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:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:11:26 INFO - Using env: {'DISPLAY': ':0', 09:11:26 INFO - 'HOME': '/home/cltbld', 09:11:26 INFO - 'LANG': 'en_US.UTF-8', 09:11:26 INFO - 'LANGUAGE': 'en_US:en', 09:11:26 INFO - 'LOGNAME': 'cltbld', 09:11:26 INFO - 'MAIL': '/var/mail/cltbld', 09:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:26 INFO - 'MOZ_NO_REMOTE': '1', 09:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:26 INFO - 'NO_EM_RESTART': '1', 09:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:26 INFO - 'PWD': '/builds/slave/test', 09:11:26 INFO - 'SHELL': '/bin/bash', 09:11:26 INFO - 'SHLVL': '1', 09:11:26 INFO - 'TERM': 'linux', 09:11:26 INFO - 'TMOUT': '86400', 09:11:26 INFO - 'USER': 'cltbld', 09:11:26 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', 09:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:26 INFO - '_': '/tools/buildbot/bin/python'} 09:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:26 INFO - Downloading/unpacking jsonschema 09:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:11:28 INFO - Downloading/unpacking functools32 (from jsonschema) 09:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:28 INFO - Downloading functools32-3.2.3-2.tar.gz 09:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:11:29 INFO - warning: no files found matching '*.txt' 09:11:29 INFO - no previously-included directories found matching 'build' 09:11:29 INFO - no previously-included directories found matching 'dist' 09:11:29 INFO - no previously-included directories found matching '.git*' 09:11:29 INFO - Installing collected packages: jsonschema, functools32 09:11:29 INFO - Running setup.py install for functools32 09:11:29 INFO - warning: no files found matching '*.txt' 09:11:29 INFO - no previously-included directories found matching 'build' 09:11:29 INFO - no previously-included directories found matching 'dist' 09:11:29 INFO - no previously-included directories found matching '.git*' 09:11:29 INFO - Successfully installed jsonschema functools32 09:11:29 INFO - Cleaning up... 09:11:29 INFO - Return code: 0 09:11:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:11:29 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:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:29 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:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:29 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 0x7fdadaee6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b77160>, '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 0x1b78060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b784f0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', '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:11:29 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:11:29 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:11:29 INFO - Using env: {'DISPLAY': ':0', 09:11:29 INFO - 'HOME': '/home/cltbld', 09:11:29 INFO - 'LANG': 'en_US.UTF-8', 09:11:29 INFO - 'LANGUAGE': 'en_US:en', 09:11:29 INFO - 'LOGNAME': 'cltbld', 09:11:29 INFO - 'MAIL': '/var/mail/cltbld', 09:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:29 INFO - 'MOZ_NO_REMOTE': '1', 09:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:29 INFO - 'NO_EM_RESTART': '1', 09:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:29 INFO - 'PWD': '/builds/slave/test', 09:11:29 INFO - 'SHELL': '/bin/bash', 09:11:29 INFO - 'SHLVL': '1', 09:11:29 INFO - 'TERM': 'linux', 09:11:29 INFO - 'TMOUT': '86400', 09:11:29 INFO - 'USER': 'cltbld', 09:11:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', 09:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:29 INFO - '_': '/tools/buildbot/bin/python'} 09:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:29 INFO - Downloading/unpacking flake8 09:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:11:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:11:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:11:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:11:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:11:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:11:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:11:32 INFO - no previously-included directories found matching 'docs/_build' 09:11:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:11:32 INFO - Running setup.py install for pep8 09:11:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:11:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:11:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:11:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:11:32 INFO - no previously-included directories found matching 'docs/_build' 09:11:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:11:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:11:32 INFO - Cleaning up... 09:11:32 INFO - Return code: 0 09:11:32 INFO - Running post-action listener: _resource_record_post_action 09:11:32 INFO - Running post-action listener: _start_resource_monitoring 09:11:32 INFO - Starting resource monitoring. 09:11:32 INFO - ##### 09:11:32 INFO - ##### Running install step. 09:11:32 INFO - ##### 09:11:32 INFO - Running pre-action listener: _resource_record_pre_action 09:11:32 INFO - Running main action method: install 09:11:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:32 INFO - Reading from file tmpfile_stdout 09:11:32 INFO - Detecting whether we're running mozinstall >=1.0... 09:11:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:11:32 INFO - Reading from file tmpfile_stdout 09:11:32 INFO - Output received: 09:11:32 INFO - Usage: mozinstall [options] installer 09:11:32 INFO - Options: 09:11:32 INFO - -h, --help show this help message and exit 09:11:32 INFO - -d DEST, --destination=DEST 09:11:32 INFO - Directory to install application into. [default: 09:11:32 INFO - "/builds/slave/test"] 09:11:32 INFO - --app=APP Application being installed. [default: firefox] 09:11:32 INFO - mkdir: /builds/slave/test/build/application 09:11:32 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:11:32 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:11:47 INFO - Reading from file tmpfile_stdout 09:11:47 INFO - Output received: 09:11:47 INFO - /builds/slave/test/build/application/firefox/firefox 09:11:47 INFO - Running post-action listener: _resource_record_post_action 09:11:47 INFO - ##### 09:11:47 INFO - ##### Running run-tests step. 09:11:47 INFO - ##### 09:11:47 INFO - Running pre-action listener: _resource_record_pre_action 09:11:47 INFO - Running main action method: run_tests 09:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:11:47 INFO - Python 2.7.3 09:11:47 INFO - Return code: 0 09:11:47 INFO - grabbing minidump binary from tooltool 09:11:47 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:11:47 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 0x1b77160>, '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 0x1b78060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b784f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:11:47 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:11:47 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:11:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:11:47 INFO - Return code: 0 09:11:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:11:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:11:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:11:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:11:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:11:48 INFO - Return code: 0 09:11:48 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/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:11:48 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/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:11:48 INFO - Using env: {'DISPLAY': ':0', 09:11:48 INFO - 'HOME': '/home/cltbld', 09:11:48 INFO - 'LANG': 'en_US.UTF-8', 09:11:48 INFO - 'LANGUAGE': 'en_US:en', 09:11:48 INFO - 'LOGNAME': 'cltbld', 09:11:48 INFO - 'MAIL': '/var/mail/cltbld', 09:11:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:11:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:48 INFO - 'MOZ_NO_REMOTE': '1', 09:11:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:48 INFO - 'NO_EM_RESTART': '1', 09:11:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:48 INFO - 'PWD': '/builds/slave/test', 09:11:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:11:48 INFO - 'SHELL': '/bin/bash', 09:11:48 INFO - 'SHLVL': '1', 09:11:48 INFO - 'TERM': 'linux', 09:11:48 INFO - 'TMOUT': '86400', 09:11:48 INFO - 'USER': 'cltbld', 09:11:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797', 09:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:48 INFO - '_': '/tools/buildbot/bin/python'} 09:11:48 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/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:11:49 INFO - mozversion application_buildid: 20160425062348 09:11:49 INFO - mozversion application_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 09:11:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:11:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:11:49 INFO - mozversion application_name: Firefox 09:11:49 INFO - mozversion application_remotingname: firefox-dev 09:11:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:11:49 INFO - mozversion application_vendor: Mozilla 09:11:49 INFO - mozversion application_version: 47.0a2 09:11:49 INFO - mozversion platform_buildid: 20160425062348 09:11:49 INFO - mozversion platform_changeset: 8551b253f4061db31e4be7829c2f70c2610caf42 09:11:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:11:49 INFO - mozversion platform_version: 47.0a2 09:11:49 INFO - using testdate: 1461600709 09:11:49 INFO - actual date: 1461600709 09:11:49 INFO - starting webserver on 'localhost:58825' 09:11:49 INFO - SUITE-START | Running 2 tests 09:11:49 INFO - TEST-START | dromaeo_css 09:11:49 INFO - operating with platform_type : linux_ 09:11:49 INFO - Initialising browser for dromaeo_css test... 09:11:49 INFO - TEST-INFO | started process 3266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCT7tT/profile http://localhost:58825/getInfo.html) 09:11:53 INFO - PROCESS | 3266 | __metrics Screen width/height:1600/1200 09:11:53 INFO - PROCESS | 3266 | colorDepth:24 09:11:53 INFO - PROCESS | 3266 | Browser inner width/height: 1024/697 09:11:53 INFO - PROCESS | 3266 | __metrics 09:11:54 INFO - PROCESS | 3266 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:11:55 INFO - TEST-INFO | 3266: exit 0 09:11:55 INFO - Browser initialized. 09:11:55 INFO - Running cycle 1/1 for dromaeo_css test... 09:11:55 INFO - TEST-INFO | started process 3358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppCT7tT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:12:07 INFO - PROCESS | 3358 | RSS: Main: 142020608 09:12:07 INFO - PROCESS | 3358 | 09:12:58 INFO - PROCESS | 3358 | 1461600778927 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:15:06 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:58825/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58825/tests/dromaeo/cssquery-ext.html) 09:15:07 INFO - PROCESS | 3358 | RSS: Main: 256507904 09:15:07 INFO - PROCESS | 3358 | 09:18:09 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:58825/tests/dromaeo/cssquery-ext.html (next: http://localhost:58825/tests/dromaeo/cssquery-jquery.html) 09:18:10 INFO - PROCESS | 3358 | RSS: Main: 223387648 09:18:10 INFO - PROCESS | 3358 | 09:21:12 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:58825/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58825/tests/dromaeo/cssquery-mootools.html) 09:21:12 INFO - PROCESS | 3358 | RSS: Main: 210939904 09:21:12 INFO - PROCESS | 3358 | 09:24:14 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:58825/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58825/tests/dromaeo/cssquery-prototype.html) 09:24:15 INFO - PROCESS | 3358 | RSS: Main: 204468224 09:24:15 INFO - PROCESS | 3358 | 09:27:17 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:58825/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58825/tests/dromaeo/cssquery-yui.html) 09:27:18 INFO - PROCESS | 3358 | RSS: Main: 208429056 09:27:18 INFO - PROCESS | 3358 | 09:30:20 INFO - PROCESS | 3358 | Cycle 1(1): loaded http://localhost:58825/tests/dromaeo/cssquery-yui.html (next: http://localhost:58825/tests/dromaeo/cssquery-dojo.html) 09:30:20 INFO - PROCESS | 3358 | RSS: Main: 251199488 09:30:20 INFO - PROCESS | 3358 | 09:30:20 INFO - PROCESS | 3358 | __start_tp_report 09:30:20 INFO - PROCESS | 3358 | _x_x_mozilla_page_load 09:30:20 INFO - PROCESS | 3358 | _x_x_mozilla_page_load_details 09:30:20 INFO - PROCESS | 3358 | |i|pagename|runs| 09:30:20 INFO - PROCESS | 3358 | |0;dojo.html;3305.570275864138;3354.9329013419747;3382.7801192922443;3387.491876218567;3418.111291064324;5484.725763711814;5508.118701007839;5509.256250406194;5515.862103447415;5528;5481.451854814517;5504.394516603171;5504.944950550504;5509.47659972303;5511.724413779305;4904.190808516591;4991.500849915015;5005.649604527694;5105.030044291572;5109.923351149717;4957.529034741694;5060.11447996601;5064.670796398223;5065.062963351773;5075.086484432801;5044.344235249431;5072.923906141411;5139.6659217150955;5149.047426226141;5173.249878767577;5108.20822772469;5123.154679477919;5130.615203859688;5132.923006154911;5159.380874295109;4909.509049095098;4942.456329803718;5044.621653375974;5056.165732654108;5078.238264260353;5384.946150538483;5399.7030163341;5400.351957765054;5407.270018547485;5422.891542169174;5800.4489573490455;5877.353491115974;5976.491998180117;5977.491913187384;5977.731002104916;5962.165296858443;5975.910361344583;5994.37059108796;5999.250093738283;6025.3372129065765;5585.748641311151;5590.720463976825;5592.217089607459;5593.105103183471;5593.916091258634;5914.704264786744;6055.848603784941;6110.26676798787;6120.1737765401995;6133.3866613339205;5744.712764361765;5753.194552762617;5755.194272801811;5768.192453056576;5782.537397008314;5802.593818432753;5814.476697097281;5837.474627283565;5851.882962340729;5852.356240813507;5796.82609521715;5824.417558244142;5881.794137205177;5916.763329466859;5962.07587823888;5915.822525324247;5927.673977931255;5928.970355148197;5929.792457264061;5933.614315069507;4468.709533880287;4519.41247637805;4519.751413672279;4523.253663145544;4551.044280701024;3964.088259700285;3969.6030396960073;3999.4800675911947;4033.858814941463;4072.1244932339096;5579.414161512983;5608.130739735348;5614.073677843192;5615.606907516516;5642.294713160855;5778.7688492460675;5933.139694744238;5934.287885453773;5936.287645482484;5947.494462970696;5634.943650563524;5682.829515114553;5711.257536520309;5725.885482290331;5732.226149469851;5079.238114282887;5081;5088.745562721849;5089.9565589054155;5115.488451154854;5938.792142275086;6039.124326972565;6059.636421814617;6066.029435290332;6071.180390647206;5937.732802023833;5959.0763431668165;5960.314563825215;5964.582479226413;5986.161937328865;6062.030075187949;6095.908561371494;6096.1465394845645;6098.847528811815;6100.328963813889;5717.142428635738;5802.82591522255;5868.501177399969;5877.089051197071;5877.911831322448;5908.379620139824;5909.70451477433;5918.585699001029;5921.674307912934;5923.022701254245;5721.227634269487;5725.627834190765;5762.423757624204;5790.10253410722;5792.160136780228;5605.047141985954;5757.481826635623;5786.42135786418;5865.178874957594;5888.558358123072;5614.382417933943;5621.775128994795;5622.88754224905;5623;5624.184493248538;5759.481646651821;5788.681622510802;5796.391378905154;5798.82603521895;5800.1299805029585;5519.227308176939;5567.331920169606;5672.376038635829;5765.1928729977;5783.652980821164 09:30:20 INFO - PROCESS | 3358 | |1;ext.html;553.8753780399411;565.0422533805202;584.1996464843165;620.7113692133157;636.9426751592356;30369;31024;31052.378952420968;38220.04449888754;38302.425463618;41585.7920710396;41701;42112.78943605285;42117.78941105298;42229.577704222946;8608.483490990546;8794.956025219897;8812.339074569401;8812.955935220314;8814.206721395074;8543.487390756543;8632.741017769446;8647.524386158759;8667;8679.65281388747;8716.25911797498;8813.338999575026;8815.735527934172;9058.773530661752;9069.093090690943;8907.910920890805;9010.414323068979;9015.233705135071;9015.36892417531;9016.68441604544;8898;9105.317101217435;9139.177474027303;9155.359124861263;9159.221466175382;41763;42314.78842605798;42323;42323.57676423227;42355.36466952998;3597.2625611749527;3868.0909986153233;3985.143194213258;4222.98648324403;4412.514623391425;32934;33091;33580.66419335824;33664.831675841706;33738.662613373795;3587.1032241939515;3757.1922036762226;3780.867669631577;3784.848606055782;3886.261610294035;283833;285791;287693;287736;288755;69170.65414672895;69979;70146;70156;70185.64907175432;74341;74439.25560744324;75019.62490187623;75238;75594.24405755872;16967.91516042412;17108.74336884948;17159.485215443558;17176.39882604103;17262.395816146374;13214.405351759195;13216.603501894959;13277.070605057554;13290;13303.800442993363;21688.132474700837;22437.21469748551;22480.43798905008;22511.88744056302;22513;7928.563928983961;8206;8262.958685206535;8282.792930176794;8306.792330191673;1035.3529044347283;1073.7798751255973;1100.7303210713426;1123.842662027317;1140.2189500192228;29776.85111574428;29986.85006574953;30476.695233047387;30567;30737.2315692105;1095.457748414524;1148.4143087025677;1159.5825502818977;1206.2702065250573;1263.406199086428;15845.68308633821;16490.093044882648;17222.827771722372;17726.37957671501;17795.555111122325;193750;194015;194105;194113;195549;60748;61268.630225338035;61280.69359653173;61314.69342653347;61374;1302.772014897408;1418.6240646228757;1438.6187660269827;1497.475883440787;1505.0442968714945;28493.145205643865;28609.713902860705;28834.27914302159;29172.854135729187;29400.558991614715;44587.77706111449;45083.54916450794;45216;45229;45276.094478110914;202409;203741;204062;205571;205786;30638.234044149074;34676.65323346835;34770.82614586911;35093.82453087718;35186.47220291749;40305.79847100746;40591.39112913368;41644.791776040925;41679.374809377274;43396.349054763574;37236.25527489381;37392.81303593465;37659.81170094132;38050.238995219384;42912.38526166838;38238.52154181518;38460.23079538337;39444.60555394524;39494.60505395024;40236;38374.80812595919;39243.2151356977;39289.2142157161;39466.40800387939;39535;33574.160645983065;34929.47605785966;35250;35375.82312088526;35536.28927421489;26775.732242678103;26899.86550067237;26999.730002700508;27158.864205678845;27249.59125613157 09:30:20 INFO - PROCESS | 3358 | |2;jquery.html;359.2419993813054;377.74502211007564;384.05522414859445;386.7157639135235;388.1848118950205;17370.91314543427;17976.91011544942;19010.904945475253;19022.239110435567;19031;17247.482575522725;17871.553211169696;18073.096345182723;18083.819161808377;18089.366872159444;5549.334079910416;5772.624779389326;5806.738696758656;5808.506276966442;5815.970920145414;4303.870883873489;5574.414686457904;6062.514998800086;6324.241091069055;6353.459955903731;6264.686765661721;6291.968540157316;6292.150559674431;6319.873602527947;6320.241571011462;6052.909206361886;6291.182146320972;6293.653849038301;6296.622202667854;6298.086777417295;3933.5476420211758;5411.188321751769;5606.439356064402;5608.467195616451;5611.0741727614895;21056.157753689833;21076.473088172766;21220.25729099474;21644.35066947994;21649;2374.798142157919;2574.472233192191;2625.5799072148557;2728.9727102728916;2773.334399744067;13194.142380745221;13280.800787988188;13517.864821351759;13553.525626603121;13708.314584270747;1696.1053859999615;1700.5663555793317;1745.1361576019951;1774.1306759687789;1812.9184186711498;67019;68868.31131688668;68925.65537172282;69090.3090969089;69523;9965.302428829913;10189.745256368502;10445.895541044645;10453.372797632166;10596.629117980834;14605.561833145022;14626.341814618156;14674.779878301833;14679.266036698122;14733.852661473462;7950.880736788953;8263.091059983397;8320.292775114061;8375.288100511525;8376.832463350698;8147.00796609657;8149.511029338259;8165.346772258205;8247.917520824834;8255.463394879434;6175.876482470415;6278.497720182374;6289.465395441439;6308.58994165387;6324;1810.3120814090826;1846.1323178106268;1863.41302489718;1909.9522511937312;1925.3935010471657;1003.9046290602527;1003.9899601004042;1066.1843689577324;1087.1357270969597;1092.0662833277593;15859.127747973742;16104.355825767072;16541.83458165427;17320.220590073226;17394.739078913826;1064.3347907557777;1094.2231015978584;1097.1825989637612;1116.2465335898237;1193.3496244546743;10099.545520451597;10215.591376344863;10286.691399258034;10327.741806454898;10480.68557943263;415507;419289;426684;433479;434168;69382.3061769386;70081.2991870085;70099.64950175319;70913.64543177355;72093;1096.5120521367915;1102.2669924500117;1102.8235482322789;1106.1206340958956;1118.1390329446444;15580.376784928476;15589.220538973233;15736.449224277554;15763.842361576697;15771.211439427752;32134.67865321317;32308.83845580757;32506.51240231351;33193.17017074496;33239.66760332366;43014;43646;45433;46315.76842115768;51030.23454648258;8419.83160336802;8521.318294536546;8625.094365091574;8654.740357789024;8797.956010219908;10183.643572474928;11961.461734221806;12292.877071229173;12820.935895320463;13020.739585208432;10582.417967011888;10792.352458852494;11177.608783692533;11347.37589432589;11547.018503426967;5309.707966061749;8393.748187554384;10791.165501864858;11322.490487928228;11482.081433485468;11559.133065019989;11569.768604628029;11806.350650714294;11809.940950295193;12014.879851201726;8621.482711037357;8756;8772.868406973774;8915.465072095694;8929.598168082583;10757.432295100858;11583.247088939192;11779.705507362385;11851.940740296242;11895.82156267674 09:30:20 INFO - PROCESS | 3358 | |3;mootools.html;1428.8785453236474;1521.5511424129882;1539.3446305123664;1750.5798608333996;1885.65115453641;7229.2047874733735;7846.13692493826;8007.39944504163;8012.078610959741;8019.599020048996;8075.232852878967;8214.219649133323;8240.299574536171;8241.958790206056;8245.175482451752;2056.928007519737;2368.5973384524673;2410.433548116191;2444.046821739523;2444.181199298237;2440.365504968703;2448.8040956723507;2449.1672831237374;2451.9754802452017;2454.9386265343333;2351.271105957159;2404.146527982567;2404.2546810488716;2404.75952404759;2406.9638955415685;2363.8936247868887;2386.284114765572;2398.940026499334;2406.7352591214953;2407.4101845048076;2331.825113116523;2337.2520793346134;2344.6131388320905;2378.21518898763;2379.5716770981217;8420.873686894702;8468.618912148968;8483.109273526314;8498.617562209716;8502.574871256413;5055.823046193365;5158.716270605115;5161.974190129063;5170.1986192140275;5178.844634660966;3205.406999705062;3299.109240505074;3302.5706658134527;3326.501024846268;3385.3567822113964;1049;1053.5417093564324;1064.542246833861;1069.3530414099514;1073.9892601073968;11716;11723.7069073273;11734.061275098056;11761.294322340602;11766.352850593214;4487.775611219426;4527.796249168795;4625.699329543569;4635.976820115878;4642.489326174118;9996.100350968447;10002.149817265614;10003.499825008721;10017.14854237398;10025.649102281384;4537.750423726727;5106.4382917879;5108.412532558729;5113.207452844815;5118.59051275897;4169.145325208325;4453.710508816916;4498.257787465097;4542.477615074243;4557.6581756368405;3820.3887378019385;3893.2213557288087;3923.725339226227;3936.724429289922;3950.3481925481974;1277.572013375511;1282.410091357967;1284.9229046257067;1286.0611753420055;1290.270996886756;1346.9528566500126;1374.5051781358702;1377.373295150704;1448.3844366144347;1456.9708605828037;7777.261160189773;7869.842603147905;7896.289333959856;7911;7918.28735413804;1119.4234968990977;1139.5441823270592;1170.6546568762235;1195.1335281920537;1220.8107743299802;6145.324014358417;6226.5641405102115;6242.344553821874;6277.1525844010475;6277.529185311028;9702.223822094216;9975.25185611082;9975.600975961026;9982.151517120981;9998.450085245237;9595.088466595662;9831.410115393099;9837.114659680663;9851.16265117473;9851.605935762633;7946.086200086948;7969.721059762996;7971.083325417535;8077.071136819341;8086.110527841933;7740.7677769667;7776.766696999099;7823.139454660097;7844.21557844211;8045.678172873254;9059.275257979214;9249.583768730557;9442.10300021497;9487.525623718648;9516.429014259167;9251.259899207913;9462.101100395452;9585.329026968324;9602;9660.130588247092;6684.699188536625;7161.4986950912935;7368.631568421664;7547.207543208104;7667.118281397487;7926.564038977681;7935.761927142195;7948.801279968047;7992.480488768211;7992.600369981594;7084.822879428056;7236.638168091679;7258.528195667264;7362.079740032496;7376.7418140364825;7059.5764254144915;7124.21633620291;7216.639168041472;7285.7814265572115;7322.597257150908;7441.441891858024;7472.925270747223;7508.174100849012;7509.4367922404945;7511.211322811027;6799;6873.5875847449315;6882.105326307748;6890.655467226518;6897.137857767779;6490.221173459215;6581.769638062645;6582.144321238208;6583.868322633616;6591.967040164768 09:30:20 INFO - PROCESS | 3358 | |4;prototype.html;365.92965575691113;370.7997681252123;372.0586915104785;372.170060764495;375.54746530430833;6054.818355449338;6090.908636370453;6113.296970848353;6123.755049798003;6133.570650054504;5992.34084250732;6038.637681739098;6039.547033972448;6052.727627256784;6067.848303792407;4556.931646025312;4600.539946005406;4667.929981050287;4723.527647235283;4749;4698.060387922412;4711.9764401177945;4746.620270378378;4763.26169443735;4775.474697783258;4729.55069268419;4733.810647574093;4738.431388233417;4740.90518189636;4751.263554149113;4513.548645135493;4605.0559635274685;4652.464966528859;4728.69263497875;4749.905001899977;4198.307279298942;4201.4538110045805;4221.430106935555;4223.894402639928;4228.471441069866;5795;5813.360530341659;5827.4755272025295;5832.329282132524;5834.883302333972;5519.475649813261;5530.5852061095175;5531.861703457445;5535.308086489189;5548.667079975215;6416.230052393743;6417.550771446001;6417.807465776034;6427.132337134473;6434.292227854932;4379.912401751979;4525.909481810379;4531.56950089741;4539.024109816405;4662.790174442124;6635;6679.666016699194;6702.396784289389;6704.83237919051;6706.899396509105;4634.606058485067;4660.580547750651;4661.86014419568;4667.906641867144;4669.18289299378;4724.740139292303;4725.9527404726205;4735.857924262277;4737.857864264078;4744.454387745384;5404.918926216032;5429.647072940246;5431.619786614978;5434.91847622286;5440.537554307849;6328.050792381179;6427.196600424947;6440.516961227927;6472.579282346633;6483.059956306309;1646.876484263685;1661.2773443552094;1664.217817625714;1666.1585899120867;1670.599056226497;1038.8078205532001;1072.6245813965206;1093.0872721277822;1097.078454098561;1120.4621781544904;5976.282846058501;5996.13056106862;6127.264728232641;6224.595401298901;6234.314225435199;6619.635920024445;6626.271110177877;6655.234648015444;6722.327767223336;6733.124693789874;6278.372162783777;6288.402601752918;6292.874142517124;6306.337834527309;6309.526785491106;3574.1064733816547;3596.478510615946;3605.837737301828;3618.8371523281517;3626.818659067036;6753.08833307507;6856.691448884812;6967.163940327193;6969.05917701114;6973.6164510952385;6861.965690171617;6879.931200687929;6893.448524118058;6901.482388820858;6922.688479018456;6925.376716095576;6933.2720064393525;6957.199922008933;6970.825729356807;6975.407090397373;6728.5197256605425;6814.62519561409;6824.010518474893;6825.078614386995;6829.1804983400325;6487.124238227779;6625.072489851328;6628.005799129976;6643.900341494785;6652.933470665232;6869.626074784963;6889.517733758589;6895.827604309932;6913.75801846933;6930.099087118642;4675.158471475167;4744.976275118603;4748.287756836502;4748.453927798348;4751.453582838018;6741.797746067626;6744.898826517508;6751.750926078691;6752.054712340178;6752.223494298219;6317.526185536195;6541.901871472027;6542.574732642363;6549.181352330958;6555.70499327541;6479;6509.218893732593;6521.5108866834225;6527.804165875032;6532.05285233629;6319.652419116993;6340.239171299474;6355.682215889095;6419.45434638061;6429.7106630200815;6553.442957348679;6561.934380656132;6564.540482166202;6565.638889860912;6569;6023.186869772525;6118.357572454828;6391.105245265573;6404.295527491879;6414.262359828679 09:30:20 INFO - PROCESS | 3358 | |5;yui.html;735.6726256815716;773.0993392697508;775.5928137727695;788.4756636836504;804.1877703519443;13883.861161388382;14175.432982680693;14202.502912398068;14203.153590033282;14210.360533775978;12938.805917911239;12959.93520032401;14570.781438278407;14923.328450219738;15027.849721502782;777.183956845313;903.6927444668811;905.7735566108456;920.7375897869109;920.9907900920972;914.3736540469799;929.1730359979623;930.3394589841221;930.8929473110577;931.1898648176096;970.3353203055894;975.4829940131741;977.0522593084696;977.907098825614;978.8776402949632;802.2218448105328;952.7570469530294;965.4593427680521;970.2092794372599;971.519098046468;711.9928800711979;712.4300559552337;712.5582139073756;712.5724565260854;712.6579241963834;13570.59288221355;13624;13671.726565468734;13701.383437745326;13720.519781807589;11567.24812887168;11858.229215101077;11924.582639607659;12056;12204.145709800317;9111.04334044929;9485;9554.378965367297;9848.90151098487;9892.95053524735;3399.847006884696;3441.346144232588;3459.5329630500064;3474.5830500339866;3480.460528618068;51183.488165118244;51602;51652.22521662178;52492.737536312074;53240.73379633116;8920;9007.909920900838;9061.13919177677;9138.954305228432;9357.766055848522;18428.815711842977;18677.81322186788;18690.81309186918;18692.34576789806;18775.34286299973;7605.771826845204;7636.961815191;7680.155182929873;7759.72840950564;8349.33205343571;3992.161646054303;4064.5122585289955;4108.075682971307;4119.649829764444;4220.599043090901;3231.2083539532964;3233.0785726067957;3246.3507298540385;3250.089974807058;3254.1376535218187;603.3785201242727;612.7334609444906;613.8649497110629;620.1782638004662;626.3767551286408;628.7767842415968;685.3968507713181;685.8285428642839;711.4557363616734;714.5998240984961;8616.396852220285;8696.73834838915;8742.08208138149;8772.605232764541;8997.01032886382;637.3690046853582;714.2107970692414;741.8516296740673;751.2487512487512;751.7368920877649;3849.8335691933653;3955.406688996616;3998.800059997047;4142.689298302639;4217.430646862635;55300.72349638226;55613.44386556163;55651.44348556543;55730.16404753932;55733.44266557364;51436.22845657318;52869.7356513215;53149.46850531445;53196;53481.465185348425;45194.32208516875;47571.524284757405;47736.761316193195;47986;48223.03553928902;8073.798155046171;8128.75613731589;8293.419460637697;8316.5425901576;8376.623051962555;36055.45916811198;36728;37113.814430927676;37288.44067339046;38031.619683802805;44202;45090.323645146;45537.77231113823;45651.315230270906;45733.54266457293;11276.830847537458;11356.432178391213;11376;12097.153199275966;12348.444320005441;12763.48946042185;13447.731045379232;13595.116317439335;13628.523001694894;13856.515021974183;11590;11710.70723231926;11996.700082498008;12022.338771367658;12203.877961220274;11251.7749645005;11282.887171128512;11948;12122.636320910387;12344.506219751109;10527.842082368923;10725.356478611307;10893.56425742993;11015.063719583924;11231.326120432474;10772.946135269274;10853.728656783644;10924.022184903999;10985.121190304917;11070.833937491105;10103.7474063149;10356.585736570452;10434.582616695247;10562.31344962575;10579.5239214234 09:30:20 INFO - PROCESS | 3358 | __end_tp_report 09:30:20 INFO - PROCESS | 3358 | __start_cc_report 09:30:20 INFO - PROCESS | 3358 | _x_x_mozilla_cycle_collect,894 09:30:20 INFO - PROCESS | 3358 | __end_cc_report 09:30:20 INFO - PROCESS | 3358 | __startTimestamp1461601820898__endTimestamp 09:30:20 INFO - PROCESS | 3358 | 09:30:20 INFO - PROCESS | 3358 | ------- Summary: start ------- 09:30:20 INFO - PROCESS | 3358 | Number of tests: 6 09:30:20 INFO - PROCESS | 3358 | 09:30:20 INFO - PROCESS | 3358 | [#0] dojo.html Cycles:165 Average:5495.32 Median:5717.14 stddev:599.99 (10.5%) stddev-sans-first:576.72 09:30:20 INFO - PROCESS | 3358 | Values: 3305.6 3354.9 3382.8 3387.5 3418.1 5484.7 5508.1 5509.3 5515.9 5528.0 5481.5 5504.4 5504.9 5509.5 5511.7 4904.2 4991.5 5005.6 5105.0 5109.9 4957.5 5060.1 5064.7 5065.1 5075.1 5044.3 5072.9 5139.7 5149.0 5173.2 5108.2 5123.2 5130.6 5132.9 5159.4 4909.5 4942.5 5044.6 5056.2 5078.2 5384.9 5399.7 5400.4 5407.3 5422.9 5800.4 5877.4 5976.5 5977.5 5977.7 5962.2 5975.9 5994.4 5999.3 6025.3 5585.7 5590.7 5592.2 5593.1 5593.9 5914.7 6055.8 6110.3 6120.2 6133.4 5744.7 5753.2 5755.2 5768.2 5782.5 5802.6 5814.5 5837.5 5851.9 5852.4 5796.8 5824.4 5881.8 5916.8 5962.1 5915.8 5927.7 5929.0 5929.8 5933.6 4468.7 4519.4 4519.8 4523.3 4551.0 3964.1 3969.6 3999.5 4033.9 4072.1 5579.4 5608.1 5614.1 5615.6 5642.3 5778.8 5933.1 5934.3 5936.3 5947.5 5634.9 5682.8 5711.3 5725.9 5732.2 5079.2 5081.0 5088.7 5090.0 5115.5 5938.8 6039.1 6059.6 6066.0 6071.2 5937.7 5959.1 5960.3 5964.6 5986.2 6062.0 6095.9 6096.1 6098.8 6100.3 5717.1 5802.8 5868.5 5877.1 5877.9 5908.4 5909.7 5918.6 5921.7 5923.0 5721.2 5725.6 5762.4 5790.1 5792.2 5605.0 5757.5 5786.4 5865.2 5888.6 5614.4 5621.8 5622.9 5623.0 5624.2 5759.5 5788.7 5796.4 5798.8 5800.1 5519.2 5567.3 5672.4 5765.2 5783.7 09:30:20 INFO - PROCESS | 3358 | 09:30:20 INFO - PROCESS | 3358 | [#1] ext.html Cycles:180 Average:42667.33 Median:20917.54 stddev:60540.21 (289.4%) stddev-sans-first:60627.45 09:30:20 INFO - PROCESS | 3358 | Values: 553.9 565.0 584.2 620.7 636.9 30369.0 31024.0 31052.4 38220.0 38302.4 41585.8 41701.0 42112.8 42117.8 42229.6 8608.5 8795.0 8812.3 8813.0 8814.2 8543.5 8632.7 8647.5 8667.0 8679.7 8716.3 8813.3 8815.7 9058.8 9069.1 8907.9 9010.4 9015.2 9015.4 9016.7 8898.0 9105.3 9139.2 9155.4 9159.2 41763.0 42314.8 42323.0 42323.6 42355.4 3597.3 3868.1 3985.1 4223.0 4412.5 32934.0 33091.0 33580.7 33664.8 33738.7 3587.1 3757.2 3780.9 3784.8 3886.3 283833.0 285791.0 287693.0 287736.0 288755.0 69170.7 69979.0 70146.0 70156.0 70185.6 74341.0 74439.3 75019.6 75238.0 75594.2 16967.9 17108.7 17159.5 17176.4 17262.4 13214.4 13216.6 13277.1 13290.0 13303.8 21688.1 22437.2 22480.4 22511.9 22513.0 7928.6 8206.0 8263.0 8282.8 8306.8 1035.4 1073.8 1100.7 1123.8 1140.2 29776.9 29986.9 30476.7 30567.0 30737.2 1095.5 1148.4 1159.6 1206.3 1263.4 15845.7 16490.1 17222.8 17726.4 17795.6 193750.0 194015.0 194105.0 194113.0 195549.0 60748.0 61268.6 61280.7 61314.7 61374.0 1302.8 1418.6 1438.6 1497.5 1505.0 28493.1 28609.7 28834.3 29172.9 29400.6 44587.8 45083.5 45216.0 45229.0 45276.1 202409.0 203741.0 204062.0 205571.0 205786.0 30638.2 34676.7 34770.8 35093.8 35186.5 40305.8 40591.4 41644.8 41679.4 43396.3 37236.3 37392.8 37659.8 38050.2 42912.4 38238.5 38460.2 39444.6 39494.6 40236.0 38374.8 39243.2 39289.2 39466.4 39535.0 33574.2 34929.5 35250.0 35375.8 35536.3 26775.7 26899.9 26999.7 27158.9 27249.6 09:30:20 INFO - PROCESS | 3358 | 09:30:20 INFO - PROCESS | 3358 | [#2] jquery.html Cycles:180 Average:25486.82 Median:21646.68 stddev:69770.76 (322.3%) stddev-sans-first:69940.98 09:30:20 INFO - PROCESS | 3358 | Values: 359.2 377.7 384.1 386.7 388.2 17370.9 17976.9 19010.9 19022.2 19031.0 17247.5 17871.6 18073.1 18083.8 18089.4 5549.3 5772.6 5806.7 5808.5 5816.0 4303.9 5574.4 6062.5 6324.2 6353.5 6264.7 6292.0 6292.2 6319.9 6320.2 6052.9 6291.2 6293.7 6296.6 6298.1 3933.5 5411.2 5606.4 5608.5 5611.1 21056.2 21076.5 21220.3 21644.4 21649.0 2374.8 2574.5 2625.6 2729.0 2773.3 13194.1 13280.8 13517.9 13553.5 13708.3 1696.1 1700.6 1745.1 1774.1 1812.9 67019.0 68868.3 68925.7 69090.3 69523.0 9965.3 10189.7 10445.9 10453.4 10596.6 14605.6 14626.3 14674.8 14679.3 14733.9 7950.9 8263.1 8320.3 8375.3 8376.8 8147.0 8149.5 8165.3 8247.9 8255.5 6175.9 6278.5 6289.5 6308.6 6324.0 1810.3 1846.1 1863.4 1910.0 1925.4 1003.9 1004.0 1066.2 1087.1 1092.1 15859.1 16104.4 16541.8 17320.2 17394.7 1064.3 1094.2 1097.2 1116.2 1193.3 10099.5 10215.6 10286.7 10327.7 10480.7 415507.0 419289.0 426684.0 433479.0 434168.0 69382.3 70081.3 70099.6 70913.6 72093.0 1096.5 1102.3 1102.8 1106.1 1118.1 15580.4 15589.2 15736.4 15763.8 15771.2 32134.7 32308.8 32506.5 33193.2 33239.7 43014.0 43646.0 45433.0 46315.8 51030.2 8419.8 8521.3 8625.1 8654.7 8798.0 10183.6 11961.5 12292.9 12820.9 13020.7 10582.4 10792.4 11177.6 11347.4 11547.0 5309.7 8393.7 10791.2 11322.5 11482.1 11559.1 11569.8 11806.4 11809.9 12014.9 8621.5 8756.0 8772.9 8915.5 8929.6 10757.4 11583.2 11779.7 11851.9 11895.8 09:30:20 INFO - PROCESS | 3358 | 09:30:20 INFO - PROCESS | 3358 | [#3] mootools.html Cycles:180 Average:5841.31 Median:6234.45 stddev:3047.35 (48.9%) stddev-sans-first:3037.85 09:30:20 INFO - PROCESS | 3358 | Values: 1428.9 1521.6 1539.3 1750.6 1885.7 7229.2 7846.1 8007.4 8012.1 8019.6 8075.2 8214.2 8240.3 8242.0 8245.2 2056.9 2368.6 2410.4 2444.0 2444.2 2440.4 2448.8 2449.2 2452.0 2454.9 2351.3 2404.1 2404.3 2404.8 2407.0 2363.9 2386.3 2398.9 2406.7 2407.4 2331.8 2337.3 2344.6 2378.2 2379.6 8420.9 8468.6 8483.1 8498.6 8502.6 5055.8 5158.7 5162.0 5170.2 5178.8 3205.4 3299.1 3302.6 3326.5 3385.4 1049.0 1053.5 1064.5 1069.4 1074.0 11716.0 11723.7 11734.1 11761.3 11766.4 4487.8 4527.8 4625.7 4636.0 4642.5 9996.1 10002.1 10003.5 10017.1 10025.6 4537.8 5106.4 5108.4 5113.2 5118.6 4169.1 4453.7 4498.3 4542.5 4557.7 3820.4 3893.2 3923.7 3936.7 3950.3 1277.6 1282.4 1284.9 1286.1 1290.3 1347.0 1374.5 1377.4 1448.4 1457.0 7777.3 7869.8 7896.3 7911.0 7918.3 1119.4 1139.5 1170.7 1195.1 1220.8 6145.3 6226.6 6242.3 6277.2 6277.5 9702.2 9975.3 9975.6 9982.2 9998.5 9595.1 9831.4 9837.1 9851.2 9851.6 7946.1 7969.7 7971.1 8077.1 8086.1 7740.8 7776.8 7823.1 7844.2 8045.7 9059.3 9249.6 9442.1 9487.5 9516.4 9251.3 9462.1 9585.3 9602.0 9660.1 6684.7 7161.5 7368.6 7547.2 7667.1 7926.6 7935.8 7948.8 7992.5 7992.6 7084.8 7236.6 7258.5 7362.1 7376.7 7059.6 7124.2 7216.6 7285.8 7322.6 7441.4 7472.9 7508.2 7509.4 7511.2 6799.0 6873.6 6882.1 6890.7 6897.1 6490.2 6581.8 6582.1 6583.9 6592.0 09:30:20 INFO - PROCESS | 3358 | 09:30:20 INFO - PROCESS | 3358 | [#4] prototype.html Cycles:180 Average:5443.01 Median:6115.83 stddev:1623.97 (26.6%) stddev-sans-first:1583.19 09:30:20 INFO - PROCESS | 3358 | Values: 365.9 370.8 372.1 372.2 375.5 6054.8 6090.9 6113.3 6123.8 6133.6 5992.3 6038.6 6039.5 6052.7 6067.8 4556.9 4600.5 4667.9 4723.5 4749.0 4698.1 4712.0 4746.6 4763.3 4775.5 4729.6 4733.8 4738.4 4740.9 4751.3 4513.5 4605.1 4652.5 4728.7 4749.9 4198.3 4201.5 4221.4 4223.9 4228.5 5795.0 5813.4 5827.5 5832.3 5834.9 5519.5 5530.6 5531.9 5535.3 5548.7 6416.2 6417.6 6417.8 6427.1 6434.3 4379.9 4525.9 4531.6 4539.0 4662.8 6635.0 6679.7 6702.4 6704.8 6706.9 4634.6 4660.6 4661.9 4667.9 4669.2 4724.7 4726.0 4735.9 4737.9 4744.5 5404.9 5429.6 5431.6 5434.9 5440.5 6328.1 6427.2 6440.5 6472.6 6483.1 1646.9 1661.3 1664.2 1666.2 1670.6 1038.8 1072.6 1093.1 1097.1 1120.5 5976.3 5996.1 6127.3 6224.6 6234.3 6619.6 6626.3 6655.2 6722.3 6733.1 6278.4 6288.4 6292.9 6306.3 6309.5 3574.1 3596.5 3605.8 3618.8 3626.8 6753.1 6856.7 6967.2 6969.1 6973.6 6862.0 6879.9 6893.4 6901.5 6922.7 6925.4 6933.3 6957.2 6970.8 6975.4 6728.5 6814.6 6824.0 6825.1 6829.2 6487.1 6625.1 6628.0 6643.9 6652.9 6869.6 6889.5 6895.8 6913.8 6930.1 4675.2 4745.0 4748.3 4748.5 4751.5 6741.8 6744.9 6751.8 6752.1 6752.2 6317.5 6541.9 6542.6 6549.2 6555.7 6479.0 6509.2 6521.5 6527.8 6532.1 6319.7 6340.2 6355.7 6419.5 6429.7 6553.4 6561.9 6564.5 6565.6 6569.0 6023.2 6118.4 6391.1 6404.3 6414.3 09:30:20 INFO - PROCESS | 3358 | 09:30:20 INFO - PROCESS | 3358 | [#5] yui.html Cycles:180 Average:14142.78 Median:46652.53 stddev:16303.45 (34.9%) stddev-sans-first:16318.10 09:30:20 INFO - PROCESS | 3358 | Values: 735.7 773.1 775.6 788.5 804.2 13883.9 14175.4 14202.5 14203.2 14210.4 12938.8 12959.9 14570.8 14923.3 15027.8 777.2 903.7 905.8 920.7 921.0 914.4 929.2 930.3 930.9 931.2 970.3 975.5 977.1 977.9 978.9 802.2 952.8 965.5 970.2 971.5 712.0 712.4 712.6 712.6 712.7 13570.6 13624.0 13671.7 13701.4 13720.5 11567.2 11858.2 11924.6 12056.0 12204.1 9111.0 9485.0 9554.4 9848.9 9893.0 3399.8 3441.3 3459.5 3474.6 3480.5 51183.5 51602.0 51652.2 52492.7 53240.7 8920.0 9007.9 9061.1 9139.0 9357.8 18428.8 18677.8 18690.8 18692.3 18775.3 7605.8 7637.0 7680.2 7759.7 8349.3 3992.2 4064.5 4108.1 4119.6 4220.6 3231.2 3233.1 3246.4 3250.1 3254.1 603.4 612.7 613.9 620.2 626.4 628.8 685.4 685.8 711.5 714.6 8616.4 8696.7 8742.1 8772.6 8997.0 637.4 714.2 741.9 751.2 751.7 3849.8 3955.4 3998.8 4142.7 4217.4 55300.7 55613.4 55651.4 55730.2 55733.4 51436.2 52869.7 53149.5 53196.0 53481.5 45194.3 47571.5 47736.8 47986.0 48223.0 8073.8 8128.8 8293.4 8316.5 8376.6 36055.5 36728.0 37113.8 37288.4 38031.6 44202.0 45090.3 45537.8 45651.3 45733.5 11276.8 11356.4 11376.0 12097.2 12348.4 12763.5 13447.7 13595.1 13628.5 13856.5 11590.0 11710.7 11996.7 12022.3 12203.9 11251.8 11282.9 11948.0 12122.6 12344.5 10527.8 10725.4 10893.6 11015.1 11231.3 10772.9 10853.7 10924.0 10985.1 11070.8 10103.7 10356.6 10434.6 10562.3 10579.5 09:30:20 INFO - PROCESS | 3358 | -------- Summary: end -------- 09:30:20 INFO - PROCESS | 3358 | 09:30:21 INFO - TEST-INFO | 3358: exit 0 09:30:21 INFO - TEST-OK | dromaeo_css | took 1112066ms 09:30:21 INFO - TEST-START | kraken 09:30:21 INFO - operating with platform_type : linux_ 09:30:21 INFO - Initialising browser for kraken test... 09:30:21 INFO - TEST-INFO | started process 3556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtViQi/profile http://localhost:58825/getInfo.html) 09:30:25 INFO - PROCESS | 3556 | __metrics Screen width/height:1600/1200 09:30:25 INFO - PROCESS | 3556 | colorDepth:24 09:30:25 INFO - PROCESS | 3556 | Browser inner width/height: 1024/697 09:30:25 INFO - PROCESS | 3556 | __metrics 09:30:25 INFO - PROCESS | 3556 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:30:26 INFO - TEST-INFO | 3556: exit 0 09:30:26 INFO - Browser initialized. 09:30:26 INFO - Running cycle 1/1 for kraken test... 09:30:26 INFO - TEST-INFO | started process 3646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmtViQi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:38 INFO - PROCESS | 3646 | RSS: Main: 141279232 09:30:38 INFO - PROCESS | 3646 | 09:30:40 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58825/tests/kraken/driver.html?testName=audio-beat-detection) 09:30:41 INFO - PROCESS | 3646 | RSS: Main: 177668096 09:30:41 INFO - PROCESS | 3646 | 09:30:44 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58825/tests/kraken/driver.html?testName=audio-dft) 09:30:44 INFO - PROCESS | 3646 | RSS: Main: 175788032 09:30:44 INFO - PROCESS | 3646 | 09:30:47 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58825/tests/kraken/driver.html?testName=audio-fft) 09:30:48 INFO - PROCESS | 3646 | RSS: Main: 173629440 09:30:48 INFO - PROCESS | 3646 | 09:30:50 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58825/tests/kraken/driver.html?testName=audio-oscillator) 09:30:50 INFO - PROCESS | 3646 | RSS: Main: 174755840 09:30:50 INFO - PROCESS | 3646 | 09:30:52 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58825/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:30:53 INFO - PROCESS | 3646 | RSS: Main: 171667456 09:30:53 INFO - PROCESS | 3646 | 09:30:56 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58825/tests/kraken/driver.html?testName=imaging-darkroom) 09:30:57 INFO - PROCESS | 3646 | RSS: Main: 171982848 09:30:57 INFO - PROCESS | 3646 | 09:31:00 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58825/tests/kraken/driver.html?testName=imaging-desaturate) 09:31:01 INFO - PROCESS | 3646 | RSS: Main: 172404736 09:31:01 INFO - PROCESS | 3646 | 09:31:03 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58825/tests/kraken/driver.html?testName=json-parse-financial) 09:31:04 INFO - PROCESS | 3646 | RSS: Main: 172650496 09:31:04 INFO - PROCESS | 3646 | 09:31:06 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58825/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:31:06 INFO - PROCESS | 3646 | RSS: Main: 176713728 09:31:06 INFO - PROCESS | 3646 | 09:31:08 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58825/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:31:08 INFO - PROCESS | 3646 | RSS: Main: 174620672 09:31:08 INFO - PROCESS | 3646 | 09:31:10 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58825/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:31:11 INFO - PROCESS | 3646 | RSS: Main: 181112832 09:31:11 INFO - PROCESS | 3646 | 09:31:13 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58825/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:31:14 INFO - PROCESS | 3646 | RSS: Main: 185552896 09:31:14 INFO - PROCESS | 3646 | 09:31:16 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58825/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:31:17 INFO - PROCESS | 3646 | RSS: Main: 185503744 09:31:17 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | Cycle 1(1): loaded http://localhost:58825/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58825/tests/kraken/driver.html?testName=ai-astar) 09:31:19 INFO - PROCESS | 3646 | RSS: Main: 247939072 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | __start_tp_report 09:31:19 INFO - PROCESS | 3646 | _x_x_mozilla_page_load 09:31:19 INFO - PROCESS | 3646 | _x_x_mozilla_page_load_details 09:31:19 INFO - PROCESS | 3646 | |i|pagename|runs| 09:31:19 INFO - PROCESS | 3646 | |0;ai-astar;109;110;106;110;110;112;101;109;110;111 09:31:19 INFO - PROCESS | 3646 | |1;audio-beat-detection;154;133;158;170;133;172;162;128;175;138 09:31:19 INFO - PROCESS | 3646 | |2;audio-dft;160;162;162;161;161;160;159;163;161;160 09:31:19 INFO - PROCESS | 3646 | |3;audio-fft;75;77;75;166;77;76;76;76;165;74 09:31:19 INFO - PROCESS | 3646 | |4;audio-oscillator;92;93;143;92;93;93;144;93;91;134 09:31:19 INFO - PROCESS | 3646 | |5;imaging-gaussian-blur;117;116;117;117;116;117;116;117;117;117 09:31:19 INFO - PROCESS | 3646 | |6;imaging-darkroom;146;145;146;145;146;145;146;146;146;147 09:31:19 INFO - PROCESS | 3646 | |7;imaging-desaturate;95;95;98;96;95;96;95;95;96;95 09:31:19 INFO - PROCESS | 3646 | |8;json-parse-financial;56;55;56;55;56;57;60;66;58;56 09:31:19 INFO - PROCESS | 3646 | |9;json-stringify-tinderbox;63;63;63;64;63;64;63;63;63;64 09:31:19 INFO - PROCESS | 3646 | |10;stanford-crypto-aes;78;77;80;79;77;78;78;79;78;78 09:31:19 INFO - PROCESS | 3646 | |11;stanford-crypto-ccm;114;113;127;111;112;118;115;116;112;112 09:31:19 INFO - PROCESS | 3646 | |12;stanford-crypto-pbkdf2;150;136;160;145;146;136;146;144;157;143 09:31:19 INFO - PROCESS | 3646 | |13;stanford-crypto-sha256-iterative;70;65;67;68;65;66;66;68;65;65 09:31:19 INFO - PROCESS | 3646 | __end_tp_report 09:31:19 INFO - PROCESS | 3646 | __start_cc_report 09:31:19 INFO - PROCESS | 3646 | _x_x_mozilla_cycle_collect,1060 09:31:19 INFO - PROCESS | 3646 | __end_cc_report 09:31:19 INFO - PROCESS | 3646 | __startTimestamp1461601879496__endTimestamp 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | ------- Summary: start ------- 09:31:19 INFO - PROCESS | 3646 | Number of tests: 14 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.16 (2.9%) stddev-sans-first:3.35 09:31:19 INFO - PROCESS | 3646 | Values: 109.0 110.0 106.0 110.0 110.0 112.0 101.0 109.0 110.0 111.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:160.00 stddev:17.91 (11.2%) stddev-sans-first:18.98 09:31:19 INFO - PROCESS | 3646 | Values: 154.0 133.0 158.0 170.0 133.0 172.0 162.0 128.0 175.0 138.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 09:31:19 INFO - PROCESS | 3646 | Values: 160.0 162.0 162.0 161.0 161.0 160.0 159.0 163.0 161.0 160.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:37.85 (49.8%) stddev-sans-first:39.54 09:31:19 INFO - PROCESS | 3646 | Values: 75.0 77.0 75.0 166.0 77.0 76.0 76.0 76.0 165.0 74.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:92.50 stddev:23.29 (25.2%) stddev-sans-first:24.08 09:31:19 INFO - PROCESS | 3646 | Values: 92.0 93.0 143.0 92.0 93.0 93.0 144.0 93.0 91.0 134.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:31:19 INFO - PROCESS | 3646 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:31:19 INFO - PROCESS | 3646 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 147.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 09:31:19 INFO - PROCESS | 3646 | Values: 95.0 95.0 98.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.50 stddev:3.34 (5.9%) stddev-sans-first:3.50 09:31:19 INFO - PROCESS | 3646 | Values: 56.0 55.0 56.0 55.0 56.0 57.0 60.0 66.0 58.0 56.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 09:31:19 INFO - PROCESS | 3646 | Values: 63.0 63.0 63.0 64.0 63.0 64.0 63.0 63.0 63.0 64.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:0.92 (1.2%) stddev-sans-first:0.97 09:31:19 INFO - PROCESS | 3646 | Values: 78.0 77.0 80.0 79.0 77.0 78.0 78.0 79.0 78.0 78.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:114.50 stddev:4.74 (4.1%) stddev-sans-first:5.01 09:31:19 INFO - PROCESS | 3646 | Values: 114.0 113.0 127.0 111.0 112.0 118.0 115.0 116.0 112.0 112.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:146.00 stddev:7.79 (5.3%) stddev-sans-first:8.15 09:31:19 INFO - PROCESS | 3646 | Values: 150.0 136.0 160.0 145.0 146.0 136.0 146.0 144.0 157.0 143.0 09:31:19 INFO - PROCESS | 3646 | 09:31:19 INFO - PROCESS | 3646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.72 (2.6%) stddev-sans-first:1.27 09:31:19 INFO - PROCESS | 3646 | Values: 70.0 65.0 67.0 68.0 65.0 66.0 66.0 68.0 65.0 65.0 09:31:19 INFO - PROCESS | 3646 | -------- Summary: end -------- 09:31:19 INFO - PROCESS | 3646 | 09:31:20 INFO - TEST-INFO | 3646: exit 0 09:31:20 INFO - TEST-OK | kraken | took 58922ms 09:31:20 INFO - SUITE-END | took 1170s 09:31:20 INFO - Completed test suite (00:19:31) 09:31:20 INFO - javascript benchmark 09:31:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3305.570275864138, 3354.9329013419747, 3382.7801192922443, 3387.491876218567, 3418.111291064324, 5484.725763711814, 5508.118701007839, 5509.256250406194, 5515.862103447415, 5528.0, 5481.451854814517, 5504.394516603171, 5504.944950550504, 5509.47659972303, 5511.724413779305, 4904.190808516591, 4991.500849915015, 5005.649604527694, 5105.030044291572, 5109.923351149717, 4957.529034741694, 5060.11447996601, 5064.670796398223, 5065.062963351773, 5075.086484432801, 5044.344235249431, 5072.923906141411, 5139.6659217150955, 5149.047426226141, 5173.249878767577, 5108.20822772469, 5123.154679477919, 5130.615203859688, 5132.923006154911, 5159.380874295109, 4909.509049095098, 4942.456329803718, 5044.621653375974, 5056.165732654108, 5078.238264260353, 5384.946150538483, 5399.7030163341, 5400.351957765054, 5407.270018547485, 5422.891542169174, 5800.4489573490455, 5877.353491115974, 5976.491998180117, 5977.491913187384, 5977.731002104916, 5962.165296858443, 5975.910361344583, 5994.37059108796, 5999.250093738283, 6025.3372129065765, 5585.748641311151, 5590.720463976825, 5592.217089607459, 5593.105103183471, 5593.916091258634, 5914.704264786744, 6055.848603784941, 6110.26676798787, 6120.1737765401995, 6133.3866613339205, 5744.712764361765, 5753.194552762617, 5755.194272801811, 5768.192453056576, 5782.537397008314, 5802.593818432753, 5814.476697097281, 5837.474627283565, 5851.882962340729, 5852.356240813507, 5796.82609521715, 5824.417558244142, 5881.794137205177, 5916.763329466859, 5962.07587823888, 5915.822525324247, 5927.673977931255, 5928.970355148197, 5929.792457264061, 5933.614315069507, 4468.709533880287, 4519.41247637805, 4519.751413672279, 4523.253663145544, 4551.044280701024, 3964.088259700285, 3969.6030396960073, 3999.4800675911947, 4033.858814941463, 4072.1244932339096, 5579.414161512983, 5608.130739735348, 5614.073677843192, 5615.606907516516, 5642.294713160855, 5778.7688492460675, 5933.139694744238, 5934.287885453773, 5936.287645482484, 5947.494462970696, 5634.943650563524, 5682.829515114553, 5711.257536520309, 5725.885482290331, 5732.226149469851, 5079.238114282887, 5081.0, 5088.745562721849, 5089.9565589054155, 5115.488451154854, 5938.792142275086, 6039.124326972565, 6059.636421814617, 6066.029435290332, 6071.180390647206, 5937.732802023833, 5959.0763431668165, 5960.314563825215, 5964.582479226413, 5986.161937328865, 6062.030075187949, 6095.908561371494, 6096.1465394845645, 6098.847528811815, 6100.328963813889, 5717.142428635738, 5802.82591522255, 5868.501177399969, 5877.089051197071, 5877.911831322448, 5908.379620139824, 5909.70451477433, 5918.585699001029, 5921.674307912934, 5923.022701254245, 5721.227634269487, 5725.627834190765, 5762.423757624204, 5790.10253410722, 5792.160136780228, 5605.047141985954, 5757.481826635623, 5786.42135786418, 5865.178874957594, 5888.558358123072, 5614.382417933943, 5621.775128994795, 5622.88754224905, 5623.0, 5624.184493248538, 5759.481646651821, 5788.681622510802, 5796.391378905154, 5798.82603521895, 5800.1299805029585, 5519.227308176939, 5567.331920169606, 5672.376038635829, 5765.1928729977, 5783.652980821164], "unit": "score", "name": "dojo.html", "value": 5457.016428889997}, {"lowerIsBetter": false, "replicates": [553.8753780399411, 565.0422533805202, 584.1996464843165, 620.7113692133157, 636.9426751592356, 30369.0, 31024.0, 31052.378952420968, 38220.04449888754, 38302.425463618, 41585.7920710396, 41701.0, 42112.78943605285, 42117.78941105298, 42229.577704222946, 8608.483490990546, 8794.956025219897, 8812.339074569401, 8812.955935220314, 8814.206721395074, 8543.487390756543, 8632.741017769446, 8647.524386158759, 8667.0, 8679.65281388747, 8716.25911797498, 8813.338999575026, 8815.735527934172, 9058.773530661752, 9069.093090690943, 8907.910920890805, 9010.414323068979, 9015.233705135071, 9015.36892417531, 9016.68441604544, 8898.0, 9105.317101217435, 9139.177474027303, 9155.359124861263, 9159.221466175382, 41763.0, 42314.78842605798, 42323.0, 42323.57676423227, 42355.36466952998, 3597.2625611749527, 3868.0909986153233, 3985.143194213258, 4222.98648324403, 4412.514623391425, 32934.0, 33091.0, 33580.66419335824, 33664.831675841706, 33738.662613373795, 3587.1032241939515, 3757.1922036762226, 3780.867669631577, 3784.848606055782, 3886.261610294035, 283833.0, 285791.0, 287693.0, 287736.0, 288755.0, 69170.65414672895, 69979.0, 70146.0, 70156.0, 70185.64907175432, 74341.0, 74439.25560744324, 75019.62490187623, 75238.0, 75594.24405755872, 16967.91516042412, 17108.74336884948, 17159.485215443558, 17176.39882604103, 17262.395816146374, 13214.405351759195, 13216.603501894959, 13277.070605057554, 13290.0, 13303.800442993363, 21688.132474700837, 22437.21469748551, 22480.43798905008, 22511.88744056302, 22513.0, 7928.563928983961, 8206.0, 8262.958685206535, 8282.792930176794, 8306.792330191673, 1035.3529044347283, 1073.7798751255973, 1100.7303210713426, 1123.842662027317, 1140.2189500192228, 29776.85111574428, 29986.85006574953, 30476.695233047387, 30567.0, 30737.2315692105, 1095.457748414524, 1148.4143087025677, 1159.5825502818977, 1206.2702065250573, 1263.406199086428, 15845.68308633821, 16490.093044882648, 17222.827771722372, 17726.37957671501, 17795.555111122325, 193750.0, 194015.0, 194105.0, 194113.0, 195549.0, 60748.0, 61268.630225338035, 61280.69359653173, 61314.69342653347, 61374.0, 1302.772014897408, 1418.6240646228757, 1438.6187660269827, 1497.475883440787, 1505.0442968714945, 28493.145205643865, 28609.713902860705, 28834.27914302159, 29172.854135729187, 29400.558991614715, 44587.77706111449, 45083.54916450794, 45216.0, 45229.0, 45276.094478110914, 202409.0, 203741.0, 204062.0, 205571.0, 205786.0, 30638.234044149074, 34676.65323346835, 34770.82614586911, 35093.82453087718, 35186.47220291749, 40305.79847100746, 40591.39112913368, 41644.791776040925, 41679.374809377274, 43396.349054763574, 37236.25527489381, 37392.81303593465, 37659.81170094132, 38050.238995219384, 42912.38526166838, 38238.52154181518, 38460.23079538337, 39444.60555394524, 39494.60505395024, 40236.0, 38374.80812595919, 39243.2151356977, 39289.2142157161, 39466.40800387939, 39535.0, 33574.160645983065, 34929.47605785966, 35250.0, 35375.82312088526, 35536.28927421489, 26775.732242678103, 26899.86550067237, 26999.730002700508, 27158.864205678845, 27249.59125613157], "unit": "score", "name": "ext.html", "value": 19161.688122943942}, {"lowerIsBetter": false, "replicates": [359.2419993813054, 377.74502211007564, 384.05522414859445, 386.7157639135235, 388.1848118950205, 17370.91314543427, 17976.91011544942, 19010.904945475253, 19022.239110435567, 19031.0, 17247.482575522725, 17871.553211169696, 18073.096345182723, 18083.819161808377, 18089.366872159444, 5549.334079910416, 5772.624779389326, 5806.738696758656, 5808.506276966442, 5815.970920145414, 4303.870883873489, 5574.414686457904, 6062.514998800086, 6324.241091069055, 6353.459955903731, 6264.686765661721, 6291.968540157316, 6292.150559674431, 6319.873602527947, 6320.241571011462, 6052.909206361886, 6291.182146320972, 6293.653849038301, 6296.622202667854, 6298.086777417295, 3933.5476420211758, 5411.188321751769, 5606.439356064402, 5608.467195616451, 5611.0741727614895, 21056.157753689833, 21076.473088172766, 21220.25729099474, 21644.35066947994, 21649.0, 2374.798142157919, 2574.472233192191, 2625.5799072148557, 2728.9727102728916, 2773.334399744067, 13194.142380745221, 13280.800787988188, 13517.864821351759, 13553.525626603121, 13708.314584270747, 1696.1053859999615, 1700.5663555793317, 1745.1361576019951, 1774.1306759687789, 1812.9184186711498, 67019.0, 68868.31131688668, 68925.65537172282, 69090.3090969089, 69523.0, 9965.302428829913, 10189.745256368502, 10445.895541044645, 10453.372797632166, 10596.629117980834, 14605.561833145022, 14626.341814618156, 14674.779878301833, 14679.266036698122, 14733.852661473462, 7950.880736788953, 8263.091059983397, 8320.292775114061, 8375.288100511525, 8376.832463350698, 8147.00796609657, 8149.511029338259, 8165.346772258205, 8247.917520824834, 8255.463394879434, 6175.876482470415, 6278.497720182374, 6289.465395441439, 6308.58994165387, 6324.0, 1810.3120814090826, 1846.1323178106268, 1863.41302489718, 1909.9522511937312, 1925.3935010471657, 1003.9046290602527, 1003.9899601004042, 1066.1843689577324, 1087.1357270969597, 1092.0662833277593, 15859.127747973742, 16104.355825767072, 16541.83458165427, 17320.220590073226, 17394.739078913826, 1064.3347907557777, 1094.2231015978584, 1097.1825989637612, 1116.2465335898237, 1193.3496244546743, 10099.545520451597, 10215.591376344863, 10286.691399258034, 10327.741806454898, 10480.68557943263, 415507.0, 419289.0, 426684.0, 433479.0, 434168.0, 69382.3061769386, 70081.2991870085, 70099.64950175319, 70913.64543177355, 72093.0, 1096.5120521367915, 1102.2669924500117, 1102.8235482322789, 1106.1206340958956, 1118.1390329446444, 15580.376784928476, 15589.220538973233, 15736.449224277554, 15763.842361576697, 15771.211439427752, 32134.67865321317, 32308.83845580757, 32506.51240231351, 33193.17017074496, 33239.66760332366, 43014.0, 43646.0, 45433.0, 46315.76842115768, 51030.23454648258, 8419.83160336802, 8521.318294536546, 8625.094365091574, 8654.740357789024, 8797.956010219908, 10183.643572474928, 11961.461734221806, 12292.877071229173, 12820.935895320463, 13020.739585208432, 10582.417967011888, 10792.352458852494, 11177.608783692533, 11347.37589432589, 11547.018503426967, 5309.707966061749, 8393.748187554384, 10791.165501864858, 11322.490487928228, 11482.081433485468, 11559.133065019989, 11569.768604628029, 11806.350650714294, 11809.940950295193, 12014.879851201726, 8621.482711037357, 8756.0, 8772.868406973774, 8915.465072095694, 8929.598168082583, 10757.432295100858, 11583.247088939192, 11779.705507362385, 11851.940740296242, 11895.82156267674], "unit": "score", "name": "jquery.html", "value": 8954.912536206306}, {"lowerIsBetter": false, "replicates": [1428.8785453236474, 1521.5511424129882, 1539.3446305123664, 1750.5798608333996, 1885.65115453641, 7229.2047874733735, 7846.13692493826, 8007.39944504163, 8012.078610959741, 8019.599020048996, 8075.232852878967, 8214.219649133323, 8240.299574536171, 8241.958790206056, 8245.175482451752, 2056.928007519737, 2368.5973384524673, 2410.433548116191, 2444.046821739523, 2444.181199298237, 2440.365504968703, 2448.8040956723507, 2449.1672831237374, 2451.9754802452017, 2454.9386265343333, 2351.271105957159, 2404.146527982567, 2404.2546810488716, 2404.75952404759, 2406.9638955415685, 2363.8936247868887, 2386.284114765572, 2398.940026499334, 2406.7352591214953, 2407.4101845048076, 2331.825113116523, 2337.2520793346134, 2344.6131388320905, 2378.21518898763, 2379.5716770981217, 8420.873686894702, 8468.618912148968, 8483.109273526314, 8498.617562209716, 8502.574871256413, 5055.823046193365, 5158.716270605115, 5161.974190129063, 5170.1986192140275, 5178.844634660966, 3205.406999705062, 3299.109240505074, 3302.5706658134527, 3326.501024846268, 3385.3567822113964, 1049.0, 1053.5417093564324, 1064.542246833861, 1069.3530414099514, 1073.9892601073968, 11716.0, 11723.7069073273, 11734.061275098056, 11761.294322340602, 11766.352850593214, 4487.775611219426, 4527.796249168795, 4625.699329543569, 4635.976820115878, 4642.489326174118, 9996.100350968447, 10002.149817265614, 10003.499825008721, 10017.14854237398, 10025.649102281384, 4537.750423726727, 5106.4382917879, 5108.412532558729, 5113.207452844815, 5118.59051275897, 4169.145325208325, 4453.710508816916, 4498.257787465097, 4542.477615074243, 4557.6581756368405, 3820.3887378019385, 3893.2213557288087, 3923.725339226227, 3936.724429289922, 3950.3481925481974, 1277.572013375511, 1282.410091357967, 1284.9229046257067, 1286.0611753420055, 1290.270996886756, 1346.9528566500126, 1374.5051781358702, 1377.373295150704, 1448.3844366144347, 1456.9708605828037, 7777.261160189773, 7869.842603147905, 7896.289333959856, 7911.0, 7918.28735413804, 1119.4234968990977, 1139.5441823270592, 1170.6546568762235, 1195.1335281920537, 1220.8107743299802, 6145.324014358417, 6226.5641405102115, 6242.344553821874, 6277.1525844010475, 6277.529185311028, 9702.223822094216, 9975.25185611082, 9975.600975961026, 9982.151517120981, 9998.450085245237, 9595.088466595662, 9831.410115393099, 9837.114659680663, 9851.16265117473, 9851.605935762633, 7946.086200086948, 7969.721059762996, 7971.083325417535, 8077.071136819341, 8086.110527841933, 7740.7677769667, 7776.766696999099, 7823.139454660097, 7844.21557844211, 8045.678172873254, 9059.275257979214, 9249.583768730557, 9442.10300021497, 9487.525623718648, 9516.429014259167, 9251.259899207913, 9462.101100395452, 9585.329026968324, 9602.0, 9660.130588247092, 6684.699188536625, 7161.4986950912935, 7368.631568421664, 7547.207543208104, 7667.118281397487, 7926.564038977681, 7935.761927142195, 7948.801279968047, 7992.480488768211, 7992.600369981594, 7084.822879428056, 7236.638168091679, 7258.528195667264, 7362.079740032496, 7376.7418140364825, 7059.5764254144915, 7124.21633620291, 7216.639168041472, 7285.7814265572115, 7322.597257150908, 7441.441891858024, 7472.925270747223, 7508.174100849012, 7509.4367922404945, 7511.211322811027, 6799.0, 6873.5875847449315, 6882.105326307748, 6890.655467226518, 6897.137857767779, 6490.221173459215, 6581.769638062645, 6582.144321238208, 6583.868322633616, 6591.967040164768], "unit": "score", "name": "mootools.html", "value": 4799.167102980632}, {"lowerIsBetter": false, "replicates": [365.92965575691113, 370.7997681252123, 372.0586915104785, 372.170060764495, 375.54746530430833, 6054.818355449338, 6090.908636370453, 6113.296970848353, 6123.755049798003, 6133.570650054504, 5992.34084250732, 6038.637681739098, 6039.547033972448, 6052.727627256784, 6067.848303792407, 4556.931646025312, 4600.539946005406, 4667.929981050287, 4723.527647235283, 4749.0, 4698.060387922412, 4711.9764401177945, 4746.620270378378, 4763.26169443735, 4775.474697783258, 4729.55069268419, 4733.810647574093, 4738.431388233417, 4740.90518189636, 4751.263554149113, 4513.548645135493, 4605.0559635274685, 4652.464966528859, 4728.69263497875, 4749.905001899977, 4198.307279298942, 4201.4538110045805, 4221.430106935555, 4223.894402639928, 4228.471441069866, 5795.0, 5813.360530341659, 5827.4755272025295, 5832.329282132524, 5834.883302333972, 5519.475649813261, 5530.5852061095175, 5531.861703457445, 5535.308086489189, 5548.667079975215, 6416.230052393743, 6417.550771446001, 6417.807465776034, 6427.132337134473, 6434.292227854932, 4379.912401751979, 4525.909481810379, 4531.56950089741, 4539.024109816405, 4662.790174442124, 6635.0, 6679.666016699194, 6702.396784289389, 6704.83237919051, 6706.899396509105, 4634.606058485067, 4660.580547750651, 4661.86014419568, 4667.906641867144, 4669.18289299378, 4724.740139292303, 4725.9527404726205, 4735.857924262277, 4737.857864264078, 4744.454387745384, 5404.918926216032, 5429.647072940246, 5431.619786614978, 5434.91847622286, 5440.537554307849, 6328.050792381179, 6427.196600424947, 6440.516961227927, 6472.579282346633, 6483.059956306309, 1646.876484263685, 1661.2773443552094, 1664.217817625714, 1666.1585899120867, 1670.599056226497, 1038.8078205532001, 1072.6245813965206, 1093.0872721277822, 1097.078454098561, 1120.4621781544904, 5976.282846058501, 5996.13056106862, 6127.264728232641, 6224.595401298901, 6234.314225435199, 6619.635920024445, 6626.271110177877, 6655.234648015444, 6722.327767223336, 6733.124693789874, 6278.372162783777, 6288.402601752918, 6292.874142517124, 6306.337834527309, 6309.526785491106, 3574.1064733816547, 3596.478510615946, 3605.837737301828, 3618.8371523281517, 3626.818659067036, 6753.08833307507, 6856.691448884812, 6967.163940327193, 6969.05917701114, 6973.6164510952385, 6861.965690171617, 6879.931200687929, 6893.448524118058, 6901.482388820858, 6922.688479018456, 6925.376716095576, 6933.2720064393525, 6957.199922008933, 6970.825729356807, 6975.407090397373, 6728.5197256605425, 6814.62519561409, 6824.010518474893, 6825.078614386995, 6829.1804983400325, 6487.124238227779, 6625.072489851328, 6628.005799129976, 6643.900341494785, 6652.933470665232, 6869.626074784963, 6889.517733758589, 6895.827604309932, 6913.75801846933, 6930.099087118642, 4675.158471475167, 4744.976275118603, 4748.287756836502, 4748.453927798348, 4751.453582838018, 6741.797746067626, 6744.898826517508, 6751.750926078691, 6752.054712340178, 6752.223494298219, 6317.526185536195, 6541.901871472027, 6542.574732642363, 6549.181352330958, 6555.70499327541, 6479.0, 6509.218893732593, 6521.5108866834225, 6527.804165875032, 6532.05285233629, 6319.652419116993, 6340.239171299474, 6355.682215889095, 6419.45434638061, 6429.7106630200815, 6553.442957348679, 6561.934380656132, 6564.540482166202, 6565.638889860912, 6569.0, 6023.186869772525, 6118.357572454828, 6391.105245265573, 6404.295527491879, 6414.262359828679], "unit": "score", "name": "prototype.html", "value": 4921.518405022221}, {"lowerIsBetter": false, "replicates": [735.6726256815716, 773.0993392697508, 775.5928137727695, 788.4756636836504, 804.1877703519443, 13883.861161388382, 14175.432982680693, 14202.502912398068, 14203.153590033282, 14210.360533775978, 12938.805917911239, 12959.93520032401, 14570.781438278407, 14923.328450219738, 15027.849721502782, 777.183956845313, 903.6927444668811, 905.7735566108456, 920.7375897869109, 920.9907900920972, 914.3736540469799, 929.1730359979623, 930.3394589841221, 930.8929473110577, 931.1898648176096, 970.3353203055894, 975.4829940131741, 977.0522593084696, 977.907098825614, 978.8776402949632, 802.2218448105328, 952.7570469530294, 965.4593427680521, 970.2092794372599, 971.519098046468, 711.9928800711979, 712.4300559552337, 712.5582139073756, 712.5724565260854, 712.6579241963834, 13570.59288221355, 13624.0, 13671.726565468734, 13701.383437745326, 13720.519781807589, 11567.24812887168, 11858.229215101077, 11924.582639607659, 12056.0, 12204.145709800317, 9111.04334044929, 9485.0, 9554.378965367297, 9848.90151098487, 9892.95053524735, 3399.847006884696, 3441.346144232588, 3459.5329630500064, 3474.5830500339866, 3480.460528618068, 51183.488165118244, 51602.0, 51652.22521662178, 52492.737536312074, 53240.73379633116, 8920.0, 9007.909920900838, 9061.13919177677, 9138.954305228432, 9357.766055848522, 18428.815711842977, 18677.81322186788, 18690.81309186918, 18692.34576789806, 18775.34286299973, 7605.771826845204, 7636.961815191, 7680.155182929873, 7759.72840950564, 8349.33205343571, 3992.161646054303, 4064.5122585289955, 4108.075682971307, 4119.649829764444, 4220.599043090901, 3231.2083539532964, 3233.0785726067957, 3246.3507298540385, 3250.089974807058, 3254.1376535218187, 603.3785201242727, 612.7334609444906, 613.8649497110629, 620.1782638004662, 626.3767551286408, 628.7767842415968, 685.3968507713181, 685.8285428642839, 711.4557363616734, 714.5998240984961, 8616.396852220285, 8696.73834838915, 8742.08208138149, 8772.605232764541, 8997.01032886382, 637.3690046853582, 714.2107970692414, 741.8516296740673, 751.2487512487512, 751.7368920877649, 3849.8335691933653, 3955.406688996616, 3998.800059997047, 4142.689298302639, 4217.430646862635, 55300.72349638226, 55613.44386556163, 55651.44348556543, 55730.16404753932, 55733.44266557364, 51436.22845657318, 52869.7356513215, 53149.46850531445, 53196.0, 53481.465185348425, 45194.32208516875, 47571.524284757405, 47736.761316193195, 47986.0, 48223.03553928902, 8073.798155046171, 8128.75613731589, 8293.419460637697, 8316.5425901576, 8376.623051962555, 36055.45916811198, 36728.0, 37113.814430927676, 37288.44067339046, 38031.619683802805, 44202.0, 45090.323645146, 45537.77231113823, 45651.315230270906, 45733.54266457293, 11276.830847537458, 11356.432178391213, 11376.0, 12097.153199275966, 12348.444320005441, 12763.48946042185, 13447.731045379232, 13595.116317439335, 13628.523001694894, 13856.515021974183, 11590.0, 11710.70723231926, 11996.700082498008, 12022.338771367658, 12203.877961220274, 11251.7749645005, 11282.887171128512, 11948.0, 12122.636320910387, 12344.506219751109, 10527.842082368923, 10725.356478611307, 10893.56425742993, 11015.063719583924, 11231.326120432474, 10772.946135269274, 10853.728656783644, 10924.022184903999, 10985.121190304917, 11070.833937491105, 10103.7474063149, 10356.585736570452, 10434.582616695247, 10562.31344962575, 10579.5239214234], "unit": "score", "name": "yui.html", "value": 6540.303414464574}], "name": "dromaeo_css", "value": 7245.331291083318}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 110.0, 110.0, 112.0, 101.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [154.0, 133.0, 158.0, 170.0, 133.0, 172.0, 162.0, 128.0, 175.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 152.3}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 162.0, 161.0, 161.0, 160.0, 159.0, 163.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 75.0, 166.0, 77.0, 76.0, 76.0, 76.0, 165.0, 74.0], "unit": "score", "name": "audio-fft", "value": 93.7}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 143.0, 92.0, 93.0, 93.0, 144.0, 93.0, 91.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 98.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 55.0, 56.0, 57.0, 60.0, 66.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.3}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 80.0, 79.0, 77.0, 78.0, 78.0, 79.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.2}, {"lowerIsBetter": true, "replicates": [114.0, 113.0, 127.0, 111.0, 112.0, 118.0, 115.0, 116.0, 112.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.0}, {"lowerIsBetter": true, "replicates": [150.0, 136.0, 160.0, 145.0, 146.0, 136.0, 146.0, 144.0, 157.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [70.0, 65.0, 67.0, 68.0, 65.0, 66.0, 66.0, 68.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1507.3999999999999}]} 09:31:20 INFO - Return code: 0 09:31:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:31:20 INFO - # TBPL SUCCESS # 09:31:20 INFO - Running post-action listener: _resource_record_post_action 09:31:20 INFO - Running post-run listener: _resource_record_post_run 09:31:21 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8073216; Write bytes: 381988864; Read time: 1636; Write time: 326220 09:31:21 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 4988928; Read time: 0; Write time: 376 09:31:21 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 6311936; Write bytes: 376713216; Read time: 1592; Write time: 325812 09:31:21 INFO - Running post-run listener: _upload_blobber_files 09:31:21 INFO - Blob upload gear active. 09:31:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:31:21 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:31:21 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:31:21 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:31:22 INFO - (blobuploader) - INFO - Open directory for files ... 09:31:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:31:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:31:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:23 INFO - (blobuploader) - INFO - Done attempting. 09:31:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:31:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:31:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:31:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:23 INFO - (blobuploader) - INFO - Done attempting. 09:31:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:31:23 INFO - Return code: 0 09:31:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:31:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:31:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/820af8675ac423fcd459c4e538cd64b22b9f1e0effd0b3ccee8e3590d7aa57a9cef25f5b04a79d00779e1e0672cffc7cf627a8f830e34d9ad7306a16639cfc82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ea7e8d47961b7694f083543a203ae9ab60096c350b4a9bf49a370c0a13831c81795a5a9761737047b74e1b90f3c24e2469cee4937eef1ff7373844d321cdae1"} 09:31:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:31:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:31:23 INFO - Contents: 09:31:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/820af8675ac423fcd459c4e538cd64b22b9f1e0effd0b3ccee8e3590d7aa57a9cef25f5b04a79d00779e1e0672cffc7cf627a8f830e34d9ad7306a16639cfc82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ea7e8d47961b7694f083543a203ae9ab60096c350b4a9bf49a370c0a13831c81795a5a9761737047b74e1b90f3c24e2469cee4937eef1ff7373844d321cdae1"} 09:31:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:31:23 INFO - Copying logs to upload dir... 09:31:23 INFO - mkdir: /builds/slave/test/build/upload/logs 09:31:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.931397 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-25 09:31:23.954602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 09:31:23.958473) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797 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/820af8675ac423fcd459c4e538cd64b22b9f1e0effd0b3ccee8e3590d7aa57a9cef25f5b04a79d00779e1e0672cffc7cf627a8f830e34d9ad7306a16639cfc82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ea7e8d47961b7694f083543a203ae9ab60096c350b4a9bf49a370c0a13831c81795a5a9761737047b74e1b90f3c24e2469cee4937eef1ff7373844d321cdae1"} build_url:https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011025 build_url: 'https://queue.taskcluster.net/v1/task/ZpuBLsfqRea_aIl5YentDQ/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/820af8675ac423fcd459c4e538cd64b22b9f1e0effd0b3ccee8e3590d7aa57a9cef25f5b04a79d00779e1e0672cffc7cf627a8f830e34d9ad7306a16639cfc82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ea7e8d47961b7694f083543a203ae9ab60096c350b4a9bf49a370c0a13831c81795a5a9761737047b74e1b90f3c24e2469cee4937eef1ff7373844d321cdae1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 09:31:23.987331) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 09:31:23.988196) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1461600210.150744-1734622797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 09:31:24.072879) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 09:31:24.073667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 09:31:24.074407) ========= ========= Total master_lag: 0.20 =========