builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1465920925.71 results: success (0) buildid: 20160614063226 builduid: 19004ab3f6ca4b948df52d5d5d5ee979 revision: 773192ea404cb80f87268e17ee8786999cf717e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:25.707805) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:25.708230) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:25.708549) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:25.729111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:25.729402) ========= 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=7de08804244eb36560b44971000001c3-1465919272.764216-1290100015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 09:15:26-- 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% 17.7M=0.001s 2016-06-14 09:15:26 (17.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201109 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:25.945703) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:25.946030) ========= 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=7de08804244eb36560b44971000001c3-1465919272.764216-1290100015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019646 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:25.995276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 09:15:25.995672) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 773192ea404cb80f87268e17ee8786999cf717e6 --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 773192ea404cb80f87268e17ee8786999cf717e6 --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=7de08804244eb36560b44971000001c3-1465919272.764216-1290100015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 09:15:26,775 truncating revision to first 12 chars 2016-06-14 09:15:26,775 Setting DEBUG logging. 2016-06-14 09:15:26,775 attempt 1/10 2016-06-14 09:15:26,775 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/773192ea404c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 09:15:27,225 unpacking tar archive at: mozilla-beta-773192ea404c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.227099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 09:15:27.237602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:27.237980) ========= script_repo_revision: 773192ea404cb80f87268e17ee8786999cf717e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:27.238442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:27.238829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 09:15:27.248276) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-14 09:15:27.248614) ========= /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=7de08804244eb36560b44971000001c3-1465919272.764216-1290100015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:15:28 INFO - MultiFileLogger online at 20160614 09:15:28 in /builds/slave/test 09:15:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:15:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:28 INFO - {'append_to_log': False, 09:15:28 INFO - 'base_work_dir': '/builds/slave/test', 09:15:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:15:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:28 INFO - 'branch': 'Mozilla-Beta', 09:15:28 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:28 INFO - 'config_files': ('talos/linux_config.py',), 09:15:28 INFO - 'default_actions': ('clobber', 09:15:28 INFO - 'read-buildbot-config', 09:15:28 INFO - 'download-and-extract', 09:15:28 INFO - 'populate-webroot', 09:15:28 INFO - 'create-virtualenv', 09:15:28 INFO - 'install', 09:15:28 INFO - 'run-tests'), 09:15:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:28 INFO - 'download_minidump_stackwalk': True, 09:15:28 INFO - 'download_symbols': 'ondemand', 09:15:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:28 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:28 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:28 INFO - 'installer_path': 'installer.exe', 09:15:28 INFO - 'log_level': 'info', 09:15:28 INFO - 'log_name': 'talos', 09:15:28 INFO - 'log_to_console': True, 09:15:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:15:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:15:28 INFO - 'opt_config_files': (), 09:15:28 INFO - 'pip_index': False, 09:15:28 INFO - 'sps_profile': False, 09:15:28 INFO - 'sps_profile_interval': 0, 09:15:28 INFO - 'suite': 'dromaeojs', 09:15:28 INFO - 'system_bits': '32', 09:15:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:28 INFO - 'title': 'talos-linux64-ix-003', 09:15:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:28 INFO - 'use_talos_json': True, 09:15:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:28 INFO - 'work_dir': 'build'} 09:15:28 INFO - ##### 09:15:28 INFO - ##### Running clobber step. 09:15:28 INFO - ##### 09:15:28 INFO - Running pre-action listener: _resource_record_pre_action 09:15:28 INFO - Running main action method: clobber 09:15:28 INFO - rmtree: /builds/slave/test/build 09:15:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:29 INFO - Running post-action listener: _resource_record_post_action 09:15:29 INFO - ##### 09:15:29 INFO - ##### Running read-buildbot-config step. 09:15:29 INFO - ##### 09:15:29 INFO - Running pre-action listener: _resource_record_pre_action 09:15:29 INFO - Running main action method: read_buildbot_config 09:15:29 INFO - Using buildbot properties: 09:15:29 INFO - { 09:15:29 INFO - "project": "", 09:15:29 INFO - "product": "firefox", 09:15:29 INFO - "script_repo_revision": "production", 09:15:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:15:29 INFO - "repository": "", 09:15:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:15:29 INFO - "buildid": "20160614063226", 09:15:29 INFO - "pgo_build": "True", 09:15:29 INFO - "basedir": "/builds/slave/test", 09:15:29 INFO - "buildnumber": 41, 09:15:29 INFO - "slavename": "talos-linux64-ix-003", 09:15:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:15:29 INFO - "platform": "ubuntu64_hw", 09:15:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:15:29 INFO - "branch": "mozilla-beta", 09:15:29 INFO - "repo_path": "releases/mozilla-beta", 09:15:29 INFO - "revision": "773192ea404cb80f87268e17ee8786999cf717e6", 09:15:29 INFO - "stage_platform": "linux64-pgo", 09:15:29 INFO - "builduid": "19004ab3f6ca4b948df52d5d5d5ee979", 09:15:29 INFO - "slavebuilddir": "test" 09:15:29 INFO - } 09:15:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 09:15:29 INFO - Running post-action listener: _resource_record_post_action 09:15:29 INFO - ##### 09:15:29 INFO - ##### Running download-and-extract step. 09:15:29 INFO - ##### 09:15:29 INFO - Running pre-action listener: _resource_record_pre_action 09:15:29 INFO - Running main action method: download_and_extract 09:15:29 INFO - mkdir: /builds/slave/test/build/tests 09:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:29 INFO - https://queue.taskcluster.net/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:15:31 INFO - Downloaded 1327 bytes. 09:15:31 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:15:31 INFO - Using the following test package requirements: 09:15:31 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:15:31 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:15:31 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:15:31 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:15:31 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:15:31 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:15:31 INFO - u'jsshell-linux-x86_64.zip'], 09:15:31 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:15:31 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:15:31 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:15:31 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:15:31 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:15:31 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:15:31 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:15:31 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:15:31 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:15:31 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:15:31 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:15:31 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:31 INFO - https://queue.taskcluster.net/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:15:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:15:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:15:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:15:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:15:32 INFO - Downloaded 24186233 bytes. 09:15:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:15:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:15:34 INFO - Return code: 0 09:15:34 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:15: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')]} 09:15:34 INFO - https://queue.taskcluster.net/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:15:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:15:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:15:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:15:40 INFO - Downloaded 24186233 bytes. 09:15:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:15:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:15:42 INFO - Return code: 0 09:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:42 INFO - https://queue.taskcluster.net/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:15:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:15:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:15:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:15:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:15:43 INFO - Downloaded 10840145 bytes. 09:15:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:15:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:15:43 INFO - Return code: 0 09:15: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')]} 09:15:43 INFO - https://queue.taskcluster.net/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:15:45 INFO - Downloaded 56012155 bytes. 09:15:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:15:45 INFO - mkdir: /builds/slave/test/properties 09:15:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:15:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:15:45 INFO - Contents: 09:15:45 INFO - build_url:https://queue.taskcluster.net/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:15:45 INFO - Running post-action listener: _resource_record_post_action 09:15:45 INFO - Running post-action listener: set_extra_try_arguments 09:15:45 INFO - ##### 09:15:45 INFO - ##### Running populate-webroot step. 09:15:45 INFO - ##### 09:15:45 INFO - Running pre-action listener: _resource_record_pre_action 09:15:45 INFO - Running main action method: populate_webroot 09:15:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:15:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:15:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:15:46 INFO - '--tppagecycles', 09:15:46 INFO - '7'], 09:15:46 INFO - 'tests': ['tsvgm']}}, 09:15:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:15:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:15:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:15:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:15:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:15:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:15:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:46 INFO - 'talos_options': ['--disable-e10s'], 09:15:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:46 INFO - 'talos_options': ['--disable-e10s'], 09:15:46 INFO - 'tests': ['damp', 'tps']}, 09:15:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:46 INFO - 'tests': ['damp', 'tps']}, 09:15:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:15:46 INFO - 'tests': ['dromaeo_dom']}, 09:15:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:15:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:15:46 INFO - 'tests': ['a11yr', 09:15:46 INFO - 'ts_paint', 09:15:46 INFO - 'tpaint', 09:15:46 INFO - 'sessionrestore', 09:15:46 INFO - 'sessionrestore_no_auto_restore', 09:15:46 INFO - 'tabpaint']}, 09:15:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:15:46 INFO - 'ts_paint', 09:15:46 INFO - 'tpaint', 09:15:46 INFO - 'sessionrestore', 09:15:46 INFO - 'sessionrestore_no_auto_restore', 09:15:46 INFO - 'tabpaint']}, 09:15:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:15:46 INFO - 'ts_paint', 09:15:46 INFO - 'tpaint', 09:15:46 INFO - 'sessionrestore', 09:15:46 INFO - 'sessionrestore_no_auto_restore', 09:15:46 INFO - 'tabpaint']}, 09:15:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:15:46 INFO - 'ts_paint', 09:15:46 INFO - 'tpaint', 09:15:46 INFO - 'sessionrestore', 09:15:46 INFO - 'sessionrestore_no_auto_restore', 09:15:46 INFO - 'tabpaint']}, 09:15:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:15:46 INFO - 'tests': ['a11yr', 09:15:46 INFO - 'ts_paint', 09:15:46 INFO - 'tpaint', 09:15:46 INFO - 'sessionrestore', 09:15:46 INFO - 'sessionrestore_no_auto_restore', 09:15:46 INFO - 'tabpaint']}, 09:15:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:15:46 INFO - 'tests': ['a11yr', 09:15:46 INFO - 'ts_paint', 09:15:46 INFO - 'tpaint', 09:15:46 INFO - 'sessionrestore', 09:15:46 INFO - 'sessionrestore_no_auto_restore', 09:15:46 INFO - 'tabpaint']}, 09:15:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:15:46 INFO - 'tests': ['tsvgx', 09:15:46 INFO - 'tsvgr_opacity', 09:15:46 INFO - 'tart', 09:15:46 INFO - 'tscrollx', 09:15:46 INFO - 'cart']}, 09:15:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:15:46 INFO - 'tsvgr_opacity', 09:15:46 INFO - 'tart', 09:15:46 INFO - 'tscrollx', 09:15:46 INFO - 'cart']}, 09:15:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:46 INFO - 'talos_options': ['--disable-e10s'], 09:15:46 INFO - 'tests': ['tp5o']}, 09:15:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:46 INFO - 'tests': ['tp5o']}, 09:15:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:46 INFO - 'talos_options': ['--disable-e10s', 09:15:46 INFO - '--xperf_path', 09:15:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:46 INFO - 'tests': ['tp5n']}, 09:15:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:46 INFO - 'talos_options': ['--xperf_path', 09:15:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:46 INFO - 'tests': ['tp5n']}}, 09:15:46 INFO - 'talos.zip': {'path': '', 09:15:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:15:46 INFO - Running post-action listener: _resource_record_post_action 09:15:46 INFO - ##### 09:15:46 INFO - ##### Running create-virtualenv step. 09:15:46 INFO - ##### 09:15:46 INFO - Running pre-action listener: _resource_record_pre_action 09:15:46 INFO - Running main action method: create_virtualenv 09:15:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:15:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:15:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:15:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:15:46 INFO - Using real prefix '/usr' 09:15:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:15:46 INFO - Installing distribute.............................................................................................................................................................................................done. 09:15:48 INFO - Installing pip.................done. 09:15:48 INFO - Return code: 0 09:15:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f12359abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6410>, '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 0x20b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b77a0>, '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': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:15:48 INFO - Using env: {'DISPLAY': ':0', 09:15:48 INFO - 'HOME': '/home/cltbld', 09:15:48 INFO - 'LANG': 'en_US.UTF-8', 09:15:48 INFO - 'LANGUAGE': 'en_US:en', 09:15:48 INFO - 'LOGNAME': 'cltbld', 09:15:48 INFO - 'MAIL': '/var/mail/cltbld', 09:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:48 INFO - 'MOZ_NO_REMOTE': '1', 09:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:48 INFO - 'NO_EM_RESTART': '1', 09:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:48 INFO - 'PWD': '/builds/slave/test', 09:15:48 INFO - 'SHELL': '/bin/bash', 09:15:48 INFO - 'SHLVL': '1', 09:15:48 INFO - 'TERM': 'linux', 09:15:48 INFO - 'TMOUT': '86400', 09:15:48 INFO - 'USER': 'cltbld', 09:15:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 09:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:48 INFO - '_': '/tools/buildbot/bin/python'} 09:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:15:48 INFO - Cleaning up... 09:15:48 INFO - Return code: 0 09:15:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f12359abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6410>, '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 0x20b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b77a0>, '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': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:15:48 INFO - Using env: {'DISPLAY': ':0', 09:15:48 INFO - 'HOME': '/home/cltbld', 09:15:48 INFO - 'LANG': 'en_US.UTF-8', 09:15:48 INFO - 'LANGUAGE': 'en_US:en', 09:15:48 INFO - 'LOGNAME': 'cltbld', 09:15:48 INFO - 'MAIL': '/var/mail/cltbld', 09:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:48 INFO - 'MOZ_NO_REMOTE': '1', 09:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:48 INFO - 'NO_EM_RESTART': '1', 09:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:48 INFO - 'PWD': '/builds/slave/test', 09:15:48 INFO - 'SHELL': '/bin/bash', 09:15:48 INFO - 'SHLVL': '1', 09:15:48 INFO - 'TERM': 'linux', 09:15:48 INFO - 'TMOUT': '86400', 09:15:48 INFO - 'USER': 'cltbld', 09:15:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 09:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:48 INFO - '_': '/tools/buildbot/bin/python'} 09:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:49 INFO - Downloading/unpacking psutil>=0.7.1 09:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:51 INFO - Installing collected packages: psutil 09:15:51 INFO - Running setup.py install for psutil 09:15:51 INFO - building 'psutil._psutil_linux' extension 09:15:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:15:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:15:51 INFO - building 'psutil._psutil_posix' extension 09:15:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:15:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:15:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:51 INFO - Successfully installed psutil 09:15:51 INFO - Cleaning up... 09:15:51 INFO - Return code: 0 09:15:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f12359abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6410>, '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 0x20b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b77a0>, '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': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:15:51 INFO - Using env: {'DISPLAY': ':0', 09:15:51 INFO - 'HOME': '/home/cltbld', 09:15:51 INFO - 'LANG': 'en_US.UTF-8', 09:15:51 INFO - 'LANGUAGE': 'en_US:en', 09:15:51 INFO - 'LOGNAME': 'cltbld', 09:15:51 INFO - 'MAIL': '/var/mail/cltbld', 09:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:51 INFO - 'MOZ_NO_REMOTE': '1', 09:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:51 INFO - 'NO_EM_RESTART': '1', 09:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:51 INFO - 'PWD': '/builds/slave/test', 09:15:51 INFO - 'SHELL': '/bin/bash', 09:15:51 INFO - 'SHLVL': '1', 09:15:51 INFO - 'TERM': 'linux', 09:15:51 INFO - 'TMOUT': '86400', 09:15:51 INFO - 'USER': 'cltbld', 09:15:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 09:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:51 INFO - '_': '/tools/buildbot/bin/python'} 09:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:15:53 INFO - Installing collected packages: mozsystemmonitor 09:15:53 INFO - Running setup.py install for mozsystemmonitor 09:15:53 INFO - Successfully installed mozsystemmonitor 09:15:53 INFO - Cleaning up... 09:15:53 INFO - Return code: 0 09:15:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:53 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 0x7f12359abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6410>, '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 0x20b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b77a0>, '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': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:15:53 INFO - Using env: {'DISPLAY': ':0', 09:15:53 INFO - 'HOME': '/home/cltbld', 09:15:53 INFO - 'LANG': 'en_US.UTF-8', 09:15:53 INFO - 'LANGUAGE': 'en_US:en', 09:15:53 INFO - 'LOGNAME': 'cltbld', 09:15:53 INFO - 'MAIL': '/var/mail/cltbld', 09:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:53 INFO - 'MOZ_NO_REMOTE': '1', 09:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:53 INFO - 'NO_EM_RESTART': '1', 09:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:53 INFO - 'PWD': '/builds/slave/test', 09:15:53 INFO - 'SHELL': '/bin/bash', 09:15:53 INFO - 'SHLVL': '1', 09:15:53 INFO - 'TERM': 'linux', 09:15:53 INFO - 'TMOUT': '86400', 09:15:53 INFO - 'USER': 'cltbld', 09:15:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 09:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:53 INFO - '_': '/tools/buildbot/bin/python'} 09:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15:55 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:15:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15: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 09:15:56 INFO - Downloading docopt-0.6.1.tar.gz 09:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:56 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:56 INFO - Running setup.py install for blobuploader 09:15:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:15:56 INFO - Running setup.py install for requests 09:15:57 INFO - Running setup.py install for docopt 09:15:57 INFO - Successfully installed blobuploader requests docopt 09:15:57 INFO - Cleaning up... 09:15:57 INFO - Return code: 0 09:15:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:57 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 0x7f12359abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6410>, '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 0x20b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b77a0>, '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': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:15:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:15:57 INFO - Using env: {'DISPLAY': ':0', 09:15:57 INFO - 'HOME': '/home/cltbld', 09:15:57 INFO - 'LANG': 'en_US.UTF-8', 09:15:57 INFO - 'LANGUAGE': 'en_US:en', 09:15:57 INFO - 'LOGNAME': 'cltbld', 09:15:57 INFO - 'MAIL': '/var/mail/cltbld', 09:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:57 INFO - 'MOZ_NO_REMOTE': '1', 09:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:57 INFO - 'NO_EM_RESTART': '1', 09:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:57 INFO - 'PWD': '/builds/slave/test', 09:15:57 INFO - 'SHELL': '/bin/bash', 09:15:57 INFO - 'SHLVL': '1', 09:15:57 INFO - 'TERM': 'linux', 09:15:57 INFO - 'TMOUT': '86400', 09:15:57 INFO - 'USER': 'cltbld', 09:15:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 09:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:57 INFO - '_': '/tools/buildbot/bin/python'} 09:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:57 INFO - Running setup.py (path:/tmp/pip-7czWt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:57 INFO - Running setup.py (path:/tmp/pip-1VPULr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:57 INFO - Running setup.py (path:/tmp/pip-UApril-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:57 INFO - Running setup.py (path:/tmp/pip-deATCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:57 INFO - Running setup.py (path:/tmp/pip-gvs3G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:57 INFO - Running setup.py (path:/tmp/pip-EOhETC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:57 INFO - Running setup.py (path:/tmp/pip-ZWZkal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:58 INFO - Running setup.py (path:/tmp/pip-xpsFBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:58 INFO - Running setup.py (path:/tmp/pip-aH98fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:58 INFO - Running setup.py (path:/tmp/pip-lNHM9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:58 INFO - Running setup.py (path:/tmp/pip-4zEDsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:58 INFO - Running setup.py (path:/tmp/pip-8Tl2OK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:58 INFO - Running setup.py (path:/tmp/pip-7uKxcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:58 INFO - Running setup.py (path:/tmp/pip-ZO85fR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:58 INFO - Running setup.py (path:/tmp/pip-KBWdT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:58 INFO - Running setup.py (path:/tmp/pip-fBMniI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:58 INFO - Running setup.py (path:/tmp/pip-FsSnUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:58 INFO - Running setup.py install for manifestparser 09:15:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:15:58 INFO - Running setup.py install for mozcrash 09:15:58 INFO - Running setup.py install for mozdebug 09:15:59 INFO - Running setup.py install for mozdevice 09:15:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:15:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:15:59 INFO - Running setup.py install for mozfile 09:15:59 INFO - Running setup.py install for mozhttpd 09:15:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:15:59 INFO - Running setup.py install for mozinfo 09:15:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:15:59 INFO - Running setup.py install for mozInstall 09:15:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:15:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:15:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:15:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:15:59 INFO - Running setup.py install for mozleak 09:15:59 INFO - Running setup.py install for mozlog 09:15:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:15:59 INFO - Running setup.py install for moznetwork 09:15:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:15:59 INFO - Running setup.py install for mozprocess 09:15:59 INFO - Running setup.py install for mozprofile 09:16:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:00 INFO - Running setup.py install for mozrunner 09:16:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:00 INFO - Running setup.py install for mozscreenshot 09:16:00 INFO - Running setup.py install for moztest 09:16:00 INFO - Running setup.py install for mozversion 09:16:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:00 INFO - Cleaning up... 09:16:00 INFO - Return code: 0 09:16:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:00 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 0x7f12359abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6410>, '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 0x20b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b77a0>, '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': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:16:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:00 INFO - Using env: {'DISPLAY': ':0', 09:16:00 INFO - 'HOME': '/home/cltbld', 09:16:00 INFO - 'LANG': 'en_US.UTF-8', 09:16:00 INFO - 'LANGUAGE': 'en_US:en', 09:16:00 INFO - 'LOGNAME': 'cltbld', 09:16:00 INFO - 'MAIL': '/var/mail/cltbld', 09:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:00 INFO - 'MOZ_NO_REMOTE': '1', 09:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:00 INFO - 'NO_EM_RESTART': '1', 09:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:00 INFO - 'PWD': '/builds/slave/test', 09:16:00 INFO - 'SHELL': '/bin/bash', 09:16:00 INFO - 'SHLVL': '1', 09:16:00 INFO - 'TERM': 'linux', 09:16:00 INFO - 'TMOUT': '86400', 09:16:00 INFO - 'USER': 'cltbld', 09:16:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 09:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:00 INFO - '_': '/tools/buildbot/bin/python'} 09:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:00 INFO - Running setup.py (path:/tmp/pip-AVQwgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:00 INFO - Running setup.py (path:/tmp/pip-q1q6kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:00 INFO - Running setup.py (path:/tmp/pip-C1S7jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:00 INFO - Running setup.py (path:/tmp/pip-xuNYny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:01 INFO - Running setup.py (path:/tmp/pip-0fwiMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:01 INFO - Running setup.py (path:/tmp/pip-vCrdwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:01 INFO - Running setup.py (path:/tmp/pip-g8_g1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:01 INFO - Running setup.py (path:/tmp/pip-SUAi3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:01 INFO - Running setup.py (path:/tmp/pip-2fkhc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:01 INFO - Running setup.py (path:/tmp/pip-U9b1de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:01 INFO - Running setup.py (path:/tmp/pip-8HPGiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:01 INFO - Running setup.py (path:/tmp/pip-8kCwcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:01 INFO - Running setup.py (path:/tmp/pip-6ETvz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:01 INFO - Running setup.py (path:/tmp/pip-K3cCHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:01 INFO - Running setup.py (path:/tmp/pip-7EbFGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:01 INFO - Running setup.py (path:/tmp/pip-3yf9o1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:01 INFO - Running setup.py (path:/tmp/pip-hqXf0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:03 INFO - Downloading blessings-1.6.tar.gz 09:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:03 INFO - Installing collected packages: blessings 09:16:03 INFO - Running setup.py install for blessings 09:16:04 INFO - Successfully installed blessings 09:16:04 INFO - Cleaning up... 09:16:04 INFO - Return code: 0 09:16:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:04 INFO - Reading from file tmpfile_stdout 09:16:04 INFO - Current package versions: 09:16:04 INFO - argparse == 1.2.1 09:16:04 INFO - blessings == 1.6 09:16:04 INFO - blobuploader == 1.2.4 09:16:04 INFO - docopt == 0.6.1 09:16:04 INFO - manifestparser == 1.1 09:16:04 INFO - mozInstall == 1.12 09:16:04 INFO - mozcrash == 0.17 09:16:04 INFO - mozdebug == 0.1 09:16:04 INFO - mozdevice == 0.48 09:16:04 INFO - mozfile == 1.2 09:16:04 INFO - mozhttpd == 0.7 09:16:04 INFO - mozinfo == 0.9 09:16:04 INFO - mozleak == 0.1 09:16:04 INFO - mozlog == 3.1 09:16:04 INFO - moznetwork == 0.27 09:16:04 INFO - mozprocess == 0.22 09:16:04 INFO - mozprofile == 0.28 09:16:04 INFO - mozrunner == 6.11 09:16:04 INFO - mozscreenshot == 0.1 09:16:04 INFO - mozsystemmonitor == 0.0 09:16:04 INFO - moztest == 0.7 09:16:04 INFO - mozversion == 1.4 09:16:04 INFO - psutil == 3.1.1 09:16:04 INFO - requests == 1.2.3 09:16:04 INFO - wsgiref == 0.1.2 09:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:04 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 0x7f12359abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6410>, '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 0x20b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b77a0>, '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': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:16:04 INFO - Using env: {'DISPLAY': ':0', 09:16:04 INFO - 'HOME': '/home/cltbld', 09:16:04 INFO - 'LANG': 'en_US.UTF-8', 09:16:04 INFO - 'LANGUAGE': 'en_US:en', 09:16:04 INFO - 'LOGNAME': 'cltbld', 09:16:04 INFO - 'MAIL': '/var/mail/cltbld', 09:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:04 INFO - 'MOZ_NO_REMOTE': '1', 09:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:04 INFO - 'NO_EM_RESTART': '1', 09:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:04 INFO - 'PWD': '/builds/slave/test', 09:16:04 INFO - 'SHELL': '/bin/bash', 09:16:04 INFO - 'SHLVL': '1', 09:16:04 INFO - 'TERM': 'linux', 09:16:04 INFO - 'TMOUT': '86400', 09:16:04 INFO - 'USER': 'cltbld', 09:16:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 09:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:04 INFO - '_': '/tools/buildbot/bin/python'} 09:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:16:04 INFO - Cleaning up... 09:16:04 INFO - Return code: 0 09:16:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:04 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 0x7f12359abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6410>, '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 0x20b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b77a0>, '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': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:16:04 INFO - Using env: {'DISPLAY': ':0', 09:16:04 INFO - 'HOME': '/home/cltbld', 09:16:04 INFO - 'LANG': 'en_US.UTF-8', 09:16:04 INFO - 'LANGUAGE': 'en_US:en', 09:16:04 INFO - 'LOGNAME': 'cltbld', 09:16:04 INFO - 'MAIL': '/var/mail/cltbld', 09:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:04 INFO - 'MOZ_NO_REMOTE': '1', 09:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:04 INFO - 'NO_EM_RESTART': '1', 09:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:04 INFO - 'PWD': '/builds/slave/test', 09:16:04 INFO - 'SHELL': '/bin/bash', 09:16:04 INFO - 'SHLVL': '1', 09:16:04 INFO - 'TERM': 'linux', 09:16:04 INFO - 'TMOUT': '86400', 09:16:04 INFO - 'USER': 'cltbld', 09:16:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 09:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:04 INFO - '_': '/tools/buildbot/bin/python'} 09:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:04 INFO - Downloading/unpacking jsonschema 09:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:06 INFO - Downloading/unpacking functools32 (from jsonschema) 09:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:06 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:06 INFO - warning: no files found matching '*.txt' 09:16:06 INFO - no previously-included directories found matching 'build' 09:16:06 INFO - no previously-included directories found matching 'dist' 09:16:06 INFO - no previously-included directories found matching '.git*' 09:16:06 INFO - Installing collected packages: jsonschema, functools32 09:16:07 INFO - Running setup.py install for functools32 09:16:07 INFO - warning: no files found matching '*.txt' 09:16:07 INFO - no previously-included directories found matching 'build' 09:16:07 INFO - no previously-included directories found matching 'dist' 09:16:07 INFO - no previously-included directories found matching '.git*' 09:16:07 INFO - Successfully installed jsonschema functools32 09:16:07 INFO - Cleaning up... 09:16:07 INFO - Return code: 0 09:16:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:07 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 0x7f12359abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6410>, '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 0x20b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b77a0>, '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': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:16:07 INFO - Using env: {'DISPLAY': ':0', 09:16:07 INFO - 'HOME': '/home/cltbld', 09:16:07 INFO - 'LANG': 'en_US.UTF-8', 09:16:07 INFO - 'LANGUAGE': 'en_US:en', 09:16:07 INFO - 'LOGNAME': 'cltbld', 09:16:07 INFO - 'MAIL': '/var/mail/cltbld', 09:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:07 INFO - 'MOZ_NO_REMOTE': '1', 09:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:07 INFO - 'NO_EM_RESTART': '1', 09:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:07 INFO - 'PWD': '/builds/slave/test', 09:16:07 INFO - 'SHELL': '/bin/bash', 09:16:07 INFO - 'SHLVL': '1', 09:16:07 INFO - 'TERM': 'linux', 09:16:07 INFO - 'TMOUT': '86400', 09:16:07 INFO - 'USER': 'cltbld', 09:16:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 09:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:07 INFO - '_': '/tools/buildbot/bin/python'} 09:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:07 INFO - Downloading/unpacking flake8 09:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:16:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:16:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:16:10 INFO - no previously-included directories found matching 'docs/_build' 09:16:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:16:10 INFO - Running setup.py install for pep8 09:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:16:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:16:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:16:10 INFO - no previously-included directories found matching 'docs/_build' 09:16:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:16:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:16:10 INFO - Cleaning up... 09:16:10 INFO - Return code: 0 09:16:10 INFO - Running post-action listener: _resource_record_post_action 09:16:10 INFO - Running post-action listener: _start_resource_monitoring 09:16:10 INFO - Starting resource monitoring. 09:16:10 INFO - ##### 09:16:10 INFO - ##### Running install step. 09:16:10 INFO - ##### 09:16:10 INFO - Running pre-action listener: _resource_record_pre_action 09:16:10 INFO - Running main action method: install 09:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:10 INFO - Reading from file tmpfile_stdout 09:16:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:10 INFO - Reading from file tmpfile_stdout 09:16:10 INFO - Output received: 09:16:10 INFO - Usage: mozinstall [options] installer 09:16:10 INFO - Options: 09:16:10 INFO - -h, --help show this help message and exit 09:16:10 INFO - -d DEST, --destination=DEST 09:16:10 INFO - Directory to install application into. [default: 09:16:10 INFO - "/builds/slave/test"] 09:16:10 INFO - --app=APP Application being installed. [default: firefox] 09:16:10 INFO - mkdir: /builds/slave/test/build/application 09:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:16:23 INFO - Reading from file tmpfile_stdout 09:16:23 INFO - Output received: 09:16:23 INFO - /builds/slave/test/build/application/firefox/firefox 09:16:23 INFO - Running post-action listener: _resource_record_post_action 09:16:23 INFO - ##### 09:16:23 INFO - ##### Running run-tests step. 09:16:23 INFO - ##### 09:16:23 INFO - Running pre-action listener: _resource_record_pre_action 09:16:23 INFO - Running main action method: run_tests 09:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:23 INFO - Python 2.7.3 09:16:23 INFO - Return code: 0 09:16:23 INFO - grabbing minidump binary from tooltool 09:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:23 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 0x20b6410>, '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 0x20b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:16:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:16:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:23 INFO - Return code: 0 09:16:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:16:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:16:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:16:24 INFO - Return code: 0 09:16:24 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/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:16:24 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/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:16:24 INFO - Using env: {'DISPLAY': ':0', 09:16:24 INFO - 'HOME': '/home/cltbld', 09:16:24 INFO - 'LANG': 'en_US.UTF-8', 09:16:24 INFO - 'LANGUAGE': 'en_US:en', 09:16:24 INFO - 'LOGNAME': 'cltbld', 09:16:24 INFO - 'MAIL': '/var/mail/cltbld', 09:16:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:24 INFO - 'MOZ_NO_REMOTE': '1', 09:16:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:24 INFO - 'NO_EM_RESTART': '1', 09:16:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:24 INFO - 'PWD': '/builds/slave/test', 09:16:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:24 INFO - 'SHELL': '/bin/bash', 09:16:24 INFO - 'SHLVL': '1', 09:16:24 INFO - 'TERM': 'linux', 09:16:24 INFO - 'TMOUT': '86400', 09:16:24 INFO - 'USER': 'cltbld', 09:16:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465919272.764216-1290100015', 09:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:24 INFO - '_': '/tools/buildbot/bin/python'} 09:16:24 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/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:16:25 INFO - mozversion application_buildid: 20160614063226 09:16:25 INFO - mozversion application_changeset: 773192ea404cb80f87268e17ee8786999cf717e6 09:16:25 INFO - mozversion application_display_name: Firefox 09:16:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:25 INFO - mozversion application_name: Firefox 09:16:25 INFO - mozversion application_remotingname: firefox 09:16:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:16:25 INFO - mozversion application_vendor: Mozilla 09:16:25 INFO - mozversion application_version: 48.0 09:16:25 INFO - mozversion platform_buildid: 20160614063226 09:16:25 INFO - mozversion platform_changeset: 773192ea404cb80f87268e17ee8786999cf717e6 09:16:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:16:25 INFO - mozversion platform_version: 48.0 09:16:25 INFO - using testdate: 1465920985 09:16:25 INFO - actual date: 1465920985 09:16:25 INFO - starting webserver on 'localhost:33295' 09:16:25 INFO - SUITE-START | Running 2 tests 09:16:25 INFO - TEST-START | dromaeo_css 09:16:25 INFO - operating with platform_type : linux_ 09:16:25 INFO - Initialising browser for dromaeo_css test... 09:16:25 INFO - TEST-INFO | started process 22170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTCbIU9/profile http://localhost:33295/getInfo.html) 09:16:29 INFO - PROCESS | 22170 | __metrics Screen width/height:1600/1200 09:16:29 INFO - PROCESS | 22170 | colorDepth:24 09:16:29 INFO - PROCESS | 22170 | Browser inner width/height: 1024/697 09:16:29 INFO - PROCESS | 22170 | __metrics 09:16:30 ERROR - PROCESS | 22170 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:16:31 INFO - TEST-INFO | 22170: exit 0 09:16:31 INFO - Browser initialized. 09:16:31 INFO - Running cycle 1/1 for dromaeo_css test... 09:16:31 INFO - TEST-INFO | started process 22264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTCbIU9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:43 INFO - PROCESS | 22264 | RSS: Main: 140943360 09:16:43 INFO - PROCESS | 22264 | 09:17:34 INFO - PROCESS | 22264 | 1465921054361 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:19:42 INFO - PROCESS | 22264 | Cycle 1(1): loaded http://localhost:33295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33295/tests/dromaeo/cssquery-ext.html) 09:19:43 INFO - PROCESS | 22264 | RSS: Main: 251379712 09:19:43 INFO - PROCESS | 22264 | 09:22:45 INFO - PROCESS | 22264 | Cycle 1(1): loaded http://localhost:33295/tests/dromaeo/cssquery-ext.html (next: http://localhost:33295/tests/dromaeo/cssquery-jquery.html) 09:22:46 INFO - PROCESS | 22264 | RSS: Main: 232910848 09:22:46 INFO - PROCESS | 22264 | 09:25:47 INFO - PROCESS | 22264 | Cycle 1(1): loaded http://localhost:33295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33295/tests/dromaeo/cssquery-mootools.html) 09:25:48 INFO - PROCESS | 22264 | RSS: Main: 221876224 09:25:48 INFO - PROCESS | 22264 | 09:28:50 INFO - PROCESS | 22264 | Cycle 1(1): loaded http://localhost:33295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33295/tests/dromaeo/cssquery-prototype.html) 09:28:50 INFO - PROCESS | 22264 | RSS: Main: 218615808 09:28:50 INFO - PROCESS | 22264 | 09:31:53 INFO - PROCESS | 22264 | Cycle 1(1): loaded http://localhost:33295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33295/tests/dromaeo/cssquery-yui.html) 09:31:53 INFO - PROCESS | 22264 | RSS: Main: 212713472 09:31:53 INFO - PROCESS | 22264 | 09:34:56 INFO - PROCESS | 22264 | Cycle 1(1): loaded http://localhost:33295/tests/dromaeo/cssquery-yui.html (next: http://localhost:33295/tests/dromaeo/cssquery-dojo.html) 09:34:56 INFO - PROCESS | 22264 | RSS: Main: 250802176 09:34:56 INFO - PROCESS | 22264 | 09:34:56 INFO - PROCESS | 22264 | __start_tp_report 09:34:56 INFO - PROCESS | 22264 | _x_x_mozilla_page_load 09:34:56 INFO - PROCESS | 22264 | _x_x_mozilla_page_load_details 09:34:56 INFO - PROCESS | 22264 | |i|pagename|runs| 09:34:56 INFO - PROCESS | 22264 | |0;dojo.html;3313.6355000949893;3321.3689399014183;3343.565336506254;3378.881739139131;3386.5258863759077;5495.148252020938;5516.034693928556;5524.4199359067225;5537.114061750116;5544.972275138629;5473.808416705416;5488.835334939949;5492.340919089715;5536.197251398555;5564.972175139129;4948.7278199699;5046.268291097788;5048.6970781753025;5075.111855425304;5092.057969275677;4988.451270360258;5058.544730974211;5067.163917953533;5070.391553013644;5074.314967479399;4920.60635149189;4972.925406118911;4994.775235114428;4997.550220480156;5029.1199040168;5029.84910452687;5055.9241611375855;5068.037072956145;5072.0870243356185;5077.822276220333;4870.245112007645;4952.826651067231;5000.324956130912;5005.27423523587;5092.414372347191;5437.429069947638;5476.507114359687;5478.424765399655;5479.424660410679;5490.011797876381;5980.760769569212;5980.820575382702;5983.282006159246;5983.371745966654;6011.188489553898;5876.353601103875;5904.704764761745;5939.109133629947;5954.136650185742;6007.879842403127;5559.499645031926;5561.165825126223;5571.66570005801;5581.6930068846605;5583.972080139654;6035.719980864293;6086.056661217518;6086.573939824259;6103.450689437972;6109.480694141048;5896.6756828374855;5930.11048342752;5939.70301484924;5950.761969521171;5953;5830.212921255661;5852.385499522489;5860.3260625027815;5876.823695289063;5877.471027607536;5798.159266906275;5812.38969908162;5820.650760954356;5897.734601942923;5956.910646340309;5960.552958528127;5962.403759624003;5970.0746384310505;5979.701014949235;6033.698315084228;4523.389342438794;4529.38853254813;4533.093381323749;4539.568740969603;4548.067646132535;4010.8195131219163;4030;4080.489938757655;4081.0409553754844;4105.363668631367;5673.290838645169;5703.173039909273;5706.115552089433;5716.456936591017;5730.3410107838135;6022.759089636365;6033.78881739137;6034;6034.275886893601;6041.607295525777;5520.254765606672;5524.530414914697;5633.971830140905;5635.746391412396;5643.322801263875;5109.9744501277255;5116.667416617908;5127.820526281637;5134.691918484828;5138.332016837862;6166.506679465632;6172.753089876354;6181.196444462281;6188.9690551546955;6203.069539569101;5936.287645482397;5948.2862056553495;5985.551083668655;6011.609245399035;6015.39846015395;6161.661108639068;6178.104174894705;6185.134081228722;6190.288116866618;6211.192544969125;5810.680412577349;5909.852253693692;5911.911321330097;5919.260092488439;5921.319048309328;5910.852228694317;5941.613795103304;5956.047032474957;5971.193888825127;5992.161097446448;5871.178035075179;5893.02765043763;5897.911531326948;5907.881842363215;5908.409159084057;5752.9137062943255;5848.502877255481;5903.557233207441;5904.409559044233;5908.911366329423;5769.740361683818;5776.797812076557;5778.248827652378;5786.479216870502;5810.796622118206;5861.882762344644;5863.472287494146;5869.383714710065;5869.882602348014;5903.822885313448;5626.85932851682;5750.712464376848;5780.421957804186;5795.76816927335;5836.883262334644 09:34:56 INFO - PROCESS | 22264 | |1;ext.html;654.0908137688614;680.0275605883587;683.6274230544353;742.2911119880515;764.4648745877887;32829.343413131755;33491.49762753561;39845.601543984514;40466.59533404665;40514;44294.557054429446;44650.55349446513;44706;44912;44912.550874491244;8129.837403251931;8980.640774369034;9165.312601554877;9169.312301577374;10635.202359823006;10714.732131696732;10864.402457864815;10867.29362591429;10868.782624347508;10870.239083264174;10889.074428673572;10951.780964380707;10968.17738669599;10974.451277436136;10977.39624320662;10781.407022613754;10842.13262938971;10855.457227138651;10857.67426977192;10858.565657373696;10688.839667404918;11171.944140279247;11179.60871369498;11182.832257516144;11187.44062796865;43179.78410107929;43406;43526;43568.91077723051;43726.562734372565;3849.480320156799;3863.9953612060785;3944.073142811466;3972.225416043844;4276.87169384919;33081.6691833081;33106.3378732424;33139;33615.32769344624;34429;4669.953300466986;4670.953290467086;4763.618910487153;4780.593649539794;4782.1631214537665;354339;354889;355852;356002;356287;63422.68288658527;63709.68145159245;63786.36213637804;63906;63970.68014659897;70832.64583677049;72221;72283;72312.63843680748;72369.4670686534;17291.481255562354;17412.21645025977;17438.215280312415;17443.651126977642;17477.7378339325;13140.408681609351;14128.364223609962;14367.13797172173;14402.855971440362;14418.279086045655;20623.69064464034;20714.896425517774;21102.155913763276;21523.354299371043;21679;7487.465069660707;7506.512076714996;7523.661435235427;7675.923240767633;7762.456628035983;1102.6636875752813;1157.9925464845637;1195.485941045359;1245.1470742541387;1267.7512650039703;34361.140971475914;34520;34932;35124.12189695278;35251.82374088113;1135.534430883334;1136.4374634555948;1156.5778490850778;1215.878412158777;1249.6251124662747;15842.52472425829;16801.73986950959;17286.913565432093;17931.641367172582;18476.538086547946;573681;582570;582628;584452;584789;62929.370706293266;63630.6818465914;63679.36320636734;63762;63850.68074659597;1421.342090291162;1485.591462347863;1499.7825315329435;1548.1639914446298;1570.1139679293885;31921.361572768878;33529.83235083907;34175.48736769;34467.4829877547;34898.65101348954;55972.440275598354;56746.71626641841;56791.432085678614;56795.43204568067;56813.715931420076;469359;471830;473803;474230;475310;40916.590834092465;41734.582654174286;42937.78531107325;48518.5148148514;49907;46491.76754116208;46672;47165.52834471611;47280.52719472899;47957;38296.808515957244;38435.6156438432;38890.4166437498;39058.60941390663;39903.80048099741;38289.80855095707;39005.21989560136;39055.804720976215;39149.2170156601;39452.605473944895;40595;43201.35197972096;44062.55937440713;44120.55879441164;44581.77709111434;37337;37898;38504.229915402095;38950;39071.41392879166;28628.28429289201;28732.42535149327;29147.271318217216;29251.268718282212;29280.560791587715 09:34:56 INFO - PROCESS | 22264 | |2;jquery.html;437.19556016928846;440.0714492420991;440.67390131302847;443.71158746814564;448.35282298971174;18308.450746477592;18757.906210468947;19284.132214050383;19325.516862078453;19348;15425.537233883002;16426.75359869603;18666.440006799785;19709.211631534756;19725.21099156032;5664.26364572605;5669.064604340289;5887.205227294325;5901.3508514063415;5923.555733319997;5863.091220860773;5891.528677705774;5905.763769449217;5920.052791553352;5930;3922.6469617734397;4081.979590102045;6149.600275982069;6408.6154830710075;6409.647469389181;6157.230346206724;6299.811005669814;6331.620102793847;6366.904496432558;6378.425941665249;5701.800436984686;5717.456841600083;5766.4233576642;5766.481016708474;5767.33675627304;22621.095156193896;22648.43378915524;23346.883265583732;23350.883245583664;23368.415789605227;2419.2137555294426;2498.5002999400194;2559.5136923984383;2775.3894143288644;2911.141213342048;10738.731531711692;10816.296940698829;10932.617358392417;11151.776964460747;12709.491620335175;2037.6535988881926;2090.4878304815265;2162.167565487299;2164.837637177218;2199.4281486813384;82286.58856705738;82580;93644;95009.52495237479;97153.51423242838;18137.63724725498;18586.535336616693;18952.81047189538;19188;19661.705074423895;33936.83031584826;34009;34327;34529;34558.48162277568;8353.0811610724;8648.394612377073;8703.260222881127;8780.253678437277;10611.469426528643;8513.616887240089;8537.701180458655;8601.784955376166;8664.956675216583;8856.601452934634;5124.538791508708;5209.505097015777;5248.160294352885;5264.31563896691;5276.81531146408;2063.3912995666315;2072.896355182235;2130.9147634094775;2147.50607360308;2163.2536774812665;990;1054.0433141267572;1105.3367979212408;1113.2763703592568;1117.0672488472217;16782.664346712998;19300.32448864283;19399.224031038884;19604.21583136687;20136.697949530768;1050.2123407444417;1066.0938202527943;1094.3433939636313;1099.6536091131268;1102.9393383363993;10625.84061239082;10873.836892446461;11109.944450277697;11239;11779.234349767237;511050;515040;567527;597033.0445043328;600990;92043.53978230066;98209.5089524562;100823;101195;101470;1159.3507635723854;1172.947217375203;1190.4523918997186;1210.2556927489532;1229.6802831263758;17194.14029298555;17611.471655850346;18073.548161296072;18206.9986150763;18389;38948.6105138945;39512.2097558053;40126;40169.1966160681;40386.79806600948;55592;56910.430895690515;57273.427265728475;57461;57642;8467.91532084696;8697.34769892248;8698.565071746261;8808.295336373203;8892.421992570462;9647;12880.484780609046;13881.444742210198;14174.43302267939;14188.503402380868;11434.485448154686;11809.291442513477;12012.339321337411;12404.25574465535;12528.812067818808;11798.705032374259;12025.518979240733;12097.879021210027;12347.444365003776;12580.685482863002;12478.43847026904;12482.251064936132;12664.240145591293;12825.871741282468;12970.286634235208;8888.533391990508;8891.19979201875;9286.767830804283;9349.205317548085;9562.760930976503;12226.510939562673;12226.816597751218;12371.75256494883;12539.49842006346;12554.937225313815 09:34:56 INFO - PROCESS | 22264 | |3;mootools.html;1402.6072699644103;1584.6117701163216;1592.4506045414332;1805.9909700451503;1905.8856468611893;7744.767656970293;8417.579121043955;8579.099194584573;8609.526476043815;8613.483191008543;8203.097659257477;8240.093589705128;8377.455465394745;8395;8423.536705481212;2432.3067925641194;2461.064795377754;2464.322311364371;2465.211132437612;2468.5309791139716;2395.928122156329;2533.1260715053368;2539.733328000561;2539.8476091434572;2562.807789415792;2479.590867506859;2491.9875400622973;2512.8869200886006;2517.144170981866;2519.282004628681;2446.8654224017673;2452.766987136219;2457.913973010954;2483.801295896333;2501.2121181827756;2478.3804048987754;2498.7626175513296;2515.8490490570625;2515.8490490570625;2536.251805717318;8420.157984201593;8574.142585741438;8699.043105258417;8741.213290803858;8751.649934002633;5349.170878513836;5406.972965135149;5449.809256676037;5455.945440545624;5456.454354564551;3565.8038807865555;3578.834804943024;3615.1865830188262;3615.475756015363;3658.1037645776687;1209.4799236328374;1226.3439060102803;1238.6717519857245;1258.6475786779624;1310.226966090002;11888;12086.153969222158;12374.071944604191;12417.19288246261;12467.314297713621;4821.108095002436;4926.433460152057;4964.280179373971;4975.925361119586;5013.172826483662;10469.790604187874;10480.213983951235;10486.108680762069;10514.26400151982;10521.631742889116;5585.385607583163;5598.944010559923;5626.774929002794;5630.493255607015;5643.068893632587;4370.2352088384405;4778.259369797687;4849.58778503824;4878.756062196876;5116.155834287375;4203.453551038346;4213.873583792491;4268.16770729711;4289.077848262638;4308.913821723548;1372.4167228927665;1417.461364681435;1420.6519402746187;1423.238567366454;1435.519101101122;844.4890841041205;917.3991035871514;956.4404823178379;1005.1556692378438;1013.1135256650431;5904.675242861684;5987.341392446828;6001.819945401645;6004.819855404345;6029.728662210211;463.2610985478157;464.06722487799766;472.15719939907103;478.62427994024523;480.02794341458826;4003.219372222447;4026;4103.322951712994;4107.158032603309;4176.728512646729;10576.101031412261;11039.83440248397;11071.225014249087;11079.944600276947;11084.944575277072;10058.04448577384;10181.694549163536;10211.7447063824;10228.386296822215;10984.670459886216;7977.401694872908;7994.720184793504;8061.83876322482;8073.596320183968;8082.353411727047;5580.944190558205;5625.043742563856;5640.435956404327;5745.885082298414;5835.9708201458725;9282.443053416817;9472.194863436409;9532.666356677482;9589.856152157863;9598.136167744937;9237.491937943478;9317.534123293945;9320.580573874327;9695.078967498077;9712;6829.385355318045;7542.4720269582795;7694.1536430993665;7744;7803.960980195063;8404.327653787805;8420.915790842259;8434.114417986268;8459.83080338402;8476.194761497647;7492.438067145095;7600.8479830404185;7633.503822251536;7723.304902558797;7812.804679883048;7494.213107623839;7509.88735168962;7554.584497852451;7617.69529218825;7648.655810488653;6063.575549711654;6107.450329470369;6189.84525386869;6202.472789812917;6252.155958945484;5133.974330128325;5222.817201397933;5318.627696061239;5389.326334208224;5408.405075441619;5222.973885130702;5329.413764485826;5344.064788662046;5346.599005074557;5415.83752487426 09:34:56 INFO - PROCESS | 22264 | |4;prototype.html;350.23124242288185;356.6451380876029;359.9982000089999;368.5025215958458;371.8642695416172;6174.969125154374;6312.842178945523;6360.17317748692;6361.68191590421;6369.777057802972;6222.137816604356;6270.843228919268;6276.937230627693;6282.151909492217;6289.654069026214;4610.4467463904375;4704.317873908281;4836.347093142416;4840.249761286988;4848.17581011229;4844.781984810692;4847.1517484440255;4850.514948505156;4858.927116093261;4863.635227357962;4790.329353890458;4793.065352256294;4794.065157294329;4803.255495398219;4808.831690890819;4560.771961401917;4658.743769092698;4743.739094349809;4791.137595232856;4798.592119669832;4215.578442155791;4231.534531201565;4231.809568569391;4232.492100947906;4235.512916014667;6010.368911264298;6012.18835457212;6020.277566692025;6025.879482410327;6031.24609423822;5576.10782274834;5587.972060139714;5593.133064375028;5593.244911936918;5597.860053498654;6623.966880165568;6632.403083722488;6637;6637.568558043712;6647.700853461606;4606.792694328763;4651.465081515601;4680.976595117003;4690.01509682967;4695.906081878344;6887.104676392087;6900.275471075515;6911.827204319882;6918.411934985532;6922.965385173092;4785.976070119627;4791.496892826272;4796.208625576741;4799.352087468217;4802.231642937113;4849.151398505247;4862.6839255448285;4867.367242258484;4867.95132048675;4870.732109733999;5554.361248456398;5581.386047534768;5581.832545023656;5584.804531841447;5587.189857470726;6529.477641788645;6660.467162626978;6673.232578253466;6676.46588272937;6695.598264104072;1696.11801863033;1715.408184176457;1723.1556537296635;1724.8533874620546;1727.1105380728934;1139.2196345503191;1150.6030419505257;1167.7139100920328;1173.0849937049115;1176.6764139861607;6207.906881396692;6344;6519.445847102955;6521.9673901630185;6526.836829079216;6938.028675985366;6940.13248343957;6944.305569443015;6956.130483689539;6956.339147780953;6422.133012043408;6499.480041596661;6510.762955038527;6516;6522.706478208492;3690.741648084662;3718.7768733876055;3724.5530536335814;3726.5155529780955;3732.794696291676;6945.930540694529;7187.353138217585;7234.74678386254;7240.094988126484;7242.49302548827;7101.9289807102305;7142.785716428515;7180.138383393922;7195.064641596559;7223.349898509055;7215.494915355875;7221.169565499929;7227.674754636054;7235.891461627974;7248.855022899513;6942.826429339307;6945.201301850352;6950.548214366252;6957.130358705162;6974.407175390149;6637.767678131242;6807.965960170168;6848.760293389907;6874.793756187322;6882.174139103339;7128.964355178191;7132.1441427029085;7140.178879428724;7172.354488096096;7202;4604.378408914888;4634.791434385394;4635.582797548237;4640.9767951161375;4648.697834640738;6871.587704737732;6884.4148247399535;6902.24075351721;6918.861622767416;6938.306169383021;6465.482761379172;6731.798046058626;6739.191297044386;6756.223034350916;6758.594484330956;6710.932890671031;6738.090357801634;6741.662916854236;6747.257801641914;6753.561018533779;6618.07346971434;6621.106150669598;6622;6638.369354911276;6649.501287403367;6781.457483401415;6783.253842077466;6784.423324017514;6786.796396108125;6794.150731158606;6475.061116138228;6608.50436217276;6608.603483790988;6612.70242839083;6614.173228346457 09:34:56 INFO - PROCESS | 22264 | |5;yui.html;878.6046279174371;930.7114794413736;934.7663084228943;938.8497840345547;959.9105015807062;15351.155686437241;15490.148041857694;15711.92144039281;15768.684626307482;15796.842031579681;14226.146431214134;14334.856651433483;14347.78478322826;14360.640983975405;14430.927845360784;761.4669731188163;885.1944730295432;899.9280057595392;923.7644400677817;926.8239034583441;901.4636291406603;909.0863681999581;913.5204017890627;913.7989642278689;914.5061666699974;963.2534785541192;969.365065881845;969.8399764038925;971.5967873332559;973.6689525561308;790.02826523376;909.7998440343114;932.8554074118455;933.3932943586655;964.4695417520336;690.6650274616807;691.2258270736756;691.8858388365913;692.4114502672738;694.035290945581;14910.70178596433;14932.62668433287;14947.850521494755;14953.177575233358;14953.40186392543;14717.190554519497;15164.24178791067;15212.163331016789;15227.390904363812;15252.923735381362;11722.589709360216;11752.588659396966;11816.822747658793;11924.582639607572;11976;4043.2722110020186;4071.3282308419075;4078.3882417637296;4089.3865920111925;4125.814338354781;60851.39148608501;60970;60989.390106098814;61083;61385.693071534355;10050.195984321237;10380.32527885685;10479.47602619866;10548.841767373495;10652;20150;20211.696824547642;20291;20293.695594566092;20326.796732032784;8663.740087797376;8666.86999695005;8688.348373871984;8740.8688869667;8824.735257942271;4947.332110165154;4982.5515703586125;5003.149464591028;5018.322526458881;5157.484251574812;3576.7675101118343;3632.9818350908604;3639.2357604902736;3646.927061458756;3647.325244829715;557.4509108528097;605.6638565596137;639.5427269502328;651.1990251990079;652.8367908022994;732.2531018361242;742.9554226746412;803.4094940218935;818.1000899011159;868.9522076285865;9776.951115244377;9999.400035997864;10018.949905250427;10047.648332308334;10054.195664346835;796.5101462600575;811.8701007838717;813.0934008580508;814.7759366174231;820.3724151024471;4556.066006468666;4557.453105627346;4617.353570500132;4680.608270695371;4707.364505791675;67933.98099028518;70372;70887;70999.64500177569;71028.64485677538;55752.16371754427;58092;60018.69990650019;60148.69925650344;60232.09651855226;54001.189982150296;54281.72859135679;55391.72304138453;55621.44378556163;56108.999999999185;8998.14517620825;9037.77405564866;9040.954795225982;9072;9118.95440522793;40762;41168.588314116474;41383.793081034404;41386.37920431136;42729.359059614755;47054.294185587925;47310.76344618255;47731.76134119307;47940.28089578729;49264.75367623139;12515.561955331885;12707;12719.236845789283;12730.554430594884;12809.935950320189;13760.449582016607;14523.564293071226;14755.926220368829;14909.3290801912;14910.179940103399;10666.306690065121;12612.87387126117;12750.171238869443;12782.36088195605;13164;12583.559575414816;12921.35393230316;13747.349770562232;14066.507672231422;14087;12585.496580136693;12826.679333016376;13136.671583210496;13591.45634174622;14344.354504047134;11017.779644406906;11119.27724697892;11214.66356009321;11566.710832229262;11745.47145378477;10698.518566664363;10982.341059536453;11245.325280483197;11472.598459053894;11502.42487875586 09:34:56 INFO - PROCESS | 22264 | __end_tp_report 09:34:56 INFO - PROCESS | 22264 | __start_cc_report 09:34:56 INFO - PROCESS | 22264 | _x_x_mozilla_cycle_collect,851 09:34:56 INFO - PROCESS | 22264 | __end_cc_report 09:34:56 INFO - PROCESS | 22264 | __startTimestamp1465922096470__endTimestamp 09:34:56 INFO - PROCESS | 22264 | 09:34:56 INFO - PROCESS | 22264 | ------- Summary: start ------- 09:34:56 INFO - PROCESS | 22264 | Number of tests: 6 09:34:56 INFO - PROCESS | 22264 | 09:34:56 INFO - PROCESS | 22264 | [#0] dojo.html Cycles:165 Average:5533.76 Median:5786.48 stddev:624.68 (10.8%) stddev-sans-first:601.82 09:34:56 INFO - PROCESS | 22264 | Values: 3313.6 3321.4 3343.6 3378.9 3386.5 5495.1 5516.0 5524.4 5537.1 5545.0 5473.8 5488.8 5492.3 5536.2 5565.0 4948.7 5046.3 5048.7 5075.1 5092.1 4988.5 5058.5 5067.2 5070.4 5074.3 4920.6 4972.9 4994.8 4997.6 5029.1 5029.8 5055.9 5068.0 5072.1 5077.8 4870.2 4952.8 5000.3 5005.3 5092.4 5437.4 5476.5 5478.4 5479.4 5490.0 5980.8 5980.8 5983.3 5983.4 6011.2 5876.4 5904.7 5939.1 5954.1 6007.9 5559.5 5561.2 5571.7 5581.7 5584.0 6035.7 6086.1 6086.6 6103.5 6109.5 5896.7 5930.1 5939.7 5950.8 5953.0 5830.2 5852.4 5860.3 5876.8 5877.5 5798.2 5812.4 5820.7 5897.7 5956.9 5960.6 5962.4 5970.1 5979.7 6033.7 4523.4 4529.4 4533.1 4539.6 4548.1 4010.8 4030.0 4080.5 4081.0 4105.4 5673.3 5703.2 5706.1 5716.5 5730.3 6022.8 6033.8 6034.0 6034.3 6041.6 5520.3 5524.5 5634.0 5635.7 5643.3 5110.0 5116.7 5127.8 5134.7 5138.3 6166.5 6172.8 6181.2 6189.0 6203.1 5936.3 5948.3 5985.6 6011.6 6015.4 6161.7 6178.1 6185.1 6190.3 6211.2 5810.7 5909.9 5911.9 5919.3 5921.3 5910.9 5941.6 5956.0 5971.2 5992.2 5871.2 5893.0 5897.9 5907.9 5908.4 5752.9 5848.5 5903.6 5904.4 5908.9 5769.7 5776.8 5778.2 5786.5 5810.8 5861.9 5863.5 5869.4 5869.9 5903.8 5626.9 5750.7 5780.4 5795.8 5836.9 09:34:56 INFO - PROCESS | 22264 | 09:34:56 INFO - PROCESS | 22264 | [#1] ext.html Cycles:180 Average:64385.83 Median:21377.21 stddev:127034.03 (594.2%) stddev-sans-first:127300.27 09:34:56 INFO - PROCESS | 22264 | Values: 654.1 680.0 683.6 742.3 764.5 32829.3 33491.5 39845.6 40466.6 40514.0 44294.6 44650.6 44706.0 44912.0 44912.6 8129.8 8980.6 9165.3 9169.3 10635.2 10714.7 10864.4 10867.3 10868.8 10870.2 10889.1 10951.8 10968.2 10974.5 10977.4 10781.4 10842.1 10855.5 10857.7 10858.6 10688.8 11171.9 11179.6 11182.8 11187.4 43179.8 43406.0 43526.0 43568.9 43726.6 3849.5 3864.0 3944.1 3972.2 4276.9 33081.7 33106.3 33139.0 33615.3 34429.0 4670.0 4671.0 4763.6 4780.6 4782.2 354339.0 354889.0 355852.0 356002.0 356287.0 63422.7 63709.7 63786.4 63906.0 63970.7 70832.6 72221.0 72283.0 72312.6 72369.5 17291.5 17412.2 17438.2 17443.7 17477.7 13140.4 14128.4 14367.1 14402.9 14418.3 20623.7 20714.9 21102.2 21523.4 21679.0 7487.5 7506.5 7523.7 7675.9 7762.5 1102.7 1158.0 1195.5 1245.1 1267.8 34361.1 34520.0 34932.0 35124.1 35251.8 1135.5 1136.4 1156.6 1215.9 1249.6 15842.5 16801.7 17286.9 17931.6 18476.5 573681.0 582570.0 582628.0 584452.0 584789.0 62929.4 63630.7 63679.4 63762.0 63850.7 1421.3 1485.6 1499.8 1548.2 1570.1 31921.4 33529.8 34175.5 34467.5 34898.7 55972.4 56746.7 56791.4 56795.4 56813.7 469359.0 471830.0 473803.0 474230.0 475310.0 40916.6 41734.6 42937.8 48518.5 49907.0 46491.8 46672.0 47165.5 47280.5 47957.0 38296.8 38435.6 38890.4 39058.6 39903.8 38289.8 39005.2 39055.8 39149.2 39452.6 40595.0 43201.4 44062.6 44120.6 44581.8 37337.0 37898.0 38504.2 38950.0 39071.4 28628.3 28732.4 29147.3 29251.3 29280.6 09:34:56 INFO - PROCESS | 22264 | 09:34:56 INFO - PROCESS | 22264 | [#2] jquery.html Cycles:180 Average:32206.58 Median:23359.65 stddev:92097.89 (394.3%) stddev-sans-first:92325.35 09:34:56 INFO - PROCESS | 22264 | Values: 437.2 440.1 440.7 443.7 448.4 18308.5 18757.9 19284.1 19325.5 19348.0 15425.5 16426.8 18666.4 19709.2 19725.2 5664.3 5669.1 5887.2 5901.4 5923.6 5863.1 5891.5 5905.8 5920.1 5930.0 3922.6 4082.0 6149.6 6408.6 6409.6 6157.2 6299.8 6331.6 6366.9 6378.4 5701.8 5717.5 5766.4 5766.5 5767.3 22621.1 22648.4 23346.9 23350.9 23368.4 2419.2 2498.5 2559.5 2775.4 2911.1 10738.7 10816.3 10932.6 11151.8 12709.5 2037.7 2090.5 2162.2 2164.8 2199.4 82286.6 82580.0 93644.0 95009.5 97153.5 18137.6 18586.5 18952.8 19188.0 19661.7 33936.8 34009.0 34327.0 34529.0 34558.5 8353.1 8648.4 8703.3 8780.3 10611.5 8513.6 8537.7 8601.8 8665.0 8856.6 5124.5 5209.5 5248.2 5264.3 5276.8 2063.4 2072.9 2130.9 2147.5 2163.3 990.0 1054.0 1105.3 1113.3 1117.1 16782.7 19300.3 19399.2 19604.2 20136.7 1050.2 1066.1 1094.3 1099.7 1102.9 10625.8 10873.8 11109.9 11239.0 11779.2 511050.0 515040.0 567527.0 597033.0 600990.0 92043.5 98209.5 100823.0 101195.0 101470.0 1159.4 1172.9 1190.5 1210.3 1229.7 17194.1 17611.5 18073.5 18207.0 18389.0 38948.6 39512.2 40126.0 40169.2 40386.8 55592.0 56910.4 57273.4 57461.0 57642.0 8467.9 8697.3 8698.6 8808.3 8892.4 9647.0 12880.5 13881.4 14174.4 14188.5 11434.5 11809.3 12012.3 12404.3 12528.8 11798.7 12025.5 12097.9 12347.4 12580.7 12478.4 12482.3 12664.2 12825.9 12970.3 8888.5 8891.2 9286.8 9349.2 9562.8 12226.5 12226.8 12371.8 12539.5 12554.9 09:34:56 INFO - PROCESS | 22264 | 09:34:56 INFO - PROCESS | 22264 | [#3] mootools.html Cycles:180 Average:5748.67 Median:5064.66 stddev:3160.71 (62.4%) stddev-sans-first:3152.70 09:34:56 INFO - PROCESS | 22264 | Values: 1402.6 1584.6 1592.5 1806.0 1905.9 7744.8 8417.6 8579.1 8609.5 8613.5 8203.1 8240.1 8377.5 8395.0 8423.5 2432.3 2461.1 2464.3 2465.2 2468.5 2395.9 2533.1 2539.7 2539.8 2562.8 2479.6 2492.0 2512.9 2517.1 2519.3 2446.9 2452.8 2457.9 2483.8 2501.2 2478.4 2498.8 2515.8 2515.8 2536.3 8420.2 8574.1 8699.0 8741.2 8751.6 5349.2 5407.0 5449.8 5455.9 5456.5 3565.8 3578.8 3615.2 3615.5 3658.1 1209.5 1226.3 1238.7 1258.6 1310.2 11888.0 12086.2 12374.1 12417.2 12467.3 4821.1 4926.4 4964.3 4975.9 5013.2 10469.8 10480.2 10486.1 10514.3 10521.6 5585.4 5598.9 5626.8 5630.5 5643.1 4370.2 4778.3 4849.6 4878.8 5116.2 4203.5 4213.9 4268.2 4289.1 4308.9 1372.4 1417.5 1420.7 1423.2 1435.5 844.5 917.4 956.4 1005.2 1013.1 5904.7 5987.3 6001.8 6004.8 6029.7 463.3 464.1 472.2 478.6 480.0 4003.2 4026.0 4103.3 4107.2 4176.7 10576.1 11039.8 11071.2 11079.9 11084.9 10058.0 10181.7 10211.7 10228.4 10984.7 7977.4 7994.7 8061.8 8073.6 8082.4 5580.9 5625.0 5640.4 5745.9 5836.0 9282.4 9472.2 9532.7 9589.9 9598.1 9237.5 9317.5 9320.6 9695.1 9712.0 6829.4 7542.5 7694.2 7744.0 7804.0 8404.3 8420.9 8434.1 8459.8 8476.2 7492.4 7600.8 7633.5 7723.3 7812.8 7494.2 7509.9 7554.6 7617.7 7648.7 6063.6 6107.5 6189.8 6202.5 6252.2 5134.0 5222.8 5318.6 5389.3 5408.4 5223.0 5329.4 5344.1 5346.6 5415.8 09:34:56 INFO - PROCESS | 22264 | 09:34:56 INFO - PROCESS | 22264 | [#4] prototype.html Cycles:180 Average:5608.93 Median:6365.73 stddev:1693.16 (26.6%) stddev-sans-first:1651.26 09:34:56 INFO - PROCESS | 22264 | Values: 350.2 356.6 360.0 368.5 371.9 6175.0 6312.8 6360.2 6361.7 6369.8 6222.1 6270.8 6276.9 6282.2 6289.7 4610.4 4704.3 4836.3 4840.2 4848.2 4844.8 4847.2 4850.5 4858.9 4863.6 4790.3 4793.1 4794.1 4803.3 4808.8 4560.8 4658.7 4743.7 4791.1 4798.6 4215.6 4231.5 4231.8 4232.5 4235.5 6010.4 6012.2 6020.3 6025.9 6031.2 5576.1 5588.0 5593.1 5593.2 5597.9 6624.0 6632.4 6637.0 6637.6 6647.7 4606.8 4651.5 4681.0 4690.0 4695.9 6887.1 6900.3 6911.8 6918.4 6923.0 4786.0 4791.5 4796.2 4799.4 4802.2 4849.2 4862.7 4867.4 4868.0 4870.7 5554.4 5581.4 5581.8 5584.8 5587.2 6529.5 6660.5 6673.2 6676.5 6695.6 1696.1 1715.4 1723.2 1724.9 1727.1 1139.2 1150.6 1167.7 1173.1 1176.7 6207.9 6344.0 6519.4 6522.0 6526.8 6938.0 6940.1 6944.3 6956.1 6956.3 6422.1 6499.5 6510.8 6516.0 6522.7 3690.7 3718.8 3724.6 3726.5 3732.8 6945.9 7187.4 7234.7 7240.1 7242.5 7101.9 7142.8 7180.1 7195.1 7223.3 7215.5 7221.2 7227.7 7235.9 7248.9 6942.8 6945.2 6950.5 6957.1 6974.4 6637.8 6808.0 6848.8 6874.8 6882.2 7129.0 7132.1 7140.2 7172.4 7202.0 4604.4 4634.8 4635.6 4641.0 4648.7 6871.6 6884.4 6902.2 6918.9 6938.3 6465.5 6731.8 6739.2 6756.2 6758.6 6710.9 6738.1 6741.7 6747.3 6753.6 6618.1 6621.1 6622.0 6638.4 6649.5 6781.5 6783.3 6784.4 6786.8 6794.2 6475.1 6608.5 6608.6 6612.7 6614.2 09:34:56 INFO - PROCESS | 22264 | 09:34:56 INFO - PROCESS | 22264 | [#5] yui.html Cycles:180 Average:16074.50 Median:4648.98 stddev:18994.98 (408.6%) stddev-sans-first:19013.99 09:34:56 INFO - PROCESS | 22264 | Values: 878.6 930.7 934.8 938.8 959.9 15351.2 15490.1 15711.9 15768.7 15796.8 14226.1 14334.9 14347.8 14360.6 14430.9 761.5 885.2 899.9 923.8 926.8 901.5 909.1 913.5 913.8 914.5 963.3 969.4 969.8 971.6 973.7 790.0 909.8 932.9 933.4 964.5 690.7 691.2 691.9 692.4 694.0 14910.7 14932.6 14947.9 14953.2 14953.4 14717.2 15164.2 15212.2 15227.4 15252.9 11722.6 11752.6 11816.8 11924.6 11976.0 4043.3 4071.3 4078.4 4089.4 4125.8 60851.4 60970.0 60989.4 61083.0 61385.7 10050.2 10380.3 10479.5 10548.8 10652.0 20150.0 20211.7 20291.0 20293.7 20326.8 8663.7 8666.9 8688.3 8740.9 8824.7 4947.3 4982.6 5003.1 5018.3 5157.5 3576.8 3633.0 3639.2 3646.9 3647.3 557.5 605.7 639.5 651.2 652.8 732.3 743.0 803.4 818.1 869.0 9777.0 9999.4 10018.9 10047.6 10054.2 796.5 811.9 813.1 814.8 820.4 4556.1 4557.5 4617.4 4680.6 4707.4 67934.0 70372.0 70887.0 70999.6 71028.6 55752.2 58092.0 60018.7 60148.7 60232.1 54001.2 54281.7 55391.7 55621.4 56109.0 8998.1 9037.8 9041.0 9072.0 9119.0 40762.0 41168.6 41383.8 41386.4 42729.4 47054.3 47310.8 47731.8 47940.3 49264.8 12515.6 12707.0 12719.2 12730.6 12809.9 13760.4 14523.6 14755.9 14909.3 14910.2 10666.3 12612.9 12750.2 12782.4 13164.0 12583.6 12921.4 13747.3 14066.5 14087.0 12585.5 12826.7 13136.7 13591.5 14344.4 11017.8 11119.3 11214.7 11566.7 11745.5 10698.5 10982.3 11245.3 11472.6 11502.4 09:34:56 INFO - PROCESS | 22264 | -------- Summary: end -------- 09:34:56 INFO - PROCESS | 22264 | 09:34:57 INFO - TEST-INFO | 22264: exit 0 09:34:57 INFO - TEST-OK | dromaeo_css | took 1112156ms 09:34:57 INFO - TEST-START | kraken 09:34:57 INFO - operating with platform_type : linux_ 09:34:57 INFO - Initialising browser for kraken test... 09:34:57 INFO - TEST-INFO | started process 22457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfnW369/profile http://localhost:33295/getInfo.html) 09:35:01 INFO - PROCESS | 22457 | __metrics Screen width/height:1600/1200 09:35:01 INFO - PROCESS | 22457 | colorDepth:24 09:35:01 INFO - PROCESS | 22457 | Browser inner width/height: 1024/697 09:35:01 INFO - PROCESS | 22457 | __metrics 09:35:02 ERROR - PROCESS | 22457 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:35:03 INFO - TEST-INFO | 22457: exit 0 09:35:03 INFO - Browser initialized. 09:35:03 INFO - Running cycle 1/1 for kraken test... 09:35:03 INFO - TEST-INFO | started process 22547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfnW369/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:14 INFO - PROCESS | 22547 | RSS: Main: 141045760 09:35:14 INFO - PROCESS | 22547 | 09:35:17 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33295/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:18 INFO - PROCESS | 22547 | RSS: Main: 197648384 09:35:18 INFO - PROCESS | 22547 | 09:35:20 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33295/tests/kraken/driver.html?testName=audio-dft) 09:35:21 INFO - PROCESS | 22547 | RSS: Main: 183533568 09:35:21 INFO - PROCESS | 22547 | 09:35:24 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33295/tests/kraken/driver.html?testName=audio-fft) 09:35:24 INFO - PROCESS | 22547 | RSS: Main: 271949824 09:35:24 INFO - PROCESS | 22547 | 09:35:26 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33295/tests/kraken/driver.html?testName=audio-oscillator) 09:35:27 INFO - PROCESS | 22547 | RSS: Main: 178814976 09:35:27 INFO - PROCESS | 22547 | 09:35:29 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:35:30 INFO - PROCESS | 22547 | RSS: Main: 177049600 09:35:30 INFO - PROCESS | 22547 | 09:35:33 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33295/tests/kraken/driver.html?testName=imaging-darkroom) 09:35:33 INFO - PROCESS | 22547 | RSS: Main: 212234240 09:35:33 INFO - PROCESS | 22547 | 09:35:37 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33295/tests/kraken/driver.html?testName=imaging-desaturate) 09:35:37 INFO - PROCESS | 22547 | RSS: Main: 212025344 09:35:37 INFO - PROCESS | 22547 | 09:35:40 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33295/tests/kraken/driver.html?testName=json-parse-financial) 09:35:41 INFO - PROCESS | 22547 | RSS: Main: 211697664 09:35:41 INFO - PROCESS | 22547 | 09:35:42 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:43 INFO - PROCESS | 22547 | RSS: Main: 192163840 09:35:43 INFO - PROCESS | 22547 | 09:35:44 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33295/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:45 INFO - PROCESS | 22547 | RSS: Main: 194809856 09:35:45 INFO - PROCESS | 22547 | 09:35:47 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:48 INFO - PROCESS | 22547 | RSS: Main: 210051072 09:35:48 INFO - PROCESS | 22547 | 09:35:50 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:51 INFO - PROCESS | 22547 | RSS: Main: 215990272 09:35:51 INFO - PROCESS | 22547 | 09:35:53 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:54 INFO - PROCESS | 22547 | RSS: Main: 212434944 09:35:54 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | Cycle 1(1): loaded http://localhost:33295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33295/tests/kraken/driver.html?testName=ai-astar) 09:35:56 INFO - PROCESS | 22547 | RSS: Main: 272969728 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | __start_tp_report 09:35:56 INFO - PROCESS | 22547 | _x_x_mozilla_page_load 09:35:56 INFO - PROCESS | 22547 | _x_x_mozilla_page_load_details 09:35:56 INFO - PROCESS | 22547 | |i|pagename|runs| 09:35:56 INFO - PROCESS | 22547 | |0;ai-astar;109;110;109;110;111;112;104;111;109;109 09:35:56 INFO - PROCESS | 22547 | |1;audio-beat-detection;156;127;151;172;127;153;156;142;178;125 09:35:56 INFO - PROCESS | 22547 | |2;audio-dft;162;161;162;161;160;161;161;161;159;162 09:35:56 INFO - PROCESS | 22547 | |3;audio-fft;76;76;76;180;76;74;74;74;184;75 09:35:56 INFO - PROCESS | 22547 | |4;audio-oscillator;91;91;151;91;90;92;147;92;92;154 09:35:56 INFO - PROCESS | 22547 | |5;imaging-gaussian-blur;116;116;116;117;116;116;116;117;116;117 09:35:56 INFO - PROCESS | 22547 | |6;imaging-darkroom;144;144;145;146;145;145;145;145;145;145 09:35:56 INFO - PROCESS | 22547 | |7;imaging-desaturate;94;94;95;95;95;94;95;94;94;94 09:35:56 INFO - PROCESS | 22547 | |8;json-parse-financial;53;53;55;53;55;54;55;76;53;51 09:35:56 INFO - PROCESS | 22547 | |9;json-stringify-tinderbox;60;60;59;59;61;60;60;61;59;60 09:35:56 INFO - PROCESS | 22547 | |10;stanford-crypto-aes;72;72;72;72;73;74;73;73;73;73 09:35:56 INFO - PROCESS | 22547 | |11;stanford-crypto-ccm;124;113;116;113;113;124;120;115;137;124 09:35:56 INFO - PROCESS | 22547 | |12;stanford-crypto-pbkdf2;158;154;157;153;163;157;161;164;159;156 09:35:56 INFO - PROCESS | 22547 | |13;stanford-crypto-sha256-iterative;66;67;66;67;64;65;73;64;68;61 09:35:56 INFO - PROCESS | 22547 | __end_tp_report 09:35:56 INFO - PROCESS | 22547 | __start_cc_report 09:35:56 INFO - PROCESS | 22547 | _x_x_mozilla_cycle_collect,1585 09:35:56 INFO - PROCESS | 22547 | __end_cc_report 09:35:56 INFO - PROCESS | 22547 | __startTimestamp1465922156399__endTimestamp 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | ------- Summary: start ------- 09:35:56 INFO - PROCESS | 22547 | Number of tests: 14 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.17 (2.0%) stddev-sans-first:2.30 09:35:56 INFO - PROCESS | 22547 | Values: 109.0 110.0 109.0 110.0 111.0 112.0 104.0 111.0 109.0 109.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:154.50 stddev:18.50 (12.0%) stddev-sans-first:19.43 09:35:56 INFO - PROCESS | 22547 | Values: 156.0 127.0 151.0 172.0 127.0 153.0 156.0 142.0 178.0 125.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 09:35:56 INFO - PROCESS | 22547 | Values: 162.0 161.0 162.0 161.0 160.0 161.0 161.0 161.0 159.0 162.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#3] audio-fft Cycles:10 Average:96.50 Median:75.50 stddev:45.08 (59.7%) stddev-sans-first:47.20 09:35:56 INFO - PROCESS | 22547 | Values: 76.0 76.0 76.0 180.0 76.0 74.0 74.0 74.0 184.0 75.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:91.00 stddev:28.74 (31.6%) stddev-sans-first:29.73 09:35:56 INFO - PROCESS | 22547 | Values: 91.0 91.0 151.0 91.0 90.0 92.0 147.0 92.0 92.0 154.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:35:56 INFO - PROCESS | 22547 | Values: 116.0 116.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 117.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 09:35:56 INFO - PROCESS | 22547 | Values: 144.0 144.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:35:56 INFO - PROCESS | 22547 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:54.50 stddev:7.21 (13.2%) stddev-sans-first:7.57 09:35:56 INFO - PROCESS | 22547 | Values: 53.0 53.0 55.0 53.0 55.0 54.0 55.0 76.0 53.0 51.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 09:35:56 INFO - PROCESS | 22547 | Values: 60.0 60.0 59.0 59.0 61.0 60.0 60.0 61.0 59.0 60.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#10] stanford-crypto-aes Cycles:10 Average:72.70 Median:73.00 stddev:0.67 (0.9%) stddev-sans-first:0.67 09:35:56 INFO - PROCESS | 22547 | Values: 72.0 72.0 72.0 72.0 73.0 74.0 73.0 73.0 73.0 73.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:122.00 stddev:7.64 (6.3%) stddev-sans-first:7.95 09:35:56 INFO - PROCESS | 22547 | Values: 124.0 113.0 116.0 113.0 113.0 124.0 120.0 115.0 137.0 124.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.50 stddev:3.61 (2.3%) stddev-sans-first:3.83 09:35:56 INFO - PROCESS | 22547 | Values: 158.0 154.0 157.0 153.0 163.0 157.0 161.0 164.0 159.0 156.0 09:35:56 INFO - PROCESS | 22547 | 09:35:56 INFO - PROCESS | 22547 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:3.14 (4.7%) stddev-sans-first:3.33 09:35:56 INFO - PROCESS | 22547 | Values: 66.0 67.0 66.0 67.0 64.0 65.0 73.0 64.0 68.0 61.0 09:35:56 INFO - PROCESS | 22547 | -------- Summary: end -------- 09:35:56 INFO - PROCESS | 22547 | 09:35:57 INFO - TEST-INFO | 22547: exit 0 09:35:57 INFO - TEST-OK | kraken | took 60142ms 09:35:57 INFO - SUITE-END | took 1172s 09:35:57 INFO - Completed test suite (00:19:32) 09:35:57 INFO - javascript benchmark 09:35:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.6355000949893, 3321.3689399014183, 3343.565336506254, 3378.881739139131, 3386.5258863759077, 5495.148252020938, 5516.034693928556, 5524.4199359067225, 5537.114061750116, 5544.972275138629, 5473.808416705416, 5488.835334939949, 5492.340919089715, 5536.197251398555, 5564.972175139129, 4948.7278199699, 5046.268291097788, 5048.6970781753025, 5075.111855425304, 5092.057969275677, 4988.451270360258, 5058.544730974211, 5067.163917953533, 5070.391553013644, 5074.314967479399, 4920.60635149189, 4972.925406118911, 4994.775235114428, 4997.550220480156, 5029.1199040168, 5029.84910452687, 5055.9241611375855, 5068.037072956145, 5072.0870243356185, 5077.822276220333, 4870.245112007645, 4952.826651067231, 5000.324956130912, 5005.27423523587, 5092.414372347191, 5437.429069947638, 5476.507114359687, 5478.424765399655, 5479.424660410679, 5490.011797876381, 5980.760769569212, 5980.820575382702, 5983.282006159246, 5983.371745966654, 6011.188489553898, 5876.353601103875, 5904.704764761745, 5939.109133629947, 5954.136650185742, 6007.879842403127, 5559.499645031926, 5561.165825126223, 5571.66570005801, 5581.6930068846605, 5583.972080139654, 6035.719980864293, 6086.056661217518, 6086.573939824259, 6103.450689437972, 6109.480694141048, 5896.6756828374855, 5930.11048342752, 5939.70301484924, 5950.761969521171, 5953.0, 5830.212921255661, 5852.385499522489, 5860.3260625027815, 5876.823695289063, 5877.471027607536, 5798.159266906275, 5812.38969908162, 5820.650760954356, 5897.734601942923, 5956.910646340309, 5960.552958528127, 5962.403759624003, 5970.0746384310505, 5979.701014949235, 6033.698315084228, 4523.389342438794, 4529.38853254813, 4533.093381323749, 4539.568740969603, 4548.067646132535, 4010.8195131219163, 4030.0, 4080.489938757655, 4081.0409553754844, 4105.363668631367, 5673.290838645169, 5703.173039909273, 5706.115552089433, 5716.456936591017, 5730.3410107838135, 6022.759089636365, 6033.78881739137, 6034.0, 6034.275886893601, 6041.607295525777, 5520.254765606672, 5524.530414914697, 5633.971830140905, 5635.746391412396, 5643.322801263875, 5109.9744501277255, 5116.667416617908, 5127.820526281637, 5134.691918484828, 5138.332016837862, 6166.506679465632, 6172.753089876354, 6181.196444462281, 6188.9690551546955, 6203.069539569101, 5936.287645482397, 5948.2862056553495, 5985.551083668655, 6011.609245399035, 6015.39846015395, 6161.661108639068, 6178.104174894705, 6185.134081228722, 6190.288116866618, 6211.192544969125, 5810.680412577349, 5909.852253693692, 5911.911321330097, 5919.260092488439, 5921.319048309328, 5910.852228694317, 5941.613795103304, 5956.047032474957, 5971.193888825127, 5992.161097446448, 5871.178035075179, 5893.02765043763, 5897.911531326948, 5907.881842363215, 5908.409159084057, 5752.9137062943255, 5848.502877255481, 5903.557233207441, 5904.409559044233, 5908.911366329423, 5769.740361683818, 5776.797812076557, 5778.248827652378, 5786.479216870502, 5810.796622118206, 5861.882762344644, 5863.472287494146, 5869.383714710065, 5869.882602348014, 5903.822885313448, 5626.85932851682, 5750.712464376848, 5780.421957804186, 5795.76816927335, 5836.883262334644], "value": 5492.57420519566, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.0908137688614, 680.0275605883587, 683.6274230544353, 742.2911119880515, 764.4648745877887, 32829.343413131755, 33491.49762753561, 39845.601543984514, 40466.59533404665, 40514.0, 44294.557054429446, 44650.55349446513, 44706.0, 44912.0, 44912.550874491244, 8129.837403251931, 8980.640774369034, 9165.312601554877, 9169.312301577374, 10635.202359823006, 10714.732131696732, 10864.402457864815, 10867.29362591429, 10868.782624347508, 10870.239083264174, 10889.074428673572, 10951.780964380707, 10968.17738669599, 10974.451277436136, 10977.39624320662, 10781.407022613754, 10842.13262938971, 10855.457227138651, 10857.67426977192, 10858.565657373696, 10688.839667404918, 11171.944140279247, 11179.60871369498, 11182.832257516144, 11187.44062796865, 43179.78410107929, 43406.0, 43526.0, 43568.91077723051, 43726.562734372565, 3849.480320156799, 3863.9953612060785, 3944.073142811466, 3972.225416043844, 4276.87169384919, 33081.6691833081, 33106.3378732424, 33139.0, 33615.32769344624, 34429.0, 4669.953300466986, 4670.953290467086, 4763.618910487153, 4780.593649539794, 4782.1631214537665, 354339.0, 354889.0, 355852.0, 356002.0, 356287.0, 63422.68288658527, 63709.68145159245, 63786.36213637804, 63906.0, 63970.68014659897, 70832.64583677049, 72221.0, 72283.0, 72312.63843680748, 72369.4670686534, 17291.481255562354, 17412.21645025977, 17438.215280312415, 17443.651126977642, 17477.7378339325, 13140.408681609351, 14128.364223609962, 14367.13797172173, 14402.855971440362, 14418.279086045655, 20623.69064464034, 20714.896425517774, 21102.155913763276, 21523.354299371043, 21679.0, 7487.465069660707, 7506.512076714996, 7523.661435235427, 7675.923240767633, 7762.456628035983, 1102.6636875752813, 1157.9925464845637, 1195.485941045359, 1245.1470742541387, 1267.7512650039703, 34361.140971475914, 34520.0, 34932.0, 35124.12189695278, 35251.82374088113, 1135.534430883334, 1136.4374634555948, 1156.5778490850778, 1215.878412158777, 1249.6251124662747, 15842.52472425829, 16801.73986950959, 17286.913565432093, 17931.641367172582, 18476.538086547946, 573681.0, 582570.0, 582628.0, 584452.0, 584789.0, 62929.370706293266, 63630.6818465914, 63679.36320636734, 63762.0, 63850.68074659597, 1421.342090291162, 1485.591462347863, 1499.7825315329435, 1548.1639914446298, 1570.1139679293885, 31921.361572768878, 33529.83235083907, 34175.48736769, 34467.4829877547, 34898.65101348954, 55972.440275598354, 56746.71626641841, 56791.432085678614, 56795.43204568067, 56813.715931420076, 469359.0, 471830.0, 473803.0, 474230.0, 475310.0, 40916.590834092465, 41734.582654174286, 42937.78531107325, 48518.5148148514, 49907.0, 46491.76754116208, 46672.0, 47165.52834471611, 47280.52719472899, 47957.0, 38296.808515957244, 38435.6156438432, 38890.4166437498, 39058.60941390663, 39903.80048099741, 38289.80855095707, 39005.21989560136, 39055.804720976215, 39149.2170156601, 39452.605473944895, 40595.0, 43201.35197972096, 44062.55937440713, 44120.55879441164, 44581.77709111434, 37337.0, 37898.0, 38504.229915402095, 38950.0, 39071.41392879166, 28628.28429289201, 28732.42535149327, 29147.271318217216, 29251.268718282212, 29280.560791587715], "value": 21900.028832011667, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.19556016928846, 440.0714492420991, 440.67390131302847, 443.71158746814564, 448.35282298971174, 18308.450746477592, 18757.906210468947, 19284.132214050383, 19325.516862078453, 19348.0, 15425.537233883002, 16426.75359869603, 18666.440006799785, 19709.211631534756, 19725.21099156032, 5664.26364572605, 5669.064604340289, 5887.205227294325, 5901.3508514063415, 5923.555733319997, 5863.091220860773, 5891.528677705774, 5905.763769449217, 5920.052791553352, 5930.0, 3922.6469617734397, 4081.979590102045, 6149.600275982069, 6408.6154830710075, 6409.647469389181, 6157.230346206724, 6299.811005669814, 6331.620102793847, 6366.904496432558, 6378.425941665249, 5701.800436984686, 5717.456841600083, 5766.4233576642, 5766.481016708474, 5767.33675627304, 22621.095156193896, 22648.43378915524, 23346.883265583732, 23350.883245583664, 23368.415789605227, 2419.2137555294426, 2498.5002999400194, 2559.5136923984383, 2775.3894143288644, 2911.141213342048, 10738.731531711692, 10816.296940698829, 10932.617358392417, 11151.776964460747, 12709.491620335175, 2037.6535988881926, 2090.4878304815265, 2162.167565487299, 2164.837637177218, 2199.4281486813384, 82286.58856705738, 82580.0, 93644.0, 95009.52495237479, 97153.51423242838, 18137.63724725498, 18586.535336616693, 18952.81047189538, 19188.0, 19661.705074423895, 33936.83031584826, 34009.0, 34327.0, 34529.0, 34558.48162277568, 8353.0811610724, 8648.394612377073, 8703.260222881127, 8780.253678437277, 10611.469426528643, 8513.616887240089, 8537.701180458655, 8601.784955376166, 8664.956675216583, 8856.601452934634, 5124.538791508708, 5209.505097015777, 5248.160294352885, 5264.31563896691, 5276.81531146408, 2063.3912995666315, 2072.896355182235, 2130.9147634094775, 2147.50607360308, 2163.2536774812665, 990.0, 1054.0433141267572, 1105.3367979212408, 1113.2763703592568, 1117.0672488472217, 16782.664346712998, 19300.32448864283, 19399.224031038884, 19604.21583136687, 20136.697949530768, 1050.2123407444417, 1066.0938202527943, 1094.3433939636313, 1099.6536091131268, 1102.9393383363993, 10625.84061239082, 10873.836892446461, 11109.944450277697, 11239.0, 11779.234349767237, 511050.0, 515040.0, 567527.0, 597033.0445043328, 600990.0, 92043.53978230066, 98209.5089524562, 100823.0, 101195.0, 101470.0, 1159.3507635723854, 1172.947217375203, 1190.4523918997186, 1210.2556927489532, 1229.6802831263758, 17194.14029298555, 17611.471655850346, 18073.548161296072, 18206.9986150763, 18389.0, 38948.6105138945, 39512.2097558053, 40126.0, 40169.1966160681, 40386.79806600948, 55592.0, 56910.430895690515, 57273.427265728475, 57461.0, 57642.0, 8467.91532084696, 8697.34769892248, 8698.565071746261, 8808.295336373203, 8892.421992570462, 9647.0, 12880.484780609046, 13881.444742210198, 14174.43302267939, 14188.503402380868, 11434.485448154686, 11809.291442513477, 12012.339321337411, 12404.25574465535, 12528.812067818808, 11798.705032374259, 12025.518979240733, 12097.879021210027, 12347.444365003776, 12580.685482863002, 12478.43847026904, 12482.251064936132, 12664.240145591293, 12825.871741282468, 12970.286634235208, 8888.533391990508, 8891.19979201875, 9286.767830804283, 9349.205317548085, 9562.760930976503, 12226.510939562673, 12226.816597751218, 12371.75256494883, 12539.49842006346, 12554.937225313815], "value": 10044.803652121574, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.6072699644103, 1584.6117701163216, 1592.4506045414332, 1805.9909700451503, 1905.8856468611893, 7744.767656970293, 8417.579121043955, 8579.099194584573, 8609.526476043815, 8613.483191008543, 8203.097659257477, 8240.093589705128, 8377.455465394745, 8395.0, 8423.536705481212, 2432.3067925641194, 2461.064795377754, 2464.322311364371, 2465.211132437612, 2468.5309791139716, 2395.928122156329, 2533.1260715053368, 2539.733328000561, 2539.8476091434572, 2562.807789415792, 2479.590867506859, 2491.9875400622973, 2512.8869200886006, 2517.144170981866, 2519.282004628681, 2446.8654224017673, 2452.766987136219, 2457.913973010954, 2483.801295896333, 2501.2121181827756, 2478.3804048987754, 2498.7626175513296, 2515.8490490570625, 2515.8490490570625, 2536.251805717318, 8420.157984201593, 8574.142585741438, 8699.043105258417, 8741.213290803858, 8751.649934002633, 5349.170878513836, 5406.972965135149, 5449.809256676037, 5455.945440545624, 5456.454354564551, 3565.8038807865555, 3578.834804943024, 3615.1865830188262, 3615.475756015363, 3658.1037645776687, 1209.4799236328374, 1226.3439060102803, 1238.6717519857245, 1258.6475786779624, 1310.226966090002, 11888.0, 12086.153969222158, 12374.071944604191, 12417.19288246261, 12467.314297713621, 4821.108095002436, 4926.433460152057, 4964.280179373971, 4975.925361119586, 5013.172826483662, 10469.790604187874, 10480.213983951235, 10486.108680762069, 10514.26400151982, 10521.631742889116, 5585.385607583163, 5598.944010559923, 5626.774929002794, 5630.493255607015, 5643.068893632587, 4370.2352088384405, 4778.259369797687, 4849.58778503824, 4878.756062196876, 5116.155834287375, 4203.453551038346, 4213.873583792491, 4268.16770729711, 4289.077848262638, 4308.913821723548, 1372.4167228927665, 1417.461364681435, 1420.6519402746187, 1423.238567366454, 1435.519101101122, 844.4890841041205, 917.3991035871514, 956.4404823178379, 1005.1556692378438, 1013.1135256650431, 5904.675242861684, 5987.341392446828, 6001.819945401645, 6004.819855404345, 6029.728662210211, 463.2610985478157, 464.06722487799766, 472.15719939907103, 478.62427994024523, 480.02794341458826, 4003.219372222447, 4026.0, 4103.322951712994, 4107.158032603309, 4176.728512646729, 10576.101031412261, 11039.83440248397, 11071.225014249087, 11079.944600276947, 11084.944575277072, 10058.04448577384, 10181.694549163536, 10211.7447063824, 10228.386296822215, 10984.670459886216, 7977.401694872908, 7994.720184793504, 8061.83876322482, 8073.596320183968, 8082.353411727047, 5580.944190558205, 5625.043742563856, 5640.435956404327, 5745.885082298414, 5835.9708201458725, 9282.443053416817, 9472.194863436409, 9532.666356677482, 9589.856152157863, 9598.136167744937, 9237.491937943478, 9317.534123293945, 9320.580573874327, 9695.078967498077, 9712.0, 6829.385355318045, 7542.4720269582795, 7694.1536430993665, 7744.0, 7803.960980195063, 8404.327653787805, 8420.915790842259, 8434.114417986268, 8459.83080338402, 8476.194761497647, 7492.438067145095, 7600.8479830404185, 7633.503822251536, 7723.304902558797, 7812.804679883048, 7494.213107623839, 7509.88735168962, 7554.584497852451, 7617.69529218825, 7648.655810488653, 6063.575549711654, 6107.450329470369, 6189.84525386869, 6202.472789812917, 6252.155958945484, 5133.974330128325, 5222.817201397933, 5318.627696061239, 5389.326334208224, 5408.405075441619, 5222.973885130702, 5329.413764485826, 5344.064788662046, 5346.599005074557, 5415.83752487426], "value": 4610.791609103708, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.23124242288185, 356.6451380876029, 359.9982000089999, 368.5025215958458, 371.8642695416172, 6174.969125154374, 6312.842178945523, 6360.17317748692, 6361.68191590421, 6369.777057802972, 6222.137816604356, 6270.843228919268, 6276.937230627693, 6282.151909492217, 6289.654069026214, 4610.4467463904375, 4704.317873908281, 4836.347093142416, 4840.249761286988, 4848.17581011229, 4844.781984810692, 4847.1517484440255, 4850.514948505156, 4858.927116093261, 4863.635227357962, 4790.329353890458, 4793.065352256294, 4794.065157294329, 4803.255495398219, 4808.831690890819, 4560.771961401917, 4658.743769092698, 4743.739094349809, 4791.137595232856, 4798.592119669832, 4215.578442155791, 4231.534531201565, 4231.809568569391, 4232.492100947906, 4235.512916014667, 6010.368911264298, 6012.18835457212, 6020.277566692025, 6025.879482410327, 6031.24609423822, 5576.10782274834, 5587.972060139714, 5593.133064375028, 5593.244911936918, 5597.860053498654, 6623.966880165568, 6632.403083722488, 6637.0, 6637.568558043712, 6647.700853461606, 4606.792694328763, 4651.465081515601, 4680.976595117003, 4690.01509682967, 4695.906081878344, 6887.104676392087, 6900.275471075515, 6911.827204319882, 6918.411934985532, 6922.965385173092, 4785.976070119627, 4791.496892826272, 4796.208625576741, 4799.352087468217, 4802.231642937113, 4849.151398505247, 4862.6839255448285, 4867.367242258484, 4867.95132048675, 4870.732109733999, 5554.361248456398, 5581.386047534768, 5581.832545023656, 5584.804531841447, 5587.189857470726, 6529.477641788645, 6660.467162626978, 6673.232578253466, 6676.46588272937, 6695.598264104072, 1696.11801863033, 1715.408184176457, 1723.1556537296635, 1724.8533874620546, 1727.1105380728934, 1139.2196345503191, 1150.6030419505257, 1167.7139100920328, 1173.0849937049115, 1176.6764139861607, 6207.906881396692, 6344.0, 6519.445847102955, 6521.9673901630185, 6526.836829079216, 6938.028675985366, 6940.13248343957, 6944.305569443015, 6956.130483689539, 6956.339147780953, 6422.133012043408, 6499.480041596661, 6510.762955038527, 6516.0, 6522.706478208492, 3690.741648084662, 3718.7768733876055, 3724.5530536335814, 3726.5155529780955, 3732.794696291676, 6945.930540694529, 7187.353138217585, 7234.74678386254, 7240.094988126484, 7242.49302548827, 7101.9289807102305, 7142.785716428515, 7180.138383393922, 7195.064641596559, 7223.349898509055, 7215.494915355875, 7221.169565499929, 7227.674754636054, 7235.891461627974, 7248.855022899513, 6942.826429339307, 6945.201301850352, 6950.548214366252, 6957.130358705162, 6974.407175390149, 6637.767678131242, 6807.965960170168, 6848.760293389907, 6874.793756187322, 6882.174139103339, 7128.964355178191, 7132.1441427029085, 7140.178879428724, 7172.354488096096, 7202.0, 4604.378408914888, 4634.791434385394, 4635.582797548237, 4640.9767951161375, 4648.697834640738, 6871.587704737732, 6884.4148247399535, 6902.24075351721, 6918.861622767416, 6938.306169383021, 6465.482761379172, 6731.798046058626, 6739.191297044386, 6756.223034350916, 6758.594484330956, 6710.932890671031, 6738.090357801634, 6741.662916854236, 6747.257801641914, 6753.561018533779, 6618.07346971434, 6621.106150669598, 6622.0, 6638.369354911276, 6649.501287403367, 6781.457483401415, 6783.253842077466, 6784.423324017514, 6786.796396108125, 6794.150731158606, 6475.061116138228, 6608.50436217276, 6608.603483790988, 6612.70242839083, 6614.173228346457], "value": 5062.933656081401, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [878.6046279174371, 930.7114794413736, 934.7663084228943, 938.8497840345547, 959.9105015807062, 15351.155686437241, 15490.148041857694, 15711.92144039281, 15768.684626307482, 15796.842031579681, 14226.146431214134, 14334.856651433483, 14347.78478322826, 14360.640983975405, 14430.927845360784, 761.4669731188163, 885.1944730295432, 899.9280057595392, 923.7644400677817, 926.8239034583441, 901.4636291406603, 909.0863681999581, 913.5204017890627, 913.7989642278689, 914.5061666699974, 963.2534785541192, 969.365065881845, 969.8399764038925, 971.5967873332559, 973.6689525561308, 790.02826523376, 909.7998440343114, 932.8554074118455, 933.3932943586655, 964.4695417520336, 690.6650274616807, 691.2258270736756, 691.8858388365913, 692.4114502672738, 694.035290945581, 14910.70178596433, 14932.62668433287, 14947.850521494755, 14953.177575233358, 14953.40186392543, 14717.190554519497, 15164.24178791067, 15212.163331016789, 15227.390904363812, 15252.923735381362, 11722.589709360216, 11752.588659396966, 11816.822747658793, 11924.582639607572, 11976.0, 4043.2722110020186, 4071.3282308419075, 4078.3882417637296, 4089.3865920111925, 4125.814338354781, 60851.39148608501, 60970.0, 60989.390106098814, 61083.0, 61385.693071534355, 10050.195984321237, 10380.32527885685, 10479.47602619866, 10548.841767373495, 10652.0, 20150.0, 20211.696824547642, 20291.0, 20293.695594566092, 20326.796732032784, 8663.740087797376, 8666.86999695005, 8688.348373871984, 8740.8688869667, 8824.735257942271, 4947.332110165154, 4982.5515703586125, 5003.149464591028, 5018.322526458881, 5157.484251574812, 3576.7675101118343, 3632.9818350908604, 3639.2357604902736, 3646.927061458756, 3647.325244829715, 557.4509108528097, 605.6638565596137, 639.5427269502328, 651.1990251990079, 652.8367908022994, 732.2531018361242, 742.9554226746412, 803.4094940218935, 818.1000899011159, 868.9522076285865, 9776.951115244377, 9999.400035997864, 10018.949905250427, 10047.648332308334, 10054.195664346835, 796.5101462600575, 811.8701007838717, 813.0934008580508, 814.7759366174231, 820.3724151024471, 4556.066006468666, 4557.453105627346, 4617.353570500132, 4680.608270695371, 4707.364505791675, 67933.98099028518, 70372.0, 70887.0, 70999.64500177569, 71028.64485677538, 55752.16371754427, 58092.0, 60018.69990650019, 60148.69925650344, 60232.09651855226, 54001.189982150296, 54281.72859135679, 55391.72304138453, 55621.44378556163, 56108.999999999185, 8998.14517620825, 9037.77405564866, 9040.954795225982, 9072.0, 9118.95440522793, 40762.0, 41168.588314116474, 41383.793081034404, 41386.37920431136, 42729.359059614755, 47054.294185587925, 47310.76344618255, 47731.76134119307, 47940.28089578729, 49264.75367623139, 12515.561955331885, 12707.0, 12719.236845789283, 12730.554430594884, 12809.935950320189, 13760.449582016607, 14523.564293071226, 14755.926220368829, 14909.3290801912, 14910.179940103399, 10666.306690065121, 12612.87387126117, 12750.171238869443, 12782.36088195605, 13164.0, 12583.559575414816, 12921.35393230316, 13747.349770562232, 14066.507672231422, 14087.0, 12585.496580136693, 12826.679333016376, 13136.671583210496, 13591.45634174622, 14344.354504047134, 11017.779644406906, 11119.27724697892, 11214.66356009321, 11566.710832229262, 11745.47145378477, 10698.518566664363, 10982.341059536453, 11245.325280483197, 11472.598459053894, 11502.42487875586], "value": 7241.09435602056, "unit": "score"}], "name": "dromaeo_css", "value": 7674.164217931682, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 109.0, 110.0, 111.0, 112.0, 104.0, 111.0, 109.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 151.0, 172.0, 127.0, 153.0, 156.0, 142.0, 178.0, 125.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0, 159.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 180.0, 76.0, 74.0, 74.0, 74.0, 184.0, 75.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 151.0, 91.0, 90.0, 92.0, 147.0, 92.0, 92.0, 154.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 55.0, 53.0, 55.0, 54.0, 55.0, 76.0, 53.0, 51.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 61.0, 60.0, 60.0, 61.0, 59.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 72.0, 73.0, 74.0, 73.0, 73.0, 73.0, 73.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 113.0, 116.0, 113.0, 113.0, 124.0, 120.0, 115.0, 137.0, 124.0], "value": 119.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 154.0, 157.0, 153.0, 163.0, 157.0, 161.0, 164.0, 159.0, 156.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 64.0, 65.0, 73.0, 64.0, 68.0, 61.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1512.9, "alertThreshold": 2.0}]} 09:35:57 INFO - Return code: 0 09:35:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:35:57 ERROR - # TBPL SUCCESS # 09:35:57 INFO - Running post-action listener: _resource_record_post_action 09:35:57 INFO - Running post-run listener: _resource_record_post_run 09:35:58 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 462442496; Read time: 16; Write time: 409228 09:35:58 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242388992; Read time: 0; Write time: 252736 09:35:58 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220053504; Read time: 16; Write time: 156492 09:35:58 INFO - Running post-run listener: _upload_blobber_files 09:35:58 INFO - Blob upload gear active. 09:35:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:35:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:35:58 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'] 09:35:58 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 09:35:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:00 INFO - (blobuploader) - INFO - Done attempting. 09:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:00 INFO - (blobuploader) - INFO - Done attempting. 09:36:00 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:01 INFO - Return code: 0 09:36:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edef61ec1e8f8bd5a5aac0865e879798f889570a1c9100daafa1a858ed2a8ab4d4b3c355a2408ca7ffb33d4f84952b8a074e5e220de9a1f00bea220734a88fb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/402be2e04cfa5b1f6ca61c636e6671bc86484e3c92fd1b8b8f2cf5064e9e6249bbad6094ee800df2d5f177c99b90545350a9d83da7bd7b529367437be2dcc40c"} 09:36:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:01 INFO - Contents: 09:36:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edef61ec1e8f8bd5a5aac0865e879798f889570a1c9100daafa1a858ed2a8ab4d4b3c355a2408ca7ffb33d4f84952b8a074e5e220de9a1f00bea220734a88fb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/402be2e04cfa5b1f6ca61c636e6671bc86484e3c92fd1b8b8f2cf5064e9e6249bbad6094ee800df2d5f177c99b90545350a9d83da7bd7b529367437be2dcc40c"} 09:36:01 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:01 INFO - Copying logs to upload dir... 09:36:01 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.045739 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-14 09:36:00.326373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 09:36:00.333932) ========= 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=7de08804244eb36560b44971000001c3-1465919272.764216-1290100015 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/edef61ec1e8f8bd5a5aac0865e879798f889570a1c9100daafa1a858ed2a8ab4d4b3c355a2408ca7ffb33d4f84952b8a074e5e220de9a1f00bea220734a88fb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/402be2e04cfa5b1f6ca61c636e6671bc86484e3c92fd1b8b8f2cf5064e9e6249bbad6094ee800df2d5f177c99b90545350a9d83da7bd7b529367437be2dcc40c"} build_url:https://queue.taskcluster.net/v1/task/VylL03o_S3CoZKL3Zn6lPA/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/VylL03o_S3CoZKL3Zn6lPA/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/edef61ec1e8f8bd5a5aac0865e879798f889570a1c9100daafa1a858ed2a8ab4d4b3c355a2408ca7ffb33d4f84952b8a074e5e220de9a1f00bea220734a88fb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/402be2e04cfa5b1f6ca61c636e6671bc86484e3c92fd1b8b8f2cf5064e9e6249bbad6094ee800df2d5f177c99b90545350a9d83da7bd7b529367437be2dcc40c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 09:36:00.359057) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 09:36:00.359355) ========= 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=7de08804244eb36560b44971000001c3-1465919272.764216-1290100015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 09:36:00.442380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 09:36:00.445760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 09:36:00.446077) ========= ========= Total master_lag: 0.18 =========