builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1467073097.89 results: success (0) buildid: 20160627144420 builduid: 4360f4d245a549be90444bafc60905d0 revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:17.893204) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:17.893673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:17.893960) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:17.923059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:17.923347) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 17:18:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-27 17:18:18 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136793 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:18.079085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:18.079394) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018652 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:18.129797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:18.130124) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 676a32cdd41fd372f4c6df3a4954939f73a6ef02 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 676a32cdd41fd372f4c6df3a4954939f73a6ef02 --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=7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 17:18:18,418 truncating revision to first 12 chars 2016-06-27 17:18:18,418 Setting DEBUG logging. 2016-06-27 17:18:18,418 attempt 1/10 2016-06-27 17:18:18,418 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/676a32cdd41f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 17:18:18,733 unpacking tar archive at: mozilla-beta-676a32cdd41f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:18.797587) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:18.797943) ========= script_repo_revision: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:18.798397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:18.798676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 17:18:18.813928) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-27 17:18:18.814207) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:18:19 INFO - MultiFileLogger online at 20160627 17:18:19 in /builds/slave/test 17:18:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:18:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:18:19 INFO - {'append_to_log': False, 17:18:19 INFO - 'base_work_dir': '/builds/slave/test', 17:18:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:18:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:18:19 INFO - 'branch': 'Mozilla-Beta', 17:18:19 INFO - 'buildbot_json_path': 'buildprops.json', 17:18:19 INFO - 'config_files': ('talos/linux_config.py',), 17:18:19 INFO - 'default_actions': ('clobber', 17:18:19 INFO - 'read-buildbot-config', 17:18:19 INFO - 'download-and-extract', 17:18:19 INFO - 'populate-webroot', 17:18:19 INFO - 'create-virtualenv', 17:18:19 INFO - 'install', 17:18:19 INFO - 'run-tests'), 17:18:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:18:19 INFO - 'download_minidump_stackwalk': True, 17:18:19 INFO - 'download_symbols': 'ondemand', 17:18:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:18:19 INFO - 'tooltool.py': '/tools/tooltool.py', 17:18:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:18:19 INFO - '/tools/misc-python/virtualenv.py')}, 17:18:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:18:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:18:19 INFO - 'installer_path': 'installer.exe', 17:18:19 INFO - 'log_level': 'info', 17:18:19 INFO - 'log_name': 'talos', 17:18:19 INFO - 'log_to_console': True, 17:18:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:18:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:18:19 INFO - 'opt_config_files': (), 17:18:19 INFO - 'pip_index': False, 17:18:19 INFO - 'sps_profile': False, 17:18:19 INFO - 'sps_profile_interval': 0, 17:18:19 INFO - 'suite': 'dromaeojs', 17:18:19 INFO - 'system_bits': '32', 17:18:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:18:19 INFO - 'title': 'talos-linux64-ix-005', 17:18:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:18:19 INFO - 'use_talos_json': True, 17:18:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:18:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:18:19 INFO - 'work_dir': 'build'} 17:18:19 INFO - ##### 17:18:19 INFO - ##### Running clobber step. 17:18:19 INFO - ##### 17:18:19 INFO - Running pre-action listener: _resource_record_pre_action 17:18:19 INFO - Running main action method: clobber 17:18:19 INFO - rmtree: /builds/slave/test/build 17:18:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:18:20 INFO - Running post-action listener: _resource_record_post_action 17:18:20 INFO - ##### 17:18:20 INFO - ##### Running read-buildbot-config step. 17:18:20 INFO - ##### 17:18:20 INFO - Running pre-action listener: _resource_record_pre_action 17:18:20 INFO - Running main action method: read_buildbot_config 17:18:20 INFO - Using buildbot properties: 17:18:20 INFO - { 17:18:20 INFO - "project": "", 17:18:20 INFO - "product": "firefox", 17:18:20 INFO - "script_repo_revision": "production", 17:18:20 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 17:18:20 INFO - "repository": "", 17:18:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 17:18:20 INFO - "buildid": "20160627144420", 17:18:20 INFO - "pgo_build": "True", 17:18:20 INFO - "basedir": "/builds/slave/test", 17:18:20 INFO - "buildnumber": 140, 17:18:20 INFO - "slavename": "talos-linux64-ix-005", 17:18:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:18:20 INFO - "platform": "ubuntu64_hw", 17:18:20 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:18:20 INFO - "branch": "mozilla-beta", 17:18:20 INFO - "repo_path": "releases/mozilla-beta", 17:18:20 INFO - "revision": "676a32cdd41fd372f4c6df3a4954939f73a6ef02", 17:18:20 INFO - "stage_platform": "linux64-pgo", 17:18:20 INFO - "builduid": "4360f4d245a549be90444bafc60905d0", 17:18:20 INFO - "slavebuilddir": "test" 17:18:20 INFO - } 17:18:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 17:18:20 INFO - Running post-action listener: _resource_record_post_action 17:18:20 INFO - ##### 17:18:20 INFO - ##### Running download-and-extract step. 17:18:20 INFO - ##### 17:18:20 INFO - Running pre-action listener: _resource_record_pre_action 17:18:20 INFO - Running main action method: download_and_extract 17:18:20 INFO - mkdir: /builds/slave/test/build/tests 17:18:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:20 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:18:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:18:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:18:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:18:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:18:22 INFO - Downloaded 1327 bytes. 17:18:22 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:18:22 INFO - Using the following test package requirements: 17:18:22 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 17:18:22 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:18:22 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 17:18:22 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:22 INFO - u'jsshell-linux-x86_64.zip'], 17:18:22 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:18:22 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 17:18:22 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 17:18:22 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 17:18:22 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:18:22 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:18:22 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:18:22 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:18:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:22 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:18:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:18:24 INFO - Downloaded 24236181 bytes. 17:18:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:18:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:18:26 INFO - Return code: 0 17:18:26 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:26 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:18:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:18:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:18:27 INFO - Downloaded 24236181 bytes. 17:18:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:18:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:18:28 INFO - Return code: 0 17:18: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')]} 17:18:28 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:18:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:18:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:18:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:18:30 INFO - Downloaded 10840145 bytes. 17:18:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:18:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:18:30 INFO - Return code: 0 17:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:30 INFO - https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:18:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:18:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:18:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:18:31 INFO - Downloaded 56013298 bytes. 17:18:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:18:31 INFO - mkdir: /builds/slave/test/properties 17:18:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:18:31 INFO - Writing to file /builds/slave/test/properties/build_url 17:18:31 INFO - Contents: 17:18:31 INFO - build_url:https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:18:32 INFO - Running post-action listener: _resource_record_post_action 17:18:32 INFO - Running post-action listener: set_extra_try_arguments 17:18:32 INFO - ##### 17:18:32 INFO - ##### Running populate-webroot step. 17:18:32 INFO - ##### 17:18:32 INFO - Running pre-action listener: _resource_record_pre_action 17:18:32 INFO - Running main action method: populate_webroot 17:18:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:18:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:18:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:18:32 INFO - '--tppagecycles', 17:18:32 INFO - '7'], 17:18:32 INFO - 'tests': ['tsvgm']}}, 17:18:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:18:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:18:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:18:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:18:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:18:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:18:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:32 INFO - 'talos_options': ['--disable-e10s'], 17:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:32 INFO - 'talos_options': ['--disable-e10s'], 17:18:32 INFO - 'tests': ['damp', 'tps']}, 17:18:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:32 INFO - 'tests': ['damp', 'tps']}, 17:18:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:18:32 INFO - 'tests': ['dromaeo_dom']}, 17:18:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:18:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:18:32 INFO - 'tests': ['a11yr', 17:18:32 INFO - 'ts_paint', 17:18:32 INFO - 'tpaint', 17:18:32 INFO - 'sessionrestore', 17:18:32 INFO - 'sessionrestore_no_auto_restore', 17:18:32 INFO - 'tabpaint']}, 17:18:32 INFO - 'other-e10s': {'tests': ['a11yr', 17:18:32 INFO - 'ts_paint', 17:18:32 INFO - 'tpaint', 17:18:32 INFO - 'sessionrestore', 17:18:32 INFO - 'sessionrestore_no_auto_restore', 17:18:32 INFO - 'tabpaint']}, 17:18:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:18:32 INFO - 'ts_paint', 17:18:32 INFO - 'tpaint', 17:18:32 INFO - 'sessionrestore', 17:18:32 INFO - 'sessionrestore_no_auto_restore', 17:18:32 INFO - 'tabpaint']}, 17:18:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:18:32 INFO - 'ts_paint', 17:18:32 INFO - 'tpaint', 17:18:32 INFO - 'sessionrestore', 17:18:32 INFO - 'sessionrestore_no_auto_restore', 17:18:32 INFO - 'tabpaint']}, 17:18:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:18:32 INFO - 'tests': ['a11yr', 17:18:32 INFO - 'ts_paint', 17:18:32 INFO - 'tpaint', 17:18:32 INFO - 'sessionrestore', 17:18:32 INFO - 'sessionrestore_no_auto_restore', 17:18:32 INFO - 'tabpaint']}, 17:18:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:18:32 INFO - 'tests': ['a11yr', 17:18:32 INFO - 'ts_paint', 17:18:32 INFO - 'tpaint', 17:18:32 INFO - 'sessionrestore', 17:18:32 INFO - 'sessionrestore_no_auto_restore', 17:18:32 INFO - 'tabpaint']}, 17:18:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:18:32 INFO - 'tests': ['tsvgx', 17:18:32 INFO - 'tsvgr_opacity', 17:18:32 INFO - 'tart', 17:18:32 INFO - 'tscrollx', 17:18:32 INFO - 'cart']}, 17:18:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:18:32 INFO - 'tsvgr_opacity', 17:18:32 INFO - 'tart', 17:18:32 INFO - 'tscrollx', 17:18:32 INFO - 'cart']}, 17:18:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:32 INFO - 'talos_options': ['--disable-e10s'], 17:18:32 INFO - 'tests': ['tp5o']}, 17:18:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:32 INFO - 'tests': ['tp5o']}, 17:18:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:32 INFO - 'talos_options': ['--disable-e10s', 17:18:32 INFO - '--xperf_path', 17:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:32 INFO - 'tests': ['tp5n']}, 17:18:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:32 INFO - 'talos_options': ['--xperf_path', 17:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:32 INFO - 'tests': ['tp5n']}}, 17:18:32 INFO - 'talos.zip': {'path': '', 17:18:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:18:32 INFO - Running post-action listener: _resource_record_post_action 17:18:32 INFO - ##### 17:18:32 INFO - ##### Running create-virtualenv step. 17:18:32 INFO - ##### 17:18:32 INFO - Running pre-action listener: _resource_record_pre_action 17:18:32 INFO - Running main action method: create_virtualenv 17:18:32 INFO - Creating virtualenv /builds/slave/test/build/venv 17:18:32 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 17:18:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:18:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:18:32 INFO - Using real prefix '/usr' 17:18:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:18:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:18:34 INFO - Installing pip.................done. 17:18:34 INFO - Return code: 0 17:18:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:18:34 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')]} 17:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:34 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')]} 17:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:34 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 0x7f85a388ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf640>, '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 0x20d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d09d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', '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 17:18:34 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 17:18:34 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 17:18:34 INFO - Using env: {'DISPLAY': ':0', 17:18:34 INFO - 'HOME': '/home/cltbld', 17:18:34 INFO - 'LANG': 'en_US.UTF-8', 17:18:34 INFO - 'LANGUAGE': 'en_US:en', 17:18:34 INFO - 'LOGNAME': 'cltbld', 17:18:34 INFO - 'MAIL': '/var/mail/cltbld', 17:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:34 INFO - 'MOZ_NO_REMOTE': '1', 17:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:34 INFO - 'NO_EM_RESTART': '1', 17:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:34 INFO - 'PWD': '/builds/slave/test', 17:18:34 INFO - 'SHELL': '/bin/bash', 17:18:34 INFO - 'SHLVL': '1', 17:18:34 INFO - 'TERM': 'linux', 17:18:34 INFO - 'TMOUT': '86400', 17:18:34 INFO - 'USER': 'cltbld', 17:18:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', 17:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:34 INFO - '_': '/tools/buildbot/bin/python'} 17:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:35 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 17:18:35 INFO - Cleaning up... 17:18:35 INFO - Return code: 0 17:18:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f85a388ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf640>, '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 0x20d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d09d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', '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 17:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:18:35 INFO - Using env: {'DISPLAY': ':0', 17:18:35 INFO - 'HOME': '/home/cltbld', 17:18:35 INFO - 'LANG': 'en_US.UTF-8', 17:18:35 INFO - 'LANGUAGE': 'en_US:en', 17:18:35 INFO - 'LOGNAME': 'cltbld', 17:18:35 INFO - 'MAIL': '/var/mail/cltbld', 17:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:35 INFO - 'MOZ_NO_REMOTE': '1', 17:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:35 INFO - 'NO_EM_RESTART': '1', 17:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:35 INFO - 'PWD': '/builds/slave/test', 17:18:35 INFO - 'SHELL': '/bin/bash', 17:18:35 INFO - 'SHLVL': '1', 17:18:35 INFO - 'TERM': 'linux', 17:18:35 INFO - 'TMOUT': '86400', 17:18:35 INFO - 'USER': 'cltbld', 17:18:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', 17:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:35 INFO - '_': '/tools/buildbot/bin/python'} 17:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:35 INFO - Downloading/unpacking psutil>=0.7.1 17:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:18:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:37 INFO - Installing collected packages: psutil 17:18:37 INFO - Running setup.py install for psutil 17:18:37 INFO - building 'psutil._psutil_linux' extension 17:18:37 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 17:18:37 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 17:18:37 INFO - building 'psutil._psutil_posix' extension 17:18:37 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 17:18:37 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 17:18:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:37 INFO - Successfully installed psutil 17:18:37 INFO - Cleaning up... 17:18:37 INFO - Return code: 0 17:18:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f85a388ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf640>, '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 0x20d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d09d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', '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 17:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:18:37 INFO - Using env: {'DISPLAY': ':0', 17:18:37 INFO - 'HOME': '/home/cltbld', 17:18:37 INFO - 'LANG': 'en_US.UTF-8', 17:18:37 INFO - 'LANGUAGE': 'en_US:en', 17:18:37 INFO - 'LOGNAME': 'cltbld', 17:18:37 INFO - 'MAIL': '/var/mail/cltbld', 17:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:37 INFO - 'MOZ_NO_REMOTE': '1', 17:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:37 INFO - 'NO_EM_RESTART': '1', 17:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:37 INFO - 'PWD': '/builds/slave/test', 17:18:37 INFO - 'SHELL': '/bin/bash', 17:18:37 INFO - 'SHLVL': '1', 17:18:37 INFO - 'TERM': 'linux', 17:18:37 INFO - 'TMOUT': '86400', 17:18:37 INFO - 'USER': 'cltbld', 17:18:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', 17:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:37 INFO - '_': '/tools/buildbot/bin/python'} 17:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:18:40 INFO - Installing collected packages: mozsystemmonitor 17:18:40 INFO - Running setup.py install for mozsystemmonitor 17:18:40 INFO - Successfully installed mozsystemmonitor 17:18:40 INFO - Cleaning up... 17:18:40 INFO - Return code: 0 17:18:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:18:40 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')]} 17:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:40 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')]} 17:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:40 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 0x7f85a388ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf640>, '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 0x20d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d09d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', '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 17:18:40 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 17:18:40 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 17:18:40 INFO - Using env: {'DISPLAY': ':0', 17:18:40 INFO - 'HOME': '/home/cltbld', 17:18:40 INFO - 'LANG': 'en_US.UTF-8', 17:18:40 INFO - 'LANGUAGE': 'en_US:en', 17:18:40 INFO - 'LOGNAME': 'cltbld', 17:18:40 INFO - 'MAIL': '/var/mail/cltbld', 17:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:40 INFO - 'MOZ_NO_REMOTE': '1', 17:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:40 INFO - 'NO_EM_RESTART': '1', 17:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:40 INFO - 'PWD': '/builds/slave/test', 17:18:40 INFO - 'SHELL': '/bin/bash', 17:18:40 INFO - 'SHLVL': '1', 17:18:40 INFO - 'TERM': 'linux', 17:18:40 INFO - 'TMOUT': '86400', 17:18:40 INFO - 'USER': 'cltbld', 17:18:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', 17:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:40 INFO - '_': '/tools/buildbot/bin/python'} 17:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:40 INFO - Downloading/unpacking blobuploader==1.2.4 17:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:42 INFO - Downloading blobuploader-1.2.4.tar.gz 17:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:18:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:18:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:43 INFO - Downloading docopt-0.6.1.tar.gz 17:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:18:43 INFO - Installing collected packages: blobuploader, requests, docopt 17:18:43 INFO - Running setup.py install for blobuploader 17:18:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:18:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:18:43 INFO - Running setup.py install for requests 17:18:43 INFO - Running setup.py install for docopt 17:18:43 INFO - Successfully installed blobuploader requests docopt 17:18:43 INFO - Cleaning up... 17:18:43 INFO - Return code: 0 17:18:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:43 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')]} 17:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:43 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')]} 17:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:43 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 0x7f85a388ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf640>, '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 0x20d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d09d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', '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 17:18:43 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 17:18:43 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 17:18:43 INFO - Using env: {'DISPLAY': ':0', 17:18:43 INFO - 'HOME': '/home/cltbld', 17:18:43 INFO - 'LANG': 'en_US.UTF-8', 17:18:43 INFO - 'LANGUAGE': 'en_US:en', 17:18:43 INFO - 'LOGNAME': 'cltbld', 17:18:43 INFO - 'MAIL': '/var/mail/cltbld', 17:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:43 INFO - 'MOZ_NO_REMOTE': '1', 17:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:43 INFO - 'NO_EM_RESTART': '1', 17:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:43 INFO - 'PWD': '/builds/slave/test', 17:18:43 INFO - 'SHELL': '/bin/bash', 17:18:43 INFO - 'SHLVL': '1', 17:18:43 INFO - 'TERM': 'linux', 17:18:43 INFO - 'TMOUT': '86400', 17:18:43 INFO - 'USER': 'cltbld', 17:18:43 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', 17:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:43 INFO - '_': '/tools/buildbot/bin/python'} 17:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:43 INFO - Running setup.py (path:/tmp/pip-QtQXMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:43 INFO - Running setup.py (path:/tmp/pip-FtFQBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:44 INFO - Running setup.py (path:/tmp/pip-QBM_r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:44 INFO - Running setup.py (path:/tmp/pip-YDi69Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:44 INFO - Running setup.py (path:/tmp/pip-j5ri_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:44 INFO - Running setup.py (path:/tmp/pip-DI6TAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:44 INFO - Running setup.py (path:/tmp/pip-v1oUsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:44 INFO - Running setup.py (path:/tmp/pip-L6ZUH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:44 INFO - Running setup.py (path:/tmp/pip-QDU8vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:44 INFO - Running setup.py (path:/tmp/pip-XGRcVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:44 INFO - Running setup.py (path:/tmp/pip-XeNYAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:44 INFO - Running setup.py (path:/tmp/pip-em6Jy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:44 INFO - Running setup.py (path:/tmp/pip-vkoDHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:44 INFO - Running setup.py (path:/tmp/pip-k8Im4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:44 INFO - Running setup.py (path:/tmp/pip-MlGDj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:45 INFO - Running setup.py (path:/tmp/pip-2lIV08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:45 INFO - Running setup.py (path:/tmp/pip-F0OE3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:18:45 INFO - Running setup.py install for manifestparser 17:18:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:18:45 INFO - Running setup.py install for mozcrash 17:18:45 INFO - Running setup.py install for mozdebug 17:18:45 INFO - Running setup.py install for mozdevice 17:18:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:18:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:18:45 INFO - Running setup.py install for mozfile 17:18:45 INFO - Running setup.py install for mozhttpd 17:18:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:18:45 INFO - Running setup.py install for mozinfo 17:18:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:18:45 INFO - Running setup.py install for mozInstall 17:18:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:18:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:18:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:18:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:18:45 INFO - Running setup.py install for mozleak 17:18:46 INFO - Running setup.py install for mozlog 17:18:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:18:46 INFO - Running setup.py install for moznetwork 17:18:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:18:46 INFO - Running setup.py install for mozprocess 17:18:46 INFO - Running setup.py install for mozprofile 17:18:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:18:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:18:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:18:46 INFO - Running setup.py install for mozrunner 17:18:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:18:46 INFO - Running setup.py install for mozscreenshot 17:18:46 INFO - Running setup.py install for moztest 17:18:46 INFO - Running setup.py install for mozversion 17:18:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:18:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:18:46 INFO - Cleaning up... 17:18:46 INFO - Return code: 0 17:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:46 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 0x7f85a388ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf640>, '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 0x20d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d09d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', '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 17:18:46 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 17:18:46 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 17:18:46 INFO - Using env: {'DISPLAY': ':0', 17:18:46 INFO - 'HOME': '/home/cltbld', 17:18:46 INFO - 'LANG': 'en_US.UTF-8', 17:18:46 INFO - 'LANGUAGE': 'en_US:en', 17:18:46 INFO - 'LOGNAME': 'cltbld', 17:18:46 INFO - 'MAIL': '/var/mail/cltbld', 17:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:46 INFO - 'MOZ_NO_REMOTE': '1', 17:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:46 INFO - 'NO_EM_RESTART': '1', 17:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:46 INFO - 'PWD': '/builds/slave/test', 17:18:46 INFO - 'SHELL': '/bin/bash', 17:18:46 INFO - 'SHLVL': '1', 17:18:46 INFO - 'TERM': 'linux', 17:18:46 INFO - 'TMOUT': '86400', 17:18:46 INFO - 'USER': 'cltbld', 17:18:46 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', 17:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:46 INFO - '_': '/tools/buildbot/bin/python'} 17:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:47 INFO - Running setup.py (path:/tmp/pip-zMFB2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:47 INFO - Running setup.py (path:/tmp/pip-vJmgQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:47 INFO - Running setup.py (path:/tmp/pip-ZWCIIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:47 INFO - Running setup.py (path:/tmp/pip-Le9oVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:47 INFO - Running setup.py (path:/tmp/pip-Kxbok7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:47 INFO - Running setup.py (path:/tmp/pip-_JLUlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:47 INFO - Running setup.py (path:/tmp/pip-oOBPWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:47 INFO - Running setup.py (path:/tmp/pip-RbvtkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:47 INFO - Running setup.py (path:/tmp/pip-uBZ931-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:47 INFO - Running setup.py (path:/tmp/pip-yeIYee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:47 INFO - Running setup.py (path:/tmp/pip-fT4zml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:47 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)) 17:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:47 INFO - Running setup.py (path:/tmp/pip-0Id5OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:48 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)) 17:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:48 INFO - Running setup.py (path:/tmp/pip-ERY9Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:48 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)) 17:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:48 INFO - Running setup.py (path:/tmp/pip-6lCdkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:48 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)) 17:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:48 INFO - Running setup.py (path:/tmp/pip-kmiGIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:48 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)) 17:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:48 INFO - Running setup.py (path:/tmp/pip-oQL_VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:48 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)) 17:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:48 INFO - Running setup.py (path:/tmp/pip-lAxnog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 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)) 17:18:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18:51 INFO - Downloading blessings-1.6.tar.gz 17:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:18:51 INFO - Installing collected packages: blessings 17:18:51 INFO - Running setup.py install for blessings 17:18:51 INFO - Successfully installed blessings 17:18:51 INFO - Cleaning up... 17:18:51 INFO - Return code: 0 17:18:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:18:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:51 INFO - Reading from file tmpfile_stdout 17:18:51 INFO - Current package versions: 17:18:51 INFO - argparse == 1.2.1 17:18:51 INFO - blessings == 1.6 17:18:51 INFO - blobuploader == 1.2.4 17:18:51 INFO - docopt == 0.6.1 17:18:51 INFO - manifestparser == 1.1 17:18:51 INFO - mozInstall == 1.12 17:18:51 INFO - mozcrash == 0.17 17:18:51 INFO - mozdebug == 0.1 17:18:51 INFO - mozdevice == 0.48 17:18:51 INFO - mozfile == 1.2 17:18:51 INFO - mozhttpd == 0.7 17:18:51 INFO - mozinfo == 0.9 17:18:51 INFO - mozleak == 0.1 17:18:51 INFO - mozlog == 3.1 17:18:51 INFO - moznetwork == 0.27 17:18:51 INFO - mozprocess == 0.22 17:18:51 INFO - mozprofile == 0.28 17:18:51 INFO - mozrunner == 6.11 17:18:51 INFO - mozscreenshot == 0.1 17:18:51 INFO - mozsystemmonitor == 0.0 17:18:51 INFO - moztest == 0.7 17:18:51 INFO - mozversion == 1.4 17:18:51 INFO - psutil == 3.1.1 17:18:51 INFO - requests == 1.2.3 17:18:51 INFO - wsgiref == 0.1.2 17:18:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:51 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 0x7f85a388ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf640>, '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 0x20d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d09d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', '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 17:18:51 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 17:18:51 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 17:18:51 INFO - Using env: {'DISPLAY': ':0', 17:18:51 INFO - 'HOME': '/home/cltbld', 17:18:51 INFO - 'LANG': 'en_US.UTF-8', 17:18:51 INFO - 'LANGUAGE': 'en_US:en', 17:18:51 INFO - 'LOGNAME': 'cltbld', 17:18:51 INFO - 'MAIL': '/var/mail/cltbld', 17:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:51 INFO - 'MOZ_NO_REMOTE': '1', 17:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:51 INFO - 'NO_EM_RESTART': '1', 17:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:51 INFO - 'PWD': '/builds/slave/test', 17:18:51 INFO - 'SHELL': '/bin/bash', 17:18:51 INFO - 'SHLVL': '1', 17:18:51 INFO - 'TERM': 'linux', 17:18:51 INFO - 'TMOUT': '86400', 17:18:51 INFO - 'USER': 'cltbld', 17:18:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', 17:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:51 INFO - '_': '/tools/buildbot/bin/python'} 17:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:51 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)) 17:18:51 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)) 17:18:51 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)) 17:18:51 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)) 17:18:51 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)) 17:18:51 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)) 17:18:51 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)) 17:18:51 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)) 17:18:51 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)) 17:18:51 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)) 17:18:51 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)) 17:18:51 INFO - Cleaning up... 17:18:52 INFO - Return code: 0 17:18:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85a388ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf640>, '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 0x20d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d09d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', '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 17:18:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:18:52 INFO - Using env: {'DISPLAY': ':0', 17:18:52 INFO - 'HOME': '/home/cltbld', 17:18:52 INFO - 'LANG': 'en_US.UTF-8', 17:18:52 INFO - 'LANGUAGE': 'en_US:en', 17:18:52 INFO - 'LOGNAME': 'cltbld', 17:18:52 INFO - 'MAIL': '/var/mail/cltbld', 17:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:52 INFO - 'MOZ_NO_REMOTE': '1', 17:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:52 INFO - 'NO_EM_RESTART': '1', 17:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:52 INFO - 'PWD': '/builds/slave/test', 17:18:52 INFO - 'SHELL': '/bin/bash', 17:18:52 INFO - 'SHLVL': '1', 17:18:52 INFO - 'TERM': 'linux', 17:18:52 INFO - 'TMOUT': '86400', 17:18:52 INFO - 'USER': 'cltbld', 17:18:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', 17:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:52 INFO - '_': '/tools/buildbot/bin/python'} 17:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:52 INFO - Downloading/unpacking jsonschema 17:18:52 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 17:18:52 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 17:18:52 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 17:18:52 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 17:18:52 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 17:18:52 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 17:18:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:18:54 INFO - Downloading/unpacking functools32 (from jsonschema) 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:18:54 INFO - warning: no files found matching '*.txt' 17:18:54 INFO - no previously-included directories found matching 'build' 17:18:54 INFO - no previously-included directories found matching 'dist' 17:18:54 INFO - no previously-included directories found matching '.git*' 17:18:54 INFO - Installing collected packages: jsonschema, functools32 17:18:54 INFO - Running setup.py install for functools32 17:18:54 INFO - warning: no files found matching '*.txt' 17:18:54 INFO - no previously-included directories found matching 'build' 17:18:54 INFO - no previously-included directories found matching 'dist' 17:18:54 INFO - no previously-included directories found matching '.git*' 17:18:54 INFO - Successfully installed jsonschema functools32 17:18:54 INFO - Cleaning up... 17:18:54 INFO - Return code: 0 17:18:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:18:54 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')]} 17:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:54 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')]} 17:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:54 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 0x7f85a388ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20407d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cf640>, '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 0x20d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d09d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', '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 17:18:54 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 17:18:54 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 17:18:54 INFO - Using env: {'DISPLAY': ':0', 17:18:54 INFO - 'HOME': '/home/cltbld', 17:18:54 INFO - 'LANG': 'en_US.UTF-8', 17:18:54 INFO - 'LANGUAGE': 'en_US:en', 17:18:54 INFO - 'LOGNAME': 'cltbld', 17:18:54 INFO - 'MAIL': '/var/mail/cltbld', 17:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:54 INFO - 'MOZ_NO_REMOTE': '1', 17:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:54 INFO - 'NO_EM_RESTART': '1', 17:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:54 INFO - 'PWD': '/builds/slave/test', 17:18:54 INFO - 'SHELL': '/bin/bash', 17:18:54 INFO - 'SHLVL': '1', 17:18:54 INFO - 'TERM': 'linux', 17:18:54 INFO - 'TMOUT': '86400', 17:18:54 INFO - 'USER': 'cltbld', 17:18:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', 17:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:54 INFO - '_': '/tools/buildbot/bin/python'} 17:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:54 INFO - Downloading/unpacking flake8 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:18:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:18:56 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 17:18:56 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 17:18:56 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 17:18:56 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 17:18:56 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 17:18:56 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 17:18:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:18:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:18:56 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 17:18:56 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 17:18:56 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 17:18:56 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 17:18:56 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 17:18:56 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 17:18:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:57 INFO - no previously-included directories found matching 'docs/_build' 17:18:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:18:57 INFO - Running setup.py install for pep8 17:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:57 INFO - no previously-included directories found matching 'docs/_build' 17:18:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:18:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:18:57 INFO - Cleaning up... 17:18:57 INFO - Return code: 0 17:18:57 INFO - Running post-action listener: _resource_record_post_action 17:18:57 INFO - Running post-action listener: _start_resource_monitoring 17:18:57 INFO - Starting resource monitoring. 17:18:57 INFO - ##### 17:18:57 INFO - ##### Running install step. 17:18:57 INFO - ##### 17:18:57 INFO - Running pre-action listener: _resource_record_pre_action 17:18:57 INFO - Running main action method: install 17:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:57 INFO - Reading from file tmpfile_stdout 17:18:57 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:18:57 INFO - Reading from file tmpfile_stdout 17:18:57 INFO - Output received: 17:18:57 INFO - Usage: mozinstall [options] installer 17:18:57 INFO - Options: 17:18:57 INFO - -h, --help show this help message and exit 17:18:57 INFO - -d DEST, --destination=DEST 17:18:57 INFO - Directory to install application into. [default: 17:18:57 INFO - "/builds/slave/test"] 17:18:57 INFO - --app=APP Application being installed. [default: firefox] 17:18:57 INFO - mkdir: /builds/slave/test/build/application 17:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:19:11 INFO - Reading from file tmpfile_stdout 17:19:11 INFO - Output received: 17:19:11 INFO - /builds/slave/test/build/application/firefox/firefox 17:19:11 INFO - Running post-action listener: _resource_record_post_action 17:19:11 INFO - ##### 17:19:11 INFO - ##### Running run-tests step. 17:19:11 INFO - ##### 17:19:11 INFO - Running pre-action listener: _resource_record_pre_action 17:19:11 INFO - Running main action method: run_tests 17:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:19:11 INFO - Python 2.7.3 17:19:11 INFO - Return code: 0 17:19:11 INFO - grabbing minidump binary from tooltool 17:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:19:11 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 0x20cf640>, '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 0x20d0540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d09d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:19:11 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 17:19:11 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 17:19:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:19:11 INFO - Return code: 0 17:19:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:19:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:19:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:19:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:19:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:19:12 INFO - Return code: 0 17:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 17:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 17:19:12 INFO - Using env: {'DISPLAY': ':0', 17:19:12 INFO - 'HOME': '/home/cltbld', 17:19:12 INFO - 'LANG': 'en_US.UTF-8', 17:19:12 INFO - 'LANGUAGE': 'en_US:en', 17:19:12 INFO - 'LOGNAME': 'cltbld', 17:19:12 INFO - 'MAIL': '/var/mail/cltbld', 17:19:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:19:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:12 INFO - 'MOZ_NO_REMOTE': '1', 17:19:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:19:12 INFO - 'NO_EM_RESTART': '1', 17:19:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:12 INFO - 'PWD': '/builds/slave/test', 17:19:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:19:12 INFO - 'SHELL': '/bin/bash', 17:19:12 INFO - 'SHLVL': '1', 17:19:12 INFO - 'TERM': 'linux', 17:19:12 INFO - 'TMOUT': '86400', 17:19:12 INFO - 'USER': 'cltbld', 17:19:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543', 17:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:12 INFO - '_': '/tools/buildbot/bin/python'} 17:19:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 17:19:12 INFO - mozversion application_buildid: 20160627144420 17:19:12 INFO - mozversion application_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 17:19:12 INFO - mozversion application_display_name: Firefox 17:19:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:19:12 INFO - mozversion application_name: Firefox 17:19:12 INFO - mozversion application_remotingname: firefox 17:19:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:19:12 INFO - mozversion application_vendor: Mozilla 17:19:12 INFO - mozversion application_version: 48.0 17:19:12 INFO - mozversion platform_buildid: 20160627144420 17:19:12 INFO - mozversion platform_changeset: 676a32cdd41fd372f4c6df3a4954939f73a6ef02 17:19:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:19:12 INFO - mozversion platform_version: 48.0 17:19:12 INFO - using testdate: 1467073152 17:19:12 INFO - actual date: 1467073152 17:19:12 INFO - starting webserver on 'localhost:51438' 17:19:12 INFO - SUITE-START | Running 2 tests 17:19:12 INFO - TEST-START | dromaeo_css 17:19:12 INFO - operating with platform_type : linux_ 17:19:12 INFO - Initialising browser for dromaeo_css test... 17:19:12 INFO - TEST-INFO | started process 23779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP6e9Q1/profile http://localhost:51438/getInfo.html) 17:19:16 INFO - PROCESS | 23779 | __metrics Screen width/height:1600/1200 17:19:16 INFO - PROCESS | 23779 | colorDepth:24 17:19:16 INFO - PROCESS | 23779 | Browser inner width/height: 1024/697 17:19:16 INFO - PROCESS | 23779 | __metrics 17:19:17 ERROR - PROCESS | 23779 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:19:17 INFO - TEST-INFO | 23779: exit 0 17:19:17 INFO - Browser initialized. 17:19:17 INFO - Running cycle 1/1 for dromaeo_css test... 17:19:17 INFO - TEST-INFO | started process 23874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP6e9Q1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:29 INFO - PROCESS | 23874 | RSS: Main: 140263424 17:19:29 INFO - PROCESS | 23874 | 17:20:20 INFO - PROCESS | 23874 | 1467073220847 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] 17:22:28 INFO - PROCESS | 23874 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51438/tests/dromaeo/cssquery-ext.html) 17:22:29 INFO - PROCESS | 23874 | RSS: Main: 243691520 17:22:29 INFO - PROCESS | 23874 | 17:25:31 INFO - PROCESS | 23874 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-ext.html (next: http://localhost:51438/tests/dromaeo/cssquery-jquery.html) 17:25:31 INFO - PROCESS | 23874 | RSS: Main: 222199808 17:25:31 INFO - PROCESS | 23874 | 17:28:33 INFO - PROCESS | 23874 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51438/tests/dromaeo/cssquery-mootools.html) 17:28:34 INFO - PROCESS | 23874 | RSS: Main: 219140096 17:28:34 INFO - PROCESS | 23874 | 17:31:36 INFO - PROCESS | 23874 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51438/tests/dromaeo/cssquery-prototype.html) 17:31:36 INFO - PROCESS | 23874 | RSS: Main: 217636864 17:31:36 INFO - PROCESS | 23874 | 17:34:39 INFO - PROCESS | 23874 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51438/tests/dromaeo/cssquery-yui.html) 17:34:39 INFO - PROCESS | 23874 | RSS: Main: 207302656 17:34:39 INFO - PROCESS | 23874 | 17:37:42 INFO - PROCESS | 23874 | Cycle 1(1): loaded http://localhost:51438/tests/dromaeo/cssquery-yui.html (next: http://localhost:51438/tests/dromaeo/cssquery-dojo.html) 17:37:42 INFO - PROCESS | 23874 | RSS: Main: 241606656 17:37:42 INFO - PROCESS | 23874 | 17:37:42 INFO - PROCESS | 23874 | __start_tp_report 17:37:42 INFO - PROCESS | 23874 | _x_x_mozilla_page_load 17:37:42 INFO - PROCESS | 23874 | _x_x_mozilla_page_load_details 17:37:42 INFO - PROCESS | 23874 | |i|pagename|runs| 17:37:42 INFO - PROCESS | 23874 | |0;dojo.html;3306.735461163107;3322.8172450515226;3325.384803811294;3366.4277072897603;3369.5114208439777;5554.805581804638;5571.8885622287635;5579.525740312069;5596.27248457701;5615.522680572151;5530.336359636849;5576.832695019156;5600.103983362663;5605.943940560594;5628.718564071801;4963.1810751226;4985.651004429673;4995.525425084611;5112.258722485238;5122.718250496221;4966.081274964144;5040.7731652075745;5044.092063428581;5046.318746969149;5046.899062018758;5016.172331565287;5052.040112378636;5085.949140508585;5113.539781419671;5132.358455193101;5001.099802035632;5014.674046187022;5015.824446144367;5019.698818070928;5045.268436076748;4946.282788995612;4946.925796113062;4967.155583550805;4987.177115775893;5027.924581131286;5400.78396864125;5448.809291674773;5448.91826622601;5460.863478413032;5467.45325467454;5873.2658417697785;5915.940840591582;5919.112133180014;5926;5929.673867937262;5966.105084237399;6032.366601506823;6078.909398477554;6105.786297479567;6131.080337949299;5494.36814766299;5495.560355171577;5515.117581186991;5519;5535.363433205152;5958.880822383615;5993.850153746104;5994.490468310242;5997.310309314397;6004.54965877561;5855.677937713466;5930.347661757203;5934.851628709317;5948.970255148696;5961.165436838846;5926.962781513304;5931.940680593225;5940.316863560746;5940.643561386244;5962.761489540369;5748.626339287933;5864.296284445893;5911.793087241926;5912.6452412854505;5915.940840591625;5827.067669172912;5835.387284335084;5836.533077353802;5848.181254624356;5876.41235876409;4496.3705081288645;4496.7301961882395;4500.549945005473;4501.88745281364;4524.16302983949;4011.157656892027;4016.2369149862016;4050.7569545827346;4079.73481723687;4083.591640835952;5612.494875461228;5636.718164091779;5643.887122257532;5646.491815736521;5682.204491371212;5893.675847828325;5893.911591326134;5897.439743224387;5902.498287645512;5917.970410148007;5603.327600687943;5639.520640745583;5685.147227915846;5777.537796976232;5779.046457334577;5041.949580504148;5060.721660308718;5061.367329083864;5062.215356619729;5066.82266120684;6154.292256390572;6159.907601385983;6169.9383006170265;6173.104899789505;6177.289611694623;5824.15549745293;5890.145928840208;5939.732712027882;5982;6006.669633170218;6159.5072394209255;6178.104174894705;6184.474319682878;6191.226096737908;6192.566520343713;5801;5806.44838740319;5810.954028274951;5813.476787089182;5846.327672317738;5864;5904.143899134688;5925.881482370414;5991.161237426677;6016.909746353721;5750.396208398225;5751.3673495916255;5772.6536407815665;5774.82675519735;5787.971060144672;5718.714064296685;5728.140778883201;5737.971310143423;5746.913796292975;5778.855528611818;5381.973090134525;5612.747426365905;5692.430756924275;5711.428857114255;5725.169850371756;5803.680797556175;5804.883902322014;5815.680137592473;5821.185034095315;5845.298564172326;5551.694656793754;5717.771289148387;5718.199452076796;5723.513501352431;5725.2843394575675 17:37:42 INFO - PROCESS | 23874 | |1;ext.html;668.1748041169155;683.497629242507;685.6263336481617;733.853229354129;750.9436792240583;32481.837590812043;33034.504482432756;33065.83467082661;33090.50364244535;40496.797516012375;44437.11125777483;44860.55139448604;44954.32568511475;44962;45001.77499112508;8841.823163536725;9029.690694849243;9041.954790226073;9043.683471078513;9053.818923621524;8687.869681954744;8818.647254109828;8822.86765698515;8828.117188281185;8829.602667879928;8866.335024873128;9166.358354915159;9179;9185.357025008252;9189.770255743626;9043.050479699636;9075.36472446929;9089.136532029479;9107;9111;9045.954770226173;9143.908560914439;9159.35884488086;9167.633294668205;9168.633254669805;43918.34122488165;44384.3342349865;44396.11207775826;44433;44463.55536444659;3724.944125838115;3864.516935383077;3898.8245528951265;3976.5426975897562;3993.341098718708;34025;34508;34897.825510872535;34950.30099397998;35225;3362.8486718097743;3373.561437013197;3386.779859309137;3436.3642726095754;3594.2863138330654;324029;326401;326542;327613;327641;38959.41560876589;40889.182216355504;65070.349296507375;65800.34199658038;65864.6706766463;38831.41752873653;38934.22131557353;38959;39050.41424378636;39065;17274.13629318529;17372;17407.3037078518;17407.91296043537;17507.38724144649;15264.694706105816;15321.540353789404;15346.846531534542;15351.462698805488;15358.155301458528;9446.905530944603;9484.90515094854;9492.193163581172;9518.428894266366;9553.522323883779;3611.530501034901;3617.656322649344;3653.926921461556;3674.5459268287723;3683.3185860615336;1073.9677809665723;1119.7368618374676;1164.3886959346241;1173.7828501727208;1277.6486466221863;34936.30127397438;35599.28801423957;35838.62338803033;35898.64101359005;36101;1205.9276443413248;1206.197878410847;1294.9741005179844;1321.6827961289414;1339.6382976596265;18011.909940450212;18877.90561047186;18935.337263195997;18983;19015;981181;992215;999934;1000882;1002402;64289.67855160788;65645.34354656392;65698;65791;65805.67097164484;1491;1501.8423065577956;1547.1645311531647;1553.6348957994862;1632.9101899395648;30465.238369040064;33198.33603327871;33303.666963330055;33347.3125043688;33353.49969750407;52504;53536.46463535315;53590.46409535855;53615.73192134014;53617;381073;388326;388689;389207;389477;30334.241643959078;31077.53383699201;32772.672273277916;33908.83045584855;34270.828645856614;48354.516454835;49697.75151124221;50471.49528504668;50718.23922641237;51023;41668.374974374805;41838.372424414265;42142;42742.5725742751;43373.13253734971;41748.165036699706;42145.78927105345;42215.366769497865;42979.785101074296;43043.7847810759;43053.56946430621;43875.34186987262;44065.559344407426;44588.777056114515;44887;36980;37994.81002594969;38289.23421531609;38653.613463865004;39139;28885.566716498848;29119.7088029117;29536.409271814875;29539.704602953694;29576.55635165431 17:37:42 INFO - PROCESS | 23874 | |2;jquery.html;432.5220631202519;435.7320248047451;436.83400307883;437.42478640587643;443.76190428703916;18593.53516162095;18658.16038278279;18888.811111888877;18983.05084745764;19371;19631.5092122697;20004.999999999964;20645.174193032297;20650;20698.172073117094;5669.319681638209;5840.707964601774;6006.909896351558;6016;6019.097135429677;4274.252005898971;5844.766209351621;5896.115582662614;6268.905966410507;6597.769078082268;6478.449331806802;6500.902486462684;6525.0864878916755;6531.51013673974;6532.706028228741;6454.322296158906;6465.579737317083;6602.834929126762;6615.140031795884;6615.33846615337;3887.961120388788;3995.580464051291;5503.724813759336;5826.708664566797;5863.413658634145;22296.21963231279;22630.207942721925;22722.204722834787;22766.65850012251;22778.544429111324;2603.544379733558;2676.4513274778624;3012.6836682148496;3071;3271.656476070026;9633.373830701052;10034.046765557261;10097.091261786401;14758.335874885655;14916.477923272741;1968.6850103983295;2082.115101082034;2084.343431818972;2118.110393634677;2167.1439781286304;81916.59041704754;83491.16508834895;84318;84541.57729211375;84860;10845.240833141605;11037.944810276058;11101.500432480558;11124.777504449865;11221;14843.406263749544;15172.696546069017;15198.240087995557;15202.239888005555;15206.467773628092;8851.380403371702;8924.732258032269;8976.461412315151;9042.779224804699;9095.454272743656;9202.263818894473;9227.584758685874;9228.26173906086;9264.90735092654;9317.254619630414;4626.398568186114;4682.719036857731;4737.336772851803;4749.786259618326;4767.332573439721;1782.852273112454;2033.1359172351988;2050.866693664907;2064.9453793475286;2140.4541841830232;958.5638534466801;1037.6835065305004;1039.9376037437778;1075.096918588374;1147.0250287255933;18325.266989320546;18541.629167416846;18646.906765466087;19516.21935122579;19568.70646940297;1078.2829418436652;1090.6673464593375;1098;1104.127739086113;1134.7673726885969;10585.153187744962;10758.354498730101;10854.45727713611;10872.67381978542;10873.565057397775;511375;517466;520387;537847;538981;85431;89660.5516972411;90902.54548727347;91226;94586;1092.792369449802;1113.4877956140103;1137.0846468592863;1146.1976616368408;1146.9254498457406;16571.254293556576;16807.41174058902;16830.242639081025;16889.662206756042;16917.154142293082;37462.68880589167;37707.62292377041;38593.421098684106;38717.41923871088;39305.803470982464;50796.49203507917;51073.23390149225;51341.486585135164;52169.217461737346;56181;8653.349747825572;8737.169968852948;8886.111388861062;8920.73237802867;8978.820423591362;12181.451834667285;13270.867291326964;13276.867231327564;13414.396352163982;13476.46094156262;11014.1739369546;11454.370009649549;11699.532018719156;11869.643910682347;12327.753444930871;11480.138989575647;11576.421178941187;11791.941040294743;11836.171467997157;11951.22317049389;11892.940535297268;12293.323867187391;12431.440585173508;12580.748385032432;12604.873951260737;8117.701167813121;8297.04583972851;8333.083360830182;8441.15588441151;8788;10638.41488718097;11390.544378224778;11640.476178571815;11656.125790565571;11666 17:37:42 INFO - PROCESS | 23874 | |3;mootools.html;1439.6976634906669;1571.7092337917484;1576.393088660866;1787.9910600446997;1881.2945145570402;8332.666693332267;8571.142885711426;8573.185547373005;8578.95710521448;8579.056303806585;8423.873641895376;8607.354448416363;8618.396712230146;8621.870671939925;8624.18070283322;2413.3363325085566;2439.3901524618846;2440.1825388494876;2440.9511809763794;2440.9633855492184;2417.9516409671796;2441.4506735984437;2487.664165337674;2490.140901389018;2493.9127130550432;2430.986603648469;2439.6462512935614;2446.388402899275;2447.0456521956453;2449.0326321103153;2378.3340664613934;2412.6139817629182;2421.3341331133993;2425.223928342931;2431.06404034448;2381.785639292472;2421.3946513371657;2440.072772346497;2443.499082688045;2444.6821913151352;7367.44744144186;7888.605569721491;8805.559722013937;8843.823123537493;8873.556322183866;5331.040412725708;5409.864753381197;5431.782728690848;5456.181572764078;5462.535684466825;3411.1472131967007;3446.844891979842;3480.2343484433386;3598.0285322962914;3600.6579374959338;1109.4674556212983;1110.2783190925882;1126.1722633864103;1131.4795194210674;1144.879787622296;11899.88100119005;12420.192687475284;12424.316662583555;12427;12438;4782.63694846967;4815.277708343777;4889.217725163957;4901.362822833009;4920.606351491872;10598.417087060132;10598.629047983284;10601.522931468102;10617.256792024638;10620.946895265473;5531.612787104945;5582.553395728332;5590.077637189818;5593.8601534961135;5595.468430499096;5021.949780502221;5117.974410128;5119.6416250862085;5120.4111527174855;5125.769340379692;4042;4115.73247738896;4157.750534967911;4162.604552567501;4171.270027745132;1263.646179069862;1283.0890068051601;1287.0925997171971;1288.671388795851;1297.331874084847;803.7588723382962;956.4452617481844;1061.2040969273046;1080.783843231357;1082.1613249731522;5907.1139329100115;5926.111083337534;5955.3151387590115;6070.180525628984;6102.938970610326;471.5850051954258;472.17605278788733;475.5434782608734;483.835495931385;491.427486977667;4247.957520424818;4327.920523459952;4339.067100573392;4389.758563278986;4405.867823965286;10330.690079297634;10782;10827.187960902964;10839.945800270949;10857.077148442313;10617.522211500347;10657.413842238751;10659.200559957879;10673.359598423964;10673.893261067446;7897.1707970662255;8221.54781487012;8353.66585336592;8361.581920903931;8371.539565323965;5970.910436343372;6059.697015149313;6119.388061194023;6167.722452489559;6202.2867370253;8955.373123881265;9266.860997085185;9301.906980930104;9482.95258523703;9493.715188544355;9492.193163580896;9494.528348106054;9670.951645241728;9691.757706057406;9703.563339649874;7866.252705992922;7889.171636978034;7910.169432209766;7941.364690824605;7951.840963180588;8224.054233763194;8251.257386834974;8275.462094963808;8316.168383161636;8324.500529968222;7513.924860751541;7539.2083831199125;7544.471886968079;7669.309762121436;7685.769426917202;7453.217412171643;7489.73785917512;7526;7558.546487210785;7593.848123037619;7034;7067.893981590383;7077.1507419107975;7124.786256412316;7140.321669441395;4724.385829842236;5363.410024897336;5398.13629819227;5477.945220547903;5528.281323427928;5128.717920514258;5232.529072383504;5249.842504724712;5363.785448582013;5409.350877894678 17:37:42 INFO - PROCESS | 23874 | |4;prototype.html;351.6782144337931;368.55036855036855;371.3964807188319;375.64126259422255;377.9074126838923;6014.158017877495;6045;6071.78748743794;6079.422454866781;6101.6033957792715;5923.348431672513;5975.880482390349;5976.65525256817;5984.132300816379;6022.2773267207995;4449.510553839075;4530.637548996073;4578.725276483405;4739.786709598076;4743.715377077369;4599;4692.648051396141;4700;4712.858614241561;4717.3631559739515;4718.079974404993;4727.243641017438;4728.338032675429;4734.195186818232;4736.431628204603;4407.250767369523;4566.269396896514;4729.290606409049;4730.219513780222;4741.905161896777;4174.373843923406;4187.706860519765;4201.285781417167;4201.4538110045805;4207.200631879933;5827.067669172954;5862.97068514659;5872.882542349129;5874.676892770896;5886.7939622113445;5466.644668096561;5469.15228139639;5484.040292948718;5485.451454854522;5492.258545096441;6379.553431259814;6386.42522173002;6393.657331960294;6399.77600783975;6401.935980640181;4383.101464199864;4630.536946305376;4642.373279607244;4644.164050470914;4648.74431906245;6608;6619.338066193391;6657.400833924921;6683.2648408675495;6697.296783837724;4562.133194692998;4563.817447302071;4566.634669226454;4566.8173273068705;4572.7713614319155;4621.745803980813;4621.768911554409;4622.168009758208;4623.283391074388;4626.907461850744;5334.653247538898;5335.5464785492895;5337.412884582693;5338.786448542092;5352.732363381815;6308.810735677937;6440.871182576322;6443.613383197023;6450.322716114834;6455.935440645533;1608.083392466283;1652.140886738889;1653.4460955579775;1653.8180800111977;1655.9420420285232;1060.9628662996759;1089.515165751249;1101.735583459964;1104.2435931387026;1109.5007246738837;6070.362611925772;6151.954167791486;6223.782167624202;6261.24865016201;6265.71804268809;6575.408213260829;6594.142761440982;6596.241432235354;6596.30738772422;6672;6309.873802523924;6315.905261421082;6327.746890124344;6327.936720632827;6328;3540.504329393887;3566.8038257895546;3576.6423357664025;3581.1763294442426;3581.8925432237074;6829.556078854958;7011.1586609607175;7017.754378596826;7023.964880175567;7082.787516374517;6844.794656160323;6887.173539175231;6907.447404207652;6913.619750913748;6914.481413893978;7005.439564834801;7030;7040.0847889774;7061;7071.7878463646175;6703.631300278532;6705.329467053256;6710.698018589078;6723.4957378197805;6725.159355080615;6417.71120299597;6588.505862060269;6611.66941652925;6626.867462650624;6628.801135965929;6910.965445172742;7036.577805331696;7037.472189585904;7038.788836334918;7048;4761.880952976203;4782.832600858953;4792.257200133985;4795.760211989317;4800.711957282574;6558.540902136805;6559.376859198369;6570.605763654196;6571.277159512545;6577.736890524517;6331.461825744679;6392.4246817786625;6395.488360931021;6396.520260980538;6400.51996100285;6203.534734894991;6348.77779277723;6379.170707807955;6380.489560835215;6381.329960354096;6242.375762423721;6258.530610204162;6270.059491076375;6271.310155882758;6277.874442511215;6376.808695739135;6409.262934762562;6421.71102300407;6495.805125846232;6507.511936604679;6120.969395152996;6359.777407790705;6362.968185159045;6365.1088847562305;6372.36276372359 17:37:42 INFO - PROCESS | 23874 | |5;yui.html;865.9480431174126;867.0549101479386;884.0584777212268;898.6944438890778;943.8961714211438;14881.330340134693;15150.242487875617;15151.924240378783;15219.391224351013;15297.388104475822;13691;13731.58805235842;13732.725345493083;13733.656658583515;14814.407423703038;881.616496823882;886.9024407315222;893.3300024981264;893.6246776353947;893.8569828827389;903.1645727701882;916.6929078758591;917.0874979395511;917.9586918588647;918.4489306416164;944.5985456181096;946.5314669238736;946.7869729310919;948.0472125513849;948.1987720376271;937.3438592984904;943.5942544705808;944.4144630329171;944.574941276425;944.9669261575812;695.7182341151841;696.9094017777657;697.1564407067455;697.7627606613776;698.0227681246296;14297.49958751449;14345.282735863166;14364.20996845173;14390.568282951528;14404.78392824098;12684.746305073939;12818.230906145662;12880.227186368755;13149.474021039146;13219.140755850838;11207.943960280229;11314.773704525946;11425.885741142565;11466.942665286704;11692.94153529227;3857.2285542891254;3898.5906479819496;3953.1500727343473;3987.182627561343;4076.408920706511;48188.518114818755;53390;54239.45760542423;55454.16818747722;55694.443055568925;11278.210525263317;12120.151589388659;12175.573854915212;12316;12708.809367859489;19055.80944190568;21562.78437215608;21897.562048758937;21932.780672193076;22054.33836984893;9175.678851240174;9342.624230939453;9467.621295148117;9593.184579310697;9603.751512303495;4807.254875494304;4808.903821923542;4855.174620314555;4890.388701412324;4907.828226012072;3587.7309201809967;3600.945985810215;3627.909302267464;3629.237860049366;3632.4914511968345;672.1060988884772;677.4343423241648;698.3575110897985;705.8341289796894;710.8294009437698;685.67773146621;712.4798896805257;736.2048987093925;775.6897241103603;807.6026038221943;10104.898951010397;10282.537285822156;10379.584816607403;10427;10581.259311848251;740.8740514112613;748.6331697468202;785.3913217256558;805.697863301262;841.3773807382493;4590.586847183703;4678.602318802872;4735.171345014609;4743.501932297128;4837.540433658797;61285;62007;62190.37809621936;62347.376526235064;62428.68785656043;49830.252546211836;50765.49234507682;52224.738876305375;52695.73652131715;52845.73577132167;44890.77554612206;47998.76000620044;48704.51295487;49342;49867.01063914878;10054.54754536033;10219.795604088025;10381.169506439617;10432.634857779942;10548.208884333551;35827.283454331286;37105.25789484249;38579.228415432095;38796.61203388043;38827.6117238824;43434;47606.761966189944;47758.522414775405;48211.27683084827;48630.75684621554;12857.871421286041;12941.805872911726;12990.805137923127;13121.278329691959;13175.538856140372;13880.444782208599;14422.42310307576;14710.41158353654;15231.086134831945;15234.314455849735;13037.413316400594;13090.214587124803;13242.20546767197;13572.524961626295;13621;13693.794593081311;13738.793918091036;13787.448502059806;14023.439062437388;14113.858861411254;13313.400896959467;13616.52342168059;13628.386722597705;13640.181589104686;13671.31643417845;11184.217104802585;11310.4910279036;11804.468798903898;11924.165308428326;12084.51661933548;11116.92140662278;11325.830112548154;11410.94294528522;11425.14311426663;11543.942280288546 17:37:42 INFO - PROCESS | 23874 | __end_tp_report 17:37:42 INFO - PROCESS | 23874 | __start_cc_report 17:37:42 INFO - PROCESS | 23874 | _x_x_mozilla_cycle_collect,776 17:37:42 INFO - PROCESS | 23874 | __end_cc_report 17:37:42 INFO - PROCESS | 23874 | __startTimestamp1467074262303__endTimestamp 17:37:42 INFO - PROCESS | 23874 | 17:37:42 INFO - PROCESS | 23874 | ------- Summary: start ------- 17:37:42 INFO - PROCESS | 23874 | Number of tests: 6 17:37:42 INFO - PROCESS | 23874 | 17:37:42 INFO - PROCESS | 23874 | [#0] dojo.html Cycles:165 Average:5505.45 Median:5725.17 stddev:615.12 (10.7%) stddev-sans-first:592.33 17:37:42 INFO - PROCESS | 23874 | Values: 3306.7 3322.8 3325.4 3366.4 3369.5 5554.8 5571.9 5579.5 5596.3 5615.5 5530.3 5576.8 5600.1 5605.9 5628.7 4963.2 4985.7 4995.5 5112.3 5122.7 4966.1 5040.8 5044.1 5046.3 5046.9 5016.2 5052.0 5085.9 5113.5 5132.4 5001.1 5014.7 5015.8 5019.7 5045.3 4946.3 4946.9 4967.2 4987.2 5027.9 5400.8 5448.8 5448.9 5460.9 5467.5 5873.3 5915.9 5919.1 5926.0 5929.7 5966.1 6032.4 6078.9 6105.8 6131.1 5494.4 5495.6 5515.1 5519.0 5535.4 5958.9 5993.9 5994.5 5997.3 6004.5 5855.7 5930.3 5934.9 5949.0 5961.2 5927.0 5931.9 5940.3 5940.6 5962.8 5748.6 5864.3 5911.8 5912.6 5915.9 5827.1 5835.4 5836.5 5848.2 5876.4 4496.4 4496.7 4500.5 4501.9 4524.2 4011.2 4016.2 4050.8 4079.7 4083.6 5612.5 5636.7 5643.9 5646.5 5682.2 5893.7 5893.9 5897.4 5902.5 5918.0 5603.3 5639.5 5685.1 5777.5 5779.0 5041.9 5060.7 5061.4 5062.2 5066.8 6154.3 6159.9 6169.9 6173.1 6177.3 5824.2 5890.1 5939.7 5982.0 6006.7 6159.5 6178.1 6184.5 6191.2 6192.6 5801.0 5806.4 5811.0 5813.5 5846.3 5864.0 5904.1 5925.9 5991.2 6016.9 5750.4 5751.4 5772.7 5774.8 5788.0 5718.7 5728.1 5738.0 5746.9 5778.9 5382.0 5612.7 5692.4 5711.4 5725.2 5803.7 5804.9 5815.7 5821.2 5845.3 5551.7 5717.8 5718.2 5723.5 5725.3 17:37:42 INFO - PROCESS | 23874 | 17:37:42 INFO - PROCESS | 23874 | [#1] ext.html Cycles:180 Average:70824.31 Median:21429.12 stddev:175306.61 (818.1%) stddev-sans-first:175719.25 17:37:42 INFO - PROCESS | 23874 | Values: 668.2 683.5 685.6 733.9 750.9 32481.8 33034.5 33065.8 33090.5 40496.8 44437.1 44860.6 44954.3 44962.0 45001.8 8841.8 9029.7 9042.0 9043.7 9053.8 8687.9 8818.6 8822.9 8828.1 8829.6 8866.3 9166.4 9179.0 9185.4 9189.8 9043.1 9075.4 9089.1 9107.0 9111.0 9046.0 9143.9 9159.4 9167.6 9168.6 43918.3 44384.3 44396.1 44433.0 44463.6 3724.9 3864.5 3898.8 3976.5 3993.3 34025.0 34508.0 34897.8 34950.3 35225.0 3362.8 3373.6 3386.8 3436.4 3594.3 324029.0 326401.0 326542.0 327613.0 327641.0 38959.4 40889.2 65070.3 65800.3 65864.7 38831.4 38934.2 38959.0 39050.4 39065.0 17274.1 17372.0 17407.3 17407.9 17507.4 15264.7 15321.5 15346.8 15351.5 15358.2 9446.9 9484.9 9492.2 9518.4 9553.5 3611.5 3617.7 3653.9 3674.5 3683.3 1074.0 1119.7 1164.4 1173.8 1277.6 34936.3 35599.3 35838.6 35898.6 36101.0 1205.9 1206.2 1295.0 1321.7 1339.6 18011.9 18877.9 18935.3 18983.0 19015.0 981181.0 992215.0 999934.0 1000882.0 1002402.0 64289.7 65645.3 65698.0 65791.0 65805.7 1491.0 1501.8 1547.2 1553.6 1632.9 30465.2 33198.3 33303.7 33347.3 33353.5 52504.0 53536.5 53590.5 53615.7 53617.0 381073.0 388326.0 388689.0 389207.0 389477.0 30334.2 31077.5 32772.7 33908.8 34270.8 48354.5 49697.8 50471.5 50718.2 51023.0 41668.4 41838.4 42142.0 42742.6 43373.1 41748.2 42145.8 42215.4 42979.8 43043.8 43053.6 43875.3 44065.6 44588.8 44887.0 36980.0 37994.8 38289.2 38653.6 39139.0 28885.6 29119.7 29536.4 29539.7 29576.6 17:37:42 INFO - PROCESS | 23874 | 17:37:42 INFO - PROCESS | 23874 | [#2] jquery.html Cycles:180 Average:29930.11 Median:22744.43 stddev:86350.97 (379.7%) stddev-sans-first:86564.80 17:37:42 INFO - PROCESS | 23874 | Values: 432.5 435.7 436.8 437.4 443.8 18593.5 18658.2 18888.8 18983.1 19371.0 19631.5 20005.0 20645.2 20650.0 20698.2 5669.3 5840.7 6006.9 6016.0 6019.1 4274.3 5844.8 5896.1 6268.9 6597.8 6478.4 6500.9 6525.1 6531.5 6532.7 6454.3 6465.6 6602.8 6615.1 6615.3 3888.0 3995.6 5503.7 5826.7 5863.4 22296.2 22630.2 22722.2 22766.7 22778.5 2603.5 2676.5 3012.7 3071.0 3271.7 9633.4 10034.0 10097.1 14758.3 14916.5 1968.7 2082.1 2084.3 2118.1 2167.1 81916.6 83491.2 84318.0 84541.6 84860.0 10845.2 11037.9 11101.5 11124.8 11221.0 14843.4 15172.7 15198.2 15202.2 15206.5 8851.4 8924.7 8976.5 9042.8 9095.5 9202.3 9227.6 9228.3 9264.9 9317.3 4626.4 4682.7 4737.3 4749.8 4767.3 1782.9 2033.1 2050.9 2064.9 2140.5 958.6 1037.7 1039.9 1075.1 1147.0 18325.3 18541.6 18646.9 19516.2 19568.7 1078.3 1090.7 1098.0 1104.1 1134.8 10585.2 10758.4 10854.5 10872.7 10873.6 511375.0 517466.0 520387.0 537847.0 538981.0 85431.0 89660.6 90902.5 91226.0 94586.0 1092.8 1113.5 1137.1 1146.2 1146.9 16571.3 16807.4 16830.2 16889.7 16917.2 37462.7 37707.6 38593.4 38717.4 39305.8 50796.5 51073.2 51341.5 52169.2 56181.0 8653.3 8737.2 8886.1 8920.7 8978.8 12181.5 13270.9 13276.9 13414.4 13476.5 11014.2 11454.4 11699.5 11869.6 12327.8 11480.1 11576.4 11791.9 11836.2 11951.2 11892.9 12293.3 12431.4 12580.7 12604.9 8117.7 8297.0 8333.1 8441.2 8788.0 10638.4 11390.5 11640.5 11656.1 11666.0 17:37:42 INFO - PROCESS | 23874 | 17:37:42 INFO - PROCESS | 23874 | [#3] mootools.html Cycles:180 Average:5795.85 Median:5118.81 stddev:3201.38 (62.5%) stddev-sans-first:3193.62 17:37:42 INFO - PROCESS | 23874 | Values: 1439.7 1571.7 1576.4 1788.0 1881.3 8332.7 8571.1 8573.2 8579.0 8579.1 8423.9 8607.4 8618.4 8621.9 8624.2 2413.3 2439.4 2440.2 2441.0 2441.0 2418.0 2441.5 2487.7 2490.1 2493.9 2431.0 2439.6 2446.4 2447.0 2449.0 2378.3 2412.6 2421.3 2425.2 2431.1 2381.8 2421.4 2440.1 2443.5 2444.7 7367.4 7888.6 8805.6 8843.8 8873.6 5331.0 5409.9 5431.8 5456.2 5462.5 3411.1 3446.8 3480.2 3598.0 3600.7 1109.5 1110.3 1126.2 1131.5 1144.9 11899.9 12420.2 12424.3 12427.0 12438.0 4782.6 4815.3 4889.2 4901.4 4920.6 10598.4 10598.6 10601.5 10617.3 10620.9 5531.6 5582.6 5590.1 5593.9 5595.5 5021.9 5118.0 5119.6 5120.4 5125.8 4042.0 4115.7 4157.8 4162.6 4171.3 1263.6 1283.1 1287.1 1288.7 1297.3 803.8 956.4 1061.2 1080.8 1082.2 5907.1 5926.1 5955.3 6070.2 6102.9 471.6 472.2 475.5 483.8 491.4 4248.0 4327.9 4339.1 4389.8 4405.9 10330.7 10782.0 10827.2 10839.9 10857.1 10617.5 10657.4 10659.2 10673.4 10673.9 7897.2 8221.5 8353.7 8361.6 8371.5 5970.9 6059.7 6119.4 6167.7 6202.3 8955.4 9266.9 9301.9 9483.0 9493.7 9492.2 9494.5 9671.0 9691.8 9703.6 7866.3 7889.2 7910.2 7941.4 7951.8 8224.1 8251.3 8275.5 8316.2 8324.5 7513.9 7539.2 7544.5 7669.3 7685.8 7453.2 7489.7 7526.0 7558.5 7593.8 7034.0 7067.9 7077.2 7124.8 7140.3 4724.4 5363.4 5398.1 5477.9 5528.3 5128.7 5232.5 5249.8 5363.8 5409.4 17:37:42 INFO - PROCESS | 23874 | 17:37:42 INFO - PROCESS | 23874 | [#4] prototype.html Cycles:180 Average:5415.22 Median:6111.29 stddev:1619.93 (26.5%) stddev-sans-first:1579.26 17:37:42 INFO - PROCESS | 23874 | Values: 351.7 368.6 371.4 375.6 377.9 6014.2 6045.0 6071.8 6079.4 6101.6 5923.3 5975.9 5976.7 5984.1 6022.3 4449.5 4530.6 4578.7 4739.8 4743.7 4599.0 4692.6 4700.0 4712.9 4717.4 4718.1 4727.2 4728.3 4734.2 4736.4 4407.3 4566.3 4729.3 4730.2 4741.9 4174.4 4187.7 4201.3 4201.5 4207.2 5827.1 5863.0 5872.9 5874.7 5886.8 5466.6 5469.2 5484.0 5485.5 5492.3 6379.6 6386.4 6393.7 6399.8 6401.9 4383.1 4630.5 4642.4 4644.2 4648.7 6608.0 6619.3 6657.4 6683.3 6697.3 4562.1 4563.8 4566.6 4566.8 4572.8 4621.7 4621.8 4622.2 4623.3 4626.9 5334.7 5335.5 5337.4 5338.8 5352.7 6308.8 6440.9 6443.6 6450.3 6455.9 1608.1 1652.1 1653.4 1653.8 1655.9 1061.0 1089.5 1101.7 1104.2 1109.5 6070.4 6152.0 6223.8 6261.2 6265.7 6575.4 6594.1 6596.2 6596.3 6672.0 6309.9 6315.9 6327.7 6327.9 6328.0 3540.5 3566.8 3576.6 3581.2 3581.9 6829.6 7011.2 7017.8 7024.0 7082.8 6844.8 6887.2 6907.4 6913.6 6914.5 7005.4 7030.0 7040.1 7061.0 7071.8 6703.6 6705.3 6710.7 6723.5 6725.2 6417.7 6588.5 6611.7 6626.9 6628.8 6911.0 7036.6 7037.5 7038.8 7048.0 4761.9 4782.8 4792.3 4795.8 4800.7 6558.5 6559.4 6570.6 6571.3 6577.7 6331.5 6392.4 6395.5 6396.5 6400.5 6203.5 6348.8 6379.2 6380.5 6381.3 6242.4 6258.5 6270.1 6271.3 6277.9 6376.8 6409.3 6421.7 6495.8 6507.5 6121.0 6359.8 6363.0 6365.1 6372.4 17:37:42 INFO - PROCESS | 23874 | 17:37:42 INFO - PROCESS | 23874 | [#5] yui.html Cycles:180 Average:15214.69 Median:21363.10 stddev:16834.26 (78.8%) stddev-sans-first:16847.00 17:37:42 INFO - PROCESS | 23874 | Values: 865.9 867.1 884.1 898.7 943.9 14881.3 15150.2 15151.9 15219.4 15297.4 13691.0 13731.6 13732.7 13733.7 14814.4 881.6 886.9 893.3 893.6 893.9 903.2 916.7 917.1 918.0 918.4 944.6 946.5 946.8 948.0 948.2 937.3 943.6 944.4 944.6 945.0 695.7 696.9 697.2 697.8 698.0 14297.5 14345.3 14364.2 14390.6 14404.8 12684.7 12818.2 12880.2 13149.5 13219.1 11207.9 11314.8 11425.9 11466.9 11692.9 3857.2 3898.6 3953.2 3987.2 4076.4 48188.5 53390.0 54239.5 55454.2 55694.4 11278.2 12120.2 12175.6 12316.0 12708.8 19055.8 21562.8 21897.6 21932.8 22054.3 9175.7 9342.6 9467.6 9593.2 9603.8 4807.3 4808.9 4855.2 4890.4 4907.8 3587.7 3600.9 3627.9 3629.2 3632.5 672.1 677.4 698.4 705.8 710.8 685.7 712.5 736.2 775.7 807.6 10104.9 10282.5 10379.6 10427.0 10581.3 740.9 748.6 785.4 805.7 841.4 4590.6 4678.6 4735.2 4743.5 4837.5 61285.0 62007.0 62190.4 62347.4 62428.7 49830.3 50765.5 52224.7 52695.7 52845.7 44890.8 47998.8 48704.5 49342.0 49867.0 10054.5 10219.8 10381.2 10432.6 10548.2 35827.3 37105.3 38579.2 38796.6 38827.6 43434.0 47606.8 47758.5 48211.3 48630.8 12857.9 12941.8 12990.8 13121.3 13175.5 13880.4 14422.4 14710.4 15231.1 15234.3 13037.4 13090.2 13242.2 13572.5 13621.0 13693.8 13738.8 13787.4 14023.4 14113.9 13313.4 13616.5 13628.4 13640.2 13671.3 11184.2 11310.5 11804.5 11924.2 12084.5 11116.9 11325.8 11410.9 11425.1 11543.9 17:37:42 INFO - PROCESS | 23874 | -------- Summary: end -------- 17:37:42 INFO - PROCESS | 23874 | 17:37:42 INFO - TEST-INFO | 23874: exit 0 17:37:42 INFO - TEST-OK | dromaeo_css | took 1110477ms 17:37:42 INFO - TEST-START | kraken 17:37:42 INFO - operating with platform_type : linux_ 17:37:42 INFO - Initialising browser for kraken test... 17:37:42 INFO - TEST-INFO | started process 24072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoJa6sC/profile http://localhost:51438/getInfo.html) 17:37:46 INFO - PROCESS | 24072 | __metrics Screen width/height:1600/1200 17:37:46 INFO - PROCESS | 24072 | colorDepth:24 17:37:46 INFO - PROCESS | 24072 | Browser inner width/height: 1024/697 17:37:46 INFO - PROCESS | 24072 | __metrics 17:37:47 ERROR - PROCESS | 24072 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:37:48 INFO - TEST-INFO | 24072: exit 0 17:37:48 INFO - Browser initialized. 17:37:48 INFO - Running cycle 1/1 for kraken test... 17:37:48 INFO - TEST-INFO | started process 24165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoJa6sC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:38:00 INFO - PROCESS | 24165 | RSS: Main: 140021760 17:38:00 INFO - PROCESS | 24165 | 17:38:02 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51438/tests/kraken/driver.html?testName=audio-beat-detection) 17:38:03 INFO - PROCESS | 24165 | RSS: Main: 197517312 17:38:03 INFO - PROCESS | 24165 | 17:38:06 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51438/tests/kraken/driver.html?testName=audio-dft) 17:38:06 INFO - PROCESS | 24165 | RSS: Main: 185630720 17:38:06 INFO - PROCESS | 24165 | 17:38:09 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51438/tests/kraken/driver.html?testName=audio-fft) 17:38:10 INFO - PROCESS | 24165 | RSS: Main: 274251776 17:38:10 INFO - PROCESS | 24165 | 17:38:12 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51438/tests/kraken/driver.html?testName=audio-oscillator) 17:38:12 INFO - PROCESS | 24165 | RSS: Main: 180641792 17:38:12 INFO - PROCESS | 24165 | 17:38:14 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51438/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:38:15 INFO - PROCESS | 24165 | RSS: Main: 177856512 17:38:15 INFO - PROCESS | 24165 | 17:38:18 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51438/tests/kraken/driver.html?testName=imaging-darkroom) 17:38:19 INFO - PROCESS | 24165 | RSS: Main: 213880832 17:38:19 INFO - PROCESS | 24165 | 17:38:22 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51438/tests/kraken/driver.html?testName=imaging-desaturate) 17:38:22 INFO - PROCESS | 24165 | RSS: Main: 213372928 17:38:22 INFO - PROCESS | 24165 | 17:38:25 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51438/tests/kraken/driver.html?testName=json-parse-financial) 17:38:26 INFO - PROCESS | 24165 | RSS: Main: 213078016 17:38:26 INFO - PROCESS | 24165 | 17:38:27 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51438/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:38:28 INFO - PROCESS | 24165 | RSS: Main: 192942080 17:38:28 INFO - PROCESS | 24165 | 17:38:30 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:38:30 INFO - PROCESS | 24165 | RSS: Main: 197353472 17:38:30 INFO - PROCESS | 24165 | 17:38:32 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:38:33 INFO - PROCESS | 24165 | RSS: Main: 209854464 17:38:33 INFO - PROCESS | 24165 | 17:38:35 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:38:36 INFO - PROCESS | 24165 | RSS: Main: 217378816 17:38:36 INFO - PROCESS | 24165 | 17:38:38 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:38:39 INFO - PROCESS | 24165 | RSS: Main: 212443136 17:38:39 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:51438/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51438/tests/kraken/driver.html?testName=ai-astar) 17:38:41 INFO - PROCESS | 24165 | RSS: Main: 274169856 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | __start_tp_report 17:38:41 INFO - PROCESS | 24165 | _x_x_mozilla_page_load 17:38:41 INFO - PROCESS | 24165 | _x_x_mozilla_page_load_details 17:38:41 INFO - PROCESS | 24165 | |i|pagename|runs| 17:38:41 INFO - PROCESS | 24165 | |0;ai-astar;111;112;111;111;113;111;106;110;113;110 17:38:41 INFO - PROCESS | 24165 | |1;audio-beat-detection;155;133;157;172;125;163;154;135;177;125 17:38:41 INFO - PROCESS | 24165 | |2;audio-dft;160;163;161;162;162;162;162;159;161;159 17:38:41 INFO - PROCESS | 24165 | |3;audio-fft;72;73;75;199;74;76;74;75;159;76 17:38:41 INFO - PROCESS | 24165 | |4;audio-oscillator;92;92;155;92;92;92;145;91;92;155 17:38:41 INFO - PROCESS | 24165 | |5;imaging-gaussian-blur;116;118;117;116;116;117;116;117;117;116 17:38:41 INFO - PROCESS | 24165 | |6;imaging-darkroom;145;144;145;145;145;145;145;145;146;145 17:38:41 INFO - PROCESS | 24165 | |7;imaging-desaturate;95;95;95;95;94;94;94;95;95;95 17:38:41 INFO - PROCESS | 24165 | |8;json-parse-financial;53;53;53;54;53;53;54;71;50;52 17:38:41 INFO - PROCESS | 24165 | |9;json-stringify-tinderbox;57;56;58;57;57;56;58;57;57;57 17:38:41 INFO - PROCESS | 24165 | |10;stanford-crypto-aes;72;77;79;71;75;73;73;73;74;72 17:38:41 INFO - PROCESS | 24165 | |11;stanford-crypto-ccm;114;120;113;115;112;119;110;112;130;129 17:38:41 INFO - PROCESS | 24165 | |12;stanford-crypto-pbkdf2;161;154;155;157;155;157;160;160;155;156 17:38:41 INFO - PROCESS | 24165 | |13;stanford-crypto-sha256-iterative;67;66;64;67;64;65;66;65;66;63 17:38:41 INFO - PROCESS | 24165 | __end_tp_report 17:38:41 INFO - PROCESS | 24165 | __start_cc_report 17:38:41 INFO - PROCESS | 24165 | _x_x_mozilla_cycle_collect,1579 17:38:41 INFO - PROCESS | 24165 | __end_cc_report 17:38:41 INFO - PROCESS | 24165 | __startTimestamp1467074321422__endTimestamp 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | ------- Summary: start ------- 17:38:41 INFO - PROCESS | 24165 | Number of tests: 14 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.99 (1.8%) stddev-sans-first:2.11 17:38:41 INFO - PROCESS | 24165 | Values: 111.0 112.0 111.0 111.0 113.0 111.0 106.0 110.0 113.0 110.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.00 stddev:18.96 (12.2%) stddev-sans-first:20.01 17:38:41 INFO - PROCESS | 24165 | Values: 155.0 133.0 157.0 172.0 125.0 163.0 154.0 135.0 177.0 125.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.39 17:38:41 INFO - PROCESS | 24165 | Values: 160.0 163.0 161.0 162.0 162.0 162.0 162.0 159.0 161.0 159.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#3] audio-fft Cycles:10 Average:95.30 Median:74.50 stddev:45.13 (60.6%) stddev-sans-first:47.07 17:38:41 INFO - PROCESS | 24165 | Values: 72.0 73.0 75.0 199.0 74.0 76.0 74.0 75.0 159.0 76.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:29.02 (31.5%) stddev-sans-first:30.06 17:38:41 INFO - PROCESS | 24165 | Values: 92.0 92.0 155.0 92.0 92.0 92.0 145.0 91.0 92.0 155.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 17:38:41 INFO - PROCESS | 24165 | Values: 116.0 118.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 17:38:41 INFO - PROCESS | 24165 | Values: 145.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:38:41 INFO - PROCESS | 24165 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:53.00 stddev:5.87 (11.1%) stddev-sans-first:6.20 17:38:41 INFO - PROCESS | 24165 | Values: 53.0 53.0 53.0 54.0 53.0 53.0 54.0 71.0 50.0 52.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 17:38:41 INFO - PROCESS | 24165 | Values: 57.0 56.0 58.0 57.0 57.0 56.0 58.0 57.0 57.0 57.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.50 stddev:2.47 (3.4%) stddev-sans-first:2.52 17:38:41 INFO - PROCESS | 24165 | Values: 72.0 77.0 79.0 71.0 75.0 73.0 73.0 73.0 74.0 72.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:117.00 stddev:7.09 (6.1%) stddev-sans-first:7.41 17:38:41 INFO - PROCESS | 24165 | Values: 114.0 120.0 113.0 115.0 112.0 119.0 110.0 112.0 130.0 129.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.00 stddev:2.49 (1.6%) stddev-sans-first:2.19 17:38:41 INFO - PROCESS | 24165 | Values: 161.0 154.0 155.0 157.0 155.0 157.0 160.0 160.0 155.0 156.0 17:38:41 INFO - PROCESS | 24165 | 17:38:41 INFO - PROCESS | 24165 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:66.00 stddev:1.34 (2.0%) stddev-sans-first:1.27 17:38:41 INFO - PROCESS | 24165 | Values: 67.0 66.0 64.0 67.0 64.0 65.0 66.0 65.0 66.0 63.0 17:38:41 INFO - PROCESS | 24165 | -------- Summary: end -------- 17:38:41 INFO - PROCESS | 24165 | 17:38:42 INFO - TEST-INFO | 24165: exit 0 17:38:42 INFO - TEST-OK | kraken | took 59443ms 17:38:42 INFO - SUITE-END | took 1169s 17:38:42 INFO - Completed test suite (00:19:30) 17:38:42 INFO - javascript benchmark 17:38:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.735461163107, 3322.8172450515226, 3325.384803811294, 3366.4277072897603, 3369.5114208439777, 5554.805581804638, 5571.8885622287635, 5579.525740312069, 5596.27248457701, 5615.522680572151, 5530.336359636849, 5576.832695019156, 5600.103983362663, 5605.943940560594, 5628.718564071801, 4963.1810751226, 4985.651004429673, 4995.525425084611, 5112.258722485238, 5122.718250496221, 4966.081274964144, 5040.7731652075745, 5044.092063428581, 5046.318746969149, 5046.899062018758, 5016.172331565287, 5052.040112378636, 5085.949140508585, 5113.539781419671, 5132.358455193101, 5001.099802035632, 5014.674046187022, 5015.824446144367, 5019.698818070928, 5045.268436076748, 4946.282788995612, 4946.925796113062, 4967.155583550805, 4987.177115775893, 5027.924581131286, 5400.78396864125, 5448.809291674773, 5448.91826622601, 5460.863478413032, 5467.45325467454, 5873.2658417697785, 5915.940840591582, 5919.112133180014, 5926.0, 5929.673867937262, 5966.105084237399, 6032.366601506823, 6078.909398477554, 6105.786297479567, 6131.080337949299, 5494.36814766299, 5495.560355171577, 5515.117581186991, 5519.0, 5535.363433205152, 5958.880822383615, 5993.850153746104, 5994.490468310242, 5997.310309314397, 6004.54965877561, 5855.677937713466, 5930.347661757203, 5934.851628709317, 5948.970255148696, 5961.165436838846, 5926.962781513304, 5931.940680593225, 5940.316863560746, 5940.643561386244, 5962.761489540369, 5748.626339287933, 5864.296284445893, 5911.793087241926, 5912.6452412854505, 5915.940840591625, 5827.067669172912, 5835.387284335084, 5836.533077353802, 5848.181254624356, 5876.41235876409, 4496.3705081288645, 4496.7301961882395, 4500.549945005473, 4501.88745281364, 4524.16302983949, 4011.157656892027, 4016.2369149862016, 4050.7569545827346, 4079.73481723687, 4083.591640835952, 5612.494875461228, 5636.718164091779, 5643.887122257532, 5646.491815736521, 5682.204491371212, 5893.675847828325, 5893.911591326134, 5897.439743224387, 5902.498287645512, 5917.970410148007, 5603.327600687943, 5639.520640745583, 5685.147227915846, 5777.537796976232, 5779.046457334577, 5041.949580504148, 5060.721660308718, 5061.367329083864, 5062.215356619729, 5066.82266120684, 6154.292256390572, 6159.907601385983, 6169.9383006170265, 6173.104899789505, 6177.289611694623, 5824.15549745293, 5890.145928840208, 5939.732712027882, 5982.0, 6006.669633170218, 6159.5072394209255, 6178.104174894705, 6184.474319682878, 6191.226096737908, 6192.566520343713, 5801.0, 5806.44838740319, 5810.954028274951, 5813.476787089182, 5846.327672317738, 5864.0, 5904.143899134688, 5925.881482370414, 5991.161237426677, 6016.909746353721, 5750.396208398225, 5751.3673495916255, 5772.6536407815665, 5774.82675519735, 5787.971060144672, 5718.714064296685, 5728.140778883201, 5737.971310143423, 5746.913796292975, 5778.855528611818, 5381.973090134525, 5612.747426365905, 5692.430756924275, 5711.428857114255, 5725.169850371756, 5803.680797556175, 5804.883902322014, 5815.680137592473, 5821.185034095315, 5845.298564172326, 5551.694656793754, 5717.771289148387, 5718.199452076796, 5723.513501352431, 5725.2843394575675], "value": 5465.3071047588155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.1748041169155, 683.497629242507, 685.6263336481617, 733.853229354129, 750.9436792240583, 32481.837590812043, 33034.504482432756, 33065.83467082661, 33090.50364244535, 40496.797516012375, 44437.11125777483, 44860.55139448604, 44954.32568511475, 44962.0, 45001.77499112508, 8841.823163536725, 9029.690694849243, 9041.954790226073, 9043.683471078513, 9053.818923621524, 8687.869681954744, 8818.647254109828, 8822.86765698515, 8828.117188281185, 8829.602667879928, 8866.335024873128, 9166.358354915159, 9179.0, 9185.357025008252, 9189.770255743626, 9043.050479699636, 9075.36472446929, 9089.136532029479, 9107.0, 9111.0, 9045.954770226173, 9143.908560914439, 9159.35884488086, 9167.633294668205, 9168.633254669805, 43918.34122488165, 44384.3342349865, 44396.11207775826, 44433.0, 44463.55536444659, 3724.944125838115, 3864.516935383077, 3898.8245528951265, 3976.5426975897562, 3993.341098718708, 34025.0, 34508.0, 34897.825510872535, 34950.30099397998, 35225.0, 3362.8486718097743, 3373.561437013197, 3386.779859309137, 3436.3642726095754, 3594.2863138330654, 324029.0, 326401.0, 326542.0, 327613.0, 327641.0, 38959.41560876589, 40889.182216355504, 65070.349296507375, 65800.34199658038, 65864.6706766463, 38831.41752873653, 38934.22131557353, 38959.0, 39050.41424378636, 39065.0, 17274.13629318529, 17372.0, 17407.3037078518, 17407.91296043537, 17507.38724144649, 15264.694706105816, 15321.540353789404, 15346.846531534542, 15351.462698805488, 15358.155301458528, 9446.905530944603, 9484.90515094854, 9492.193163581172, 9518.428894266366, 9553.522323883779, 3611.530501034901, 3617.656322649344, 3653.926921461556, 3674.5459268287723, 3683.3185860615336, 1073.9677809665723, 1119.7368618374676, 1164.3886959346241, 1173.7828501727208, 1277.6486466221863, 34936.30127397438, 35599.28801423957, 35838.62338803033, 35898.64101359005, 36101.0, 1205.9276443413248, 1206.197878410847, 1294.9741005179844, 1321.6827961289414, 1339.6382976596265, 18011.909940450212, 18877.90561047186, 18935.337263195997, 18983.0, 19015.0, 981181.0, 992215.0, 999934.0, 1000882.0, 1002402.0, 64289.67855160788, 65645.34354656392, 65698.0, 65791.0, 65805.67097164484, 1491.0, 1501.8423065577956, 1547.1645311531647, 1553.6348957994862, 1632.9101899395648, 30465.238369040064, 33198.33603327871, 33303.666963330055, 33347.3125043688, 33353.49969750407, 52504.0, 53536.46463535315, 53590.46409535855, 53615.73192134014, 53617.0, 381073.0, 388326.0, 388689.0, 389207.0, 389477.0, 30334.241643959078, 31077.53383699201, 32772.672273277916, 33908.83045584855, 34270.828645856614, 48354.516454835, 49697.75151124221, 50471.49528504668, 50718.23922641237, 51023.0, 41668.374974374805, 41838.372424414265, 42142.0, 42742.5725742751, 43373.13253734971, 41748.165036699706, 42145.78927105345, 42215.366769497865, 42979.785101074296, 43043.7847810759, 43053.56946430621, 43875.34186987262, 44065.559344407426, 44588.777056114515, 44887.0, 36980.0, 37994.81002594969, 38289.23421531609, 38653.613463865004, 39139.0, 28885.566716498848, 29119.7088029117, 29536.409271814875, 29539.704602953694, 29576.55635165431], "value": 20119.610552588267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.5220631202519, 435.7320248047451, 436.83400307883, 437.42478640587643, 443.76190428703916, 18593.53516162095, 18658.16038278279, 18888.811111888877, 18983.05084745764, 19371.0, 19631.5092122697, 20004.999999999964, 20645.174193032297, 20650.0, 20698.172073117094, 5669.319681638209, 5840.707964601774, 6006.909896351558, 6016.0, 6019.097135429677, 4274.252005898971, 5844.766209351621, 5896.115582662614, 6268.905966410507, 6597.769078082268, 6478.449331806802, 6500.902486462684, 6525.0864878916755, 6531.51013673974, 6532.706028228741, 6454.322296158906, 6465.579737317083, 6602.834929126762, 6615.140031795884, 6615.33846615337, 3887.961120388788, 3995.580464051291, 5503.724813759336, 5826.708664566797, 5863.413658634145, 22296.21963231279, 22630.207942721925, 22722.204722834787, 22766.65850012251, 22778.544429111324, 2603.544379733558, 2676.4513274778624, 3012.6836682148496, 3071.0, 3271.656476070026, 9633.373830701052, 10034.046765557261, 10097.091261786401, 14758.335874885655, 14916.477923272741, 1968.6850103983295, 2082.115101082034, 2084.343431818972, 2118.110393634677, 2167.1439781286304, 81916.59041704754, 83491.16508834895, 84318.0, 84541.57729211375, 84860.0, 10845.240833141605, 11037.944810276058, 11101.500432480558, 11124.777504449865, 11221.0, 14843.406263749544, 15172.696546069017, 15198.240087995557, 15202.239888005555, 15206.467773628092, 8851.380403371702, 8924.732258032269, 8976.461412315151, 9042.779224804699, 9095.454272743656, 9202.263818894473, 9227.584758685874, 9228.26173906086, 9264.90735092654, 9317.254619630414, 4626.398568186114, 4682.719036857731, 4737.336772851803, 4749.786259618326, 4767.332573439721, 1782.852273112454, 2033.1359172351988, 2050.866693664907, 2064.9453793475286, 2140.4541841830232, 958.5638534466801, 1037.6835065305004, 1039.9376037437778, 1075.096918588374, 1147.0250287255933, 18325.266989320546, 18541.629167416846, 18646.906765466087, 19516.21935122579, 19568.70646940297, 1078.2829418436652, 1090.6673464593375, 1098.0, 1104.127739086113, 1134.7673726885969, 10585.153187744962, 10758.354498730101, 10854.45727713611, 10872.67381978542, 10873.565057397775, 511375.0, 517466.0, 520387.0, 537847.0, 538981.0, 85431.0, 89660.5516972411, 90902.54548727347, 91226.0, 94586.0, 1092.792369449802, 1113.4877956140103, 1137.0846468592863, 1146.1976616368408, 1146.9254498457406, 16571.254293556576, 16807.41174058902, 16830.242639081025, 16889.662206756042, 16917.154142293082, 37462.68880589167, 37707.62292377041, 38593.421098684106, 38717.41923871088, 39305.803470982464, 50796.49203507917, 51073.23390149225, 51341.486585135164, 52169.217461737346, 56181.0, 8653.349747825572, 8737.169968852948, 8886.111388861062, 8920.73237802867, 8978.820423591362, 12181.451834667285, 13270.867291326964, 13276.867231327564, 13414.396352163982, 13476.46094156262, 11014.1739369546, 11454.370009649549, 11699.532018719156, 11869.643910682347, 12327.753444930871, 11480.138989575647, 11576.421178941187, 11791.941040294743, 11836.171467997157, 11951.22317049389, 11892.940535297268, 12293.323867187391, 12431.440585173508, 12580.748385032432, 12604.873951260737, 8117.701167813121, 8297.04583972851, 8333.083360830182, 8441.15588441151, 8788.0, 10638.41488718097, 11390.544378224778, 11640.476178571815, 11656.125790565571, 11666.0], "value": 9533.808610977789, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.6976634906669, 1571.7092337917484, 1576.393088660866, 1787.9910600446997, 1881.2945145570402, 8332.666693332267, 8571.142885711426, 8573.185547373005, 8578.95710521448, 8579.056303806585, 8423.873641895376, 8607.354448416363, 8618.396712230146, 8621.870671939925, 8624.18070283322, 2413.3363325085566, 2439.3901524618846, 2440.1825388494876, 2440.9511809763794, 2440.9633855492184, 2417.9516409671796, 2441.4506735984437, 2487.664165337674, 2490.140901389018, 2493.9127130550432, 2430.986603648469, 2439.6462512935614, 2446.388402899275, 2447.0456521956453, 2449.0326321103153, 2378.3340664613934, 2412.6139817629182, 2421.3341331133993, 2425.223928342931, 2431.06404034448, 2381.785639292472, 2421.3946513371657, 2440.072772346497, 2443.499082688045, 2444.6821913151352, 7367.44744144186, 7888.605569721491, 8805.559722013937, 8843.823123537493, 8873.556322183866, 5331.040412725708, 5409.864753381197, 5431.782728690848, 5456.181572764078, 5462.535684466825, 3411.1472131967007, 3446.844891979842, 3480.2343484433386, 3598.0285322962914, 3600.6579374959338, 1109.4674556212983, 1110.2783190925882, 1126.1722633864103, 1131.4795194210674, 1144.879787622296, 11899.88100119005, 12420.192687475284, 12424.316662583555, 12427.0, 12438.0, 4782.63694846967, 4815.277708343777, 4889.217725163957, 4901.362822833009, 4920.606351491872, 10598.417087060132, 10598.629047983284, 10601.522931468102, 10617.256792024638, 10620.946895265473, 5531.612787104945, 5582.553395728332, 5590.077637189818, 5593.8601534961135, 5595.468430499096, 5021.949780502221, 5117.974410128, 5119.6416250862085, 5120.4111527174855, 5125.769340379692, 4042.0, 4115.73247738896, 4157.750534967911, 4162.604552567501, 4171.270027745132, 1263.646179069862, 1283.0890068051601, 1287.0925997171971, 1288.671388795851, 1297.331874084847, 803.7588723382962, 956.4452617481844, 1061.2040969273046, 1080.783843231357, 1082.1613249731522, 5907.1139329100115, 5926.111083337534, 5955.3151387590115, 6070.180525628984, 6102.938970610326, 471.5850051954258, 472.17605278788733, 475.5434782608734, 483.835495931385, 491.427486977667, 4247.957520424818, 4327.920523459952, 4339.067100573392, 4389.758563278986, 4405.867823965286, 10330.690079297634, 10782.0, 10827.187960902964, 10839.945800270949, 10857.077148442313, 10617.522211500347, 10657.413842238751, 10659.200559957879, 10673.359598423964, 10673.893261067446, 7897.1707970662255, 8221.54781487012, 8353.66585336592, 8361.581920903931, 8371.539565323965, 5970.910436343372, 6059.697015149313, 6119.388061194023, 6167.722452489559, 6202.2867370253, 8955.373123881265, 9266.860997085185, 9301.906980930104, 9482.95258523703, 9493.715188544355, 9492.193163580896, 9494.528348106054, 9670.951645241728, 9691.757706057406, 9703.563339649874, 7866.252705992922, 7889.171636978034, 7910.169432209766, 7941.364690824605, 7951.840963180588, 8224.054233763194, 8251.257386834974, 8275.462094963808, 8316.168383161636, 8324.500529968222, 7513.924860751541, 7539.2083831199125, 7544.471886968079, 7669.309762121436, 7685.769426917202, 7453.217412171643, 7489.73785917512, 7526.0, 7558.546487210785, 7593.848123037619, 7034.0, 7067.893981590383, 7077.1507419107975, 7124.786256412316, 7140.321669441395, 4724.385829842236, 5363.410024897336, 5398.13629819227, 5477.945220547903, 5528.281323427928, 5128.717920514258, 5232.529072383504, 5249.842504724712, 5363.785448582013, 5409.350877894678], "value": 4619.783784814613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.6782144337931, 368.55036855036855, 371.3964807188319, 375.64126259422255, 377.9074126838923, 6014.158017877495, 6045.0, 6071.78748743794, 6079.422454866781, 6101.6033957792715, 5923.348431672513, 5975.880482390349, 5976.65525256817, 5984.132300816379, 6022.2773267207995, 4449.510553839075, 4530.637548996073, 4578.725276483405, 4739.786709598076, 4743.715377077369, 4599.0, 4692.648051396141, 4700.0, 4712.858614241561, 4717.3631559739515, 4718.079974404993, 4727.243641017438, 4728.338032675429, 4734.195186818232, 4736.431628204603, 4407.250767369523, 4566.269396896514, 4729.290606409049, 4730.219513780222, 4741.905161896777, 4174.373843923406, 4187.706860519765, 4201.285781417167, 4201.4538110045805, 4207.200631879933, 5827.067669172954, 5862.97068514659, 5872.882542349129, 5874.676892770896, 5886.7939622113445, 5466.644668096561, 5469.15228139639, 5484.040292948718, 5485.451454854522, 5492.258545096441, 6379.553431259814, 6386.42522173002, 6393.657331960294, 6399.77600783975, 6401.935980640181, 4383.101464199864, 4630.536946305376, 4642.373279607244, 4644.164050470914, 4648.74431906245, 6608.0, 6619.338066193391, 6657.400833924921, 6683.2648408675495, 6697.296783837724, 4562.133194692998, 4563.817447302071, 4566.634669226454, 4566.8173273068705, 4572.7713614319155, 4621.745803980813, 4621.768911554409, 4622.168009758208, 4623.283391074388, 4626.907461850744, 5334.653247538898, 5335.5464785492895, 5337.412884582693, 5338.786448542092, 5352.732363381815, 6308.810735677937, 6440.871182576322, 6443.613383197023, 6450.322716114834, 6455.935440645533, 1608.083392466283, 1652.140886738889, 1653.4460955579775, 1653.8180800111977, 1655.9420420285232, 1060.9628662996759, 1089.515165751249, 1101.735583459964, 1104.2435931387026, 1109.5007246738837, 6070.362611925772, 6151.954167791486, 6223.782167624202, 6261.24865016201, 6265.71804268809, 6575.408213260829, 6594.142761440982, 6596.241432235354, 6596.30738772422, 6672.0, 6309.873802523924, 6315.905261421082, 6327.746890124344, 6327.936720632827, 6328.0, 3540.504329393887, 3566.8038257895546, 3576.6423357664025, 3581.1763294442426, 3581.8925432237074, 6829.556078854958, 7011.1586609607175, 7017.754378596826, 7023.964880175567, 7082.787516374517, 6844.794656160323, 6887.173539175231, 6907.447404207652, 6913.619750913748, 6914.481413893978, 7005.439564834801, 7030.0, 7040.0847889774, 7061.0, 7071.7878463646175, 6703.631300278532, 6705.329467053256, 6710.698018589078, 6723.4957378197805, 6725.159355080615, 6417.71120299597, 6588.505862060269, 6611.66941652925, 6626.867462650624, 6628.801135965929, 6910.965445172742, 7036.577805331696, 7037.472189585904, 7038.788836334918, 7048.0, 4761.880952976203, 4782.832600858953, 4792.257200133985, 4795.760211989317, 4800.711957282574, 6558.540902136805, 6559.376859198369, 6570.605763654196, 6571.277159512545, 6577.736890524517, 6331.461825744679, 6392.4246817786625, 6395.488360931021, 6396.520260980538, 6400.51996100285, 6203.534734894991, 6348.77779277723, 6379.170707807955, 6380.489560835215, 6381.329960354096, 6242.375762423721, 6258.530610204162, 6270.059491076375, 6271.310155882758, 6277.874442511215, 6376.808695739135, 6409.262934762562, 6421.71102300407, 6495.805125846232, 6507.511936604679, 6120.969395152996, 6359.777407790705, 6362.968185159045, 6365.1088847562305, 6372.36276372359], "value": 4896.137340119135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.9480431174126, 867.0549101479386, 884.0584777212268, 898.6944438890778, 943.8961714211438, 14881.330340134693, 15150.242487875617, 15151.924240378783, 15219.391224351013, 15297.388104475822, 13691.0, 13731.58805235842, 13732.725345493083, 13733.656658583515, 14814.407423703038, 881.616496823882, 886.9024407315222, 893.3300024981264, 893.6246776353947, 893.8569828827389, 903.1645727701882, 916.6929078758591, 917.0874979395511, 917.9586918588647, 918.4489306416164, 944.5985456181096, 946.5314669238736, 946.7869729310919, 948.0472125513849, 948.1987720376271, 937.3438592984904, 943.5942544705808, 944.4144630329171, 944.574941276425, 944.9669261575812, 695.7182341151841, 696.9094017777657, 697.1564407067455, 697.7627606613776, 698.0227681246296, 14297.49958751449, 14345.282735863166, 14364.20996845173, 14390.568282951528, 14404.78392824098, 12684.746305073939, 12818.230906145662, 12880.227186368755, 13149.474021039146, 13219.140755850838, 11207.943960280229, 11314.773704525946, 11425.885741142565, 11466.942665286704, 11692.94153529227, 3857.2285542891254, 3898.5906479819496, 3953.1500727343473, 3987.182627561343, 4076.408920706511, 48188.518114818755, 53390.0, 54239.45760542423, 55454.16818747722, 55694.443055568925, 11278.210525263317, 12120.151589388659, 12175.573854915212, 12316.0, 12708.809367859489, 19055.80944190568, 21562.78437215608, 21897.562048758937, 21932.780672193076, 22054.33836984893, 9175.678851240174, 9342.624230939453, 9467.621295148117, 9593.184579310697, 9603.751512303495, 4807.254875494304, 4808.903821923542, 4855.174620314555, 4890.388701412324, 4907.828226012072, 3587.7309201809967, 3600.945985810215, 3627.909302267464, 3629.237860049366, 3632.4914511968345, 672.1060988884772, 677.4343423241648, 698.3575110897985, 705.8341289796894, 710.8294009437698, 685.67773146621, 712.4798896805257, 736.2048987093925, 775.6897241103603, 807.6026038221943, 10104.898951010397, 10282.537285822156, 10379.584816607403, 10427.0, 10581.259311848251, 740.8740514112613, 748.6331697468202, 785.3913217256558, 805.697863301262, 841.3773807382493, 4590.586847183703, 4678.602318802872, 4735.171345014609, 4743.501932297128, 4837.540433658797, 61285.0, 62007.0, 62190.37809621936, 62347.376526235064, 62428.68785656043, 49830.252546211836, 50765.49234507682, 52224.738876305375, 52695.73652131715, 52845.73577132167, 44890.77554612206, 47998.76000620044, 48704.51295487, 49342.0, 49867.01063914878, 10054.54754536033, 10219.795604088025, 10381.169506439617, 10432.634857779942, 10548.208884333551, 35827.283454331286, 37105.25789484249, 38579.228415432095, 38796.61203388043, 38827.6117238824, 43434.0, 47606.761966189944, 47758.522414775405, 48211.27683084827, 48630.75684621554, 12857.871421286041, 12941.805872911726, 12990.805137923127, 13121.278329691959, 13175.538856140372, 13880.444782208599, 14422.42310307576, 14710.41158353654, 15231.086134831945, 15234.314455849735, 13037.413316400594, 13090.214587124803, 13242.20546767197, 13572.524961626295, 13621.0, 13693.794593081311, 13738.793918091036, 13787.448502059806, 14023.439062437388, 14113.858861411254, 13313.400896959467, 13616.52342168059, 13628.386722597705, 13640.181589104686, 13671.31643417845, 11184.217104802585, 11310.4910279036, 11804.468798903898, 11924.165308428326, 12084.51661933548, 11116.92140662278, 11325.830112548154, 11410.94294528522, 11425.14311426663, 11543.942280288546], "value": 7178.865478148433, "unit": "score"}], "name": "dromaeo_css", "value": 7444.666279165182, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 111.0, 113.0, 111.0, 106.0, 110.0, 113.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 133.0, 157.0, 172.0, 125.0, 163.0, 154.0, 135.0, 177.0, 125.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 161.0, 162.0, 162.0, 162.0, 162.0, 159.0, 161.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 75.0, 199.0, 74.0, 76.0, 74.0, 75.0, 159.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 155.0, 92.0, 92.0, 92.0, 145.0, 91.0, 92.0, 155.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 54.0, 71.0, 50.0, 52.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 57.0, 57.0, 56.0, 58.0, 57.0, 57.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 77.0, 79.0, 71.0, 75.0, 73.0, 73.0, 73.0, 74.0, 72.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 120.0, 113.0, 115.0, 112.0, 119.0, 110.0, 112.0, 130.0, 129.0], "value": 117.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 154.0, 155.0, 157.0, 155.0, 157.0, 160.0, 160.0, 155.0, 156.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 64.0, 67.0, 64.0, 65.0, 66.0, 65.0, 66.0, 63.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1508.1000000000001, "alertThreshold": 2.0}]} 17:38:42 INFO - Return code: 0 17:38:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:38:42 ERROR - # TBPL SUCCESS # 17:38:42 INFO - Running post-action listener: _resource_record_post_action 17:38:42 INFO - Running post-run listener: _resource_record_post_run 17:38:43 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 481452032; Read time: 20; Write time: 313000 17:38:43 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 177012736; Read time: 0; Write time: 149740 17:38:43 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222564352; Read time: 20; Write time: 113020 17:38:43 INFO - Running post-run listener: _upload_blobber_files 17:38:43 INFO - Blob upload gear active. 17:38:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:38:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:38:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:38:44 INFO - (blobuploader) - INFO - Open directory for files ... 17:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:45 INFO - (blobuploader) - INFO - Done attempting. 17:38:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:38:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:45 INFO - (blobuploader) - INFO - Done attempting. 17:38:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:45 INFO - Return code: 0 17:38:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ce990cf2ef5ab332e3b5955122634b3583deca90c15a8e104084f4c43400d0e42f44c4db5f35d3b32580b5bc6ad20f21629c1450c3b2422a42a92e6b7775af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e261ee8b256e67dcfa9f97c7abc9b6d06eb3037891601f1376084675d72ea0c127b9d5eba0a670da7c60dbcf8b9083293d58b870b0446deebbdbbc134d317c8"} 17:38:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:45 INFO - Contents: 17:38:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ce990cf2ef5ab332e3b5955122634b3583deca90c15a8e104084f4c43400d0e42f44c4db5f35d3b32580b5bc6ad20f21629c1450c3b2422a42a92e6b7775af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e261ee8b256e67dcfa9f97c7abc9b6d06eb3037891601f1376084675d72ea0c127b9d5eba0a670da7c60dbcf8b9083293d58b870b0446deebbdbbc134d317c8"} 17:38:45 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:45 INFO - Copying logs to upload dir... 17:38:45 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.845998 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-27 17:38:45.674915) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 17:38:45.678709) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ce990cf2ef5ab332e3b5955122634b3583deca90c15a8e104084f4c43400d0e42f44c4db5f35d3b32580b5bc6ad20f21629c1450c3b2422a42a92e6b7775af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e261ee8b256e67dcfa9f97c7abc9b6d06eb3037891601f1376084675d72ea0c127b9d5eba0a670da7c60dbcf8b9083293d58b870b0446deebbdbbc134d317c8"} build_url:https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011476 build_url: 'https://queue.taskcluster.net/v1/task/MZjTpQ87TIS357w9hxTqWA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ce990cf2ef5ab332e3b5955122634b3583deca90c15a8e104084f4c43400d0e42f44c4db5f35d3b32580b5bc6ad20f21629c1450c3b2422a42a92e6b7775af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e261ee8b256e67dcfa9f97c7abc9b6d06eb3037891601f1376084675d72ea0c127b9d5eba0a670da7c60dbcf8b9083293d58b870b0446deebbdbbc134d317c8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 17:38:45.704171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:38:45.704577) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1467071094.823854-61832543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:38:45.788699) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 17:38:45.789053) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 17:38:45.789414) ========= ========= Total master_lag: 0.17 =========