builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1464614966.93 results: success (0) buildid: 20160530034637 builduid: 0b3ff36e268143bebae2b558b3180e94 revision: 3fa0f58b23395a7f9f95384b18607ff10c581c00 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:26.930752) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:26.931486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:26.931771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:26.965029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:26.965293) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 06:29:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-05-30 06:29:27 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084307 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:27.063102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:27.063380) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019164 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:27.120021) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:27.120826) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3fa0f58b23395a7f9f95384b18607ff10c581c00 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3fa0f58b23395a7f9f95384b18607ff10c581c00 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 06:29:27,233 truncating revision to first 12 chars 2016-05-30 06:29:27,233 Setting DEBUG logging. 2016-05-30 06:29:27,234 attempt 1/10 2016-05-30 06:29:27,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3fa0f58b2339?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 06:29:27,530 unpacking tar archive at: mozilla-aurora-3fa0f58b2339/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:27.781561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:27.782586) ========= script_repo_revision: 3fa0f58b23395a7f9f95384b18607ff10c581c00 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:27.783623) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:27.784335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 06:29:27.796254) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-30 06:29:27.796573) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:29:27 INFO - MultiFileLogger online at 20160530 06:29:27 in /builds/slave/test 06:29:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:29:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:29:27 INFO - {'append_to_log': False, 06:29:27 INFO - 'base_work_dir': '/builds/slave/test', 06:29:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:29:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:29:27 INFO - 'branch': 'Mozilla-Aurora', 06:29:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:29:27 INFO - 'config_files': ('talos/linux_config.py',), 06:29:27 INFO - 'default_actions': ('clobber', 06:29:27 INFO - 'read-buildbot-config', 06:29:27 INFO - 'download-and-extract', 06:29:27 INFO - 'populate-webroot', 06:29:27 INFO - 'create-virtualenv', 06:29:27 INFO - 'install', 06:29:27 INFO - 'run-tests'), 06:29:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:29:27 INFO - 'download_minidump_stackwalk': True, 06:29:27 INFO - 'download_symbols': 'ondemand', 06:29:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:29:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:29:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:29:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:29:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:29:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:29:27 INFO - 'installer_path': 'installer.exe', 06:29:27 INFO - 'log_level': 'info', 06:29:27 INFO - 'log_name': 'talos', 06:29:27 INFO - 'log_to_console': True, 06:29:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:29:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:29:27 INFO - 'opt_config_files': (), 06:29:27 INFO - 'pip_index': False, 06:29:27 INFO - 'sps_profile': False, 06:29:27 INFO - 'sps_profile_interval': 0, 06:29:27 INFO - 'suite': 'dromaeojs', 06:29:27 INFO - 'system_bits': '32', 06:29:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:29:27 INFO - 'title': 'talos-linux64-ix-067', 06:29:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:29:27 INFO - 'use_talos_json': True, 06:29:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:29:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:29:27 INFO - 'work_dir': 'build'} 06:29:27 INFO - ##### 06:29:27 INFO - ##### Running clobber step. 06:29:27 INFO - ##### 06:29:27 INFO - Running pre-action listener: _resource_record_pre_action 06:29:27 INFO - Running main action method: clobber 06:29:27 INFO - rmtree: /builds/slave/test/build 06:29:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:29:28 INFO - Running post-action listener: _resource_record_post_action 06:29:28 INFO - ##### 06:29:28 INFO - ##### Running read-buildbot-config step. 06:29:28 INFO - ##### 06:29:28 INFO - Running pre-action listener: _resource_record_pre_action 06:29:28 INFO - Running main action method: read_buildbot_config 06:29:28 INFO - Using buildbot properties: 06:29:28 INFO - { 06:29:28 INFO - "project": "", 06:29:28 INFO - "product": "firefox", 06:29:28 INFO - "script_repo_revision": "production", 06:29:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:29:28 INFO - "repository": "", 06:29:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 06:29:28 INFO - "buildid": "20160530034637", 06:29:28 INFO - "pgo_build": "True", 06:29:28 INFO - "basedir": "/builds/slave/test", 06:29:28 INFO - "buildnumber": 530, 06:29:28 INFO - "slavename": "talos-linux64-ix-067", 06:29:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:29:28 INFO - "platform": "ubuntu64_hw", 06:29:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:29:28 INFO - "branch": "mozilla-aurora", 06:29:28 INFO - "repo_path": "releases/mozilla-aurora", 06:29:28 INFO - "revision": "3fa0f58b23395a7f9f95384b18607ff10c581c00", 06:29:28 INFO - "stage_platform": "linux64-pgo", 06:29:28 INFO - "builduid": "0b3ff36e268143bebae2b558b3180e94", 06:29:28 INFO - "slavebuilddir": "test" 06:29:28 INFO - } 06:29:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 06:29:28 INFO - Running post-action listener: _resource_record_post_action 06:29:28 INFO - ##### 06:29:28 INFO - ##### Running download-and-extract step. 06:29:28 INFO - ##### 06:29:28 INFO - Running pre-action listener: _resource_record_pre_action 06:29:28 INFO - Running main action method: download_and_extract 06:29:28 INFO - mkdir: /builds/slave/test/build/tests 06:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:28 INFO - https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:29:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:29:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:29:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:29:29 INFO - Downloaded 1361 bytes. 06:29:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 06:29:29 INFO - Using the following test package requirements: 06:29:29 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:29:29 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:29:29 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:29:29 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:29 INFO - u'jsshell-linux-x86_64.zip'], 06:29:29 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:29:29 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 06:29:29 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:29:29 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:29:29 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:29:29 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 06:29:29 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:29:29 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:29 INFO - https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:29:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:29:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:29:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:29:30 INFO - Downloaded 24137230 bytes. 06:29:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:29:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:29:31 INFO - Return code: 0 06:29:31 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:29:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:31 INFO - https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:29:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:29:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:29:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 06:29:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:29:33 INFO - Downloaded 24137230 bytes. 06:29:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:29:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:29:35 INFO - Return code: 0 06:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:35 INFO - https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:29:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:29:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:29:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 06:29:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:29:36 INFO - Downloaded 10840145 bytes. 06:29:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:29:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:29:36 INFO - Return code: 0 06:29: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')]} 06:29:36 INFO - https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:29:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:29:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:29:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:29:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:29:37 INFO - Downloaded 62761519 bytes. 06:29:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:29:37 INFO - mkdir: /builds/slave/test/properties 06:29:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:29:37 INFO - Writing to file /builds/slave/test/properties/build_url 06:29:37 INFO - Contents: 06:29:37 INFO - build_url:https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 06:29:38 INFO - Running post-action listener: _resource_record_post_action 06:29:38 INFO - Running post-action listener: set_extra_try_arguments 06:29:38 INFO - ##### 06:29:38 INFO - ##### Running populate-webroot step. 06:29:38 INFO - ##### 06:29:38 INFO - Running pre-action listener: _resource_record_pre_action 06:29:38 INFO - Running main action method: populate_webroot 06:29:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:29:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:29:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:29:38 INFO - '--tppagecycles', 06:29:38 INFO - '7'], 06:29:38 INFO - 'tests': ['tsvgm']}}, 06:29:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:29:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:29:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:29:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:29:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:29:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:29:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:38 INFO - 'talos_options': ['--disable-e10s'], 06:29:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:29:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:29:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:38 INFO - 'talos_options': ['--disable-e10s'], 06:29:38 INFO - 'tests': ['damp', 'tps']}, 06:29:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:38 INFO - 'tests': ['damp', 'tps']}, 06:29:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:29:38 INFO - 'tests': ['dromaeo_dom']}, 06:29:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:29:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:29:38 INFO - 'tests': ['a11yr', 06:29:38 INFO - 'ts_paint', 06:29:38 INFO - 'tpaint', 06:29:38 INFO - 'sessionrestore', 06:29:38 INFO - 'sessionrestore_no_auto_restore', 06:29:38 INFO - 'tabpaint']}, 06:29:38 INFO - 'other-e10s': {'tests': ['a11yr', 06:29:38 INFO - 'ts_paint', 06:29:38 INFO - 'tpaint', 06:29:38 INFO - 'sessionrestore', 06:29:38 INFO - 'sessionrestore_no_auto_restore', 06:29:38 INFO - 'tabpaint']}, 06:29:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:29:38 INFO - 'ts_paint', 06:29:38 INFO - 'tpaint', 06:29:38 INFO - 'sessionrestore', 06:29:38 INFO - 'sessionrestore_no_auto_restore', 06:29:38 INFO - 'tabpaint']}, 06:29:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:29:38 INFO - 'ts_paint', 06:29:38 INFO - 'tpaint', 06:29:38 INFO - 'sessionrestore', 06:29:38 INFO - 'sessionrestore_no_auto_restore', 06:29:38 INFO - 'tabpaint']}, 06:29:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:29:38 INFO - 'tests': ['a11yr', 06:29:38 INFO - 'ts_paint', 06:29:38 INFO - 'tpaint', 06:29:38 INFO - 'sessionrestore', 06:29:38 INFO - 'sessionrestore_no_auto_restore', 06:29:38 INFO - 'tabpaint']}, 06:29:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:29:38 INFO - 'tests': ['a11yr', 06:29:38 INFO - 'ts_paint', 06:29:38 INFO - 'tpaint', 06:29:38 INFO - 'sessionrestore', 06:29:38 INFO - 'sessionrestore_no_auto_restore', 06:29:38 INFO - 'tabpaint']}, 06:29:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:29:38 INFO - 'tests': ['tsvgx', 06:29:38 INFO - 'tsvgr_opacity', 06:29:38 INFO - 'tart', 06:29:38 INFO - 'tscrollx', 06:29:38 INFO - 'cart']}, 06:29:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:29:38 INFO - 'tsvgr_opacity', 06:29:38 INFO - 'tart', 06:29:38 INFO - 'tscrollx', 06:29:38 INFO - 'cart']}, 06:29:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:38 INFO - 'talos_options': ['--disable-e10s'], 06:29:38 INFO - 'tests': ['tp5o']}, 06:29:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:38 INFO - 'tests': ['tp5o']}, 06:29:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:38 INFO - 'talos_options': ['--disable-e10s', 06:29:38 INFO - '--xperf_path', 06:29:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:29:38 INFO - 'tests': ['tp5n']}, 06:29:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:29:38 INFO - 'talos_options': ['--xperf_path', 06:29:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:29:38 INFO - 'tests': ['tp5n']}}, 06:29:38 INFO - 'talos.zip': {'path': '', 06:29:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:29:38 INFO - Running post-action listener: _resource_record_post_action 06:29:38 INFO - ##### 06:29:38 INFO - ##### Running create-virtualenv step. 06:29:38 INFO - ##### 06:29:38 INFO - Running pre-action listener: _resource_record_pre_action 06:29:38 INFO - Running main action method: create_virtualenv 06:29:38 INFO - Creating virtualenv /builds/slave/test/build/venv 06:29:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:29:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:29:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:29:38 INFO - Using real prefix '/usr' 06:29:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:29:39 INFO - Installing distribute.............................................................................................................................................................................................done. 06:29:40 INFO - Installing pip.................done. 06:29:41 INFO - Return code: 0 06:29:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:41 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 0x7fedc743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1452410>, '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 0x1453310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14537a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:29:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:29:41 INFO - Using env: {'DISPLAY': ':0', 06:29:41 INFO - 'HOME': '/home/cltbld', 06:29:41 INFO - 'LANG': 'en_US.UTF-8', 06:29:41 INFO - 'LANGUAGE': 'en_US:en', 06:29:41 INFO - 'LOGNAME': 'cltbld', 06:29:41 INFO - 'MAIL': '/var/mail/cltbld', 06:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:41 INFO - 'MOZ_NO_REMOTE': '1', 06:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:41 INFO - 'NO_EM_RESTART': '1', 06:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:41 INFO - 'PWD': '/builds/slave/test', 06:29:41 INFO - 'SHELL': '/bin/bash', 06:29:41 INFO - 'SHLVL': '1', 06:29:41 INFO - 'TERM': 'linux', 06:29:41 INFO - 'TMOUT': '86400', 06:29:41 INFO - 'USER': 'cltbld', 06:29:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 06:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:41 INFO - '_': '/tools/buildbot/bin/python'} 06:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:29:41 INFO - Cleaning up... 06:29:41 INFO - Return code: 0 06:29:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:41 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 0x7fedc743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1452410>, '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 0x1453310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14537a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:29:41 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 06:29:41 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 06:29:41 INFO - Using env: {'DISPLAY': ':0', 06:29:41 INFO - 'HOME': '/home/cltbld', 06:29:41 INFO - 'LANG': 'en_US.UTF-8', 06:29:41 INFO - 'LANGUAGE': 'en_US:en', 06:29:41 INFO - 'LOGNAME': 'cltbld', 06:29:41 INFO - 'MAIL': '/var/mail/cltbld', 06:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:41 INFO - 'MOZ_NO_REMOTE': '1', 06:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:41 INFO - 'NO_EM_RESTART': '1', 06:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:41 INFO - 'PWD': '/builds/slave/test', 06:29:41 INFO - 'SHELL': '/bin/bash', 06:29:41 INFO - 'SHLVL': '1', 06:29:41 INFO - 'TERM': 'linux', 06:29:41 INFO - 'TMOUT': '86400', 06:29:41 INFO - 'USER': 'cltbld', 06:29:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 06:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:41 INFO - '_': '/tools/buildbot/bin/python'} 06:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:41 INFO - Downloading/unpacking psutil>=0.7.1 06:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:29:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:43 INFO - Installing collected packages: psutil 06:29:43 INFO - Running setup.py install for psutil 06:29:43 INFO - building 'psutil._psutil_linux' extension 06:29:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:29:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:29:43 INFO - building 'psutil._psutil_posix' extension 06:29:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:29:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:29:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:43 INFO - Successfully installed psutil 06:29:43 INFO - Cleaning up... 06:29:44 INFO - Return code: 0 06:29:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:44 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 0x7fedc743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1452410>, '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 0x1453310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14537a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:29:44 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 06:29:44 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 06:29:44 INFO - Using env: {'DISPLAY': ':0', 06:29:44 INFO - 'HOME': '/home/cltbld', 06:29:44 INFO - 'LANG': 'en_US.UTF-8', 06:29:44 INFO - 'LANGUAGE': 'en_US:en', 06:29:44 INFO - 'LOGNAME': 'cltbld', 06:29:44 INFO - 'MAIL': '/var/mail/cltbld', 06:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:44 INFO - 'MOZ_NO_REMOTE': '1', 06:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:44 INFO - 'NO_EM_RESTART': '1', 06:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:44 INFO - 'PWD': '/builds/slave/test', 06:29:44 INFO - 'SHELL': '/bin/bash', 06:29:44 INFO - 'SHLVL': '1', 06:29:44 INFO - 'TERM': 'linux', 06:29:44 INFO - 'TMOUT': '86400', 06:29:44 INFO - 'USER': 'cltbld', 06:29:44 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 06:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:44 INFO - '_': '/tools/buildbot/bin/python'} 06:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:29:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:29:46 INFO - Installing collected packages: mozsystemmonitor 06:29:46 INFO - Running setup.py install for mozsystemmonitor 06:29:46 INFO - Successfully installed mozsystemmonitor 06:29:46 INFO - Cleaning up... 06:29:46 INFO - Return code: 0 06:29:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:46 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 0x7fedc743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1452410>, '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 0x1453310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14537a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:29:46 INFO - Using env: {'DISPLAY': ':0', 06:29:46 INFO - 'HOME': '/home/cltbld', 06:29:46 INFO - 'LANG': 'en_US.UTF-8', 06:29:46 INFO - 'LANGUAGE': 'en_US:en', 06:29:46 INFO - 'LOGNAME': 'cltbld', 06:29:46 INFO - 'MAIL': '/var/mail/cltbld', 06:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:46 INFO - 'MOZ_NO_REMOTE': '1', 06:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:46 INFO - 'NO_EM_RESTART': '1', 06:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:46 INFO - 'PWD': '/builds/slave/test', 06:29:46 INFO - 'SHELL': '/bin/bash', 06:29:46 INFO - 'SHLVL': '1', 06:29:46 INFO - 'TERM': 'linux', 06:29:46 INFO - 'TMOUT': '86400', 06:29:46 INFO - 'USER': 'cltbld', 06:29:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 06:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:46 INFO - '_': '/tools/buildbot/bin/python'} 06:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:46 INFO - Downloading/unpacking blobuploader==1.2.4 06:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:48 INFO - Downloading blobuploader-1.2.4.tar.gz 06:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:29:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:29:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:49 INFO - Downloading docopt-0.6.1.tar.gz 06:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:29:49 INFO - Installing collected packages: blobuploader, requests, docopt 06:29:49 INFO - Running setup.py install for blobuploader 06:29:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:29:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:29:49 INFO - Running setup.py install for requests 06:29:49 INFO - Running setup.py install for docopt 06:29:49 INFO - Successfully installed blobuploader requests docopt 06:29:49 INFO - Cleaning up... 06:29:49 INFO - Return code: 0 06:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:49 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 0x7fedc743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1452410>, '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 0x1453310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14537a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:29:49 INFO - Using env: {'DISPLAY': ':0', 06:29:49 INFO - 'HOME': '/home/cltbld', 06:29:49 INFO - 'LANG': 'en_US.UTF-8', 06:29:49 INFO - 'LANGUAGE': 'en_US:en', 06:29:49 INFO - 'LOGNAME': 'cltbld', 06:29:49 INFO - 'MAIL': '/var/mail/cltbld', 06:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:49 INFO - 'MOZ_NO_REMOTE': '1', 06:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:49 INFO - 'NO_EM_RESTART': '1', 06:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:49 INFO - 'PWD': '/builds/slave/test', 06:29:49 INFO - 'SHELL': '/bin/bash', 06:29:49 INFO - 'SHLVL': '1', 06:29:49 INFO - 'TERM': 'linux', 06:29:49 INFO - 'TMOUT': '86400', 06:29:49 INFO - 'USER': 'cltbld', 06:29:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 06:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:49 INFO - '_': '/tools/buildbot/bin/python'} 06:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:49 INFO - Running setup.py (path:/tmp/pip-Yw0kR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:50 INFO - Running setup.py (path:/tmp/pip-kxgULc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:50 INFO - Running setup.py (path:/tmp/pip-JzKLEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:50 INFO - Running setup.py (path:/tmp/pip-JbE5tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:50 INFO - Running setup.py (path:/tmp/pip-Pcogcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:50 INFO - Running setup.py (path:/tmp/pip-RLy7Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:50 INFO - Running setup.py (path:/tmp/pip-AEbXQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:50 INFO - Running setup.py (path:/tmp/pip-fomlwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:50 INFO - Running setup.py (path:/tmp/pip-UxwonL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:50 INFO - Running setup.py (path:/tmp/pip-rdKrwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:50 INFO - Running setup.py (path:/tmp/pip-GKkS0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:50 INFO - Running setup.py (path:/tmp/pip-7gPjuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:50 INFO - Running setup.py (path:/tmp/pip-FlVioA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:50 INFO - Running setup.py (path:/tmp/pip-pbN6Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:50 INFO - Running setup.py (path:/tmp/pip-7AdfOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:51 INFO - Running setup.py (path:/tmp/pip-TFWhmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:51 INFO - Running setup.py (path:/tmp/pip-hbQ1Ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:29:51 INFO - Running setup.py install for manifestparser 06:29:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:29:51 INFO - Running setup.py install for mozcrash 06:29:51 INFO - Running setup.py install for mozdebug 06:29:51 INFO - Running setup.py install for mozdevice 06:29:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:29:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:29:51 INFO - Running setup.py install for mozfile 06:29:51 INFO - Running setup.py install for mozhttpd 06:29:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:29:51 INFO - Running setup.py install for mozinfo 06:29:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:29:51 INFO - Running setup.py install for mozInstall 06:29:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:29:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:29:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:29:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:29:51 INFO - Running setup.py install for mozleak 06:29:52 INFO - Running setup.py install for mozlog 06:29:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:29:52 INFO - Running setup.py install for moznetwork 06:29:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:29:52 INFO - Running setup.py install for mozprocess 06:29:52 INFO - Running setup.py install for mozprofile 06:29:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:29:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:29:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:29:52 INFO - Running setup.py install for mozrunner 06:29:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:29:52 INFO - Running setup.py install for mozscreenshot 06:29:52 INFO - Running setup.py install for moztest 06:29:52 INFO - Running setup.py install for mozversion 06:29:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:29:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:29:52 INFO - Cleaning up... 06:29:52 INFO - Return code: 0 06:29:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29: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')]} 06:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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')]} 06:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:52 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 0x7fedc743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1452410>, '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 0x1453310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14537a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:29:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:29:52 INFO - Using env: {'DISPLAY': ':0', 06:29:52 INFO - 'HOME': '/home/cltbld', 06:29:52 INFO - 'LANG': 'en_US.UTF-8', 06:29:52 INFO - 'LANGUAGE': 'en_US:en', 06:29:52 INFO - 'LOGNAME': 'cltbld', 06:29:52 INFO - 'MAIL': '/var/mail/cltbld', 06:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:52 INFO - 'MOZ_NO_REMOTE': '1', 06:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:52 INFO - 'NO_EM_RESTART': '1', 06:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:52 INFO - 'PWD': '/builds/slave/test', 06:29:52 INFO - 'SHELL': '/bin/bash', 06:29:52 INFO - 'SHLVL': '1', 06:29:52 INFO - 'TERM': 'linux', 06:29:52 INFO - 'TMOUT': '86400', 06:29:52 INFO - 'USER': 'cltbld', 06:29:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 06:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:52 INFO - '_': '/tools/buildbot/bin/python'} 06:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:53 INFO - Running setup.py (path:/tmp/pip-EUuFWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:53 INFO - Running setup.py (path:/tmp/pip-JuKley-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:53 INFO - Running setup.py (path:/tmp/pip-ua26Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:53 INFO - Running setup.py (path:/tmp/pip-nOZcrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:53 INFO - Running setup.py (path:/tmp/pip-RZlRYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:53 INFO - Running setup.py (path:/tmp/pip-Mpa6Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:53 INFO - Running setup.py (path:/tmp/pip-vswCgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:53 INFO - Running setup.py (path:/tmp/pip-AO5gnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:53 INFO - Running setup.py (path:/tmp/pip-NZoWmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:53 INFO - Running setup.py (path:/tmp/pip-0ZeLJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:53 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)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:53 INFO - Running setup.py (path:/tmp/pip-wgmYRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:53 INFO - Running setup.py (path:/tmp/pip-TN_0Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:54 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)) 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:54 INFO - Running setup.py (path:/tmp/pip-3ka3RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:54 INFO - Running setup.py (path:/tmp/pip-C1oBNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:54 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)) 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:54 INFO - Running setup.py (path:/tmp/pip-23k_Dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:54 INFO - Running setup.py (path:/tmp/pip-EMObux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:54 INFO - Running setup.py (path:/tmp/pip-zXQJ5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:56 INFO - Downloading blessings-1.6.tar.gz 06:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:29:56 INFO - Installing collected packages: blessings 06:29:56 INFO - Running setup.py install for blessings 06:29:56 INFO - Successfully installed blessings 06:29:56 INFO - Cleaning up... 06:29:56 INFO - Return code: 0 06:29:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:29:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:56 INFO - Reading from file tmpfile_stdout 06:29:56 INFO - Current package versions: 06:29:56 INFO - argparse == 1.2.1 06:29:56 INFO - blessings == 1.6 06:29:56 INFO - blobuploader == 1.2.4 06:29:56 INFO - docopt == 0.6.1 06:29:56 INFO - manifestparser == 1.1 06:29:56 INFO - mozInstall == 1.12 06:29:56 INFO - mozcrash == 0.17 06:29:56 INFO - mozdebug == 0.1 06:29:56 INFO - mozdevice == 0.48 06:29:56 INFO - mozfile == 1.2 06:29:56 INFO - mozhttpd == 0.7 06:29:56 INFO - mozinfo == 0.9 06:29:56 INFO - mozleak == 0.1 06:29:56 INFO - mozlog == 3.1 06:29:56 INFO - moznetwork == 0.27 06:29:56 INFO - mozprocess == 0.22 06:29:56 INFO - mozprofile == 0.28 06:29:56 INFO - mozrunner == 6.11 06:29:56 INFO - mozscreenshot == 0.1 06:29:56 INFO - mozsystemmonitor == 0.0 06:29:56 INFO - moztest == 0.7 06:29:56 INFO - mozversion == 1.4 06:29:56 INFO - psutil == 3.1.1 06:29:56 INFO - requests == 1.2.3 06:29:56 INFO - wsgiref == 0.1.2 06:29:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:56 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 0x7fedc743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1452410>, '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 0x1453310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14537a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:29:56 INFO - Using env: {'DISPLAY': ':0', 06:29:56 INFO - 'HOME': '/home/cltbld', 06:29:56 INFO - 'LANG': 'en_US.UTF-8', 06:29:56 INFO - 'LANGUAGE': 'en_US:en', 06:29:56 INFO - 'LOGNAME': 'cltbld', 06:29:56 INFO - 'MAIL': '/var/mail/cltbld', 06:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:56 INFO - 'MOZ_NO_REMOTE': '1', 06:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:56 INFO - 'NO_EM_RESTART': '1', 06:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:56 INFO - 'PWD': '/builds/slave/test', 06:29:56 INFO - 'SHELL': '/bin/bash', 06:29:56 INFO - 'SHLVL': '1', 06:29:56 INFO - 'TERM': 'linux', 06:29:56 INFO - 'TMOUT': '86400', 06:29:56 INFO - 'USER': 'cltbld', 06:29:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 06:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:56 INFO - '_': '/tools/buildbot/bin/python'} 06:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:29:56 INFO - Cleaning up... 06:29:56 INFO - Return code: 0 06:29:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:56 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 0x7fedc743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1452410>, '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 0x1453310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14537a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:29:56 INFO - Using env: {'DISPLAY': ':0', 06:29:56 INFO - 'HOME': '/home/cltbld', 06:29:56 INFO - 'LANG': 'en_US.UTF-8', 06:29:56 INFO - 'LANGUAGE': 'en_US:en', 06:29:56 INFO - 'LOGNAME': 'cltbld', 06:29:56 INFO - 'MAIL': '/var/mail/cltbld', 06:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:56 INFO - 'MOZ_NO_REMOTE': '1', 06:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:56 INFO - 'NO_EM_RESTART': '1', 06:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:56 INFO - 'PWD': '/builds/slave/test', 06:29:56 INFO - 'SHELL': '/bin/bash', 06:29:56 INFO - 'SHLVL': '1', 06:29:56 INFO - 'TERM': 'linux', 06:29:56 INFO - 'TMOUT': '86400', 06:29:56 INFO - 'USER': 'cltbld', 06:29:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 06:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:56 INFO - '_': '/tools/buildbot/bin/python'} 06:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:57 INFO - Downloading/unpacking jsonschema 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:29:59 INFO - Downloading/unpacking functools32 (from jsonschema) 06:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:59 INFO - Downloading functools32-3.2.3-2.tar.gz 06:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:29:59 INFO - warning: no files found matching '*.txt' 06:29:59 INFO - no previously-included directories found matching 'build' 06:29:59 INFO - no previously-included directories found matching 'dist' 06:29:59 INFO - no previously-included directories found matching '.git*' 06:29:59 INFO - Installing collected packages: jsonschema, functools32 06:29:59 INFO - Running setup.py install for functools32 06:29:59 INFO - warning: no files found matching '*.txt' 06:29:59 INFO - no previously-included directories found matching 'build' 06:29:59 INFO - no previously-included directories found matching 'dist' 06:29:59 INFO - no previously-included directories found matching '.git*' 06:29:59 INFO - Successfully installed jsonschema functools32 06:29:59 INFO - Cleaning up... 06:29:59 INFO - Return code: 0 06:29:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:59 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 0x7fedc743ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1452410>, '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 0x1453310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14537a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:29:59 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 06:29:59 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 06:29:59 INFO - Using env: {'DISPLAY': ':0', 06:29:59 INFO - 'HOME': '/home/cltbld', 06:29:59 INFO - 'LANG': 'en_US.UTF-8', 06:29:59 INFO - 'LANGUAGE': 'en_US:en', 06:29:59 INFO - 'LOGNAME': 'cltbld', 06:29:59 INFO - 'MAIL': '/var/mail/cltbld', 06:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:59 INFO - 'MOZ_NO_REMOTE': '1', 06:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:29:59 INFO - 'NO_EM_RESTART': '1', 06:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:59 INFO - 'PWD': '/builds/slave/test', 06:29:59 INFO - 'SHELL': '/bin/bash', 06:29:59 INFO - 'SHLVL': '1', 06:29:59 INFO - 'TERM': 'linux', 06:29:59 INFO - 'TMOUT': '86400', 06:29:59 INFO - 'USER': 'cltbld', 06:29:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 06:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:59 INFO - '_': '/tools/buildbot/bin/python'} 06:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:59 INFO - Downloading/unpacking flake8 06:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:30:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:30:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:30:02 INFO - no previously-included directories found matching 'docs/_build' 06:30:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:30:02 INFO - Running setup.py install for pep8 06:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:30:02 INFO - no previously-included directories found matching 'docs/_build' 06:30:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:30:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:30:02 INFO - Cleaning up... 06:30:02 INFO - Return code: 0 06:30:02 INFO - Running post-action listener: _resource_record_post_action 06:30:02 INFO - Running post-action listener: _start_resource_monitoring 06:30:02 INFO - Starting resource monitoring. 06:30:02 INFO - ##### 06:30:02 INFO - ##### Running install step. 06:30:02 INFO - ##### 06:30:02 INFO - Running pre-action listener: _resource_record_pre_action 06:30:02 INFO - Running main action method: install 06:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:30:02 INFO - Reading from file tmpfile_stdout 06:30:02 INFO - Detecting whether we're running mozinstall >=1.0... 06:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:30:02 INFO - Reading from file tmpfile_stdout 06:30:02 INFO - Output received: 06:30:02 INFO - Usage: mozinstall [options] installer 06:30:02 INFO - Options: 06:30:02 INFO - -h, --help show this help message and exit 06:30:02 INFO - -d DEST, --destination=DEST 06:30:02 INFO - Directory to install application into. [default: 06:30:02 INFO - "/builds/slave/test"] 06:30:02 INFO - --app=APP Application being installed. [default: firefox] 06:30:02 INFO - mkdir: /builds/slave/test/build/application 06:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:30:18 INFO - Reading from file tmpfile_stdout 06:30:18 INFO - Output received: 06:30:18 INFO - /builds/slave/test/build/application/firefox/firefox 06:30:18 INFO - Running post-action listener: _resource_record_post_action 06:30:18 INFO - ##### 06:30:18 INFO - ##### Running run-tests step. 06:30:18 INFO - ##### 06:30:18 INFO - Running pre-action listener: _resource_record_pre_action 06:30:18 INFO - Running main action method: run_tests 06:30:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:30:18 INFO - Python 2.7.3 06:30:18 INFO - Return code: 0 06:30:18 INFO - grabbing minidump binary from tooltool 06:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:18 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 0x1452410>, '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 0x1453310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14537a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:30:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:30:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:30:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:30:18 INFO - Return code: 0 06:30:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:30:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:30:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:30:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:30:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:30:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:30:19 INFO - Return code: 0 06:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:30:19 INFO - Using env: {'DISPLAY': ':0', 06:30:19 INFO - 'HOME': '/home/cltbld', 06:30:19 INFO - 'LANG': 'en_US.UTF-8', 06:30:19 INFO - 'LANGUAGE': 'en_US:en', 06:30:19 INFO - 'LOGNAME': 'cltbld', 06:30:19 INFO - 'MAIL': '/var/mail/cltbld', 06:30:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:30:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:19 INFO - 'MOZ_NO_REMOTE': '1', 06:30:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:19 INFO - 'NO_EM_RESTART': '1', 06:30:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:19 INFO - 'PWD': '/builds/slave/test', 06:30:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:30:19 INFO - 'SHELL': '/bin/bash', 06:30:19 INFO - 'SHLVL': '1', 06:30:19 INFO - 'TERM': 'linux', 06:30:19 INFO - 'TMOUT': '86400', 06:30:19 INFO - 'USER': 'cltbld', 06:30:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109', 06:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:19 INFO - '_': '/tools/buildbot/bin/python'} 06:30:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:30:19 INFO - mozversion application_buildid: 20160530034637 06:30:19 INFO - mozversion application_changeset: 3fa0f58b23395a7f9f95384b18607ff10c581c00 06:30:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:30:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:30:19 INFO - mozversion application_name: Firefox 06:30:19 INFO - mozversion application_remotingname: firefox-dev 06:30:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:30:19 INFO - mozversion application_vendor: Mozilla 06:30:19 INFO - mozversion application_version: 48.0a2 06:30:19 INFO - mozversion platform_buildid: 20160530034637 06:30:19 INFO - mozversion platform_changeset: 3fa0f58b23395a7f9f95384b18607ff10c581c00 06:30:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:30:19 INFO - mozversion platform_version: 48.0a2 06:30:19 INFO - using testdate: 1464615019 06:30:19 INFO - actual date: 1464615019 06:30:19 INFO - starting webserver on 'localhost:58281' 06:30:19 INFO - SUITE-START | Running 2 tests 06:30:19 INFO - TEST-START | dromaeo_css 06:30:19 INFO - operating with platform_type : linux_ 06:30:19 INFO - Initialising browser for dromaeo_css test... 06:30:19 INFO - TEST-INFO | started process 6241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuQS99L/profile http://localhost:58281/getInfo.html) 06:30:23 INFO - PROCESS | 6241 | __metrics Screen width/height:1600/1200 06:30:23 INFO - PROCESS | 6241 | colorDepth:24 06:30:23 INFO - PROCESS | 6241 | Browser inner width/height: 1024/697 06:30:23 INFO - PROCESS | 6241 | __metrics 06:30:24 ERROR - PROCESS | 6241 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:30:24 INFO - TEST-INFO | 6241: exit 0 06:30:24 INFO - Browser initialized. 06:30:24 INFO - Running cycle 1/1 for dromaeo_css test... 06:30:25 INFO - TEST-INFO | started process 6335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuQS99L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:36 INFO - PROCESS | 6335 | RSS: Main: 141914112 06:30:36 INFO - PROCESS | 6335 | 06:31:27 INFO - PROCESS | 6335 | 1464615087862 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:33:35 INFO - PROCESS | 6335 | Cycle 1(1): loaded http://localhost:58281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58281/tests/dromaeo/cssquery-ext.html) 06:33:36 INFO - PROCESS | 6335 | RSS: Main: 250949632 06:33:36 INFO - PROCESS | 6335 | 06:36:38 INFO - PROCESS | 6335 | Cycle 1(1): loaded http://localhost:58281/tests/dromaeo/cssquery-ext.html (next: http://localhost:58281/tests/dromaeo/cssquery-jquery.html) 06:36:39 INFO - PROCESS | 6335 | RSS: Main: 220172288 06:36:39 INFO - PROCESS | 6335 | 06:39:40 INFO - PROCESS | 6335 | Cycle 1(1): loaded http://localhost:58281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58281/tests/dromaeo/cssquery-mootools.html) 06:39:41 INFO - PROCESS | 6335 | RSS: Main: 206336000 06:39:41 INFO - PROCESS | 6335 | 06:42:43 INFO - PROCESS | 6335 | Cycle 1(1): loaded http://localhost:58281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58281/tests/dromaeo/cssquery-prototype.html) 06:42:44 INFO - PROCESS | 6335 | RSS: Main: 212922368 06:42:44 INFO - PROCESS | 6335 | 06:45:46 INFO - PROCESS | 6335 | Cycle 1(1): loaded http://localhost:58281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58281/tests/dromaeo/cssquery-yui.html) 06:45:47 INFO - PROCESS | 6335 | RSS: Main: 212107264 06:45:47 INFO - PROCESS | 6335 | 06:48:49 INFO - PROCESS | 6335 | Cycle 1(1): loaded http://localhost:58281/tests/dromaeo/cssquery-yui.html (next: http://localhost:58281/tests/dromaeo/cssquery-dojo.html) 06:48:49 INFO - PROCESS | 6335 | RSS: Main: 255115264 06:48:49 INFO - PROCESS | 6335 | 06:48:49 INFO - PROCESS | 6335 | __start_tp_report 06:48:49 INFO - PROCESS | 6335 | _x_x_mozilla_page_load 06:48:49 INFO - PROCESS | 6335 | _x_x_mozilla_page_load_details 06:48:49 INFO - PROCESS | 6335 | |i|pagename|runs| 06:48:49 INFO - PROCESS | 6335 | |0;dojo.html;3301.2737197816477;3357.1607098225427;3362.680545348191;3382.188274814045;3394.745394095442;5484.945150548493;5508.531774799137;5521.061419558675;5531.308586426697;5534.640248383852;5462.535684466825;5482.5613950883935;5528.838943821802;5536.363318218406;5554.028045092113;4867.415910090776;4948.084604348198;5041.773120209581;5082.0598189334905;5111.4121875984365;4910.435299940499;4956.950430495703;4968.552830245278;4976.154053810861;4980.978899325648;4981.701097934118;5007.949920500803;5053.5451809337155;5079.2635067915135;5082.440931497532;5035.219540971156;5064.290999260106;5071.923921141186;5078.4413714491375;5107.948920510803;4829.1790395632825;4852.17513022787;4872.634552408548;4979.0788704089855;4986.925196122061;5419.295491586108;5479.698616576086;5480.506754392084;5492.890142197134;5498.092814685572;5932.9406705932815;6000.519958403361;6005.249343832021;6007.729652165663;6008.879822403571;5945.732442040118;6025.698715064229;6061.848453788646;6077.027675571887;6087.4825639820665;5572.832815015556;5585.8603534911545;5615.522680572197;5620.156976453523;5622.184783206453;5815.9709201453725;6088.726007329681;6091.360407157274;6104.38956104386;6105.419985101408;5748.7125643717645;5819.505342045889;5827.096799996008;5827.388124246893;5834.212381328552;5970.522358211333;6012.549058820606;6015.368386319374;6015.54883383748;6018.428249316308;5773.24947756789;5903.616264942765;5950.315713692894;5971.731272092767;5983.431574000463;5924.822255332347;5967.1347654589845;5968.134620480006;5988.431099045583;6009.459148676553;4529.728216307032;4540.614047805973;4541.5231400703115;4548.135854187693;4572.51988541205;3939.527256729211;4012.598740126022;4041.91916161681;4045.7370270932297;4127.669786417079;5601.327840659147;5619.80330688424;5624.521915637217;5626.915596266059;5651.8304450866535;5928.347881733006;5929.911051334234;5930.436608522184;5933.703314834327;5938.673372964528;5476.67139971595;5552.555795536347;5559.332880054339;5642.971785141048;5654.46282603152;5017.84946451607;5033.924491132636;5036.169032109734;5041.445441001487;5042.495750424928;6073.08903664445;6081.17904082952;6087.3303936566945;6096.420840020191;6115.082737589309;5770.567207459458;5989.550783691154;6070.180525628984;6104.725287362168;6117.96941015292;5992.1910542078;5993.790217342372;5995.310539287863;6014.8195554133445;6054.212952316171;5675.943240567542;5756;5764.510016648464;5769.07694768835;5784.595078344475;5886.764529418775;5958.582899197015;5960.433758792908;5962.433568810956;5997.610155339889;5766.452187042224;5815.3893841147765;5818.505427038749;5823.301203855395;5826.854328641818;5706.3152421708;5712.685802280915;5749.13762935563;5798;5806.796762113306;5707.315122185364;5742.712864356849;5746.080627099644;5746.913796292975;5775.711214439178;5818.040023396092;5837.562182836389;5846.853828654318;5849.415058494116;5856.736446859816;5526.751296191601;5695.8860822784145;5723.771049157987;5740.282464691913;5798.884022319615 06:48:49 INFO - PROCESS | 6335 | |1;ext.html;663.6383171171713;673.8955461903404;677.5223467455445;684.2917580304386;755.9773206803798;31375.686243137563;39696;40187;40212.39681404781;40229.798851005704;42915;43529.7823510882;43544;43593.34609980853;43621;8021.558814265213;8852.291816654651;9051.049639787827;10495.580176792919;10683.572657093746;10505.73735656611;10651.360918344886;10660;10664.680059598186;10669.35983840972;10700.250982431233;10811.08105811003;10812.621558245462;10819.67540973772;10820;10667.893321066806;10721.678349649523;10731.624393146281;10736.355818650827;10739.24825262232;10633.255672102956;10754.677359679223;11159.27464714791;11167.944160279229;11171.720706982309;34116.82941585301;34805.30389392198;44385.11229775419;44817.103657926986;44883.32675009877;3794.2411517696573;3946.2304850554156;4077.4087757275324;4486.282194848841;4538.251188553884;31448.37103257922;31695.683043169505;31714.36571268585;31961;33330;4298.097399546099;4405;4408.338749187647;4412.24991751403;4468.3074123510905;346092;351120.99999999744;354047;354383;355378;39500.407493887615;40268.1946361077;67978.3202167972;68629.65685171643;68664;38810;38826.80586597105;38828;39044.41433378502;39129.80435097806;14114.64713382153;15548.067115973077;15644.765328520081;15658;16378.590535236475;14021.649458763408;14103;14127.293635318192;14137.43450261978;14137.717245655029;9176;9189.3108016899;9206.723798286062;9219.17027467531;9297;3594.6045934947133;3653.8173091345325;3681.4109742441615;3693.7229707772026;3704.5369328833895;1063;1092.3664274720643;1153.9192256542128;1167.0335484708294;1194.116353898109;33612.49581256283;33765.15587110293;33895;33906;34060;1190.6904204906614;1205.921615095016;1290.4064130500076;1298.7727147749295;1324.543032653733;17542.824571754118;17993.2802687891;18034.819651803315;18251.361202357853;18291.45125646233;498972;504663;504738;505099;507280;62654.68672656608;63349;63447.999999999076;63469.682651586445;63659.681701591195;1416.4560628914533;1463.3049301581877;1466.8973171878079;1508.509734336345;1564.2257082743888;29584.704152959057;30454.238644034078;30885;31077;31588.842055789573;46100;46113;46704.29943550781;46751.766241168574;46781.766091169324;253604;254343;254688;255682;256010;27415;29279.414411712074;30929;31283.374332512765;31358.37283254368;44861.32708009448;45040.324395134754;46213;51044.23433648572;52503;37639.435408468344;38161.23677526379;38219.23561528698;38355;39699.206015878946;37514;37929.43105853359;38058;38203.80898095492;38555;42867;43069;43754.34368484412;44012.779936100116;44345;35434.82282588674;36872;36966;37590.43614345841;37717.81141094277;28192.85903570469;28328;28768.280792980342;29073.27316817012;29158.416831662824 06:48:49 INFO - PROCESS | 6335 | |2;jquery.html;423.4896949176243;425.75519076531003;432.20690033787986;435.46872815165506;440.72674941536246;18486.722699159505;19099.618007639838;19118.426447206606;19448.902755486204;20207.09068091936;12933.547325843598;13182.868171318283;14758.778618320734;19836.313913317386;19873.10571024304;5361.249425080492;5401.70290634015;5495.175723641466;5497.835064948058;5530.308711411074;5668;5671.829845104653;5694.4590263924865;5700.344460387047;5706.087026075828;5592.748326325304;5622.409646987069;5653.604247702662;5707.62900411474;5719.74165683551;5765.164051212592;5784.566157538202;5791.449812267828;5792.478676919077;5798.942010579883;5531.917021244684;5649.4633009864;5688.715564221814;5727.255456790632;5730.541556675456;13806.447742090304;13819.723605527934;13841.238731869744;13857.58427247174;13876.930615346959;2261.7512073671883;2536.353229926357;2662.0815818542574;2762.8204166729097;2960.4523163214876;9858.80282394348;9933.10602045812;10223.744406389826;10313;10672.09287210588;1954.3355259211794;2064.7728749837506;2090.1221486975355;2097.601455723423;2102.6005059038735;56370.71814640942;66857.66571167162;75801.62099189524;80728;82234.58882705608;11232.3260604364;11267.830982535268;11559.364234967157;11704.88295117055;11838.171328006956;14299.78550321746;15023.624409389853;15851.365945362288;16339.101349425895;16357;8687.305015598737;8696.869546956801;8720.912790872137;8756.343274254456;8867.778305542413;8574.09971952936;8587.656493740305;8647.308215342757;8735.082816304324;8796;4963.851084467472;5103.795848166106;5117.232415137684;5120.769565369567;5146.588272938156;2011.4971257185703;2036.8879711616003;2038.6024725178447;2044.9386518404472;2059.7116403703494;466.62902992121343;486.14681234433345;896.5024411451707;1076.5908954597203;1095.6993799337567;11871.76256474883;12245.69385765363;12314.384280785926;12358.567450139202;12365.443555040045;485.6406259368042;497.4428639923309;1037.5175543372368;1067.3435836960368;1083.815751322277;10497.317674351143;10709.625163119254;10795.244332896778;10805.675829725122;10855.835422783472;529558;529805;537565;547342;547557;59151.408485915454;65503;99786;100815;102900.48549757354;1121.6466812953893;1145.4272863568217;1149.1553708024596;1154.786364522566;1164.714644912002;16565.751513727544;16668.833311666727;16896.66206675835;16905.154742263083;17248.051357175475;27605.30986725348;35453.29093418066;39489.407658884564;40263;40513;48805;49381;50891.49108508867;50894.49105509045;51554.22668659898;8733.650653974024;8736.519491428033;8811.471311721318;8827.602757875782;9043.864342035007;9965;13138.080334376502;13302.800457993331;13700.109492882932;13739.175649461064;11563.364014979257;11885.82171267449;11995.880041199825;12085.395730213279;12428.937855310665;6521.5108866834225;11154;11492.885071149516;11540.422978850856;11776.646700598652;11791.528338866348;12235.571754988532;12338.259704417764;12375.257484550595;12661.303628300531;8882.733517994471;9149.954250228706;9308;9378.906210937803;9499.857502137611;9568.4737339447;12441.440135193758;12479.126461147996;12598;12676.556320528738 06:48:49 INFO - PROCESS | 6335 | |3;mootools.html;1417.3976060174436;1578.8657964073054;1584.8890577659563;1818.0818686563284;1913.661109644514;7717.498362606434;8417.579121043946;8594.87107693385;8597.613107410174;8599.484030958147;8437.114103019187;8621.913780862189;8622.35332350073;8624.482531048141;8638.784030399243;2120.07776617172;2169.967450488244;2369.3247424484025;2379.7501262367464;2399.7360290368047;2462.7660372264604;2470.3700556358103;2489.427431690712;2491.9750802492017;2492.9376765580914;2405.001924201454;2428.732839387666;2492.140211626986;2507.059852555292;2509.2346834215555;2117.714108595343;2402.615581506959;2410.0118951229997;2413.3122060212754;2465.0755966512556;2418.830681852271;2433.9322287737714;2449.3876530867283;2457.31195265326;2458.520588485246;8431.494110353337;8507.404481686284;8516.914830851736;8533.615987280526;8559.700410485602;5364.168553874156;5541.750621222055;5546.27898373213;5547.33431988164;5556.666600004012;3425.4348032574594;3460.619331873492;3464.4110501214855;3522.172289511963;3567.126054116732;1081.9621313254;1086.5219303506433;1090.9908334790366;1109.7281166114274;1115.4590023838432;12462;12643.810342844865;12648.304343261208;12656.114072014963;12671.936640316831;4773.880652983634;4799.592034677022;4808.422989241313;4860.2223644217465;4902.509749025069;10656.467176641137;10667.573297068031;10671.35971841692;10682.519286631965;10692.305000174963;5543.722813859291;5545.057340252167;5545.944540554624;5546.112621980464;5549.445055494418;4414.448193975753;4874.707517548958;4960.131976904027;4967.0065986802065;5069.847904562869;4166.500019997619;4181.059261666101;4287.121140166259;4323;4358.302671572533;1351.1892864281353;1369.103237379498;1371.533678549298;1372.8901687864948;1400.7338605665095;995.5470261031213;998.83519219328;1006.959721611142;1011.1506334678905;1027.1166796554958;5862.501687356623;5890.175375447441;5891.145783861316;6041.033434650435;6052.727627256784;434.81520353849487;459.3087403457775;467.9578837904537;471.03437952197856;471.6368396334803;3949.54580223278;4024.2957482440456;4079.4678351557673;4096.446979657768;4144.44050053245;10768.892311076788;11202.60790872332;11287.435628218556;11303.547858085585;11310.94344528272;10996.725081872857;11035.503402346914;11060.612878549213;11073.72315692098;11092.667219983252;7877.842443151105;8193.057798353266;8201.13888041759;8369.748907532661;8393.790155246046;5872.002862936773;5965.671888046026;6035.39646035393;6123.050927106306;6125.081237814364;9377.437353758796;9391.154796068387;9403.153716165305;9462.952685236529;9562.713118606453;9360.719178424659;9709.27180461454;9709.514524273616;9711.66009189675;9800.166985806001;7089;7284.526505777108;7294.927050729637;7739.110002349802;7875.684972601031;8077.636506357346;8225.670973161246;8302.958485207535;8338.583070846313;8341.957255343083;7282.198958114709;7342.155652099863;7469.850602987801;7519.661615227437;7711.768646940601;7471.252874712485;7558.13081495635;7586.506877052974;7666.769996900102;7686.154523002577;7071.328223818729;7112.857742845217;7126.2873712628325;7135.607541585263;7143.214246432784;4978.950210497994;5186.092433824141;5193;5307.044731948286;5319.255304257485;5177.0940085485645;5222.29499017643;5270.393904701008;5301.284326616012;5382.569394448513 06:48:49 INFO - PROCESS | 6335 | |4;prototype.html;342.2299825392866;349.60669247097013;349.6276465564173;353.45391370332817;355.02545512567974;6201.317855035943;6268.905966410507;6285.528585356094;6374.904376434346;6438.420542151217;6207.813765587029;6249.468795152417;6275.278342990558;6276.466500347465;6293.4335909768115;4506.076254367863;4726.763661816913;4739.218029025206;4741.644376671755;4747.382840230783;4623.144718227122;4726.291056341542;4760.8333708320215;4762.333273341717;4771;4711.434627844664;4711.858644240679;4716.198246298138;4717;4729;4483.39474170986;4576.656750743708;4702.835400760957;4713.952860471403;4729.432468103815;4085.3667681509414;4094.4063110849056;4094.897627559305;4099.364598487239;4121.4848143982;5986.042233242704;6004.489618382443;6027.879442411171;6029.879402411971;6032.728527216286;5521.641093328921;5523.972380138073;5526.06056970312;5533.529649979757;5534.916976245359;6571.704273307665;6577.638229897354;6584.946408574605;6585.440237579812;6586.670666466657;4519.118771839492;4608.216603177468;4618.1687296286655;4624.237000894848;4624.491305956342;6778.389944904933;6827.112475378169;6849.383555480031;6859.519833611599;6870.519063665545;4672.976635116803;4684.414448193976;4685.133250348628;4689.413823272091;4694.835680751157;4732.313814496879;4735.21868891629;4742.928856067162;4743.66794324394;4745.762711864393;5482.17767334895;5484.040292948718;5488.121900495901;5488.643238189505;5491.764353020619;6456.709448074848;6610.933890661128;6615.86768264632;6626.171728533934;6632.403083722392;1640.8195098539152;1647.3410635745558;1658.7594798754355;1663.3014134063721;1666.1086318819373;1088.1403691083956;1094.458243169636;1101.4823033174555;1109.6670998700358;1114.8550688410455;6175.938240617626;6360.491160707133;6477.902831457532;6534.803955881332;6536.803895883131;6952;6956.513044086865;6961.512694111465;6968.303169682991;6969.372756451944;6443.226812782496;6455.225372955276;6457.354264573505;6458.967705161538;6483.837904052342;3657.798821064867;3704.666580007812;3708.5364329458816;3710.8144592770254;3716.7212459065677;6887.2079710832895;7054.470914681419;7076.575405475688;7132.572045677276;7169.390601798801;6946.305369463114;6947.7220911162985;6948.826279343057;6962.2341542430295;6972.988916607063;7119.038929744522;7134.143902731706;7140.357367836919;7143.249958754256;7144.357007869213;6852.794416167523;6859.176898772179;6859.897101543581;6865.27914568963;6869.210040845367;6597.208334999831;6774.525783195326;6792.728290868507;6806.727730890907;6821.488388370793;7111.60886151246;7131.607761573163;7137.643117843983;7138.4301651406495;7144.571325720265;4689.296605509201;4694.43666759991;4733.195356789423;4744.264638980963;4744.4069491313585;6816.795496135124;6839.863202735818;6857;6870.27862074475;6889.138857642794;6502.317256687979;6703.229128650268;6716.664166791543;6738.494612903954;6740.292269311848;6640;6676.232233293234;6685.966570167313;6688.598684078971;6692.966535167293;6558.475321974326;6561.639109849004;6578.5395022347975;6582.506312026521;6584.8024559263295;6724.092247546519;6731.124953756176;6732.192136943598;6736.360045795642;6742.089817874524;6416.9679151605815;6519.380658837403;6531.085648009187;6536.673166341759;6564.80305590833 06:48:49 INFO - PROCESS | 6335 | |5;yui.html;818.2962652119177;822.5352675738211;849.2272032450469;929.0384452092086;931.9021502742212;15644.608884777886;15722.449714260003;15777.763333549978;15783.790269362298;15818.288177032033;13973.720525589508;14005.159690418557;14010.439582416717;14032.859671403283;14033.719325613481;727.0838743183574;859.230988265502;870.3689824876977;879.0286733159862;881.5327876225579;871.7994861181932;877.0659247900996;877.2543338162543;877.5349064995562;878.6617152396342;928.5450129436595;929.693201243588;930.5951910918772;930.6230976454513;931.7950050988771;755.761934990479;907.3467103685336;923.1460898668705;927.4620719982394;930.7998780262242;665.3346653346654;668.0980676087291;669.5480550628306;670.1121014655553;670.17568390879;14472.204028778413;14624.049436786681;14661.926690366587;14669.633259168499;14721.484748033874;14100.717985640333;14391.856081439157;14411.567652970427;14843.183624900626;15337.693246135126;11999.280043197436;12098.213616114925;12199.451024703909;12211.023118150526;12346.938265308705;4078.286299897506;4080.285949958775;4134.669226461876;4150.584941505856;4157.729747566398;57822;57900.710496447246;58038;58169.12746308809;58285;11900.107491937966;12151.331676757687;12477.5008999639;12483.126181167412;12732.29972351511;21744;21809.127634894427;21866.671999920014;21872.12511499554;21978.45053873634;9025;9148.496832674267;9150.725478235663;9181.540922953825;9188.63245470187;4767.332573439721;4806.615470762401;4850.53919877611;4888.608911287089;4942.703437793743;3592.317459682652;3650.9634903651154;3661.4324779659196;3661.707063434919;3663.065918190844;608.2579253310954;609.1106983803696;655.9799511759165;697.0554898113085;721.7654262364753;742.2466196810242;799.8680217764004;810.1851851851809;827.9917200827915;830.5307501261889;9935.900640993497;9973.900260997443;10023.398596084258;10046.899531004596;10192.847107293397;775.1047540091091;776.8329809090959;799.1249581708021;820.1552401026952;839.6053854688287;4507.909841803145;4841.298011788342;4883.169861123618;4919.508049195052;4960.280759289883;65964;67576.66211669009;67936.66031669908;68084;68207.65896170586;57974.420255796904;58398;59498.70250648806;59511.40488595145;59532.70233648804;49516;49770.75114624476;50147;53338.19992700113;53422;9292.349535532448;9731.870931783436;9754.658586949423;9832.852507212254;9882.703518894445;38607.6139238604;38873.8056309728;39122;39289.80355098206;40926.79536602417;45208.77395613132;49722;52977.4702252988;53287.46712532825;54958.72520637371;13024.479020839439;13142;13164;13340.86659133435;13539.526116586267;14205.573832785032;14621.342039608457;14724.411023558938;15360.231988400312;15433.459828906383;13614.863851361359;13727.313634318045;13884.09753366028;13889.166650001032;14134.858651413355;13527.526536571173;13685.726285474035;13766.587002389944;13769.380377882819;14249.073810202304;12836.807447888103;13292.26892520882;13438.664033399244;13541.93229033888;13651.385687644279;11375;11394.94676213095;11466.369349685847;11652.126090543074;11658.88341116578;10579;11222;11235.15736319763;11372.601958931398;11403 06:48:49 INFO - PROCESS | 6335 | __end_tp_report 06:48:49 INFO - PROCESS | 6335 | __start_cc_report 06:48:49 INFO - PROCESS | 6335 | _x_x_mozilla_cycle_collect,880 06:48:49 INFO - PROCESS | 6335 | __end_cc_report 06:48:49 INFO - PROCESS | 6335 | __startTimestamp1464616129759__endTimestamp 06:48:49 INFO - PROCESS | 6335 | 06:48:49 INFO - PROCESS | 6335 | ------- Summary: start ------- 06:48:49 INFO - PROCESS | 6335 | Number of tests: 6 06:48:49 INFO - PROCESS | 6335 | 06:48:49 INFO - PROCESS | 6335 | [#0] dojo.html Cycles:165 Average:5504.22 Median:5740.28 stddev:618.09 (10.8%) stddev-sans-first:595.34 06:48:49 INFO - PROCESS | 6335 | Values: 3301.3 3357.2 3362.7 3382.2 3394.7 5484.9 5508.5 5521.1 5531.3 5534.6 5462.5 5482.6 5528.8 5536.4 5554.0 4867.4 4948.1 5041.8 5082.1 5111.4 4910.4 4957.0 4968.6 4976.2 4981.0 4981.7 5007.9 5053.5 5079.3 5082.4 5035.2 5064.3 5071.9 5078.4 5107.9 4829.2 4852.2 4872.6 4979.1 4986.9 5419.3 5479.7 5480.5 5492.9 5498.1 5932.9 6000.5 6005.2 6007.7 6008.9 5945.7 6025.7 6061.8 6077.0 6087.5 5572.8 5585.9 5615.5 5620.2 5622.2 5816.0 6088.7 6091.4 6104.4 6105.4 5748.7 5819.5 5827.1 5827.4 5834.2 5970.5 6012.5 6015.4 6015.5 6018.4 5773.2 5903.6 5950.3 5971.7 5983.4 5924.8 5967.1 5968.1 5988.4 6009.5 4529.7 4540.6 4541.5 4548.1 4572.5 3939.5 4012.6 4041.9 4045.7 4127.7 5601.3 5619.8 5624.5 5626.9 5651.8 5928.3 5929.9 5930.4 5933.7 5938.7 5476.7 5552.6 5559.3 5643.0 5654.5 5017.8 5033.9 5036.2 5041.4 5042.5 6073.1 6081.2 6087.3 6096.4 6115.1 5770.6 5989.6 6070.2 6104.7 6118.0 5992.2 5993.8 5995.3 6014.8 6054.2 5675.9 5756.0 5764.5 5769.1 5784.6 5886.8 5958.6 5960.4 5962.4 5997.6 5766.5 5815.4 5818.5 5823.3 5826.9 5706.3 5712.7 5749.1 5798.0 5806.8 5707.3 5742.7 5746.1 5746.9 5775.7 5818.0 5837.6 5846.9 5849.4 5856.7 5526.8 5695.9 5723.8 5740.3 5798.9 06:48:49 INFO - PROCESS | 6335 | 06:48:49 INFO - PROCESS | 6335 | [#1] ext.html Cycles:180 Average:53493.92 Median:179486.30 stddev:101820.15 (56.7%) stddev-sans-first:102028.52 06:48:49 INFO - PROCESS | 6335 | Values: 663.6 673.9 677.5 684.3 756.0 31375.7 39696.0 40187.0 40212.4 40229.8 42915.0 43529.8 43544.0 43593.3 43621.0 8021.6 8852.3 9051.0 10495.6 10683.6 10505.7 10651.4 10660.0 10664.7 10669.4 10700.3 10811.1 10812.6 10819.7 10820.0 10667.9 10721.7 10731.6 10736.4 10739.2 10633.3 10754.7 11159.3 11167.9 11171.7 34116.8 34805.3 44385.1 44817.1 44883.3 3794.2 3946.2 4077.4 4486.3 4538.3 31448.4 31695.7 31714.4 31961.0 33330.0 4298.1 4405.0 4408.3 4412.2 4468.3 346092.0 351121.0 354047.0 354383.0 355378.0 39500.4 40268.2 67978.3 68629.7 68664.0 38810.0 38826.8 38828.0 39044.4 39129.8 14114.6 15548.1 15644.8 15658.0 16378.6 14021.6 14103.0 14127.3 14137.4 14137.7 9176.0 9189.3 9206.7 9219.2 9297.0 3594.6 3653.8 3681.4 3693.7 3704.5 1063.0 1092.4 1153.9 1167.0 1194.1 33612.5 33765.2 33895.0 33906.0 34060.0 1190.7 1205.9 1290.4 1298.8 1324.5 17542.8 17993.3 18034.8 18251.4 18291.5 498972.0 504663.0 504738.0 505099.0 507280.0 62654.7 63349.0 63448.0 63469.7 63659.7 1416.5 1463.3 1466.9 1508.5 1564.2 29584.7 30454.2 30885.0 31077.0 31588.8 46100.0 46113.0 46704.3 46751.8 46781.8 253604.0 254343.0 254688.0 255682.0 256010.0 27415.0 29279.4 30929.0 31283.4 31358.4 44861.3 45040.3 46213.0 51044.2 52503.0 37639.4 38161.2 38219.2 38355.0 39699.2 37514.0 37929.4 38058.0 38203.8 38555.0 42867.0 43069.0 43754.3 44012.8 44345.0 35434.8 36872.0 36966.0 37590.4 37717.8 28192.9 28328.0 28768.3 29073.3 29158.4 06:48:49 INFO - PROCESS | 6335 | 06:48:49 INFO - PROCESS | 6335 | [#2] jquery.html Cycles:180 Average:29110.87 Median:15184.07 stddev:88347.08 (581.8%) stddev-sans-first:88568.65 06:48:49 INFO - PROCESS | 6335 | Values: 423.5 425.8 432.2 435.5 440.7 18486.7 19099.6 19118.4 19448.9 20207.1 12933.5 13182.9 14758.8 19836.3 19873.1 5361.2 5401.7 5495.2 5497.8 5530.3 5668.0 5671.8 5694.5 5700.3 5706.1 5592.7 5622.4 5653.6 5707.6 5719.7 5765.2 5784.6 5791.4 5792.5 5798.9 5531.9 5649.5 5688.7 5727.3 5730.5 13806.4 13819.7 13841.2 13857.6 13876.9 2261.8 2536.4 2662.1 2762.8 2960.5 9858.8 9933.1 10223.7 10313.0 10672.1 1954.3 2064.8 2090.1 2097.6 2102.6 56370.7 66857.7 75801.6 80728.0 82234.6 11232.3 11267.8 11559.4 11704.9 11838.2 14299.8 15023.6 15851.4 16339.1 16357.0 8687.3 8696.9 8720.9 8756.3 8867.8 8574.1 8587.7 8647.3 8735.1 8796.0 4963.9 5103.8 5117.2 5120.8 5146.6 2011.5 2036.9 2038.6 2044.9 2059.7 466.6 486.1 896.5 1076.6 1095.7 11871.8 12245.7 12314.4 12358.6 12365.4 485.6 497.4 1037.5 1067.3 1083.8 10497.3 10709.6 10795.2 10805.7 10855.8 529558.0 529805.0 537565.0 547342.0 547557.0 59151.4 65503.0 99786.0 100815.0 102900.5 1121.6 1145.4 1149.2 1154.8 1164.7 16565.8 16668.8 16896.7 16905.2 17248.1 27605.3 35453.3 39489.4 40263.0 40513.0 48805.0 49381.0 50891.5 50894.5 51554.2 8733.7 8736.5 8811.5 8827.6 9043.9 9965.0 13138.1 13302.8 13700.1 13739.2 11563.4 11885.8 11995.9 12085.4 12428.9 6521.5 11154.0 11492.9 11540.4 11776.6 11791.5 12235.6 12338.3 12375.3 12661.3 8882.7 9150.0 9308.0 9378.9 9499.9 9568.5 12441.4 12479.1 12598.0 12676.6 06:48:49 INFO - PROCESS | 6335 | 06:48:49 INFO - PROCESS | 6335 | [#3] mootools.html Cycles:180 Average:5800.95 Median:4963.57 stddev:3261.17 (65.7%) stddev-sans-first:3253.68 06:48:49 INFO - PROCESS | 6335 | Values: 1417.4 1578.9 1584.9 1818.1 1913.7 7717.5 8417.6 8594.9 8597.6 8599.5 8437.1 8621.9 8622.4 8624.5 8638.8 2120.1 2170.0 2369.3 2379.8 2399.7 2462.8 2470.4 2489.4 2492.0 2492.9 2405.0 2428.7 2492.1 2507.1 2509.2 2117.7 2402.6 2410.0 2413.3 2465.1 2418.8 2433.9 2449.4 2457.3 2458.5 8431.5 8507.4 8516.9 8533.6 8559.7 5364.2 5541.8 5546.3 5547.3 5556.7 3425.4 3460.6 3464.4 3522.2 3567.1 1082.0 1086.5 1091.0 1109.7 1115.5 12462.0 12643.8 12648.3 12656.1 12671.9 4773.9 4799.6 4808.4 4860.2 4902.5 10656.5 10667.6 10671.4 10682.5 10692.3 5543.7 5545.1 5545.9 5546.1 5549.4 4414.4 4874.7 4960.1 4967.0 5069.8 4166.5 4181.1 4287.1 4323.0 4358.3 1351.2 1369.1 1371.5 1372.9 1400.7 995.5 998.8 1007.0 1011.2 1027.1 5862.5 5890.2 5891.1 6041.0 6052.7 434.8 459.3 468.0 471.0 471.6 3949.5 4024.3 4079.5 4096.4 4144.4 10768.9 11202.6 11287.4 11303.5 11310.9 10996.7 11035.5 11060.6 11073.7 11092.7 7877.8 8193.1 8201.1 8369.7 8393.8 5872.0 5965.7 6035.4 6123.1 6125.1 9377.4 9391.2 9403.2 9463.0 9562.7 9360.7 9709.3 9709.5 9711.7 9800.2 7089.0 7284.5 7294.9 7739.1 7875.7 8077.6 8225.7 8303.0 8338.6 8342.0 7282.2 7342.2 7469.9 7519.7 7711.8 7471.3 7558.1 7586.5 7666.8 7686.2 7071.3 7112.9 7126.3 7135.6 7143.2 4979.0 5186.1 5193.0 5307.0 5319.3 5177.1 5222.3 5270.4 5301.3 5382.6 06:48:49 INFO - PROCESS | 6335 | 06:48:49 INFO - PROCESS | 6335 | [#4] prototype.html Cycles:180 Average:5550.59 Median:6395.94 stddev:1690.51 (26.4%) stddev-sans-first:1649.43 06:48:49 INFO - PROCESS | 6335 | Values: 342.2 349.6 349.6 353.5 355.0 6201.3 6268.9 6285.5 6374.9 6438.4 6207.8 6249.5 6275.3 6276.5 6293.4 4506.1 4726.8 4739.2 4741.6 4747.4 4623.1 4726.3 4760.8 4762.3 4771.0 4711.4 4711.9 4716.2 4717.0 4729.0 4483.4 4576.7 4702.8 4714.0 4729.4 4085.4 4094.4 4094.9 4099.4 4121.5 5986.0 6004.5 6027.9 6029.9 6032.7 5521.6 5524.0 5526.1 5533.5 5534.9 6571.7 6577.6 6584.9 6585.4 6586.7 4519.1 4608.2 4618.2 4624.2 4624.5 6778.4 6827.1 6849.4 6859.5 6870.5 4673.0 4684.4 4685.1 4689.4 4694.8 4732.3 4735.2 4742.9 4743.7 4745.8 5482.2 5484.0 5488.1 5488.6 5491.8 6456.7 6610.9 6615.9 6626.2 6632.4 1640.8 1647.3 1658.8 1663.3 1666.1 1088.1 1094.5 1101.5 1109.7 1114.9 6175.9 6360.5 6477.9 6534.8 6536.8 6952.0 6956.5 6961.5 6968.3 6969.4 6443.2 6455.2 6457.4 6459.0 6483.8 3657.8 3704.7 3708.5 3710.8 3716.7 6887.2 7054.5 7076.6 7132.6 7169.4 6946.3 6947.7 6948.8 6962.2 6973.0 7119.0 7134.1 7140.4 7143.2 7144.4 6852.8 6859.2 6859.9 6865.3 6869.2 6597.2 6774.5 6792.7 6806.7 6821.5 7111.6 7131.6 7137.6 7138.4 7144.6 4689.3 4694.4 4733.2 4744.3 4744.4 6816.8 6839.9 6857.0 6870.3 6889.1 6502.3 6703.2 6716.7 6738.5 6740.3 6640.0 6676.2 6686.0 6688.6 6693.0 6558.5 6561.6 6578.5 6582.5 6584.8 6724.1 6731.1 6732.2 6736.4 6742.1 6417.0 6519.4 6531.1 6536.7 6564.8 06:48:49 INFO - PROCESS | 6335 | 06:48:49 INFO - PROCESS | 6335 | [#5] yui.html Cycles:180 Average:16034.24 Median:4786.97 stddev:18459.57 (385.6%) stddev-sans-first:18475.99 06:48:49 INFO - PROCESS | 6335 | Values: 818.3 822.5 849.2 929.0 931.9 15644.6 15722.4 15777.8 15783.8 15818.3 13973.7 14005.2 14010.4 14032.9 14033.7 727.1 859.2 870.4 879.0 881.5 871.8 877.1 877.3 877.5 878.7 928.5 929.7 930.6 930.6 931.8 755.8 907.3 923.1 927.5 930.8 665.3 668.1 669.5 670.1 670.2 14472.2 14624.0 14661.9 14669.6 14721.5 14100.7 14391.9 14411.6 14843.2 15337.7 11999.3 12098.2 12199.5 12211.0 12346.9 4078.3 4080.3 4134.7 4150.6 4157.7 57822.0 57900.7 58038.0 58169.1 58285.0 11900.1 12151.3 12477.5 12483.1 12732.3 21744.0 21809.1 21866.7 21872.1 21978.5 9025.0 9148.5 9150.7 9181.5 9188.6 4767.3 4806.6 4850.5 4888.6 4942.7 3592.3 3651.0 3661.4 3661.7 3663.1 608.3 609.1 656.0 697.1 721.8 742.2 799.9 810.2 828.0 830.5 9935.9 9973.9 10023.4 10046.9 10192.8 775.1 776.8 799.1 820.2 839.6 4507.9 4841.3 4883.2 4919.5 4960.3 65964.0 67576.7 67936.7 68084.0 68207.7 57974.4 58398.0 59498.7 59511.4 59532.7 49516.0 49770.8 50147.0 53338.2 53422.0 9292.3 9731.9 9754.7 9832.9 9882.7 38607.6 38873.8 39122.0 39289.8 40926.8 45208.8 49722.0 52977.5 53287.5 54958.7 13024.5 13142.0 13164.0 13340.9 13539.5 14205.6 14621.3 14724.4 15360.2 15433.5 13614.9 13727.3 13884.1 13889.2 14134.9 13527.5 13685.7 13766.6 13769.4 14249.1 12836.8 13292.3 13438.7 13541.9 13651.4 11375.0 11394.9 11466.4 11652.1 11658.9 10579.0 11222.0 11235.2 11372.6 11403.0 06:48:49 INFO - PROCESS | 6335 | -------- Summary: end -------- 06:48:49 INFO - PROCESS | 6335 | 06:48:50 INFO - TEST-INFO | 6335: exit 0 06:48:50 INFO - TEST-OK | dromaeo_css | took 1110689ms 06:48:50 INFO - TEST-START | kraken 06:48:50 INFO - operating with platform_type : linux_ 06:48:50 INFO - Initialising browser for kraken test... 06:48:50 INFO - TEST-INFO | started process 6527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeomLpj/profile http://localhost:58281/getInfo.html) 06:48:53 INFO - PROCESS | 6527 | __metrics Screen width/height:1600/1200 06:48:53 INFO - PROCESS | 6527 | colorDepth:24 06:48:53 INFO - PROCESS | 6527 | Browser inner width/height: 1024/697 06:48:53 INFO - PROCESS | 6527 | __metrics 06:48:54 ERROR - PROCESS | 6527 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:48:55 INFO - TEST-INFO | 6527: exit 0 06:48:55 INFO - Browser initialized. 06:48:55 INFO - Running cycle 1/1 for kraken test... 06:48:55 INFO - TEST-INFO | started process 6616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeomLpj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:07 INFO - PROCESS | 6616 | RSS: Main: 142340096 06:49:07 INFO - PROCESS | 6616 | 06:49:09 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58281/tests/kraken/driver.html?testName=audio-beat-detection) 06:49:10 INFO - PROCESS | 6616 | RSS: Main: 196169728 06:49:10 INFO - PROCESS | 6616 | 06:49:13 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58281/tests/kraken/driver.html?testName=audio-dft) 06:49:13 INFO - PROCESS | 6616 | RSS: Main: 181420032 06:49:13 INFO - PROCESS | 6616 | 06:49:16 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58281/tests/kraken/driver.html?testName=audio-fft) 06:49:17 INFO - PROCESS | 6616 | RSS: Main: 272400384 06:49:17 INFO - PROCESS | 6616 | 06:49:19 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58281/tests/kraken/driver.html?testName=audio-oscillator) 06:49:20 INFO - PROCESS | 6616 | RSS: Main: 177975296 06:49:20 INFO - PROCESS | 6616 | 06:49:22 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:49:22 INFO - PROCESS | 6616 | RSS: Main: 176422912 06:49:22 INFO - PROCESS | 6616 | 06:49:25 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58281/tests/kraken/driver.html?testName=imaging-darkroom) 06:49:26 INFO - PROCESS | 6616 | RSS: Main: 211755008 06:49:26 INFO - PROCESS | 6616 | 06:49:29 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58281/tests/kraken/driver.html?testName=imaging-desaturate) 06:49:30 INFO - PROCESS | 6616 | RSS: Main: 211951616 06:49:30 INFO - PROCESS | 6616 | 06:49:33 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58281/tests/kraken/driver.html?testName=json-parse-financial) 06:49:33 INFO - PROCESS | 6616 | RSS: Main: 211128320 06:49:33 INFO - PROCESS | 6616 | 06:49:35 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:49:35 INFO - PROCESS | 6616 | RSS: Main: 191627264 06:49:35 INFO - PROCESS | 6616 | 06:49:37 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58281/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:49:38 INFO - PROCESS | 6616 | RSS: Main: 193392640 06:49:38 INFO - PROCESS | 6616 | 06:49:40 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:49:40 INFO - PROCESS | 6616 | RSS: Main: 209031168 06:49:40 INFO - PROCESS | 6616 | 06:49:43 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:49:43 INFO - PROCESS | 6616 | RSS: Main: 212885504 06:49:43 INFO - PROCESS | 6616 | 06:49:46 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:49:47 INFO - PROCESS | 6616 | RSS: Main: 208244736 06:49:47 INFO - PROCESS | 6616 | 06:49:48 INFO - PROCESS | 6616 | Cycle 1(1): loaded http://localhost:58281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58281/tests/kraken/driver.html?testName=ai-astar) 06:49:49 INFO - PROCESS | 6616 | RSS: Main: 272818176 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | __start_tp_report 06:49:49 INFO - PROCESS | 6616 | _x_x_mozilla_page_load 06:49:49 INFO - PROCESS | 6616 | _x_x_mozilla_page_load_details 06:49:49 INFO - PROCESS | 6616 | |i|pagename|runs| 06:49:49 INFO - PROCESS | 6616 | |0;ai-astar;110;112;111;109;110;110;105;110;109;109 06:49:49 INFO - PROCESS | 6616 | |1;audio-beat-detection;164;127;156;172;130;150;152;129;174;126 06:49:49 INFO - PROCESS | 6616 | |2;audio-dft;160;160;160;166;159;160;160;159;157;164 06:49:49 INFO - PROCESS | 6616 | |3;audio-fft;76;73;76;174;77;76;74;75;163;75 06:49:49 INFO - PROCESS | 6616 | |4;audio-oscillator;92;92;148;91;92;92;158;91;92;145 06:49:49 INFO - PROCESS | 6616 | |5;imaging-gaussian-blur;118;116;117;117;117;117;117;117;116;117 06:49:49 INFO - PROCESS | 6616 | |6;imaging-darkroom;145;145;145;145;146;146;146;147;146;147 06:49:49 INFO - PROCESS | 6616 | |7;imaging-desaturate;95;94;96;95;95;95;94;94;95;94 06:49:49 INFO - PROCESS | 6616 | |8;json-parse-financial;53;54;55;55;54;54;54;72;54;59 06:49:49 INFO - PROCESS | 6616 | |9;json-stringify-tinderbox;58;59;59;58;59;58;58;58;58;58 06:49:49 INFO - PROCESS | 6616 | |10;stanford-crypto-aes;71;71;71;80;74;73;74;74;74;72 06:49:49 INFO - PROCESS | 6616 | |11;stanford-crypto-ccm;121;123;120;113;114;119;118;112;132;129 06:49:49 INFO - PROCESS | 6616 | |12;stanford-crypto-pbkdf2;171;158;162;167;161;160;160;159;158;159 06:49:49 INFO - PROCESS | 6616 | |13;stanford-crypto-sha256-iterative;67;66;65;63;65;67;64;65;67;65 06:49:49 INFO - PROCESS | 6616 | __end_tp_report 06:49:49 INFO - PROCESS | 6616 | __start_cc_report 06:49:49 INFO - PROCESS | 6616 | _x_x_mozilla_cycle_collect,1610 06:49:49 INFO - PROCESS | 6616 | __end_cc_report 06:49:49 INFO - PROCESS | 6616 | __startTimestamp1464616189004__endTimestamp 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | ------- Summary: start ------- 06:49:49 INFO - PROCESS | 6616 | Number of tests: 14 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.84 (1.7%) stddev-sans-first:1.94 06:49:49 INFO - PROCESS | 6616 | Values: 110.0 112.0 111.0 109.0 110.0 110.0 105.0 110.0 109.0 109.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:154.00 stddev:18.86 (12.2%) stddev-sans-first:19.10 06:49:49 INFO - PROCESS | 6616 | Values: 164.0 127.0 156.0 172.0 130.0 150.0 152.0 129.0 174.0 126.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.00 stddev:2.59 (1.6%) stddev-sans-first:2.74 06:49:49 INFO - PROCESS | 6616 | Values: 160.0 160.0 160.0 166.0 159.0 160.0 160.0 159.0 157.0 164.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.50 stddev:39.42 (52.2%) stddev-sans-first:41.27 06:49:49 INFO - PROCESS | 6616 | Values: 76.0 73.0 76.0 174.0 77.0 76.0 74.0 75.0 163.0 75.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:92.00 stddev:28.50 (31.0%) stddev-sans-first:29.53 06:49:49 INFO - PROCESS | 6616 | Values: 92.0 92.0 148.0 91.0 92.0 92.0 158.0 91.0 92.0 145.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 06:49:49 INFO - PROCESS | 6616 | Values: 118.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 06:49:49 INFO - PROCESS | 6616 | Values: 145.0 145.0 145.0 145.0 146.0 146.0 146.0 147.0 146.0 147.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:49:49 INFO - PROCESS | 6616 | Values: 95.0 94.0 96.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:54.50 stddev:5.72 (10.5%) stddev-sans-first:5.93 06:49:49 INFO - PROCESS | 6616 | Values: 53.0 54.0 55.0 55.0 54.0 54.0 54.0 72.0 54.0 59.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 06:49:49 INFO - PROCESS | 6616 | Values: 58.0 59.0 59.0 58.0 59.0 58.0 58.0 58.0 58.0 58.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:74.00 stddev:2.67 (3.6%) stddev-sans-first:2.69 06:49:49 INFO - PROCESS | 6616 | Values: 71.0 71.0 71.0 80.0 74.0 73.0 74.0 74.0 74.0 72.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:120.50 stddev:6.57 (5.5%) stddev-sans-first:6.96 06:49:49 INFO - PROCESS | 6616 | Values: 121.0 123.0 120.0 113.0 114.0 119.0 118.0 112.0 132.0 129.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:160.50 stddev:4.25 (2.6%) stddev-sans-first:2.79 06:49:49 INFO - PROCESS | 6616 | Values: 171.0 158.0 162.0 167.0 161.0 160.0 160.0 159.0 158.0 159.0 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - PROCESS | 6616 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:1.35 (2.1%) stddev-sans-first:1.30 06:49:49 INFO - PROCESS | 6616 | Values: 67.0 66.0 65.0 63.0 65.0 67.0 64.0 65.0 67.0 65.0 06:49:49 INFO - PROCESS | 6616 | -------- Summary: end -------- 06:49:49 INFO - PROCESS | 6616 | 06:49:49 INFO - TEST-INFO | 6616: exit 0 06:49:49 INFO - TEST-OK | kraken | took 59586ms 06:49:49 INFO - SUITE-END | took 1170s 06:49:50 INFO - Completed test suite (00:19:30) 06:49:50 INFO - javascript benchmark 06:49:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.2737197816477, 3357.1607098225427, 3362.680545348191, 3382.188274814045, 3394.745394095442, 5484.945150548493, 5508.531774799137, 5521.061419558675, 5531.308586426697, 5534.640248383852, 5462.535684466825, 5482.5613950883935, 5528.838943821802, 5536.363318218406, 5554.028045092113, 4867.415910090776, 4948.084604348198, 5041.773120209581, 5082.0598189334905, 5111.4121875984365, 4910.435299940499, 4956.950430495703, 4968.552830245278, 4976.154053810861, 4980.978899325648, 4981.701097934118, 5007.949920500803, 5053.5451809337155, 5079.2635067915135, 5082.440931497532, 5035.219540971156, 5064.290999260106, 5071.923921141186, 5078.4413714491375, 5107.948920510803, 4829.1790395632825, 4852.17513022787, 4872.634552408548, 4979.0788704089855, 4986.925196122061, 5419.295491586108, 5479.698616576086, 5480.506754392084, 5492.890142197134, 5498.092814685572, 5932.9406705932815, 6000.519958403361, 6005.249343832021, 6007.729652165663, 6008.879822403571, 5945.732442040118, 6025.698715064229, 6061.848453788646, 6077.027675571887, 6087.4825639820665, 5572.832815015556, 5585.8603534911545, 5615.522680572197, 5620.156976453523, 5622.184783206453, 5815.9709201453725, 6088.726007329681, 6091.360407157274, 6104.38956104386, 6105.419985101408, 5748.7125643717645, 5819.505342045889, 5827.096799996008, 5827.388124246893, 5834.212381328552, 5970.522358211333, 6012.549058820606, 6015.368386319374, 6015.54883383748, 6018.428249316308, 5773.24947756789, 5903.616264942765, 5950.315713692894, 5971.731272092767, 5983.431574000463, 5924.822255332347, 5967.1347654589845, 5968.134620480006, 5988.431099045583, 6009.459148676553, 4529.728216307032, 4540.614047805973, 4541.5231400703115, 4548.135854187693, 4572.51988541205, 3939.527256729211, 4012.598740126022, 4041.91916161681, 4045.7370270932297, 4127.669786417079, 5601.327840659147, 5619.80330688424, 5624.521915637217, 5626.915596266059, 5651.8304450866535, 5928.347881733006, 5929.911051334234, 5930.436608522184, 5933.703314834327, 5938.673372964528, 5476.67139971595, 5552.555795536347, 5559.332880054339, 5642.971785141048, 5654.46282603152, 5017.84946451607, 5033.924491132636, 5036.169032109734, 5041.445441001487, 5042.495750424928, 6073.08903664445, 6081.17904082952, 6087.3303936566945, 6096.420840020191, 6115.082737589309, 5770.567207459458, 5989.550783691154, 6070.180525628984, 6104.725287362168, 6117.96941015292, 5992.1910542078, 5993.790217342372, 5995.310539287863, 6014.8195554133445, 6054.212952316171, 5675.943240567542, 5756.0, 5764.510016648464, 5769.07694768835, 5784.595078344475, 5886.764529418775, 5958.582899197015, 5960.433758792908, 5962.433568810956, 5997.610155339889, 5766.452187042224, 5815.3893841147765, 5818.505427038749, 5823.301203855395, 5826.854328641818, 5706.3152421708, 5712.685802280915, 5749.13762935563, 5798.0, 5806.796762113306, 5707.315122185364, 5742.712864356849, 5746.080627099644, 5746.913796292975, 5775.711214439178, 5818.040023396092, 5837.562182836389, 5846.853828654318, 5849.415058494116, 5856.736446859816, 5526.751296191601, 5695.8860822784145, 5723.771049157987, 5740.282464691913, 5798.884022319615], "value": 5463.940089045292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.6383171171713, 673.8955461903404, 677.5223467455445, 684.2917580304386, 755.9773206803798, 31375.686243137563, 39696.0, 40187.0, 40212.39681404781, 40229.798851005704, 42915.0, 43529.7823510882, 43544.0, 43593.34609980853, 43621.0, 8021.558814265213, 8852.291816654651, 9051.049639787827, 10495.580176792919, 10683.572657093746, 10505.73735656611, 10651.360918344886, 10660.0, 10664.680059598186, 10669.35983840972, 10700.250982431233, 10811.08105811003, 10812.621558245462, 10819.67540973772, 10820.0, 10667.893321066806, 10721.678349649523, 10731.624393146281, 10736.355818650827, 10739.24825262232, 10633.255672102956, 10754.677359679223, 11159.27464714791, 11167.944160279229, 11171.720706982309, 34116.82941585301, 34805.30389392198, 44385.11229775419, 44817.103657926986, 44883.32675009877, 3794.2411517696573, 3946.2304850554156, 4077.4087757275324, 4486.282194848841, 4538.251188553884, 31448.37103257922, 31695.683043169505, 31714.36571268585, 31961.0, 33330.0, 4298.097399546099, 4405.0, 4408.338749187647, 4412.24991751403, 4468.3074123510905, 346092.0, 351120.99999999744, 354047.0, 354383.0, 355378.0, 39500.407493887615, 40268.1946361077, 67978.3202167972, 68629.65685171643, 68664.0, 38810.0, 38826.80586597105, 38828.0, 39044.41433378502, 39129.80435097806, 14114.64713382153, 15548.067115973077, 15644.765328520081, 15658.0, 16378.590535236475, 14021.649458763408, 14103.0, 14127.293635318192, 14137.43450261978, 14137.717245655029, 9176.0, 9189.3108016899, 9206.723798286062, 9219.17027467531, 9297.0, 3594.6045934947133, 3653.8173091345325, 3681.4109742441615, 3693.7229707772026, 3704.5369328833895, 1063.0, 1092.3664274720643, 1153.9192256542128, 1167.0335484708294, 1194.116353898109, 33612.49581256283, 33765.15587110293, 33895.0, 33906.0, 34060.0, 1190.6904204906614, 1205.921615095016, 1290.4064130500076, 1298.7727147749295, 1324.543032653733, 17542.824571754118, 17993.2802687891, 18034.819651803315, 18251.361202357853, 18291.45125646233, 498972.0, 504663.0, 504738.0, 505099.0, 507280.0, 62654.68672656608, 63349.0, 63447.999999999076, 63469.682651586445, 63659.681701591195, 1416.4560628914533, 1463.3049301581877, 1466.8973171878079, 1508.509734336345, 1564.2257082743888, 29584.704152959057, 30454.238644034078, 30885.0, 31077.0, 31588.842055789573, 46100.0, 46113.0, 46704.29943550781, 46751.766241168574, 46781.766091169324, 253604.0, 254343.0, 254688.0, 255682.0, 256010.0, 27415.0, 29279.414411712074, 30929.0, 31283.374332512765, 31358.37283254368, 44861.32708009448, 45040.324395134754, 46213.0, 51044.23433648572, 52503.0, 37639.435408468344, 38161.23677526379, 38219.23561528698, 38355.0, 39699.206015878946, 37514.0, 37929.43105853359, 38058.0, 38203.80898095492, 38555.0, 42867.0, 43069.0, 43754.34368484412, 44012.779936100116, 44345.0, 35434.82282588674, 36872.0, 36966.0, 37590.43614345841, 37717.81141094277, 28192.85903570469, 28328.0, 28768.280792980342, 29073.27316817012, 29158.416831662824], "value": 19537.05290056658, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.4896949176243, 425.75519076531003, 432.20690033787986, 435.46872815165506, 440.72674941536246, 18486.722699159505, 19099.618007639838, 19118.426447206606, 19448.902755486204, 20207.09068091936, 12933.547325843598, 13182.868171318283, 14758.778618320734, 19836.313913317386, 19873.10571024304, 5361.249425080492, 5401.70290634015, 5495.175723641466, 5497.835064948058, 5530.308711411074, 5668.0, 5671.829845104653, 5694.4590263924865, 5700.344460387047, 5706.087026075828, 5592.748326325304, 5622.409646987069, 5653.604247702662, 5707.62900411474, 5719.74165683551, 5765.164051212592, 5784.566157538202, 5791.449812267828, 5792.478676919077, 5798.942010579883, 5531.917021244684, 5649.4633009864, 5688.715564221814, 5727.255456790632, 5730.541556675456, 13806.447742090304, 13819.723605527934, 13841.238731869744, 13857.58427247174, 13876.930615346959, 2261.7512073671883, 2536.353229926357, 2662.0815818542574, 2762.8204166729097, 2960.4523163214876, 9858.80282394348, 9933.10602045812, 10223.744406389826, 10313.0, 10672.09287210588, 1954.3355259211794, 2064.7728749837506, 2090.1221486975355, 2097.601455723423, 2102.6005059038735, 56370.71814640942, 66857.66571167162, 75801.62099189524, 80728.0, 82234.58882705608, 11232.3260604364, 11267.830982535268, 11559.364234967157, 11704.88295117055, 11838.171328006956, 14299.78550321746, 15023.624409389853, 15851.365945362288, 16339.101349425895, 16357.0, 8687.305015598737, 8696.869546956801, 8720.912790872137, 8756.343274254456, 8867.778305542413, 8574.09971952936, 8587.656493740305, 8647.308215342757, 8735.082816304324, 8796.0, 4963.851084467472, 5103.795848166106, 5117.232415137684, 5120.769565369567, 5146.588272938156, 2011.4971257185703, 2036.8879711616003, 2038.6024725178447, 2044.9386518404472, 2059.7116403703494, 466.62902992121343, 486.14681234433345, 896.5024411451707, 1076.5908954597203, 1095.6993799337567, 11871.76256474883, 12245.69385765363, 12314.384280785926, 12358.567450139202, 12365.443555040045, 485.6406259368042, 497.4428639923309, 1037.5175543372368, 1067.3435836960368, 1083.815751322277, 10497.317674351143, 10709.625163119254, 10795.244332896778, 10805.675829725122, 10855.835422783472, 529558.0, 529805.0, 537565.0, 547342.0, 547557.0, 59151.408485915454, 65503.0, 99786.0, 100815.0, 102900.48549757354, 1121.6466812953893, 1145.4272863568217, 1149.1553708024596, 1154.786364522566, 1164.714644912002, 16565.751513727544, 16668.833311666727, 16896.66206675835, 16905.154742263083, 17248.051357175475, 27605.30986725348, 35453.29093418066, 39489.407658884564, 40263.0, 40513.0, 48805.0, 49381.0, 50891.49108508867, 50894.49105509045, 51554.22668659898, 8733.650653974024, 8736.519491428033, 8811.471311721318, 8827.602757875782, 9043.864342035007, 9965.0, 13138.080334376502, 13302.800457993331, 13700.109492882932, 13739.175649461064, 11563.364014979257, 11885.82171267449, 11995.880041199825, 12085.395730213279, 12428.937855310665, 6521.5108866834225, 11154.0, 11492.885071149516, 11540.422978850856, 11776.646700598652, 11791.528338866348, 12235.571754988532, 12338.259704417764, 12375.257484550595, 12661.303628300531, 8882.733517994471, 9149.954250228706, 9308.0, 9378.906210937803, 9499.857502137611, 9568.4737339447, 12441.440135193758, 12479.126461147996, 12598.0, 12676.556320528738], "value": 8929.64847787997, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.3976060174436, 1578.8657964073054, 1584.8890577659563, 1818.0818686563284, 1913.661109644514, 7717.498362606434, 8417.579121043946, 8594.87107693385, 8597.613107410174, 8599.484030958147, 8437.114103019187, 8621.913780862189, 8622.35332350073, 8624.482531048141, 8638.784030399243, 2120.07776617172, 2169.967450488244, 2369.3247424484025, 2379.7501262367464, 2399.7360290368047, 2462.7660372264604, 2470.3700556358103, 2489.427431690712, 2491.9750802492017, 2492.9376765580914, 2405.001924201454, 2428.732839387666, 2492.140211626986, 2507.059852555292, 2509.2346834215555, 2117.714108595343, 2402.615581506959, 2410.0118951229997, 2413.3122060212754, 2465.0755966512556, 2418.830681852271, 2433.9322287737714, 2449.3876530867283, 2457.31195265326, 2458.520588485246, 8431.494110353337, 8507.404481686284, 8516.914830851736, 8533.615987280526, 8559.700410485602, 5364.168553874156, 5541.750621222055, 5546.27898373213, 5547.33431988164, 5556.666600004012, 3425.4348032574594, 3460.619331873492, 3464.4110501214855, 3522.172289511963, 3567.126054116732, 1081.9621313254, 1086.5219303506433, 1090.9908334790366, 1109.7281166114274, 1115.4590023838432, 12462.0, 12643.810342844865, 12648.304343261208, 12656.114072014963, 12671.936640316831, 4773.880652983634, 4799.592034677022, 4808.422989241313, 4860.2223644217465, 4902.509749025069, 10656.467176641137, 10667.573297068031, 10671.35971841692, 10682.519286631965, 10692.305000174963, 5543.722813859291, 5545.057340252167, 5545.944540554624, 5546.112621980464, 5549.445055494418, 4414.448193975753, 4874.707517548958, 4960.131976904027, 4967.0065986802065, 5069.847904562869, 4166.500019997619, 4181.059261666101, 4287.121140166259, 4323.0, 4358.302671572533, 1351.1892864281353, 1369.103237379498, 1371.533678549298, 1372.8901687864948, 1400.7338605665095, 995.5470261031213, 998.83519219328, 1006.959721611142, 1011.1506334678905, 1027.1166796554958, 5862.501687356623, 5890.175375447441, 5891.145783861316, 6041.033434650435, 6052.727627256784, 434.81520353849487, 459.3087403457775, 467.9578837904537, 471.03437952197856, 471.6368396334803, 3949.54580223278, 4024.2957482440456, 4079.4678351557673, 4096.446979657768, 4144.44050053245, 10768.892311076788, 11202.60790872332, 11287.435628218556, 11303.547858085585, 11310.94344528272, 10996.725081872857, 11035.503402346914, 11060.612878549213, 11073.72315692098, 11092.667219983252, 7877.842443151105, 8193.057798353266, 8201.13888041759, 8369.748907532661, 8393.790155246046, 5872.002862936773, 5965.671888046026, 6035.39646035393, 6123.050927106306, 6125.081237814364, 9377.437353758796, 9391.154796068387, 9403.153716165305, 9462.952685236529, 9562.713118606453, 9360.719178424659, 9709.27180461454, 9709.514524273616, 9711.66009189675, 9800.166985806001, 7089.0, 7284.526505777108, 7294.927050729637, 7739.110002349802, 7875.684972601031, 8077.636506357346, 8225.670973161246, 8302.958485207535, 8338.583070846313, 8341.957255343083, 7282.198958114709, 7342.155652099863, 7469.850602987801, 7519.661615227437, 7711.768646940601, 7471.252874712485, 7558.13081495635, 7586.506877052974, 7666.769996900102, 7686.154523002577, 7071.328223818729, 7112.857742845217, 7126.2873712628325, 7135.607541585263, 7143.214246432784, 4978.950210497994, 5186.092433824141, 5193.0, 5307.044731948286, 5319.255304257485, 5177.0940085485645, 5222.29499017643, 5270.393904701008, 5301.284326616012, 5382.569394448513], "value": 4606.3181595427595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.2299825392866, 349.60669247097013, 349.6276465564173, 353.45391370332817, 355.02545512567974, 6201.317855035943, 6268.905966410507, 6285.528585356094, 6374.904376434346, 6438.420542151217, 6207.813765587029, 6249.468795152417, 6275.278342990558, 6276.466500347465, 6293.4335909768115, 4506.076254367863, 4726.763661816913, 4739.218029025206, 4741.644376671755, 4747.382840230783, 4623.144718227122, 4726.291056341542, 4760.8333708320215, 4762.333273341717, 4771.0, 4711.434627844664, 4711.858644240679, 4716.198246298138, 4717.0, 4729.0, 4483.39474170986, 4576.656750743708, 4702.835400760957, 4713.952860471403, 4729.432468103815, 4085.3667681509414, 4094.4063110849056, 4094.897627559305, 4099.364598487239, 4121.4848143982, 5986.042233242704, 6004.489618382443, 6027.879442411171, 6029.879402411971, 6032.728527216286, 5521.641093328921, 5523.972380138073, 5526.06056970312, 5533.529649979757, 5534.916976245359, 6571.704273307665, 6577.638229897354, 6584.946408574605, 6585.440237579812, 6586.670666466657, 4519.118771839492, 4608.216603177468, 4618.1687296286655, 4624.237000894848, 4624.491305956342, 6778.389944904933, 6827.112475378169, 6849.383555480031, 6859.519833611599, 6870.519063665545, 4672.976635116803, 4684.414448193976, 4685.133250348628, 4689.413823272091, 4694.835680751157, 4732.313814496879, 4735.21868891629, 4742.928856067162, 4743.66794324394, 4745.762711864393, 5482.17767334895, 5484.040292948718, 5488.121900495901, 5488.643238189505, 5491.764353020619, 6456.709448074848, 6610.933890661128, 6615.86768264632, 6626.171728533934, 6632.403083722392, 1640.8195098539152, 1647.3410635745558, 1658.7594798754355, 1663.3014134063721, 1666.1086318819373, 1088.1403691083956, 1094.458243169636, 1101.4823033174555, 1109.6670998700358, 1114.8550688410455, 6175.938240617626, 6360.491160707133, 6477.902831457532, 6534.803955881332, 6536.803895883131, 6952.0, 6956.513044086865, 6961.512694111465, 6968.303169682991, 6969.372756451944, 6443.226812782496, 6455.225372955276, 6457.354264573505, 6458.967705161538, 6483.837904052342, 3657.798821064867, 3704.666580007812, 3708.5364329458816, 3710.8144592770254, 3716.7212459065677, 6887.2079710832895, 7054.470914681419, 7076.575405475688, 7132.572045677276, 7169.390601798801, 6946.305369463114, 6947.7220911162985, 6948.826279343057, 6962.2341542430295, 6972.988916607063, 7119.038929744522, 7134.143902731706, 7140.357367836919, 7143.249958754256, 7144.357007869213, 6852.794416167523, 6859.176898772179, 6859.897101543581, 6865.27914568963, 6869.210040845367, 6597.208334999831, 6774.525783195326, 6792.728290868507, 6806.727730890907, 6821.488388370793, 7111.60886151246, 7131.607761573163, 7137.643117843983, 7138.4301651406495, 7144.571325720265, 4689.296605509201, 4694.43666759991, 4733.195356789423, 4744.264638980963, 4744.4069491313585, 6816.795496135124, 6839.863202735818, 6857.0, 6870.27862074475, 6889.138857642794, 6502.317256687979, 6703.229128650268, 6716.664166791543, 6738.494612903954, 6740.292269311848, 6640.0, 6676.232233293234, 6685.966570167313, 6688.598684078971, 6692.966535167293, 6558.475321974326, 6561.639109849004, 6578.5395022347975, 6582.506312026521, 6584.8024559263295, 6724.092247546519, 6731.124953756176, 6732.192136943598, 6736.360045795642, 6742.089817874524, 6416.9679151605815, 6519.380658837403, 6531.085648009187, 6536.673166341759, 6564.80305590833], "value": 4997.990340122319, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.2962652119177, 822.5352675738211, 849.2272032450469, 929.0384452092086, 931.9021502742212, 15644.608884777886, 15722.449714260003, 15777.763333549978, 15783.790269362298, 15818.288177032033, 13973.720525589508, 14005.159690418557, 14010.439582416717, 14032.859671403283, 14033.719325613481, 727.0838743183574, 859.230988265502, 870.3689824876977, 879.0286733159862, 881.5327876225579, 871.7994861181932, 877.0659247900996, 877.2543338162543, 877.5349064995562, 878.6617152396342, 928.5450129436595, 929.693201243588, 930.5951910918772, 930.6230976454513, 931.7950050988771, 755.761934990479, 907.3467103685336, 923.1460898668705, 927.4620719982394, 930.7998780262242, 665.3346653346654, 668.0980676087291, 669.5480550628306, 670.1121014655553, 670.17568390879, 14472.204028778413, 14624.049436786681, 14661.926690366587, 14669.633259168499, 14721.484748033874, 14100.717985640333, 14391.856081439157, 14411.567652970427, 14843.183624900626, 15337.693246135126, 11999.280043197436, 12098.213616114925, 12199.451024703909, 12211.023118150526, 12346.938265308705, 4078.286299897506, 4080.285949958775, 4134.669226461876, 4150.584941505856, 4157.729747566398, 57822.0, 57900.710496447246, 58038.0, 58169.12746308809, 58285.0, 11900.107491937966, 12151.331676757687, 12477.5008999639, 12483.126181167412, 12732.29972351511, 21744.0, 21809.127634894427, 21866.671999920014, 21872.12511499554, 21978.45053873634, 9025.0, 9148.496832674267, 9150.725478235663, 9181.540922953825, 9188.63245470187, 4767.332573439721, 4806.615470762401, 4850.53919877611, 4888.608911287089, 4942.703437793743, 3592.317459682652, 3650.9634903651154, 3661.4324779659196, 3661.707063434919, 3663.065918190844, 608.2579253310954, 609.1106983803696, 655.9799511759165, 697.0554898113085, 721.7654262364753, 742.2466196810242, 799.8680217764004, 810.1851851851809, 827.9917200827915, 830.5307501261889, 9935.900640993497, 9973.900260997443, 10023.398596084258, 10046.899531004596, 10192.847107293397, 775.1047540091091, 776.8329809090959, 799.1249581708021, 820.1552401026952, 839.6053854688287, 4507.909841803145, 4841.298011788342, 4883.169861123618, 4919.508049195052, 4960.280759289883, 65964.0, 67576.66211669009, 67936.66031669908, 68084.0, 68207.65896170586, 57974.420255796904, 58398.0, 59498.70250648806, 59511.40488595145, 59532.70233648804, 49516.0, 49770.75114624476, 50147.0, 53338.19992700113, 53422.0, 9292.349535532448, 9731.870931783436, 9754.658586949423, 9832.852507212254, 9882.703518894445, 38607.6139238604, 38873.8056309728, 39122.0, 39289.80355098206, 40926.79536602417, 45208.77395613132, 49722.0, 52977.4702252988, 53287.46712532825, 54958.72520637371, 13024.479020839439, 13142.0, 13164.0, 13340.86659133435, 13539.526116586267, 14205.573832785032, 14621.342039608457, 14724.411023558938, 15360.231988400312, 15433.459828906383, 13614.863851361359, 13727.313634318045, 13884.09753366028, 13889.166650001032, 14134.858651413355, 13527.526536571173, 13685.726285474035, 13766.587002389944, 13769.380377882819, 14249.073810202304, 12836.807447888103, 13292.26892520882, 13438.664033399244, 13541.93229033888, 13651.385687644279, 11375.0, 11394.94676213095, 11466.369349685847, 11652.126090543074, 11658.88341116578, 10579.0, 11222.0, 11235.15736319763, 11372.601958931398, 11403.0], "value": 7288.704011132955, "unit": "score"}], "name": "dromaeo_css", "value": 7367.8267568123865, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 111.0, 109.0, 110.0, 110.0, 105.0, 110.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 127.0, 156.0, 172.0, 130.0, 150.0, 152.0, 129.0, 174.0, 126.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 166.0, 159.0, 160.0, 160.0, 159.0, 157.0, 164.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 76.0, 174.0, 77.0, 76.0, 74.0, 75.0, 163.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 91.0, 92.0, 92.0, 158.0, 91.0, 92.0, 145.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 72.0, 54.0, 59.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 80.0, 74.0, 73.0, 74.0, 74.0, 74.0, 72.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 123.0, 120.0, 113.0, 114.0, 119.0, 118.0, 112.0, 132.0, 129.0], "value": 120.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 158.0, 162.0, 167.0, 161.0, 160.0, 160.0, 159.0, 158.0, 159.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 63.0, 65.0, 67.0, 64.0, 65.0, 67.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1513.7, "alertThreshold": 2.0}]} 06:49:50 INFO - Return code: 0 06:49:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:49:50 ERROR - # TBPL SUCCESS # 06:49:50 INFO - Running post-action listener: _resource_record_post_action 06:49:50 INFO - Running post-run listener: _resource_record_post_run 06:49:51 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 757760; Write bytes: 328675328; Read time: 64; Write time: 160124 06:49:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 76091392; Read time: 0; Write time: 37520 06:49:51 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 757760; Write bytes: 247148544; Read time: 64; Write time: 120472 06:49:51 INFO - Running post-run listener: _upload_blobber_files 06:49:51 INFO - Blob upload gear active. 06:49:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:49:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:49:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:49:51 INFO - (blobuploader) - INFO - Open directory for files ... 06:49:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:49:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:49:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:52 INFO - (blobuploader) - INFO - Done attempting. 06:49:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:49:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:49:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:53 INFO - (blobuploader) - INFO - Done attempting. 06:49:53 INFO - (blobuploader) - INFO - Iteration through files over. 06:49:53 INFO - Return code: 0 06:49:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:49:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:49:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/609ff737139427c4fd65a9c88dd110b87ce1233c15ee3713cff5f2d77e3eedbdfb0294c650f2e8be08884eccc4ce5044609ae8fd64567e85214ec8fe559463e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/910c4a55df16fd675150781e3ae4b9e16535bbc0faf5682153bdd231b474a7f7414f1589e49e8ee57d559ab17bb90cbec7d7b2d4b61a4b7509da67dd90993b91"} 06:49:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:49:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:49:53 INFO - Contents: 06:49:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/609ff737139427c4fd65a9c88dd110b87ce1233c15ee3713cff5f2d77e3eedbdfb0294c650f2e8be08884eccc4ce5044609ae8fd64567e85214ec8fe559463e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/910c4a55df16fd675150781e3ae4b9e16535bbc0faf5682153bdd231b474a7f7414f1589e49e8ee57d559ab17bb90cbec7d7b2d4b61a4b7509da67dd90993b91"} 06:49:53 INFO - Running post-run listener: copy_logs_to_upload_dir 06:49:53 INFO - Copying logs to upload dir... 06:49:53 INFO - mkdir: /builds/slave/test/build/upload/logs 06:49:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.833195 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-30 06:49:53.631695) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 06:49:53.635158) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/609ff737139427c4fd65a9c88dd110b87ce1233c15ee3713cff5f2d77e3eedbdfb0294c650f2e8be08884eccc4ce5044609ae8fd64567e85214ec8fe559463e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/910c4a55df16fd675150781e3ae4b9e16535bbc0faf5682153bdd231b474a7f7414f1589e49e8ee57d559ab17bb90cbec7d7b2d4b61a4b7509da67dd90993b91"} build_url:https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/X-hxknTVR6KfBPGhT_TEHg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/609ff737139427c4fd65a9c88dd110b87ce1233c15ee3713cff5f2d77e3eedbdfb0294c650f2e8be08884eccc4ce5044609ae8fd64567e85214ec8fe559463e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/910c4a55df16fd675150781e3ae4b9e16535bbc0faf5682153bdd231b474a7f7414f1589e49e8ee57d559ab17bb90cbec7d7b2d4b61a4b7509da67dd90993b91"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 06:49:53.660902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:49:53.661246) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1464614806.753054-1643119109 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 06:49:53.747023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 06:49:53.747382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 06:49:53.747733) ========= ========= Total master_lag: 0.17 =========