builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1467132621.64 results: success (0) buildid: 20160628075828 builduid: cc79df57ceac4240aee67e4232804bc3 revision: 39023f2bbf6e44d29165130cd5e19d35385f0b97 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:21.643160) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:21.643651) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:21.643933) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:21.658882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:21.659148) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 09:50:21-- 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% 103M=0s 2016-06-28 09:50:21 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:21.768776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:21.769152) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019333 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:21.819535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:21.819887) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 39023f2bbf6e44d29165130cd5e19d35385f0b97 --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-beta --rev 39023f2bbf6e44d29165130cd5e19d35385f0b97 --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=516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 09:50:21,939 truncating revision to first 12 chars 2016-06-28 09:50:21,939 Setting DEBUG logging. 2016-06-28 09:50:21,939 attempt 1/10 2016-06-28 09:50:21,939 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/39023f2bbf6e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 09:50:22,270 unpacking tar archive at: mozilla-beta-39023f2bbf6e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684689 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:22.519271) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:22.519722) ========= script_repo_revision: 39023f2bbf6e44d29165130cd5e19d35385f0b97 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:22.520149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:22.520440) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 09:50:22.531442) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-28 09:50:22.531761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:50:22 INFO - MultiFileLogger online at 20160628 09:50:22 in /builds/slave/test 09:50:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:50:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:22 INFO - {'append_to_log': False, 09:50:22 INFO - 'base_work_dir': '/builds/slave/test', 09:50:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:50:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:22 INFO - 'branch': 'Mozilla-Beta', 09:50:22 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:22 INFO - 'config_files': ('talos/linux_config.py',), 09:50:22 INFO - 'default_actions': ('clobber', 09:50:22 INFO - 'read-buildbot-config', 09:50:22 INFO - 'download-and-extract', 09:50:22 INFO - 'populate-webroot', 09:50:22 INFO - 'create-virtualenv', 09:50:22 INFO - 'install', 09:50:22 INFO - 'run-tests'), 09:50:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:22 INFO - 'download_minidump_stackwalk': True, 09:50:22 INFO - 'download_symbols': 'ondemand', 09:50:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:22 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:22 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:22 INFO - 'installer_path': 'installer.exe', 09:50:22 INFO - 'log_level': 'info', 09:50:22 INFO - 'log_name': 'talos', 09:50:22 INFO - 'log_to_console': True, 09:50:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:50:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:50:22 INFO - 'opt_config_files': (), 09:50:22 INFO - 'pip_index': False, 09:50:22 INFO - 'sps_profile': False, 09:50:22 INFO - 'sps_profile_interval': 0, 09:50:22 INFO - 'suite': 'dromaeojs', 09:50:22 INFO - 'system_bits': '32', 09:50:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:22 INFO - 'title': 'talos-linux64-ix-061', 09:50:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:22 INFO - 'use_talos_json': True, 09:50:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:22 INFO - 'work_dir': 'build'} 09:50:22 INFO - ##### 09:50:22 INFO - ##### Running clobber step. 09:50:22 INFO - ##### 09:50:22 INFO - Running pre-action listener: _resource_record_pre_action 09:50:22 INFO - Running main action method: clobber 09:50:22 INFO - rmtree: /builds/slave/test/build 09:50:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:23 INFO - Running post-action listener: _resource_record_post_action 09:50:23 INFO - ##### 09:50:23 INFO - ##### Running read-buildbot-config step. 09:50:23 INFO - ##### 09:50:23 INFO - Running pre-action listener: _resource_record_pre_action 09:50:23 INFO - Running main action method: read_buildbot_config 09:50:23 INFO - Using buildbot properties: 09:50:23 INFO - { 09:50:23 INFO - "project": "", 09:50:23 INFO - "product": "firefox", 09:50:23 INFO - "script_repo_revision": "production", 09:50:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:50:23 INFO - "repository": "", 09:50:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:50:23 INFO - "buildid": "20160628075828", 09:50:23 INFO - "pgo_build": "True", 09:50:23 INFO - "basedir": "/builds/slave/test", 09:50:23 INFO - "buildnumber": 143, 09:50:23 INFO - "slavename": "talos-linux64-ix-061", 09:50:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:50:23 INFO - "platform": "ubuntu64_hw", 09:50:23 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:50:23 INFO - "branch": "mozilla-beta", 09:50:23 INFO - "repo_path": "releases/mozilla-beta", 09:50:23 INFO - "revision": "39023f2bbf6e44d29165130cd5e19d35385f0b97", 09:50:23 INFO - "stage_platform": "linux64-pgo", 09:50:23 INFO - "builduid": "cc79df57ceac4240aee67e4232804bc3", 09:50:23 INFO - "slavebuilddir": "test" 09:50:23 INFO - } 09:50:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 09:50:23 INFO - Running post-action listener: _resource_record_post_action 09:50:23 INFO - ##### 09:50:23 INFO - ##### Running download-and-extract step. 09:50:23 INFO - ##### 09:50:23 INFO - Running pre-action listener: _resource_record_pre_action 09:50:23 INFO - Running main action method: download_and_extract 09:50:23 INFO - mkdir: /builds/slave/test/build/tests 09:50:23 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:50:23 INFO - https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:50:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:50:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:50:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:50:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:50:24 INFO - Downloaded 1327 bytes. 09:50:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:50:24 INFO - Using the following test package requirements: 09:50:24 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:50:24 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:50:24 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:50:24 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:50:24 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:50:24 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:50:24 INFO - u'jsshell-linux-x86_64.zip'], 09:50:24 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:50:24 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:50:24 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:50:24 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:50:24 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:50:24 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:50:24 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:50:24 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:50:24 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:50:24 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:50:24 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:50:24 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:50:24 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:50:24 INFO - https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:50:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:50:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:50:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:50:26 INFO - Downloaded 24235687 bytes. 09:50:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:50:27 INFO - Return code: 0 09:50:27 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:27 INFO - https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:50:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:50:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:50:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:50:29 INFO - Downloaded 24235687 bytes. 09:50:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:50:30 INFO - Return code: 0 09:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:30 INFO - https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:50:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:50:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:50:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:50:31 INFO - Downloaded 10840145 bytes. 09:50:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:50:32 INFO - Return code: 0 09:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:32 INFO - https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:50:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:50:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:50:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:50:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:50:33 INFO - Downloaded 56001096 bytes. 09:50:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:50:33 INFO - mkdir: /builds/slave/test/properties 09:50:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:50:33 INFO - Writing to file /builds/slave/test/properties/build_url 09:50:33 INFO - Contents: 09:50:33 INFO - build_url:https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:50:34 INFO - Running post-action listener: _resource_record_post_action 09:50:34 INFO - Running post-action listener: set_extra_try_arguments 09:50:34 INFO - ##### 09:50:34 INFO - ##### Running populate-webroot step. 09:50:34 INFO - ##### 09:50:34 INFO - Running pre-action listener: _resource_record_pre_action 09:50:34 INFO - Running main action method: populate_webroot 09:50:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:34 INFO - '--tppagecycles', 09:50:34 INFO - '7'], 09:50:34 INFO - 'tests': ['tsvgm']}}, 09:50:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:50:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:50:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:50:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:50:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:50:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:34 INFO - 'talos_options': ['--disable-e10s'], 09:50:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:34 INFO - 'talos_options': ['--disable-e10s'], 09:50:34 INFO - 'tests': ['damp', 'tps']}, 09:50:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:34 INFO - 'tests': ['damp', 'tps']}, 09:50:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:50:34 INFO - 'tests': ['dromaeo_dom']}, 09:50:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:50:34 INFO - 'tests': ['a11yr', 09:50:34 INFO - 'ts_paint', 09:50:34 INFO - 'tpaint', 09:50:34 INFO - 'sessionrestore', 09:50:34 INFO - 'sessionrestore_no_auto_restore', 09:50:34 INFO - 'tabpaint']}, 09:50:34 INFO - 'other-e10s': {'tests': ['a11yr', 09:50:34 INFO - 'ts_paint', 09:50:34 INFO - 'tpaint', 09:50:34 INFO - 'sessionrestore', 09:50:34 INFO - 'sessionrestore_no_auto_restore', 09:50:34 INFO - 'tabpaint']}, 09:50:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:50:34 INFO - 'ts_paint', 09:50:34 INFO - 'tpaint', 09:50:34 INFO - 'sessionrestore', 09:50:34 INFO - 'sessionrestore_no_auto_restore', 09:50:34 INFO - 'tabpaint']}, 09:50:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:50:34 INFO - 'ts_paint', 09:50:34 INFO - 'tpaint', 09:50:34 INFO - 'sessionrestore', 09:50:34 INFO - 'sessionrestore_no_auto_restore', 09:50:34 INFO - 'tabpaint']}, 09:50:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:50:34 INFO - 'tests': ['a11yr', 09:50:34 INFO - 'ts_paint', 09:50:34 INFO - 'tpaint', 09:50:34 INFO - 'sessionrestore', 09:50:34 INFO - 'sessionrestore_no_auto_restore', 09:50:34 INFO - 'tabpaint']}, 09:50:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:50:34 INFO - 'tests': ['a11yr', 09:50:34 INFO - 'ts_paint', 09:50:34 INFO - 'tpaint', 09:50:34 INFO - 'sessionrestore', 09:50:34 INFO - 'sessionrestore_no_auto_restore', 09:50:34 INFO - 'tabpaint']}, 09:50:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:50:34 INFO - 'tests': ['tsvgx', 09:50:34 INFO - 'tsvgr_opacity', 09:50:34 INFO - 'tart', 09:50:34 INFO - 'tscrollx', 09:50:34 INFO - 'cart']}, 09:50:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:50:34 INFO - 'tsvgr_opacity', 09:50:34 INFO - 'tart', 09:50:34 INFO - 'tscrollx', 09:50:34 INFO - 'cart']}, 09:50:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:34 INFO - 'talos_options': ['--disable-e10s'], 09:50:34 INFO - 'tests': ['tp5o']}, 09:50:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:34 INFO - 'tests': ['tp5o']}, 09:50:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:34 INFO - 'talos_options': ['--disable-e10s', 09:50:34 INFO - '--xperf_path', 09:50:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:34 INFO - 'tests': ['tp5n']}, 09:50:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:34 INFO - 'talos_options': ['--xperf_path', 09:50:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:34 INFO - 'tests': ['tp5n']}}, 09:50:34 INFO - 'talos.zip': {'path': '', 09:50:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:34 INFO - Running post-action listener: _resource_record_post_action 09:50:34 INFO - ##### 09:50:34 INFO - ##### Running create-virtualenv step. 09:50:34 INFO - ##### 09:50:34 INFO - Running pre-action listener: _resource_record_pre_action 09:50:34 INFO - Running main action method: create_virtualenv 09:50:34 INFO - Creating virtualenv /builds/slave/test/build/venv 09:50:34 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:50:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:50:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:34 INFO - Using real prefix '/usr' 09:50:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:50:34 INFO - Installing distribute.............................................................................................................................................................................................done. 09:50:36 INFO - Installing pip.................done. 09:50:36 INFO - Return code: 0 09:50:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:50:36 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:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:36 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:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:36 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 0x7f3cf11edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11410>, '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 0xe12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe127a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', '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:50:36 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:50:36 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:50:36 INFO - Using env: {'DISPLAY': ':0', 09:50:36 INFO - 'HOME': '/home/cltbld', 09:50:36 INFO - 'LANG': 'en_US.UTF-8', 09:50:36 INFO - 'LANGUAGE': 'en_US:en', 09:50:36 INFO - 'LOGNAME': 'cltbld', 09:50:36 INFO - 'MAIL': '/var/mail/cltbld', 09:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:36 INFO - 'MOZ_NO_REMOTE': '1', 09:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:36 INFO - 'NO_EM_RESTART': '1', 09:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:36 INFO - 'PWD': '/builds/slave/test', 09:50:36 INFO - 'SHELL': '/bin/bash', 09:50:36 INFO - 'SHLVL': '1', 09:50:36 INFO - 'TERM': 'linux', 09:50:36 INFO - 'TMOUT': '86400', 09:50:36 INFO - 'USER': 'cltbld', 09:50:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', 09:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:36 INFO - '_': '/tools/buildbot/bin/python'} 09:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:37 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:50:37 INFO - Cleaning up... 09:50:37 INFO - Return code: 0 09:50:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:50: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:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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:50:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:37 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 0x7f3cf11edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11410>, '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 0xe12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe127a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', '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:50:37 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:50:37 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:50:37 INFO - Using env: {'DISPLAY': ':0', 09:50:37 INFO - 'HOME': '/home/cltbld', 09:50:37 INFO - 'LANG': 'en_US.UTF-8', 09:50:37 INFO - 'LANGUAGE': 'en_US:en', 09:50:37 INFO - 'LOGNAME': 'cltbld', 09:50:37 INFO - 'MAIL': '/var/mail/cltbld', 09:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:37 INFO - 'MOZ_NO_REMOTE': '1', 09:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:37 INFO - 'NO_EM_RESTART': '1', 09:50:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:37 INFO - 'PWD': '/builds/slave/test', 09:50:37 INFO - 'SHELL': '/bin/bash', 09:50:37 INFO - 'SHLVL': '1', 09:50:37 INFO - 'TERM': 'linux', 09:50:37 INFO - 'TMOUT': '86400', 09:50:37 INFO - 'USER': 'cltbld', 09:50:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', 09:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:37 INFO - '_': '/tools/buildbot/bin/python'} 09:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:37 INFO - Downloading/unpacking psutil>=0.7.1 09:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:50:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:39 INFO - Installing collected packages: psutil 09:50:39 INFO - Running setup.py install for psutil 09:50:39 INFO - building 'psutil._psutil_linux' extension 09:50:39 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:50:39 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:50:39 INFO - building 'psutil._psutil_posix' extension 09:50:39 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:50:39 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:50:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:50:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:50:39 INFO - Successfully installed psutil 09:50:39 INFO - Cleaning up... 09:50:39 INFO - Return code: 0 09:50:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:39 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 0x7f3cf11edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11410>, '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 0xe12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe127a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', '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:50:39 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:50:39 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:50:39 INFO - Using env: {'DISPLAY': ':0', 09:50:39 INFO - 'HOME': '/home/cltbld', 09:50:39 INFO - 'LANG': 'en_US.UTF-8', 09:50:39 INFO - 'LANGUAGE': 'en_US:en', 09:50:39 INFO - 'LOGNAME': 'cltbld', 09:50:39 INFO - 'MAIL': '/var/mail/cltbld', 09:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:39 INFO - 'MOZ_NO_REMOTE': '1', 09:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:39 INFO - 'NO_EM_RESTART': '1', 09:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:39 INFO - 'PWD': '/builds/slave/test', 09:50:39 INFO - 'SHELL': '/bin/bash', 09:50:39 INFO - 'SHLVL': '1', 09:50:39 INFO - 'TERM': 'linux', 09:50:39 INFO - 'TMOUT': '86400', 09:50:39 INFO - 'USER': 'cltbld', 09:50:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', 09:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:39 INFO - '_': '/tools/buildbot/bin/python'} 09:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:50:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:50:42 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:50:42 INFO - Installing collected packages: mozsystemmonitor 09:50:42 INFO - Running setup.py install for mozsystemmonitor 09:50:42 INFO - Successfully installed mozsystemmonitor 09:50:42 INFO - Cleaning up... 09:50:42 INFO - Return code: 0 09:50:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:42 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 0x7f3cf11edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11410>, '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 0xe12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe127a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', '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:50:42 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:50:42 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:50:42 INFO - Using env: {'DISPLAY': ':0', 09:50:42 INFO - 'HOME': '/home/cltbld', 09:50:42 INFO - 'LANG': 'en_US.UTF-8', 09:50:42 INFO - 'LANGUAGE': 'en_US:en', 09:50:42 INFO - 'LOGNAME': 'cltbld', 09:50:42 INFO - 'MAIL': '/var/mail/cltbld', 09:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:42 INFO - 'MOZ_NO_REMOTE': '1', 09:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:42 INFO - 'NO_EM_RESTART': '1', 09:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:42 INFO - 'PWD': '/builds/slave/test', 09:50:42 INFO - 'SHELL': '/bin/bash', 09:50:42 INFO - 'SHLVL': '1', 09:50:42 INFO - 'TERM': 'linux', 09:50:42 INFO - 'TMOUT': '86400', 09:50:42 INFO - 'USER': 'cltbld', 09:50:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', 09:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:42 INFO - '_': '/tools/buildbot/bin/python'} 09:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:42 INFO - Downloading/unpacking blobuploader==1.2.4 09:50:42 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:50:42 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:50:42 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:50:42 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:50:42 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:50:42 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:50:44 INFO - Downloading blobuploader-1.2.4.tar.gz 09:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:50:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:50:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:44 INFO - Downloading docopt-0.6.1.tar.gz 09:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:50:45 INFO - Installing collected packages: blobuploader, requests, docopt 09:50:45 INFO - Running setup.py install for blobuploader 09:50:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:50:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:50:45 INFO - Running setup.py install for requests 09:50:45 INFO - Running setup.py install for docopt 09:50:45 INFO - Successfully installed blobuploader requests docopt 09:50:45 INFO - Cleaning up... 09:50:45 INFO - Return code: 0 09:50:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:45 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:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:45 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:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:45 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 0x7f3cf11edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11410>, '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 0xe12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe127a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', '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:50:45 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:50:45 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:50:45 INFO - Using env: {'DISPLAY': ':0', 09:50:45 INFO - 'HOME': '/home/cltbld', 09:50:45 INFO - 'LANG': 'en_US.UTF-8', 09:50:45 INFO - 'LANGUAGE': 'en_US:en', 09:50:45 INFO - 'LOGNAME': 'cltbld', 09:50:45 INFO - 'MAIL': '/var/mail/cltbld', 09:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:45 INFO - 'MOZ_NO_REMOTE': '1', 09:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:45 INFO - 'NO_EM_RESTART': '1', 09:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:45 INFO - 'PWD': '/builds/slave/test', 09:50:45 INFO - 'SHELL': '/bin/bash', 09:50:45 INFO - 'SHLVL': '1', 09:50:45 INFO - 'TERM': 'linux', 09:50:45 INFO - 'TMOUT': '86400', 09:50:45 INFO - 'USER': 'cltbld', 09:50:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', 09:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:45 INFO - '_': '/tools/buildbot/bin/python'} 09:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:50:45 INFO - Running setup.py (path:/tmp/pip-3Qeai2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:50:45 INFO - Running setup.py (path:/tmp/pip-9J23jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:50:46 INFO - Running setup.py (path:/tmp/pip-m15YNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:50:46 INFO - Running setup.py (path:/tmp/pip-oXcGsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:50:46 INFO - Running setup.py (path:/tmp/pip-23A0z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:50:46 INFO - Running setup.py (path:/tmp/pip-_V_KHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:50:46 INFO - Running setup.py (path:/tmp/pip-XUprQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:50:46 INFO - Running setup.py (path:/tmp/pip-nN1RjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:50:46 INFO - Running setup.py (path:/tmp/pip-VaKJvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:50:46 INFO - Running setup.py (path:/tmp/pip-_hpXbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:50:46 INFO - Running setup.py (path:/tmp/pip-OFxvhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:50:46 INFO - Running setup.py (path:/tmp/pip-Q6Qw5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:50:46 INFO - Running setup.py (path:/tmp/pip-8LS7RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:50:46 INFO - Running setup.py (path:/tmp/pip-UTrWSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:46 INFO - Running setup.py (path:/tmp/pip-suTGys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:50:46 INFO - Running setup.py (path:/tmp/pip-YXuuJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:50:47 INFO - Running setup.py (path:/tmp/pip-JRjIld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:50:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:50:47 INFO - Running setup.py install for manifestparser 09:50:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:50:47 INFO - Running setup.py install for mozcrash 09:50:47 INFO - Running setup.py install for mozdebug 09:50:47 INFO - Running setup.py install for mozdevice 09:50:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:50:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:50:47 INFO - Running setup.py install for mozfile 09:50:47 INFO - Running setup.py install for mozhttpd 09:50:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:50:47 INFO - Running setup.py install for mozinfo 09:50:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:50:47 INFO - Running setup.py install for mozInstall 09:50:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:50:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:50:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:50:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:50:47 INFO - Running setup.py install for mozleak 09:50:47 INFO - Running setup.py install for mozlog 09:50:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:50:48 INFO - Running setup.py install for moznetwork 09:50:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:50:48 INFO - Running setup.py install for mozprocess 09:50:48 INFO - Running setup.py install for mozprofile 09:50:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:50:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:50:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:50:48 INFO - Running setup.py install for mozrunner 09:50:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:50:48 INFO - Running setup.py install for mozscreenshot 09:50:48 INFO - Running setup.py install for moztest 09:50:48 INFO - Running setup.py install for mozversion 09:50:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:50:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:50:48 INFO - Cleaning up... 09:50:48 INFO - Return code: 0 09:50:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:48 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 0x7f3cf11edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11410>, '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 0xe12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe127a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', '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:50:48 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:50:48 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:50:48 INFO - Using env: {'DISPLAY': ':0', 09:50:48 INFO - 'HOME': '/home/cltbld', 09:50:48 INFO - 'LANG': 'en_US.UTF-8', 09:50:48 INFO - 'LANGUAGE': 'en_US:en', 09:50:48 INFO - 'LOGNAME': 'cltbld', 09:50:48 INFO - 'MAIL': '/var/mail/cltbld', 09:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:48 INFO - 'MOZ_NO_REMOTE': '1', 09:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:48 INFO - 'NO_EM_RESTART': '1', 09:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:48 INFO - 'PWD': '/builds/slave/test', 09:50:48 INFO - 'SHELL': '/bin/bash', 09:50:48 INFO - 'SHLVL': '1', 09:50:48 INFO - 'TERM': 'linux', 09:50:48 INFO - 'TMOUT': '86400', 09:50:48 INFO - 'USER': 'cltbld', 09:50:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', 09:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:48 INFO - '_': '/tools/buildbot/bin/python'} 09:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:50:49 INFO - Running setup.py (path:/tmp/pip-SEpf0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:50:49 INFO - Running setup.py (path:/tmp/pip-iKVTiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:50:49 INFO - Running setup.py (path:/tmp/pip-uZPv71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:50:49 INFO - Running setup.py (path:/tmp/pip-C_XQ0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:50:49 INFO - Running setup.py (path:/tmp/pip-ZtgnDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:50:49 INFO - Running setup.py (path:/tmp/pip-Ho_Brq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:50:49 INFO - Running setup.py (path:/tmp/pip-bpBJHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:50:49 INFO - Running setup.py (path:/tmp/pip-al2AVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:50:49 INFO - Running setup.py (path:/tmp/pip-gCvR8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:50:49 INFO - Running setup.py (path:/tmp/pip-oZhKSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:50:49 INFO - Running setup.py (path:/tmp/pip-trFfg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:50:49 INFO - Running setup.py (path:/tmp/pip-HLuFIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:50:49 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:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:50:49 INFO - Running setup.py (path:/tmp/pip-DHiifR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:50:50 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:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:50:50 INFO - Running setup.py (path:/tmp/pip-e5SQWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:50:50 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:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:50 INFO - Running setup.py (path:/tmp/pip-9o1PHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:50 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:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:50:50 INFO - Running setup.py (path:/tmp/pip-TmLkv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:50:50 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:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:50:50 INFO - Running setup.py (path:/tmp/pip-Lu0SKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:50:50 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:50:50 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:50:50 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:50:50 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:50:50 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:50:50 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:50:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:52 INFO - Downloading blessings-1.6.tar.gz 09:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:50:52 INFO - Installing collected packages: blessings 09:50:52 INFO - Running setup.py install for blessings 09:50:52 INFO - Successfully installed blessings 09:50:52 INFO - Cleaning up... 09:50:52 INFO - Return code: 0 09:50:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:50:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:50:52 INFO - Reading from file tmpfile_stdout 09:50:52 INFO - Current package versions: 09:50:52 INFO - argparse == 1.2.1 09:50:52 INFO - blessings == 1.6 09:50:52 INFO - blobuploader == 1.2.4 09:50:52 INFO - docopt == 0.6.1 09:50:52 INFO - manifestparser == 1.1 09:50:52 INFO - mozInstall == 1.12 09:50:52 INFO - mozcrash == 0.17 09:50:52 INFO - mozdebug == 0.1 09:50:52 INFO - mozdevice == 0.48 09:50:52 INFO - mozfile == 1.2 09:50:52 INFO - mozhttpd == 0.7 09:50:52 INFO - mozinfo == 0.9 09:50:52 INFO - mozleak == 0.1 09:50:52 INFO - mozlog == 3.1 09:50:52 INFO - moznetwork == 0.27 09:50:52 INFO - mozprocess == 0.22 09:50:52 INFO - mozprofile == 0.28 09:50:52 INFO - mozrunner == 6.11 09:50:52 INFO - mozscreenshot == 0.1 09:50:52 INFO - mozsystemmonitor == 0.0 09:50:52 INFO - moztest == 0.7 09:50:52 INFO - mozversion == 1.4 09:50:52 INFO - psutil == 3.1.1 09:50:52 INFO - requests == 1.2.3 09:50:52 INFO - wsgiref == 0.1.2 09:50:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:52 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 0x7f3cf11edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11410>, '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 0xe12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe127a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', '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:50:52 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:50:52 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:50:52 INFO - Using env: {'DISPLAY': ':0', 09:50:52 INFO - 'HOME': '/home/cltbld', 09:50:52 INFO - 'LANG': 'en_US.UTF-8', 09:50:52 INFO - 'LANGUAGE': 'en_US:en', 09:50:52 INFO - 'LOGNAME': 'cltbld', 09:50:52 INFO - 'MAIL': '/var/mail/cltbld', 09:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:52 INFO - 'MOZ_NO_REMOTE': '1', 09:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:52 INFO - 'NO_EM_RESTART': '1', 09:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:52 INFO - 'PWD': '/builds/slave/test', 09:50:52 INFO - 'SHELL': '/bin/bash', 09:50:52 INFO - 'SHLVL': '1', 09:50:52 INFO - 'TERM': 'linux', 09:50:52 INFO - 'TMOUT': '86400', 09:50:52 INFO - 'USER': 'cltbld', 09:50:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', 09:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:52 INFO - '_': '/tools/buildbot/bin/python'} 09:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:52 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:50:52 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:50:52 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:50:52 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:50:52 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:50:52 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:50:52 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:50:52 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:50:52 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:50:52 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:50:52 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:50:52 INFO - Cleaning up... 09:50:52 INFO - Return code: 0 09:50:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:52 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 0x7f3cf11edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11410>, '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 0xe12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe127a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', '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:50:52 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:50:52 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:50:52 INFO - Using env: {'DISPLAY': ':0', 09:50:52 INFO - 'HOME': '/home/cltbld', 09:50:52 INFO - 'LANG': 'en_US.UTF-8', 09:50:52 INFO - 'LANGUAGE': 'en_US:en', 09:50:52 INFO - 'LOGNAME': 'cltbld', 09:50:52 INFO - 'MAIL': '/var/mail/cltbld', 09:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:52 INFO - 'MOZ_NO_REMOTE': '1', 09:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:52 INFO - 'NO_EM_RESTART': '1', 09:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:52 INFO - 'PWD': '/builds/slave/test', 09:50:52 INFO - 'SHELL': '/bin/bash', 09:50:52 INFO - 'SHLVL': '1', 09:50:52 INFO - 'TERM': 'linux', 09:50:52 INFO - 'TMOUT': '86400', 09:50:52 INFO - 'USER': 'cltbld', 09:50:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', 09:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:52 INFO - '_': '/tools/buildbot/bin/python'} 09:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:53 INFO - Downloading/unpacking jsonschema 09:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:50:55 INFO - Downloading/unpacking functools32 (from jsonschema) 09:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:50:55 INFO - warning: no files found matching '*.txt' 09:50:55 INFO - no previously-included directories found matching 'build' 09:50:55 INFO - no previously-included directories found matching 'dist' 09:50:55 INFO - no previously-included directories found matching '.git*' 09:50:55 INFO - Installing collected packages: jsonschema, functools32 09:50:55 INFO - Running setup.py install for functools32 09:50:55 INFO - warning: no files found matching '*.txt' 09:50:55 INFO - no previously-included directories found matching 'build' 09:50:55 INFO - no previously-included directories found matching 'dist' 09:50:55 INFO - no previously-included directories found matching '.git*' 09:50:55 INFO - Successfully installed jsonschema functools32 09:50:55 INFO - Cleaning up... 09:50:55 INFO - Return code: 0 09:50:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:50:55 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:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:55 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:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:55 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 0x7f3cf11edf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd825a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe11410>, '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 0xe12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe127a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', '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:50:55 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:50:55 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:50:55 INFO - Using env: {'DISPLAY': ':0', 09:50:55 INFO - 'HOME': '/home/cltbld', 09:50:55 INFO - 'LANG': 'en_US.UTF-8', 09:50:55 INFO - 'LANGUAGE': 'en_US:en', 09:50:55 INFO - 'LOGNAME': 'cltbld', 09:50:55 INFO - 'MAIL': '/var/mail/cltbld', 09:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:55 INFO - 'MOZ_NO_REMOTE': '1', 09:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:55 INFO - 'NO_EM_RESTART': '1', 09:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:55 INFO - 'PWD': '/builds/slave/test', 09:50:55 INFO - 'SHELL': '/bin/bash', 09:50:55 INFO - 'SHLVL': '1', 09:50:55 INFO - 'TERM': 'linux', 09:50:55 INFO - 'TMOUT': '86400', 09:50:55 INFO - 'USER': 'cltbld', 09:50:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', 09:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:55 INFO - '_': '/tools/buildbot/bin/python'} 09:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:55 INFO - Downloading/unpacking flake8 09:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:50:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:50:57 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:50:57 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:50:57 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:50:57 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:50:57 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:50:57 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:50:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:50:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:50:58 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:50:58 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:50:58 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:50:58 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:50:58 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:50:58 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:50:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:50:58 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:50:58 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:50:58 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:50:58 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:50:58 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:50:58 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:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:50:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:50:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:50:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:50:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:50:58 INFO - no previously-included directories found matching 'docs/_build' 09:50:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:50:58 INFO - Running setup.py install for pep8 09:50:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:50:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:50:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:50:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:50:58 INFO - no previously-included directories found matching 'docs/_build' 09:50:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:50:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:50:58 INFO - Cleaning up... 09:50:58 INFO - Return code: 0 09:50:58 INFO - Running post-action listener: _resource_record_post_action 09:50:58 INFO - Running post-action listener: _start_resource_monitoring 09:50:58 INFO - Starting resource monitoring. 09:50:58 INFO - ##### 09:50:58 INFO - ##### Running install step. 09:50:58 INFO - ##### 09:50:58 INFO - Running pre-action listener: _resource_record_pre_action 09:50:58 INFO - Running main action method: install 09:50:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:50:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:50:59 INFO - Reading from file tmpfile_stdout 09:50:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:50:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:50:59 INFO - Reading from file tmpfile_stdout 09:50:59 INFO - Output received: 09:50:59 INFO - Usage: mozinstall [options] installer 09:50:59 INFO - Options: 09:50:59 INFO - -h, --help show this help message and exit 09:50:59 INFO - -d DEST, --destination=DEST 09:50:59 INFO - Directory to install application into. [default: 09:50:59 INFO - "/builds/slave/test"] 09:50:59 INFO - --app=APP Application being installed. [default: firefox] 09:50:59 INFO - mkdir: /builds/slave/test/build/application 09:50:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:51:12 INFO - Reading from file tmpfile_stdout 09:51:12 INFO - Output received: 09:51:12 INFO - /builds/slave/test/build/application/firefox/firefox 09:51:12 INFO - Running post-action listener: _resource_record_post_action 09:51:12 INFO - ##### 09:51:12 INFO - ##### Running run-tests step. 09:51:12 INFO - ##### 09:51:12 INFO - Running pre-action listener: _resource_record_pre_action 09:51:12 INFO - Running main action method: run_tests 09:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:51:12 INFO - Python 2.7.3 09:51:12 INFO - Return code: 0 09:51:12 INFO - grabbing minidump binary from tooltool 09:51:12 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:51:12 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 0xe11410>, '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 0xe12310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe127a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:51:12 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:51:12 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:51:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:51:12 INFO - Return code: 0 09:51:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:51:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:51:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:51:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:51:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:51:13 INFO - Return code: 0 09:51:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:51:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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:51:13 INFO - Using env: {'DISPLAY': ':0', 09:51:13 INFO - 'HOME': '/home/cltbld', 09:51:13 INFO - 'LANG': 'en_US.UTF-8', 09:51:13 INFO - 'LANGUAGE': 'en_US:en', 09:51:13 INFO - 'LOGNAME': 'cltbld', 09:51:13 INFO - 'MAIL': '/var/mail/cltbld', 09:51:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:51:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:13 INFO - 'MOZ_NO_REMOTE': '1', 09:51:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:13 INFO - 'NO_EM_RESTART': '1', 09:51:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:13 INFO - 'PWD': '/builds/slave/test', 09:51:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:51:13 INFO - 'SHELL': '/bin/bash', 09:51:13 INFO - 'SHLVL': '1', 09:51:13 INFO - 'TERM': 'linux', 09:51:13 INFO - 'TMOUT': '86400', 09:51:13 INFO - 'USER': 'cltbld', 09:51:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887', 09:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:13 INFO - '_': '/tools/buildbot/bin/python'} 09:51:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:51:13 INFO - mozversion application_buildid: 20160628075828 09:51:13 INFO - mozversion application_changeset: 39023f2bbf6e44d29165130cd5e19d35385f0b97 09:51:13 INFO - mozversion application_display_name: Firefox 09:51:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:51:13 INFO - mozversion application_name: Firefox 09:51:13 INFO - mozversion application_remotingname: firefox 09:51:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:51:13 INFO - mozversion application_vendor: Mozilla 09:51:13 INFO - mozversion application_version: 48.0 09:51:13 INFO - mozversion platform_buildid: 20160628075828 09:51:13 INFO - mozversion platform_changeset: 39023f2bbf6e44d29165130cd5e19d35385f0b97 09:51:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:51:13 INFO - mozversion platform_version: 48.0 09:51:13 INFO - using testdate: 1467132673 09:51:13 INFO - actual date: 1467132673 09:51:13 INFO - starting webserver on 'localhost:56420' 09:51:13 INFO - SUITE-START | Running 2 tests 09:51:13 INFO - TEST-START | dromaeo_css 09:51:13 INFO - operating with platform_type : linux_ 09:51:13 INFO - Initialising browser for dromaeo_css test... 09:51:13 INFO - TEST-INFO | started process 18292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfd4nUh/profile http://localhost:56420/getInfo.html) 09:51:17 INFO - PROCESS | 18292 | __metrics Screen width/height:1600/1200 09:51:17 INFO - PROCESS | 18292 | colorDepth:24 09:51:17 INFO - PROCESS | 18292 | Browser inner width/height: 1024/697 09:51:17 INFO - PROCESS | 18292 | __metrics 09:51:18 ERROR - PROCESS | 18292 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:51:19 INFO - TEST-INFO | 18292: exit 0 09:51:19 INFO - Browser initialized. 09:51:19 INFO - Running cycle 1/1 for dromaeo_css test... 09:51:19 INFO - TEST-INFO | started process 18385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfd4nUh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:31 INFO - PROCESS | 18385 | RSS: Main: 139173888 09:51:31 INFO - PROCESS | 18385 | 09:52:22 INFO - PROCESS | 18385 | 1467132742743 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:54:29 INFO - PROCESS | 18385 | Cycle 1(1): loaded http://localhost:56420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56420/tests/dromaeo/cssquery-ext.html) 09:54:30 INFO - PROCESS | 18385 | RSS: Main: 253857792 09:54:30 INFO - PROCESS | 18385 | 09:57:32 INFO - PROCESS | 18385 | Cycle 1(1): loaded http://localhost:56420/tests/dromaeo/cssquery-ext.html (next: http://localhost:56420/tests/dromaeo/cssquery-jquery.html) 09:57:33 INFO - PROCESS | 18385 | RSS: Main: 220585984 09:57:33 INFO - PROCESS | 18385 | 10:00:34 INFO - PROCESS | 18385 | Cycle 1(1): loaded http://localhost:56420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56420/tests/dromaeo/cssquery-mootools.html) 10:00:35 INFO - PROCESS | 18385 | RSS: Main: 219385856 10:00:35 INFO - PROCESS | 18385 | 10:03:37 INFO - PROCESS | 18385 | Cycle 1(1): loaded http://localhost:56420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56420/tests/dromaeo/cssquery-prototype.html) 10:03:37 INFO - PROCESS | 18385 | RSS: Main: 213233664 10:03:37 INFO - PROCESS | 18385 | 10:06:40 INFO - PROCESS | 18385 | Cycle 1(1): loaded http://localhost:56420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56420/tests/dromaeo/cssquery-yui.html) 10:06:40 INFO - PROCESS | 18385 | RSS: Main: 209690624 10:06:40 INFO - PROCESS | 18385 | 10:09:43 INFO - PROCESS | 18385 | Cycle 1(1): loaded http://localhost:56420/tests/dromaeo/cssquery-yui.html (next: http://localhost:56420/tests/dromaeo/cssquery-dojo.html) 10:09:43 INFO - PROCESS | 18385 | RSS: Main: 256036864 10:09:43 INFO - PROCESS | 18385 | 10:09:43 INFO - PROCESS | 18385 | __start_tp_report 10:09:43 INFO - PROCESS | 18385 | _x_x_mozilla_page_load 10:09:43 INFO - PROCESS | 18385 | _x_x_mozilla_page_load_details 10:09:43 INFO - PROCESS | 18385 | |i|pagename|runs| 10:09:43 INFO - PROCESS | 18385 | |0;dojo.html;3272.6563710810365;3302.1579497228204;3351.631320554737;3356.966430335696;3406.642302558231;5458.5087342139195;5475.972620136904;5479.863003424916;5488.615796894214;5495.450454954503;5461.808836690717;5488.094464413377;5493.148561972891;5494.0934745767;5527.226188333637;4967.105920934239;4990.101781679296;5046.571041461461;5086.79652813887;5137.691738495683;4954.97522512387;4985;5046.066477701637;5121.052605268019;5165.121929272014;5067.873303167414;5102.846914592568;5109.744512774347;5113.616478764107;5125.077486052509;5031.874203144914;5083.237514372837;5096.1846104623455;5097.974510127426;5112.872178195537;4891.510848915115;4915.361003069614;4972.577330926875;4993.7503124843615;4999.475055119196;5395.81114660985;5396.298481197419;5406.216098665672;5427.538659213932;5429.267048948381;5721.084626459747;5869.941300586982;5874.030784920483;5875.177475153482;5910.911336329916;5883.14694369314;5917.763289468416;5930.644161350333;5975.133605627159;5987.191729116557;5447.319085114361;5450.018996580614;5451.155070964007;5451.182322651634;5455.509004189602;5846.649201047951;5859.355470898283;5912.704364781744;5919.023361145363;5981.431763982415;5698.629589076697;5702.45826646468;5704.8859022819315;5723.170140329629;5736;5783.652980821164;5789.681567513743;5792.21805056312;5797.88404231913;5803.622764520293;5736.483716465538;5749.252597162342;5749.482546570829;5765.308163020464;5797.797077102281;5850.23946886902;5854.443827836349;5867.442592953663;5868.061110222344;5868.383819698955;4512.368268442421;4514.61625761814;4521.321801729767;4521.344405061313;4529.660275479352;3957.485526881487;4006.0585762345827;4024;4043.595640435933;4045.7167998239843;5616.66300022;5626.43735626434;5629.690367029771;5637.408072152365;5668.829935101953;5707.172459993278;5879.853003674943;5880.176775251468;5882.676452795052;5884.382139875252;5593.8321850344555;5664.235328230719;5687;5722.284714410699;5724.599278050579;4916.311716359713;4938.061768264019;4938.530839570235;4945.23348880924;4979.3526841510375;6102.69486525672;6112.2970858351855;6159.969200153971;6161.96919015411;6182;5891.528677705859;5892.7642894283745;5893.057110862413;5899.970500147472;5905.202797622438;6184.752609895554;6194.101855231056;6195.380461953769;6197.442230199304;6200.596961197508;5709.9714501427225;5782.913256301243;5792.160136780228;5795.59430839854;5839.562032847638;5873.765049397976;5899.941000590111;5900.616459930091;5900.911486327623;5903.645781253139;5727.45589169045;5752.539796816161;5753;5754.338251101177;5756.625819321731;5530.253415788817;5714.79998200061;5729.54163666914;5775.451332123442;5787.623804452697;5602.607817452739;5624.3250809903075;5630.380658127685;5633.2395126657375;5634.23937768396;5736.627119237236;5763.9135412968;5766.509846662912;5767.192593037062;5771.538276937918;5456.91814622773;5492.286002819608;5541.445855414588;5628.549716022627;5638.887222255614 10:09:43 INFO - PROCESS | 18385 | |1;ext.html;657.6218674262298;665.4809248785946;665.8601693644334;675.793882865726;738.8965544823726;32029.19927001823;40610;41441.58558414415;41465.378019329735;41532.37701434477;42867.35698964518;43673;43684;43759.12481750363;43785.343219851726;8894.733158005254;9043.276537876987;9053;9054.909450905472;9082.409643373192;8844.690435834747;8935.106489351077;8961.193492585666;8962.238209752179;9252.953735231315;9235.907640923606;9299.30255230857;9319.440833549976;9324.720258392259;9341.252699784001;9172.2203612693;9272.07279272074;9272.536373181347;9273.350865439423;9282.257419406431;9069.31980101495;9172.357934944557;9181.724548263563;9181.908180918172;9185.632574697003;43020.13959720788;43805.56194438079;43842.342364864555;43943;43958.12083758307;3854.479645247912;4006.7395619284653;4274.123804620045;4372.584604462571;4695.248760198352;33485.665143348495;33706.32587348239;33918.152046199044;34141.65858341409;35339.29321413583;4347.608715215646;4383.846565370229;4399.406080179167;4400.713953593038;4461.732296062247;319398;319620;320385;320955;322112;64016.79916004181;64142.358576414576;64546.67726661337;64555.677221613594;64573;67986;71435.28564714287;72741.6362918182;72756.63621681857;72863.27136728671;18700.06499675011;19049.61900761977;19050.52373690669;19058.42824715261;19064.61870762577;15127.54617361481;15142.015768975201;15191.62020949463;15208.08751474915;15213;21120.89439552823;21193.78806211918;21334.679979800316;21358.145674172858;21413.250536231157;7556.034353772072;7609;7710.0701733340975;7809.921900781033;7830.334421574116;1083.3878858444953;1165.959191428296;1181.8877206665354;1203.0976767424431;1222.572099765075;33416.49875251873;34168;34384.82807585946;34526.96419107431;34557.827210864285;1188.2692144331174;1237.2283298412983;1254.7804134276464;1317.5652034828674;1335.5859683498147;17240;17901;18033.819661803478;18099.457016289532;18206.271749130152;526682;595294;598293;603396;604464;62381.37618623846;63121.36878631155;63380.36619633745;63417.365826342066;63832;1475.6901050779243;1496.304218538385;1528.5108765195253;1554.3704799556424;1565.8747300215955;32352;33964;34118.31763364768;34406.19321434755;34468.48297275593;50911.74544127404;51618.22572661338;51935;52077;52153;402119;402910;404699;405362;405502;28523;32125;32300.35399292048;32337.51493727549;32538.186545336557;44316.33525497056;44980.325295121256;45320;46033;46111.308330375745;38249.426258605585;38670.6132938667;38993;39742.60257397505;42296.788516057226;40103.79948100241;40498.1900361997;40638;41177.1764564701;41434;40410;41643.7917810409;41975.370369445096;42356.15287694167;42588.36117458303;35733.28533429369;36398.27203455969;36631.45052824263;36728.449073264455;36746.26507469889;28401.43197136087;28450.85774571114;28513.857430712713;28703.282417939718;28893.711062889943 10:09:43 INFO - PROCESS | 18385 | |2;jquery.html;427.809624717001;440.83909373078814;446.8346711716665;449.5010538302484;463.19404236628253;18172.18225179867;18742.90628546857;19250.786159591633;19293;19300.131494082765;18770.249190032417;18914.810851891478;20068.297609583668;20114.195432182732;20127;5701.743421546041;5705.65766054036;5903.409659034084;5914.4381283777975;5917.467427931485;4937.086638971802;4938.086454006002;4951.133551628469;4953.0589188054155;4973.278874563204;4836.854894353175;4929.975350123263;4933.309336692866;5634.239377684022;5869.589128760988;5836.416358364151;5847.912281315784;5854.502367298742;5888.64668119912;5899.941000590004;5127.102757017507;5291.417944026154;5304.416514183436;5318.282031925679;5327.520523152896;23016.65475017876;23081.422964425856;23249.651255231183;23320.533589328286;23657.29028129159;2605.8697065146666;2710.268227578543;3051.252443151442;3108.2384815720065;3290.7696461247724;14491.130532167997;14496.85503144976;14669.559913202622;14694.853051469456;14742.262886855615;1988.0656091636909;2039.51051747581;2050.6718924971933;2085.2805782005184;2137.6045431595203;80019;80986.59506702429;83051.5847420765;83563.5821820893;83639;10871.619493317696;11535.423228838525;11550.364729939765;11577.594784182513;11626.651200463999;16362.672746545002;16560.254788534545;16574.751378729088;16578.58553536147;16604.58488537796;8780.297576193889;8857.582786754088;8866.512341821133;8994.550272486349;9048.819023619491;8549.230569248797;8578.142185781497;8668.176523230282;8674.349423793241;8753.518556479328;6903.068085808452;7031.226565077837;7031.472639552054;7058.541194822423;7069.646517674199;1997.3209108903043;2030.6243344981226;2033.4509682385674;2076.802703743142;2098.7586427560723;998.7852611688522;1037.3568387599737;1068.6633710381204;1107.972300692473;1240.2682417373792;18028.549286267687;18367.632647346978;18919.959402232733;19825.405237842886;19961.900190498956;1125.1673761416494;1136.5737848306885;1157.4849192109598;1196.3360335013977;1214.0833670578656;11238.66284011481;11483.13876459269;11498.310101393943;11510.482028308747;11528.423578821026;495429;496960;501251;506409;512668;83742.58128709317;85048;86106;86383.56808215918;86894.56552717322;1110.783397237547;1123.02858027807;1126.1047467263545;1128.0975219824109;1128.949197286124;17008.57478563046;17199.312027518758;17240.482785516455;17360;17509.649807004043;37345.43981840329;38194.236115278094;38208.42687359636;39039.6096039036;39134.217315654096;51281.743591283295;53686.46313536815;53782.73108634432;53791.46208537865;54037.72981135069;8816.471011739317;8826.161514656098;8909.73270801877;9037.322200835095;9038.322125840457;6505.674716264073;9319.767005824908;12786.680332991378;13603.523876664269;14074.085184462978;11605.767884642091;11706.356150411468;11738.237014594024;11826.34955077479;11910.940445297718;10607.363558186533;10687.358758474516;10935.945320273348;11177.385243811343;11268;11699.473523691284;11840.940795295968;12126.636200913987;12149.331786751813;12894.935525322313;8614.956925215334;8881.555922203994;9274.6290148396;9283.907160928304;9504.334696571173;8672.609732562176;10740.570377184826;11670.183087183816;11676.182667213554;11771.176017678681 10:09:43 INFO - PROCESS | 18385 | |3;mootools.html;1431.162769779679;1571.9764203536945;1594.3781925049234;1819.6815557277473;1914.9701316604392;8305.294050005748;8509.702160424378;8528.317734581235;8537.676660117677;8539.48763074216;8304.045034820998;8490.066092729794;8490.235878770909;8494.660213591464;8511.489310641366;2420.6006009008493;2435.6468312094735;2442.0598069743187;2443.8655873926928;2444.743301953296;2423.8060955123547;2446.571849926265;2471.3450935502105;2493.6633554470186;2498.1381423408984;2398.7766239218035;2407.879606019701;2415.553122672311;2427.5509030829353;2431.3313838694326;2435.2207293666033;2453.7791598756107;2465.938351541208;2470.8393954392996;2492.962605560918;2342.26218741096;2397.4725560376687;2482.218101298103;2493.5137648158616;2494.9875250623813;7342.118945726494;8089.757307280732;8599.183077607617;8606.526641034741;8648.437851539693;5169.56058735008;5293.179557168645;5338.706371149585;5340;5344.973275133639;3252.040648008843;3289.506574013893;3299.5215693724276;3308.735301175924;3373.03868397508;1044.1281529922524;1044.6448207609374;1062.0706881478707;1069.6092540122838;1076.1767248055244;12248.632541023784;12316.753664926651;12341.259524428562;12344.567940122142;12372.319522426264;4711.081339138835;4810.4467986182035;4827.444843842933;4858.5384388483035;4874.122657921608;9598.18415434682;9612.75968100803;9626.181774549243;9653.03469653029;9664.71005869825;5346.492083252085;5354.089804733205;5355.196720491879;5356.464353564613;5365.678059316453;4913.803447862046;4941.629377796679;5000.449950505442;5001.4998500149695;5008.69947803133;3773.132179598708;3786.9431958520645;3807.8476860925252;3836.0218144373007;3849.9807500962875;1136.5226604825993;1180.2328486483855;1181.8050021746487;1185.454690842205;1186.9703257418462;1048.632978457549;1074.8602681651334;1078.6063086973354;1079.1690398393193;1111.360967443723;6155.630662160284;6214.844628884223;6245.906311405332;6247.937850565415;6339;966.9516524173763;994.4033579852031;1000.1548691355792;1010.9191264698953;1092.830611255241;3809.5238095238096;4396.142752163298;4397.560243975641;4445.799939002753;4449.755263460476;10202.642907498202;10398.116160126474;10480.213983951235;10513.316634418738;10520.842187367196;10031.297809153435;10341.63804266847;10352.378857268588;10369.377837329785;10370.27408081427;8110.797230069295;8126.674933002614;8144.185581441927;8205.58972051395;8225.300849427746;5918.674472904032;6074.726637301421;6083.209182806207;6148.907766383597;6262.405071518198;9264.073592640681;9339.066093390607;9342.813143736952;9436.197923176607;9523.28575356837;9718.611255549698;9725.513724313614;9817.067378599022;9952.950235248778;9955.20358371343;7726.1501234863;7939.0870049945;7989.560574168477;8007.958965334469;8040;8024.117347091698;8092.4335296531035;8092.514449133071;8096.068952070587;8108.837823243384;7171.247019062923;7407.185209627044;7548.773536793905;7621.1997740236475;7722.266384693445;7277.708891644275;7430.405567554691;7431.554106753612;7511.9624401877645;7545.7358992435;7034.894476582753;7066.787996360117;7083.468739844429;7096.219415864354;7096.609686467087;4845.903081938412;4923.606111511142;5027.622928280467;5027.874303142305;5076.137056700443;4692.366530518337;5343.118385466354;5404.756785944721;5414.566834653139;5441.455854414527 10:09:43 INFO - PROCESS | 18385 | |4;prototype.html;346.5356422393992;350.07579988829485;351.43068229468264;352.57514694792775;354.52670684636024;6081.817545473637;6119.143319935207;6150.169727086842;6155.353687862772;6161.291451483081;6048.45563899249;6051.878962420749;6058.030715085587;6065;6069.726862291208;4513.435820522434;4560.8403705870305;4609.893625529882;4631.930521042187;4650.209464391045;4665.9066818663605;4668.43978722552;4670.136024835399;4699.060187962404;4703.553162449579;4493.303537951622;4660.137874493213;4682.391289132408;4685.83599574015;4687.390639216897;4569.565891240327;4584.472785629662;4590.724556526602;4683.711979205712;4698.741569213692;4130.690198235115;4134.524529679065;4143.854965076208;4144.772037537934;4153.854615088488;5842.649441033509;5846.678432686201;5853.560982926255;5854.882902341972;5859.003969325225;5435.1847222916485;5445.428230035829;5446.863828404282;5448.782048718086;5448.83653490396;6385.425311721968;6399.968000160016;6401.199850018747;6408.23101227851;6409.327020662857;4306.440162778818;4418.381426600278;4436.645068394553;4467.084247729208;4469;6524.314946930599;6602.1087153234175;6616.305287944745;6623.966880165616;6633.104530888365;4546.909061818745;4548.363229147922;4554.63562914966;4559.589636932692;4572.0855828834365;4604.58558729716;4613.930791038137;4615;4616.722996620147;4620.768961551909;5325.334333208349;5329.040772660881;5339.332583427072;5341;5344.358676958712;6190.7523699052435;6353.047042943503;6411.455026322721;6416.197975253093;6427.742890284337;1649.7442896351085;1657.2873664324457;1664.8501634852921;1667.5080851148698;1672.874534409924;1094.9671509854718;1095.5124969388546;1120.9495572699086;1126.6282126898104;1129.8192289233684;6098.298695649968;6227.813165605039;6262.09199666055;6283.497320214372;6283.654399008098;6585.275619681831;6667.43326817226;6676.46588272937;6678.165229346332;6692.230393504712;6378.043293506012;6391.488680905516;6395.392437718409;6400.39196276353;6407.359264073555;3545;3568.678818906311;3583.5699716033723;3586.677199052098;3588.300281445145;6826.863462730717;7080.433565314763;7083.079199704005;7103.964480177566;7105.573665580082;6762.83092922671;6794.932050679528;6795.2185498667295;6806.727730890808;6817.522773405814;7065.6113913735235;7072.434205263567;7079.681414336367;7085.751998680022;7093.077899872984;6671.499637527108;6679.833004174934;6682.9331706682315;6685.298043705341;6704.899426508704;6521.011091616912;6600.504962127764;6605.207375114825;6613.603183808987;6628.370304821035;7020.929790702027;7040.0847889774;7064.611446370499;7070.575765454089;7079.115110611174;4544.886377840448;4574.931376029429;4579.335996280587;4579.7252164870215;4586.334981427608;6655.101561289358;6655.633940133145;6665.633390163587;6666.100076489612;6666.333366663295;6319;6465.612063276219;6474.2878283387845;6480.675966201577;6486.837829054311;6438.6458744767615;6459.095726598374;6471.191101112361;6474.417302442803;6497.415232629086;6303.716332764945;6303.716332765129;6303.810885673437;6324.620522768649;6332.841678958063;6501.44737697301;6508.707108180049;6515.674216289071;6521.152250207632;6521.673916304071;5999.280086389661;6070.7875224366935;6341.619502829661;6341.619502829845;6351.745930162741 10:09:43 INFO - PROCESS | 18385 | |5;yui.html;832.3341326938448;862.4954401675018;887.5340446265714;901.6677389023606;905.1220316293197;14867.851321486782;14898.925505372485;14910.329035193416;14912.701745965074;14954.626134346647;13973.930130349334;14168.291585420713;14204.928975355135;14205;14206.289685515709;736.260058641065;858.459170722444;866.0300463480879;888.5601627194548;890.4434728294816;864.5072308783996;875.3609864798701;879.2789912271908;879.3536750488386;879.7228872905047;933.780561568031;939.3659279986016;939.8543225800012;939.9248060155171;940.6848705683605;780.4497829030548;921.2675922641516;936.0405584276103;942.0579420579421;945.5225111318808;684.5926673629183;689.1902015132199;692.3803196139477;692.9653517324164;693.0747452151384;14945.775813362809;15072.321745521478;15111.168885711282;15138.091714497166;15179.316930738143;14522.201278929655;14969.775453368207;15089;15104.697906041927;15106.848931510654;12498.625041248777;12595.05537084713;12666.49334026638;12677.239365637999;12689.873101268962;4097.8565750198895;4098.077932465201;4116.9794151029055;4144.48193975753;4156.729812562174;56718.71640641812;57213.713931430495;57419.13871291934;57505.42494575043;57557.424425755205;11650.475728592233;11922.403879806148;11981.341026243466;11986.041116710643;12229.205101668364;20798.79201207999;21040.894795525925;21051.78948210498;21088.894555527124;21102.894485527475;9113.498757568264;9125.269978401711;9152.8627070594;9267.304952128618;9529.428234305964;4990.30135780991;5053.393592768891;5086.9745651271505;5143.691378517301;5205.401378841406;3607.783532988029;3718.5165928429133;3719.1445967427644;3720.5535335759882;3722.274156539449;590.8611476303065;680.7753441364338;696.4846013949641;711.4415184080472;717.3543810570528;663.5090033375365;696.5646470955653;718.4360277182491;752.3041186902203;776.7126163319608;9909.603615855429;9925.50372481373;9964;10153.644622438327;10267.589296428208;770.379844225404;813.1868131868132;816.3795515408333;819.8606236939615;836.6862426590029;4707.319738162188;4722.740249286322;4830;4867.902641947141;4915.4347250065985;64515.67742161259;64597;68798;69626.30373696299;70419;58106.7094664524;59967;60056.39943600508;60711.69644151751;61929.69035154796;54140;54919;55076.72461637666;55083.44916550783;55217.72970383951;10325.63860264887;10349.586016559253;10454.215933804842;10484.161267098767;10670.519826607977;36809.263814724094;37214.62785372112;37664.81167594145;38447;39835.2032959345;46514.534854652375;48118;52347;53409.198862016325;53496;12245.081618878441;12728.363581821057;12817.371383036856;12820.551280705504;13161.210327380388;13110.803337949748;14458;14725.263736812902;14751;15205.771913421086;12704.618861434172;12770.169938953939;13265.469381224642;14098.36557354942;14116.576502704935;13157.342132893125;13484.932575337061;13624;13790.103643263557;13794.586162415144;11624.302541847515;12217.816732748837;12315.322657253579;12334.259944403364;12373.75252494963;11287.492062857355;11313.490892910004;11774.3524106175;11812.114091443003;12142.150049496804;10393.324433911772;10459;10964.342139471657;11028.448577570929;11106.167037472384 10:09:43 INFO - PROCESS | 18385 | __end_tp_report 10:09:43 INFO - PROCESS | 18385 | __start_cc_report 10:09:43 INFO - PROCESS | 18385 | _x_x_mozilla_cycle_collect,909 10:09:43 INFO - PROCESS | 18385 | __end_cc_report 10:09:43 INFO - PROCESS | 18385 | __startTimestamp1467133783452__endTimestamp 10:09:43 INFO - PROCESS | 18385 | 10:09:43 INFO - PROCESS | 18385 | ------- Summary: start ------- 10:09:43 INFO - PROCESS | 18385 | Number of tests: 6 10:09:43 INFO - PROCESS | 18385 | 10:09:43 INFO - PROCESS | 18385 | [#0] dojo.html Cycles:165 Average:5460.14 Median:5668.83 stddev:596.01 (10.5%) stddev-sans-first:572.61 10:09:43 INFO - PROCESS | 18385 | Values: 3272.7 3302.2 3351.6 3357.0 3406.6 5458.5 5476.0 5479.9 5488.6 5495.5 5461.8 5488.1 5493.1 5494.1 5527.2 4967.1 4990.1 5046.6 5086.8 5137.7 4955.0 4985.0 5046.1 5121.1 5165.1 5067.9 5102.8 5109.7 5113.6 5125.1 5031.9 5083.2 5096.2 5098.0 5112.9 4891.5 4915.4 4972.6 4993.8 4999.5 5395.8 5396.3 5406.2 5427.5 5429.3 5721.1 5869.9 5874.0 5875.2 5910.9 5883.1 5917.8 5930.6 5975.1 5987.2 5447.3 5450.0 5451.2 5451.2 5455.5 5846.6 5859.4 5912.7 5919.0 5981.4 5698.6 5702.5 5704.9 5723.2 5736.0 5783.7 5789.7 5792.2 5797.9 5803.6 5736.5 5749.3 5749.5 5765.3 5797.8 5850.2 5854.4 5867.4 5868.1 5868.4 4512.4 4514.6 4521.3 4521.3 4529.7 3957.5 4006.1 4024.0 4043.6 4045.7 5616.7 5626.4 5629.7 5637.4 5668.8 5707.2 5879.9 5880.2 5882.7 5884.4 5593.8 5664.2 5687.0 5722.3 5724.6 4916.3 4938.1 4938.5 4945.2 4979.4 6102.7 6112.3 6160.0 6162.0 6182.0 5891.5 5892.8 5893.1 5900.0 5905.2 6184.8 6194.1 6195.4 6197.4 6200.6 5710.0 5782.9 5792.2 5795.6 5839.6 5873.8 5899.9 5900.6 5900.9 5903.6 5727.5 5752.5 5753.0 5754.3 5756.6 5530.3 5714.8 5729.5 5775.5 5787.6 5602.6 5624.3 5630.4 5633.2 5634.2 5736.6 5763.9 5766.5 5767.2 5771.5 5456.9 5492.3 5541.4 5628.5 5638.9 10:09:43 INFO - PROCESS | 18385 | 10:09:43 INFO - PROCESS | 18385 | [#1] ext.html Cycles:180 Average:60949.29 Median:41498.88 stddev:119706.46 (288.5%) stddev-sans-first:119956.68 10:09:43 INFO - PROCESS | 18385 | Values: 657.6 665.5 665.9 675.8 738.9 32029.2 40610.0 41441.6 41465.4 41532.4 42867.4 43673.0 43684.0 43759.1 43785.3 8894.7 9043.3 9053.0 9054.9 9082.4 8844.7 8935.1 8961.2 8962.2 9253.0 9235.9 9299.3 9319.4 9324.7 9341.3 9172.2 9272.1 9272.5 9273.4 9282.3 9069.3 9172.4 9181.7 9181.9 9185.6 43020.1 43805.6 43842.3 43943.0 43958.1 3854.5 4006.7 4274.1 4372.6 4695.2 33485.7 33706.3 33918.2 34141.7 35339.3 4347.6 4383.8 4399.4 4400.7 4461.7 319398.0 319620.0 320385.0 320955.0 322112.0 64016.8 64142.4 64546.7 64555.7 64573.0 67986.0 71435.3 72741.6 72756.6 72863.3 18700.1 19049.6 19050.5 19058.4 19064.6 15127.5 15142.0 15191.6 15208.1 15213.0 21120.9 21193.8 21334.7 21358.1 21413.3 7556.0 7609.0 7710.1 7809.9 7830.3 1083.4 1166.0 1181.9 1203.1 1222.6 33416.5 34168.0 34384.8 34527.0 34557.8 1188.3 1237.2 1254.8 1317.6 1335.6 17240.0 17901.0 18033.8 18099.5 18206.3 526682.0 595294.0 598293.0 603396.0 604464.0 62381.4 63121.4 63380.4 63417.4 63832.0 1475.7 1496.3 1528.5 1554.4 1565.9 32352.0 33964.0 34118.3 34406.2 34468.5 50911.7 51618.2 51935.0 52077.0 52153.0 402119.0 402910.0 404699.0 405362.0 405502.0 28523.0 32125.0 32300.4 32337.5 32538.2 44316.3 44980.3 45320.0 46033.0 46111.3 38249.4 38670.6 38993.0 39742.6 42296.8 40103.8 40498.2 40638.0 41177.2 41434.0 40410.0 41643.8 41975.4 42356.2 42588.4 35733.3 36398.3 36631.5 36728.4 36746.3 28401.4 28450.9 28513.9 28703.3 28893.7 10:09:43 INFO - PROCESS | 18385 | 10:09:43 INFO - PROCESS | 18385 | [#2] jquery.html Cycles:180 Average:29220.15 Median:13131.58 stddev:82584.61 (628.9%) stddev-sans-first:82787.98 10:09:43 INFO - PROCESS | 18385 | Values: 427.8 440.8 446.8 449.5 463.2 18172.2 18742.9 19250.8 19293.0 19300.1 18770.2 18914.8 20068.3 20114.2 20127.0 5701.7 5705.7 5903.4 5914.4 5917.5 4937.1 4938.1 4951.1 4953.1 4973.3 4836.9 4930.0 4933.3 5634.2 5869.6 5836.4 5847.9 5854.5 5888.6 5899.9 5127.1 5291.4 5304.4 5318.3 5327.5 23016.7 23081.4 23249.7 23320.5 23657.3 2605.9 2710.3 3051.3 3108.2 3290.8 14491.1 14496.9 14669.6 14694.9 14742.3 1988.1 2039.5 2050.7 2085.3 2137.6 80019.0 80986.6 83051.6 83563.6 83639.0 10871.6 11535.4 11550.4 11577.6 11626.7 16362.7 16560.3 16574.8 16578.6 16604.6 8780.3 8857.6 8866.5 8994.6 9048.8 8549.2 8578.1 8668.2 8674.3 8753.5 6903.1 7031.2 7031.5 7058.5 7069.6 1997.3 2030.6 2033.5 2076.8 2098.8 998.8 1037.4 1068.7 1108.0 1240.3 18028.5 18367.6 18920.0 19825.4 19961.9 1125.2 1136.6 1157.5 1196.3 1214.1 11238.7 11483.1 11498.3 11510.5 11528.4 495429.0 496960.0 501251.0 506409.0 512668.0 83742.6 85048.0 86106.0 86383.6 86894.6 1110.8 1123.0 1126.1 1128.1 1128.9 17008.6 17199.3 17240.5 17360.0 17509.6 37345.4 38194.2 38208.4 39039.6 39134.2 51281.7 53686.5 53782.7 53791.5 54037.7 8816.5 8826.2 8909.7 9037.3 9038.3 6505.7 9319.8 12786.7 13603.5 14074.1 11605.8 11706.4 11738.2 11826.3 11910.9 10607.4 10687.4 10935.9 11177.4 11268.0 11699.5 11840.9 12126.6 12149.3 12894.9 8615.0 8881.6 9274.6 9283.9 9504.3 8672.6 10740.6 11670.2 11676.2 11771.2 10:09:43 INFO - PROCESS | 18385 | 10:09:43 INFO - PROCESS | 18385 | [#3] mootools.html Cycles:180 Average:5720.39 Median:5018.16 stddev:3123.89 (62.3%) stddev-sans-first:3116.02 10:09:43 INFO - PROCESS | 18385 | Values: 1431.2 1572.0 1594.4 1819.7 1915.0 8305.3 8509.7 8528.3 8537.7 8539.5 8304.0 8490.1 8490.2 8494.7 8511.5 2420.6 2435.6 2442.1 2443.9 2444.7 2423.8 2446.6 2471.3 2493.7 2498.1 2398.8 2407.9 2415.6 2427.6 2431.3 2435.2 2453.8 2465.9 2470.8 2493.0 2342.3 2397.5 2482.2 2493.5 2495.0 7342.1 8089.8 8599.2 8606.5 8648.4 5169.6 5293.2 5338.7 5340.0 5345.0 3252.0 3289.5 3299.5 3308.7 3373.0 1044.1 1044.6 1062.1 1069.6 1076.2 12248.6 12316.8 12341.3 12344.6 12372.3 4711.1 4810.4 4827.4 4858.5 4874.1 9598.2 9612.8 9626.2 9653.0 9664.7 5346.5 5354.1 5355.2 5356.5 5365.7 4913.8 4941.6 5000.4 5001.5 5008.7 3773.1 3786.9 3807.8 3836.0 3850.0 1136.5 1180.2 1181.8 1185.5 1187.0 1048.6 1074.9 1078.6 1079.2 1111.4 6155.6 6214.8 6245.9 6247.9 6339.0 967.0 994.4 1000.2 1010.9 1092.8 3809.5 4396.1 4397.6 4445.8 4449.8 10202.6 10398.1 10480.2 10513.3 10520.8 10031.3 10341.6 10352.4 10369.4 10370.3 8110.8 8126.7 8144.2 8205.6 8225.3 5918.7 6074.7 6083.2 6148.9 6262.4 9264.1 9339.1 9342.8 9436.2 9523.3 9718.6 9725.5 9817.1 9953.0 9955.2 7726.2 7939.1 7989.6 8008.0 8040.0 8024.1 8092.4 8092.5 8096.1 8108.8 7171.2 7407.2 7548.8 7621.2 7722.3 7277.7 7430.4 7431.6 7512.0 7545.7 7034.9 7066.8 7083.5 7096.2 7096.6 4845.9 4923.6 5027.6 5027.9 5076.1 4692.4 5343.1 5404.8 5414.6 5441.5 10:09:43 INFO - PROCESS | 18385 | 10:09:43 INFO - PROCESS | 18385 | [#4] prototype.html Cycles:180 Average:5413.63 Median:6152.76 stddev:1635.80 (26.6%) stddev-sans-first:1595.56 10:09:43 INFO - PROCESS | 18385 | Values: 346.5 350.1 351.4 352.6 354.5 6081.8 6119.1 6150.2 6155.4 6161.3 6048.5 6051.9 6058.0 6065.0 6069.7 4513.4 4560.8 4609.9 4631.9 4650.2 4665.9 4668.4 4670.1 4699.1 4703.6 4493.3 4660.1 4682.4 4685.8 4687.4 4569.6 4584.5 4590.7 4683.7 4698.7 4130.7 4134.5 4143.9 4144.8 4153.9 5842.6 5846.7 5853.6 5854.9 5859.0 5435.2 5445.4 5446.9 5448.8 5448.8 6385.4 6400.0 6401.2 6408.2 6409.3 4306.4 4418.4 4436.6 4467.1 4469.0 6524.3 6602.1 6616.3 6624.0 6633.1 4546.9 4548.4 4554.6 4559.6 4572.1 4604.6 4613.9 4615.0 4616.7 4620.8 5325.3 5329.0 5339.3 5341.0 5344.4 6190.8 6353.0 6411.5 6416.2 6427.7 1649.7 1657.3 1664.9 1667.5 1672.9 1095.0 1095.5 1120.9 1126.6 1129.8 6098.3 6227.8 6262.1 6283.5 6283.7 6585.3 6667.4 6676.5 6678.2 6692.2 6378.0 6391.5 6395.4 6400.4 6407.4 3545.0 3568.7 3583.6 3586.7 3588.3 6826.9 7080.4 7083.1 7104.0 7105.6 6762.8 6794.9 6795.2 6806.7 6817.5 7065.6 7072.4 7079.7 7085.8 7093.1 6671.5 6679.8 6682.9 6685.3 6704.9 6521.0 6600.5 6605.2 6613.6 6628.4 7020.9 7040.1 7064.6 7070.6 7079.1 4544.9 4574.9 4579.3 4579.7 4586.3 6655.1 6655.6 6665.6 6666.1 6666.3 6319.0 6465.6 6474.3 6480.7 6486.8 6438.6 6459.1 6471.2 6474.4 6497.4 6303.7 6303.7 6303.8 6324.6 6332.8 6501.4 6508.7 6515.7 6521.2 6521.7 5999.3 6070.8 6341.6 6341.6 6351.7 10:09:43 INFO - PROCESS | 18385 | 10:09:43 INFO - PROCESS | 18385 | [#5] yui.html Cycles:180 Average:16027.72 Median:4150.61 stddev:18617.92 (448.6%) stddev-sans-first:18635.18 10:09:43 INFO - PROCESS | 18385 | Values: 832.3 862.5 887.5 901.7 905.1 14867.9 14898.9 14910.3 14912.7 14954.6 13973.9 14168.3 14204.9 14205.0 14206.3 736.3 858.5 866.0 888.6 890.4 864.5 875.4 879.3 879.4 879.7 933.8 939.4 939.9 939.9 940.7 780.4 921.3 936.0 942.1 945.5 684.6 689.2 692.4 693.0 693.1 14945.8 15072.3 15111.2 15138.1 15179.3 14522.2 14969.8 15089.0 15104.7 15106.8 12498.6 12595.1 12666.5 12677.2 12689.9 4097.9 4098.1 4117.0 4144.5 4156.7 56718.7 57213.7 57419.1 57505.4 57557.4 11650.5 11922.4 11981.3 11986.0 12229.2 20798.8 21040.9 21051.8 21088.9 21102.9 9113.5 9125.3 9152.9 9267.3 9529.4 4990.3 5053.4 5087.0 5143.7 5205.4 3607.8 3718.5 3719.1 3720.6 3722.3 590.9 680.8 696.5 711.4 717.4 663.5 696.6 718.4 752.3 776.7 9909.6 9925.5 9964.0 10153.6 10267.6 770.4 813.2 816.4 819.9 836.7 4707.3 4722.7 4830.0 4867.9 4915.4 64515.7 64597.0 68798.0 69626.3 70419.0 58106.7 59967.0 60056.4 60711.7 61929.7 54140.0 54919.0 55076.7 55083.4 55217.7 10325.6 10349.6 10454.2 10484.2 10670.5 36809.3 37214.6 37664.8 38447.0 39835.2 46514.5 48118.0 52347.0 53409.2 53496.0 12245.1 12728.4 12817.4 12820.6 13161.2 13110.8 14458.0 14725.3 14751.0 15205.8 12704.6 12770.2 13265.5 14098.4 14116.6 13157.3 13484.9 13624.0 13790.1 13794.6 11624.3 12217.8 12315.3 12334.3 12373.8 11287.5 11313.5 11774.4 11812.1 12142.2 10393.3 10459.0 10964.3 11028.4 11106.2 10:09:43 INFO - PROCESS | 18385 | -------- Summary: end -------- 10:09:43 INFO - PROCESS | 18385 | 10:09:44 INFO - TEST-INFO | 18385: exit 0 10:09:44 INFO - TEST-OK | dromaeo_css | took 1110622ms 10:09:44 INFO - TEST-START | kraken 10:09:44 INFO - operating with platform_type : linux_ 10:09:44 INFO - Initialising browser for kraken test... 10:09:44 INFO - TEST-INFO | started process 18576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpov4jnd/profile http://localhost:56420/getInfo.html) 10:09:48 INFO - PROCESS | 18576 | __metrics Screen width/height:1600/1200 10:09:48 INFO - PROCESS | 18576 | colorDepth:24 10:09:48 INFO - PROCESS | 18576 | Browser inner width/height: 1024/697 10:09:48 INFO - PROCESS | 18576 | __metrics 10:09:49 ERROR - PROCESS | 18576 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:09:50 INFO - TEST-INFO | 18576: exit 0 10:09:50 INFO - Browser initialized. 10:09:50 INFO - Running cycle 1/1 for kraken test... 10:09:50 INFO - TEST-INFO | started process 18670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpov4jnd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:01 INFO - PROCESS | 18670 | RSS: Main: 139767808 10:10:01 INFO - PROCESS | 18670 | 10:10:04 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56420/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:05 INFO - PROCESS | 18670 | RSS: Main: 197603328 10:10:05 INFO - PROCESS | 18670 | 10:10:07 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56420/tests/kraken/driver.html?testName=audio-dft) 10:10:08 INFO - PROCESS | 18670 | RSS: Main: 185348096 10:10:08 INFO - PROCESS | 18670 | 10:10:11 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56420/tests/kraken/driver.html?testName=audio-fft) 10:10:11 INFO - PROCESS | 18670 | RSS: Main: 274636800 10:10:11 INFO - PROCESS | 18670 | 10:10:13 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56420/tests/kraken/driver.html?testName=audio-oscillator) 10:10:14 INFO - PROCESS | 18670 | RSS: Main: 181350400 10:10:14 INFO - PROCESS | 18670 | 10:10:16 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:10:17 INFO - PROCESS | 18670 | RSS: Main: 179359744 10:10:17 INFO - PROCESS | 18670 | 10:10:20 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56420/tests/kraken/driver.html?testName=imaging-darkroom) 10:10:20 INFO - PROCESS | 18670 | RSS: Main: 213848064 10:10:20 INFO - PROCESS | 18670 | 10:10:24 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56420/tests/kraken/driver.html?testName=imaging-desaturate) 10:10:24 INFO - PROCESS | 18670 | RSS: Main: 213569536 10:10:24 INFO - PROCESS | 18670 | 10:10:27 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56420/tests/kraken/driver.html?testName=json-parse-financial) 10:10:27 INFO - PROCESS | 18670 | RSS: Main: 213999616 10:10:27 INFO - PROCESS | 18670 | 10:10:29 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:10:30 INFO - PROCESS | 18670 | RSS: Main: 195641344 10:10:30 INFO - PROCESS | 18670 | 10:10:31 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56420/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:10:32 INFO - PROCESS | 18670 | RSS: Main: 200482816 10:10:32 INFO - PROCESS | 18670 | 10:10:34 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:10:35 INFO - PROCESS | 18670 | RSS: Main: 209936384 10:10:35 INFO - PROCESS | 18670 | 10:10:37 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:10:37 INFO - PROCESS | 18670 | RSS: Main: 217112576 10:10:37 INFO - PROCESS | 18670 | 10:10:40 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:10:41 INFO - PROCESS | 18670 | RSS: Main: 212439040 10:10:41 INFO - PROCESS | 18670 | 10:10:42 INFO - PROCESS | 18670 | Cycle 1(1): loaded http://localhost:56420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56420/tests/kraken/driver.html?testName=ai-astar) 10:10:43 INFO - PROCESS | 18670 | RSS: Main: 273367040 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | __start_tp_report 10:10:43 INFO - PROCESS | 18670 | _x_x_mozilla_page_load 10:10:43 INFO - PROCESS | 18670 | _x_x_mozilla_page_load_details 10:10:43 INFO - PROCESS | 18670 | |i|pagename|runs| 10:10:43 INFO - PROCESS | 18670 | |0;ai-astar;111;110;109;109;111;110;105;108;110;112 10:10:43 INFO - PROCESS | 18670 | |1;audio-beat-detection;157;126;155;170;128;157;171;127;179;131 10:10:43 INFO - PROCESS | 18670 | |2;audio-dft;160;160;160;159;160;159;160;161;161;161 10:10:43 INFO - PROCESS | 18670 | |3;audio-fft;76;76;77;180;76;76;73;76;167;76 10:10:43 INFO - PROCESS | 18670 | |4;audio-oscillator;91;91;157;92;91;93;145;91;92;158 10:10:43 INFO - PROCESS | 18670 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;118;117 10:10:43 INFO - PROCESS | 18670 | |6;imaging-darkroom;146;145;146;147;146;146;145;147;146;146 10:10:43 INFO - PROCESS | 18670 | |7;imaging-desaturate;94;94;95;94;94;95;94;94;94;95 10:10:43 INFO - PROCESS | 18670 | |8;json-parse-financial;54;54;55;55;55;53;56;73;53;53 10:10:43 INFO - PROCESS | 18670 | |9;json-stringify-tinderbox;58;60;58;58;58;59;58;60;59;60 10:10:43 INFO - PROCESS | 18670 | |10;stanford-crypto-aes;73;79;72;72;73;79;72;72;73;71 10:10:43 INFO - PROCESS | 18670 | |11;stanford-crypto-ccm;119;119;112;111;110;113;114;114;126;130 10:10:43 INFO - PROCESS | 18670 | |12;stanford-crypto-pbkdf2;159;155;155;161;154;163;158;163;153;153 10:10:43 INFO - PROCESS | 18670 | |13;stanford-crypto-sha256-iterative;68;65;64;73;65;65;74;64;64;64 10:10:43 INFO - PROCESS | 18670 | __end_tp_report 10:10:43 INFO - PROCESS | 18670 | __start_cc_report 10:10:43 INFO - PROCESS | 18670 | _x_x_mozilla_cycle_collect,1593 10:10:43 INFO - PROCESS | 18670 | __end_cc_report 10:10:43 INFO - PROCESS | 18670 | __startTimestamp1467133843146__endTimestamp 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | ------- Summary: start ------- 10:10:43 INFO - PROCESS | 18670 | Number of tests: 14 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.96 (1.8%) stddev-sans-first:2.00 10:10:43 INFO - PROCESS | 18670 | Values: 111.0 110.0 109.0 109.0 111.0 110.0 105.0 108.0 110.0 112.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:157.00 stddev:20.43 (13.0%) stddev-sans-first:21.51 10:10:43 INFO - PROCESS | 18670 | Values: 157.0 126.0 155.0 170.0 128.0 157.0 171.0 127.0 179.0 131.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:10:43 INFO - PROCESS | 18670 | Values: 160.0 160.0 160.0 159.0 160.0 159.0 160.0 161.0 161.0 161.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:41.34 (54.4%) stddev-sans-first:43.26 10:10:43 INFO - PROCESS | 18670 | Values: 76.0 76.0 77.0 180.0 76.0 76.0 73.0 76.0 167.0 76.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:91.00 stddev:30.03 (33.0%) stddev-sans-first:31.05 10:10:43 INFO - PROCESS | 18670 | Values: 91.0 91.0 157.0 92.0 91.0 93.0 145.0 91.0 92.0 158.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 10:10:43 INFO - PROCESS | 18670 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:10:43 INFO - PROCESS | 18670 | Values: 146.0 145.0 146.0 147.0 146.0 146.0 145.0 147.0 146.0 146.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:10:43 INFO - PROCESS | 18670 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:6.03 (11.0%) stddev-sans-first:6.34 10:10:43 INFO - PROCESS | 18670 | Values: 54.0 54.0 55.0 55.0 55.0 53.0 56.0 73.0 53.0 53.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 10:10:43 INFO - PROCESS | 18670 | Values: 58.0 60.0 58.0 58.0 58.0 59.0 58.0 60.0 59.0 60.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#10] stanford-crypto-aes Cycles:10 Average:73.60 Median:73.00 stddev:2.91 (4.0%) stddev-sans-first:3.08 10:10:43 INFO - PROCESS | 18670 | Values: 73.0 79.0 72.0 72.0 73.0 79.0 72.0 72.0 73.0 71.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:116.50 stddev:6.68 (5.7%) stddev-sans-first:7.04 10:10:43 INFO - PROCESS | 18670 | Values: 119.0 119.0 112.0 111.0 110.0 113.0 114.0 114.0 126.0 130.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:158.50 stddev:3.95 (2.5%) stddev-sans-first:4.15 10:10:43 INFO - PROCESS | 18670 | Values: 159.0 155.0 155.0 161.0 154.0 163.0 158.0 163.0 153.0 153.0 10:10:43 INFO - PROCESS | 18670 | 10:10:43 INFO - PROCESS | 18670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:65.00 stddev:3.84 (5.9%) stddev-sans-first:4.03 10:10:43 INFO - PROCESS | 18670 | Values: 68.0 65.0 64.0 73.0 65.0 65.0 74.0 64.0 64.0 64.0 10:10:43 INFO - PROCESS | 18670 | -------- Summary: end -------- 10:10:43 INFO - PROCESS | 18670 | 10:10:44 INFO - TEST-INFO | 18670: exit 0 10:10:44 INFO - TEST-OK | kraken | took 59928ms 10:10:44 INFO - SUITE-END | took 1170s 10:10:44 INFO - Completed test suite (00:19:30) 10:10:44 INFO - javascript benchmark 10:10:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.6563710810365, 3302.1579497228204, 3351.631320554737, 3356.966430335696, 3406.642302558231, 5458.5087342139195, 5475.972620136904, 5479.863003424916, 5488.615796894214, 5495.450454954503, 5461.808836690717, 5488.094464413377, 5493.148561972891, 5494.0934745767, 5527.226188333637, 4967.105920934239, 4990.101781679296, 5046.571041461461, 5086.79652813887, 5137.691738495683, 4954.97522512387, 4985.0, 5046.066477701637, 5121.052605268019, 5165.121929272014, 5067.873303167414, 5102.846914592568, 5109.744512774347, 5113.616478764107, 5125.077486052509, 5031.874203144914, 5083.237514372837, 5096.1846104623455, 5097.974510127426, 5112.872178195537, 4891.510848915115, 4915.361003069614, 4972.577330926875, 4993.7503124843615, 4999.475055119196, 5395.81114660985, 5396.298481197419, 5406.216098665672, 5427.538659213932, 5429.267048948381, 5721.084626459747, 5869.941300586982, 5874.030784920483, 5875.177475153482, 5910.911336329916, 5883.14694369314, 5917.763289468416, 5930.644161350333, 5975.133605627159, 5987.191729116557, 5447.319085114361, 5450.018996580614, 5451.155070964007, 5451.182322651634, 5455.509004189602, 5846.649201047951, 5859.355470898283, 5912.704364781744, 5919.023361145363, 5981.431763982415, 5698.629589076697, 5702.45826646468, 5704.8859022819315, 5723.170140329629, 5736.0, 5783.652980821164, 5789.681567513743, 5792.21805056312, 5797.88404231913, 5803.622764520293, 5736.483716465538, 5749.252597162342, 5749.482546570829, 5765.308163020464, 5797.797077102281, 5850.23946886902, 5854.443827836349, 5867.442592953663, 5868.061110222344, 5868.383819698955, 4512.368268442421, 4514.61625761814, 4521.321801729767, 4521.344405061313, 4529.660275479352, 3957.485526881487, 4006.0585762345827, 4024.0, 4043.595640435933, 4045.7167998239843, 5616.66300022, 5626.43735626434, 5629.690367029771, 5637.408072152365, 5668.829935101953, 5707.172459993278, 5879.853003674943, 5880.176775251468, 5882.676452795052, 5884.382139875252, 5593.8321850344555, 5664.235328230719, 5687.0, 5722.284714410699, 5724.599278050579, 4916.311716359713, 4938.061768264019, 4938.530839570235, 4945.23348880924, 4979.3526841510375, 6102.69486525672, 6112.2970858351855, 6159.969200153971, 6161.96919015411, 6182.0, 5891.528677705859, 5892.7642894283745, 5893.057110862413, 5899.970500147472, 5905.202797622438, 6184.752609895554, 6194.101855231056, 6195.380461953769, 6197.442230199304, 6200.596961197508, 5709.9714501427225, 5782.913256301243, 5792.160136780228, 5795.59430839854, 5839.562032847638, 5873.765049397976, 5899.941000590111, 5900.616459930091, 5900.911486327623, 5903.645781253139, 5727.45589169045, 5752.539796816161, 5753.0, 5754.338251101177, 5756.625819321731, 5530.253415788817, 5714.79998200061, 5729.54163666914, 5775.451332123442, 5787.623804452697, 5602.607817452739, 5624.3250809903075, 5630.380658127685, 5633.2395126657375, 5634.23937768396, 5736.627119237236, 5763.9135412968, 5766.509846662912, 5767.192593037062, 5771.538276937918, 5456.91814622773, 5492.286002819608, 5541.445855414588, 5628.549716022627, 5638.887222255614], "value": 5422.146382219844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.6218674262298, 665.4809248785946, 665.8601693644334, 675.793882865726, 738.8965544823726, 32029.19927001823, 40610.0, 41441.58558414415, 41465.378019329735, 41532.37701434477, 42867.35698964518, 43673.0, 43684.0, 43759.12481750363, 43785.343219851726, 8894.733158005254, 9043.276537876987, 9053.0, 9054.909450905472, 9082.409643373192, 8844.690435834747, 8935.106489351077, 8961.193492585666, 8962.238209752179, 9252.953735231315, 9235.907640923606, 9299.30255230857, 9319.440833549976, 9324.720258392259, 9341.252699784001, 9172.2203612693, 9272.07279272074, 9272.536373181347, 9273.350865439423, 9282.257419406431, 9069.31980101495, 9172.357934944557, 9181.724548263563, 9181.908180918172, 9185.632574697003, 43020.13959720788, 43805.56194438079, 43842.342364864555, 43943.0, 43958.12083758307, 3854.479645247912, 4006.7395619284653, 4274.123804620045, 4372.584604462571, 4695.248760198352, 33485.665143348495, 33706.32587348239, 33918.152046199044, 34141.65858341409, 35339.29321413583, 4347.608715215646, 4383.846565370229, 4399.406080179167, 4400.713953593038, 4461.732296062247, 319398.0, 319620.0, 320385.0, 320955.0, 322112.0, 64016.79916004181, 64142.358576414576, 64546.67726661337, 64555.677221613594, 64573.0, 67986.0, 71435.28564714287, 72741.6362918182, 72756.63621681857, 72863.27136728671, 18700.06499675011, 19049.61900761977, 19050.52373690669, 19058.42824715261, 19064.61870762577, 15127.54617361481, 15142.015768975201, 15191.62020949463, 15208.08751474915, 15213.0, 21120.89439552823, 21193.78806211918, 21334.679979800316, 21358.145674172858, 21413.250536231157, 7556.034353772072, 7609.0, 7710.0701733340975, 7809.921900781033, 7830.334421574116, 1083.3878858444953, 1165.959191428296, 1181.8877206665354, 1203.0976767424431, 1222.572099765075, 33416.49875251873, 34168.0, 34384.82807585946, 34526.96419107431, 34557.827210864285, 1188.2692144331174, 1237.2283298412983, 1254.7804134276464, 1317.5652034828674, 1335.5859683498147, 17240.0, 17901.0, 18033.819661803478, 18099.457016289532, 18206.271749130152, 526682.0, 595294.0, 598293.0, 603396.0, 604464.0, 62381.37618623846, 63121.36878631155, 63380.36619633745, 63417.365826342066, 63832.0, 1475.6901050779243, 1496.304218538385, 1528.5108765195253, 1554.3704799556424, 1565.8747300215955, 32352.0, 33964.0, 34118.31763364768, 34406.19321434755, 34468.48297275593, 50911.74544127404, 51618.22572661338, 51935.0, 52077.0, 52153.0, 402119.0, 402910.0, 404699.0, 405362.0, 405502.0, 28523.0, 32125.0, 32300.35399292048, 32337.51493727549, 32538.186545336557, 44316.33525497056, 44980.325295121256, 45320.0, 46033.0, 46111.308330375745, 38249.426258605585, 38670.6132938667, 38993.0, 39742.60257397505, 42296.788516057226, 40103.79948100241, 40498.1900361997, 40638.0, 41177.1764564701, 41434.0, 40410.0, 41643.7917810409, 41975.370369445096, 42356.15287694167, 42588.36117458303, 35733.28533429369, 36398.27203455969, 36631.45052824263, 36728.449073264455, 36746.26507469889, 28401.43197136087, 28450.85774571114, 28513.857430712713, 28703.282417939718, 28893.711062889943], "value": 21169.947271350415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.809624717001, 440.83909373078814, 446.8346711716665, 449.5010538302484, 463.19404236628253, 18172.18225179867, 18742.90628546857, 19250.786159591633, 19293.0, 19300.131494082765, 18770.249190032417, 18914.810851891478, 20068.297609583668, 20114.195432182732, 20127.0, 5701.743421546041, 5705.65766054036, 5903.409659034084, 5914.4381283777975, 5917.467427931485, 4937.086638971802, 4938.086454006002, 4951.133551628469, 4953.0589188054155, 4973.278874563204, 4836.854894353175, 4929.975350123263, 4933.309336692866, 5634.239377684022, 5869.589128760988, 5836.416358364151, 5847.912281315784, 5854.502367298742, 5888.64668119912, 5899.941000590004, 5127.102757017507, 5291.417944026154, 5304.416514183436, 5318.282031925679, 5327.520523152896, 23016.65475017876, 23081.422964425856, 23249.651255231183, 23320.533589328286, 23657.29028129159, 2605.8697065146666, 2710.268227578543, 3051.252443151442, 3108.2384815720065, 3290.7696461247724, 14491.130532167997, 14496.85503144976, 14669.559913202622, 14694.853051469456, 14742.262886855615, 1988.0656091636909, 2039.51051747581, 2050.6718924971933, 2085.2805782005184, 2137.6045431595203, 80019.0, 80986.59506702429, 83051.5847420765, 83563.5821820893, 83639.0, 10871.619493317696, 11535.423228838525, 11550.364729939765, 11577.594784182513, 11626.651200463999, 16362.672746545002, 16560.254788534545, 16574.751378729088, 16578.58553536147, 16604.58488537796, 8780.297576193889, 8857.582786754088, 8866.512341821133, 8994.550272486349, 9048.819023619491, 8549.230569248797, 8578.142185781497, 8668.176523230282, 8674.349423793241, 8753.518556479328, 6903.068085808452, 7031.226565077837, 7031.472639552054, 7058.541194822423, 7069.646517674199, 1997.3209108903043, 2030.6243344981226, 2033.4509682385674, 2076.802703743142, 2098.7586427560723, 998.7852611688522, 1037.3568387599737, 1068.6633710381204, 1107.972300692473, 1240.2682417373792, 18028.549286267687, 18367.632647346978, 18919.959402232733, 19825.405237842886, 19961.900190498956, 1125.1673761416494, 1136.5737848306885, 1157.4849192109598, 1196.3360335013977, 1214.0833670578656, 11238.66284011481, 11483.13876459269, 11498.310101393943, 11510.482028308747, 11528.423578821026, 495429.0, 496960.0, 501251.0, 506409.0, 512668.0, 83742.58128709317, 85048.0, 86106.0, 86383.56808215918, 86894.56552717322, 1110.783397237547, 1123.02858027807, 1126.1047467263545, 1128.0975219824109, 1128.949197286124, 17008.57478563046, 17199.312027518758, 17240.482785516455, 17360.0, 17509.649807004043, 37345.43981840329, 38194.236115278094, 38208.42687359636, 39039.6096039036, 39134.217315654096, 51281.743591283295, 53686.46313536815, 53782.73108634432, 53791.46208537865, 54037.72981135069, 8816.471011739317, 8826.161514656098, 8909.73270801877, 9037.322200835095, 9038.322125840457, 6505.674716264073, 9319.767005824908, 12786.680332991378, 13603.523876664269, 14074.085184462978, 11605.767884642091, 11706.356150411468, 11738.237014594024, 11826.34955077479, 11910.940445297718, 10607.363558186533, 10687.358758474516, 10935.945320273348, 11177.385243811343, 11268.0, 11699.473523691284, 11840.940795295968, 12126.636200913987, 12149.331786751813, 12894.935525322313, 8614.956925215334, 8881.555922203994, 9274.6290148396, 9283.907160928304, 9504.334696571173, 8672.609732562176, 10740.570377184826, 11670.183087183816, 11676.182667213554, 11771.176017678681], "value": 9568.554951797929, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.162769779679, 1571.9764203536945, 1594.3781925049234, 1819.6815557277473, 1914.9701316604392, 8305.294050005748, 8509.702160424378, 8528.317734581235, 8537.676660117677, 8539.48763074216, 8304.045034820998, 8490.066092729794, 8490.235878770909, 8494.660213591464, 8511.489310641366, 2420.6006009008493, 2435.6468312094735, 2442.0598069743187, 2443.8655873926928, 2444.743301953296, 2423.8060955123547, 2446.571849926265, 2471.3450935502105, 2493.6633554470186, 2498.1381423408984, 2398.7766239218035, 2407.879606019701, 2415.553122672311, 2427.5509030829353, 2431.3313838694326, 2435.2207293666033, 2453.7791598756107, 2465.938351541208, 2470.8393954392996, 2492.962605560918, 2342.26218741096, 2397.4725560376687, 2482.218101298103, 2493.5137648158616, 2494.9875250623813, 7342.118945726494, 8089.757307280732, 8599.183077607617, 8606.526641034741, 8648.437851539693, 5169.56058735008, 5293.179557168645, 5338.706371149585, 5340.0, 5344.973275133639, 3252.040648008843, 3289.506574013893, 3299.5215693724276, 3308.735301175924, 3373.03868397508, 1044.1281529922524, 1044.6448207609374, 1062.0706881478707, 1069.6092540122838, 1076.1767248055244, 12248.632541023784, 12316.753664926651, 12341.259524428562, 12344.567940122142, 12372.319522426264, 4711.081339138835, 4810.4467986182035, 4827.444843842933, 4858.5384388483035, 4874.122657921608, 9598.18415434682, 9612.75968100803, 9626.181774549243, 9653.03469653029, 9664.71005869825, 5346.492083252085, 5354.089804733205, 5355.196720491879, 5356.464353564613, 5365.678059316453, 4913.803447862046, 4941.629377796679, 5000.449950505442, 5001.4998500149695, 5008.69947803133, 3773.132179598708, 3786.9431958520645, 3807.8476860925252, 3836.0218144373007, 3849.9807500962875, 1136.5226604825993, 1180.2328486483855, 1181.8050021746487, 1185.454690842205, 1186.9703257418462, 1048.632978457549, 1074.8602681651334, 1078.6063086973354, 1079.1690398393193, 1111.360967443723, 6155.630662160284, 6214.844628884223, 6245.906311405332, 6247.937850565415, 6339.0, 966.9516524173763, 994.4033579852031, 1000.1548691355792, 1010.9191264698953, 1092.830611255241, 3809.5238095238096, 4396.142752163298, 4397.560243975641, 4445.799939002753, 4449.755263460476, 10202.642907498202, 10398.116160126474, 10480.213983951235, 10513.316634418738, 10520.842187367196, 10031.297809153435, 10341.63804266847, 10352.378857268588, 10369.377837329785, 10370.27408081427, 8110.797230069295, 8126.674933002614, 8144.185581441927, 8205.58972051395, 8225.300849427746, 5918.674472904032, 6074.726637301421, 6083.209182806207, 6148.907766383597, 6262.405071518198, 9264.073592640681, 9339.066093390607, 9342.813143736952, 9436.197923176607, 9523.28575356837, 9718.611255549698, 9725.513724313614, 9817.067378599022, 9952.950235248778, 9955.20358371343, 7726.1501234863, 7939.0870049945, 7989.560574168477, 8007.958965334469, 8040.0, 8024.117347091698, 8092.4335296531035, 8092.514449133071, 8096.068952070587, 8108.837823243384, 7171.247019062923, 7407.185209627044, 7548.773536793905, 7621.1997740236475, 7722.266384693445, 7277.708891644275, 7430.405567554691, 7431.554106753612, 7511.9624401877645, 7545.7358992435, 7034.894476582753, 7066.787996360117, 7083.468739844429, 7096.219415864354, 7096.609686467087, 4845.903081938412, 4923.606111511142, 5027.622928280467, 5027.874303142305, 5076.137056700443, 4692.366530518337, 5343.118385466354, 5404.756785944721, 5414.566834653139, 5441.455854414527], "value": 4647.5243871798775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.5356422393992, 350.07579988829485, 351.43068229468264, 352.57514694792775, 354.52670684636024, 6081.817545473637, 6119.143319935207, 6150.169727086842, 6155.353687862772, 6161.291451483081, 6048.45563899249, 6051.878962420749, 6058.030715085587, 6065.0, 6069.726862291208, 4513.435820522434, 4560.8403705870305, 4609.893625529882, 4631.930521042187, 4650.209464391045, 4665.9066818663605, 4668.43978722552, 4670.136024835399, 4699.060187962404, 4703.553162449579, 4493.303537951622, 4660.137874493213, 4682.391289132408, 4685.83599574015, 4687.390639216897, 4569.565891240327, 4584.472785629662, 4590.724556526602, 4683.711979205712, 4698.741569213692, 4130.690198235115, 4134.524529679065, 4143.854965076208, 4144.772037537934, 4153.854615088488, 5842.649441033509, 5846.678432686201, 5853.560982926255, 5854.882902341972, 5859.003969325225, 5435.1847222916485, 5445.428230035829, 5446.863828404282, 5448.782048718086, 5448.83653490396, 6385.425311721968, 6399.968000160016, 6401.199850018747, 6408.23101227851, 6409.327020662857, 4306.440162778818, 4418.381426600278, 4436.645068394553, 4467.084247729208, 4469.0, 6524.314946930599, 6602.1087153234175, 6616.305287944745, 6623.966880165616, 6633.104530888365, 4546.909061818745, 4548.363229147922, 4554.63562914966, 4559.589636932692, 4572.0855828834365, 4604.58558729716, 4613.930791038137, 4615.0, 4616.722996620147, 4620.768961551909, 5325.334333208349, 5329.040772660881, 5339.332583427072, 5341.0, 5344.358676958712, 6190.7523699052435, 6353.047042943503, 6411.455026322721, 6416.197975253093, 6427.742890284337, 1649.7442896351085, 1657.2873664324457, 1664.8501634852921, 1667.5080851148698, 1672.874534409924, 1094.9671509854718, 1095.5124969388546, 1120.9495572699086, 1126.6282126898104, 1129.8192289233684, 6098.298695649968, 6227.813165605039, 6262.09199666055, 6283.497320214372, 6283.654399008098, 6585.275619681831, 6667.43326817226, 6676.46588272937, 6678.165229346332, 6692.230393504712, 6378.043293506012, 6391.488680905516, 6395.392437718409, 6400.39196276353, 6407.359264073555, 3545.0, 3568.678818906311, 3583.5699716033723, 3586.677199052098, 3588.300281445145, 6826.863462730717, 7080.433565314763, 7083.079199704005, 7103.964480177566, 7105.573665580082, 6762.83092922671, 6794.932050679528, 6795.2185498667295, 6806.727730890808, 6817.522773405814, 7065.6113913735235, 7072.434205263567, 7079.681414336367, 7085.751998680022, 7093.077899872984, 6671.499637527108, 6679.833004174934, 6682.9331706682315, 6685.298043705341, 6704.899426508704, 6521.011091616912, 6600.504962127764, 6605.207375114825, 6613.603183808987, 6628.370304821035, 7020.929790702027, 7040.0847889774, 7064.611446370499, 7070.575765454089, 7079.115110611174, 4544.886377840448, 4574.931376029429, 4579.335996280587, 4579.7252164870215, 4586.334981427608, 6655.101561289358, 6655.633940133145, 6665.633390163587, 6666.100076489612, 6666.333366663295, 6319.0, 6465.612063276219, 6474.2878283387845, 6480.675966201577, 6486.837829054311, 6438.6458744767615, 6459.095726598374, 6471.191101112361, 6474.417302442803, 6497.415232629086, 6303.716332764945, 6303.716332765129, 6303.810885673437, 6324.620522768649, 6332.841678958063, 6501.44737697301, 6508.707108180049, 6515.674216289071, 6521.152250207632, 6521.673916304071, 5999.280086389661, 6070.7875224366935, 6341.619502829661, 6341.619502829845, 6351.745930162741], "value": 4886.758791037144, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [832.3341326938448, 862.4954401675018, 887.5340446265714, 901.6677389023606, 905.1220316293197, 14867.851321486782, 14898.925505372485, 14910.329035193416, 14912.701745965074, 14954.626134346647, 13973.930130349334, 14168.291585420713, 14204.928975355135, 14205.0, 14206.289685515709, 736.260058641065, 858.459170722444, 866.0300463480879, 888.5601627194548, 890.4434728294816, 864.5072308783996, 875.3609864798701, 879.2789912271908, 879.3536750488386, 879.7228872905047, 933.780561568031, 939.3659279986016, 939.8543225800012, 939.9248060155171, 940.6848705683605, 780.4497829030548, 921.2675922641516, 936.0405584276103, 942.0579420579421, 945.5225111318808, 684.5926673629183, 689.1902015132199, 692.3803196139477, 692.9653517324164, 693.0747452151384, 14945.775813362809, 15072.321745521478, 15111.168885711282, 15138.091714497166, 15179.316930738143, 14522.201278929655, 14969.775453368207, 15089.0, 15104.697906041927, 15106.848931510654, 12498.625041248777, 12595.05537084713, 12666.49334026638, 12677.239365637999, 12689.873101268962, 4097.8565750198895, 4098.077932465201, 4116.9794151029055, 4144.48193975753, 4156.729812562174, 56718.71640641812, 57213.713931430495, 57419.13871291934, 57505.42494575043, 57557.424425755205, 11650.475728592233, 11922.403879806148, 11981.341026243466, 11986.041116710643, 12229.205101668364, 20798.79201207999, 21040.894795525925, 21051.78948210498, 21088.894555527124, 21102.894485527475, 9113.498757568264, 9125.269978401711, 9152.8627070594, 9267.304952128618, 9529.428234305964, 4990.30135780991, 5053.393592768891, 5086.9745651271505, 5143.691378517301, 5205.401378841406, 3607.783532988029, 3718.5165928429133, 3719.1445967427644, 3720.5535335759882, 3722.274156539449, 590.8611476303065, 680.7753441364338, 696.4846013949641, 711.4415184080472, 717.3543810570528, 663.5090033375365, 696.5646470955653, 718.4360277182491, 752.3041186902203, 776.7126163319608, 9909.603615855429, 9925.50372481373, 9964.0, 10153.644622438327, 10267.589296428208, 770.379844225404, 813.1868131868132, 816.3795515408333, 819.8606236939615, 836.6862426590029, 4707.319738162188, 4722.740249286322, 4830.0, 4867.902641947141, 4915.4347250065985, 64515.67742161259, 64597.0, 68798.0, 69626.30373696299, 70419.0, 58106.7094664524, 59967.0, 60056.39943600508, 60711.69644151751, 61929.69035154796, 54140.0, 54919.0, 55076.72461637666, 55083.44916550783, 55217.72970383951, 10325.63860264887, 10349.586016559253, 10454.215933804842, 10484.161267098767, 10670.519826607977, 36809.263814724094, 37214.62785372112, 37664.81167594145, 38447.0, 39835.2032959345, 46514.534854652375, 48118.0, 52347.0, 53409.198862016325, 53496.0, 12245.081618878441, 12728.363581821057, 12817.371383036856, 12820.551280705504, 13161.210327380388, 13110.803337949748, 14458.0, 14725.263736812902, 14751.0, 15205.771913421086, 12704.618861434172, 12770.169938953939, 13265.469381224642, 14098.36557354942, 14116.576502704935, 13157.342132893125, 13484.932575337061, 13624.0, 13790.103643263557, 13794.586162415144, 11624.302541847515, 12217.816732748837, 12315.322657253579, 12334.259944403364, 12373.75252494963, 11287.492062857355, 11313.490892910004, 11774.3524106175, 11812.114091443003, 12142.150049496804, 10393.324433911772, 10459.0, 10964.342139471657, 11028.448577570929, 11106.167037472384], "value": 7275.201361287432, "unit": "score"}], "name": "dromaeo_css", "value": 7524.502270510622, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 109.0, 109.0, 111.0, 110.0, 105.0, 108.0, 110.0, 112.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 155.0, 170.0, 128.0, 157.0, 171.0, 127.0, 179.0, 131.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 160.0, 159.0, 160.0, 161.0, 161.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 180.0, 76.0, 76.0, 73.0, 76.0, 167.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 157.0, 92.0, 91.0, 93.0, 145.0, 91.0, 92.0, 158.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 53.0, 56.0, 73.0, 53.0, 53.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 58.0, 58.0, 59.0, 58.0, 60.0, 59.0, 60.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 72.0, 72.0, 73.0, 79.0, 72.0, 72.0, 73.0, 71.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 112.0, 111.0, 110.0, 113.0, 114.0, 114.0, 126.0, 130.0], "value": 116.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 155.0, 161.0, 154.0, 163.0, 158.0, 163.0, 153.0, 153.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 64.0, 73.0, 65.0, 65.0, 74.0, 64.0, 64.0, 64.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1511.5999999999997, "alertThreshold": 2.0}]} 10:10:44 INFO - Return code: 0 10:10:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:10:44 ERROR - # TBPL SUCCESS # 10:10:44 INFO - Running post-action listener: _resource_record_post_action 10:10:44 INFO - Running post-run listener: _resource_record_post_run 10:10:45 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 20480; Write bytes: 463892480; Read time: 336; Write time: 294316 10:10:45 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 4096; Write bytes: 242348032; Read time: 132; Write time: 192644 10:10:45 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 214523904; Read time: 204; Write time: 100648 10:10:45 INFO - Running post-run listener: _upload_blobber_files 10:10:45 INFO - Blob upload gear active. 10:10:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:10:45 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 10:10:45 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:10:45 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:10:45 INFO - (blobuploader) - INFO - Open directory for files ... 10:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:10:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:46 INFO - (blobuploader) - INFO - Done attempting. 10:10:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:10:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:10:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:47 INFO - (blobuploader) - INFO - Done attempting. 10:10:47 INFO - (blobuploader) - INFO - Iteration through files over. 10:10:47 INFO - Return code: 0 10:10:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:10:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:10:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc9c661f91f632f42d4cd7eacd22def44e9e41322f75cf10d54da57309406dbe69e1aec50254311dcef2e927be88af8ec98e8fcd2b4e2667253c596cf48d3a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ca79ba6ba7e57159467b1c433f692ba70c460d87b103cb007e0647358ff075b1feda7e515e529d30caffd19378f8811321dba65660da398ba511999cd1a7efe"} 10:10:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:10:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:10:47 INFO - Contents: 10:10:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc9c661f91f632f42d4cd7eacd22def44e9e41322f75cf10d54da57309406dbe69e1aec50254311dcef2e927be88af8ec98e8fcd2b4e2667253c596cf48d3a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ca79ba6ba7e57159467b1c433f692ba70c460d87b103cb007e0647358ff075b1feda7e515e529d30caffd19378f8811321dba65660da398ba511999cd1a7efe"} 10:10:47 INFO - Running post-run listener: copy_logs_to_upload_dir 10:10:47 INFO - Copying logs to upload dir... 10:10:47 INFO - mkdir: /builds/slave/test/build/upload/logs 10:10:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.780492 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-28 10:10:47.319703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:10:47.323684) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887 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-Beta/sha512/dc9c661f91f632f42d4cd7eacd22def44e9e41322f75cf10d54da57309406dbe69e1aec50254311dcef2e927be88af8ec98e8fcd2b4e2667253c596cf48d3a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ca79ba6ba7e57159467b1c433f692ba70c460d87b103cb007e0647358ff075b1feda7e515e529d30caffd19378f8811321dba65660da398ba511999cd1a7efe"} build_url:https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011129 build_url: 'https://queue.taskcluster.net/v1/task/QH29NtQzRva3tlFDbJK8Gg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dc9c661f91f632f42d4cd7eacd22def44e9e41322f75cf10d54da57309406dbe69e1aec50254311dcef2e927be88af8ec98e8fcd2b4e2667253c596cf48d3a69", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ca79ba6ba7e57159467b1c433f692ba70c460d87b103cb007e0647358ff075b1feda7e515e529d30caffd19378f8811321dba65660da398ba511999cd1a7efe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 10:10:47.349010) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:10:47.349352) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1467132620.711806-760937887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004302 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 10:10:47.434380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:10:47.434774) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 10:10:47.435079) ========= ========= Total master_lag: 0.16 =========