builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1466183065.39 results: success (0) buildid: 20160617071423 builduid: c80fd51f306c4cf9834fa970e43af5ca revision: d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.392589) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.393304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.393902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.410766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.411270) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 10:04:25-- 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% 37.3M=0s 2016-06-17 10:04:25 (37.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099198 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.535564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.535922) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019940 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.591989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.592573) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf --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 d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf --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=9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 10:04:25,692 truncating revision to first 12 chars 2016-06-17 10:04:25,692 Setting DEBUG logging. 2016-06-17 10:04:25,692 attempt 1/10 2016-06-17 10:04:25,692 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d9ea8a5c1694?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 10:04:26,039 unpacking tar archive at: mozilla-beta-d9ea8a5c1694/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662703 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:26.272540) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:26.272923) ========= script_repo_revision: d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:26.273416) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:26.273776) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:26.285015) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-17 10:04:26.285334) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:26 INFO - MultiFileLogger online at 20160617 10:04:26 in /builds/slave/test 10:04:26 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 10:04:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:26 INFO - {'append_to_log': False, 10:04:26 INFO - 'base_work_dir': '/builds/slave/test', 10:04:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:04:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:26 INFO - 'branch': 'Mozilla-Beta', 10:04:26 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:26 INFO - 'config_files': ('talos/linux_config.py',), 10:04:26 INFO - 'default_actions': ('clobber', 10:04:26 INFO - 'read-buildbot-config', 10:04:26 INFO - 'download-and-extract', 10:04:26 INFO - 'populate-webroot', 10:04:26 INFO - 'create-virtualenv', 10:04:26 INFO - 'install', 10:04:26 INFO - 'run-tests'), 10:04:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:26 INFO - 'download_minidump_stackwalk': True, 10:04:26 INFO - 'download_symbols': 'ondemand', 10:04:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:26 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:26 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:26 INFO - 'installer_path': 'installer.exe', 10:04:26 INFO - 'log_level': 'info', 10:04:26 INFO - 'log_name': 'talos', 10:04:26 INFO - 'log_to_console': True, 10:04:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:26 INFO - 'opt_config_files': (), 10:04:26 INFO - 'pip_index': False, 10:04:26 INFO - 'sps_profile': False, 10:04:26 INFO - 'sps_profile_interval': 0, 10:04:26 INFO - 'suite': 'dromaeojs', 10:04:26 INFO - 'system_bits': '32', 10:04:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:26 INFO - 'title': 'talos-linux64-ix-013', 10:04:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:26 INFO - 'use_talos_json': True, 10:04:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:26 INFO - 'work_dir': 'build'} 10:04:26 INFO - ##### 10:04:26 INFO - ##### Running clobber step. 10:04:26 INFO - ##### 10:04:26 INFO - Running pre-action listener: _resource_record_pre_action 10:04:26 INFO - Running main action method: clobber 10:04:26 INFO - rmtree: /builds/slave/test/build 10:04:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:27 INFO - Running post-action listener: _resource_record_post_action 10:04:27 INFO - ##### 10:04:27 INFO - ##### Running read-buildbot-config step. 10:04:27 INFO - ##### 10:04:27 INFO - Running pre-action listener: _resource_record_pre_action 10:04:27 INFO - Running main action method: read_buildbot_config 10:04:27 INFO - Using buildbot properties: 10:04:27 INFO - { 10:04:27 INFO - "project": "", 10:04:27 INFO - "product": "firefox", 10:04:27 INFO - "script_repo_revision": "production", 10:04:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:04:27 INFO - "repository": "", 10:04:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:04:27 INFO - "buildid": "20160617071423", 10:04:27 INFO - "pgo_build": "True", 10:04:27 INFO - "basedir": "/builds/slave/test", 10:04:27 INFO - "buildnumber": 44, 10:04:27 INFO - "slavename": "talos-linux64-ix-013", 10:04:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:04:27 INFO - "platform": "ubuntu64_hw", 10:04:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:04:27 INFO - "branch": "mozilla-beta", 10:04:27 INFO - "repo_path": "releases/mozilla-beta", 10:04:27 INFO - "revision": "d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf", 10:04:27 INFO - "stage_platform": "linux64-pgo", 10:04:27 INFO - "builduid": "c80fd51f306c4cf9834fa970e43af5ca", 10:04:27 INFO - "slavebuilddir": "test" 10:04:27 INFO - } 10:04:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 10:04:27 INFO - Running post-action listener: _resource_record_post_action 10:04:27 INFO - ##### 10:04:27 INFO - ##### Running download-and-extract step. 10:04:27 INFO - ##### 10:04:27 INFO - Running pre-action listener: _resource_record_pre_action 10:04:27 INFO - Running main action method: download_and_extract 10:04:27 INFO - mkdir: /builds/slave/test/build/tests 10:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:27 INFO - https://queue.taskcluster.net/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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 10:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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 10:04:33 INFO - Downloaded 1327 bytes. 10:04:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:04:33 INFO - Using the following test package requirements: 10:04:33 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:04:33 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:33 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:04:33 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:33 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:04:33 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:33 INFO - u'jsshell-linux-x86_64.zip'], 10:04:33 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:33 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:04:33 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:04:33 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:33 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:04:33 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:33 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:04:33 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:33 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:04:33 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:33 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:04:33 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:04:33 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')]} 10:04:33 INFO - https://queue.taskcluster.net/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:04:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:04:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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 10:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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 10:04:35 INFO - Downloaded 24185717 bytes. 10:04:35 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'] 10:04:35 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 10:04:37 INFO - Return code: 0 10:04:37 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 10:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:37 INFO - https://queue.taskcluster.net/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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 10:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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 10:04:43 INFO - Downloaded 24185717 bytes. 10:04:43 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'] 10:04:43 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 10:04:45 INFO - Return code: 0 10:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:45 INFO - https://queue.taskcluster.net/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:04:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:04:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:04:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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 10:04:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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 10:04:46 INFO - Downloaded 10840145 bytes. 10:04:46 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'] 10:04:46 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 10:04:46 INFO - Return code: 0 10:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:46 INFO - https://queue.taskcluster.net/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:04:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:04:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:04:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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 10:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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 10:04:48 INFO - Downloaded 55997067 bytes. 10:04:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:04:48 INFO - mkdir: /builds/slave/test/properties 10:04:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:04:48 INFO - Writing to file /builds/slave/test/properties/build_url 10:04:48 INFO - Contents: 10:04:48 INFO - build_url:https://queue.taskcluster.net/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:04:49 INFO - Running post-action listener: _resource_record_post_action 10:04:49 INFO - Running post-action listener: set_extra_try_arguments 10:04:49 INFO - ##### 10:04:49 INFO - ##### Running populate-webroot step. 10:04:49 INFO - ##### 10:04:49 INFO - Running pre-action listener: _resource_record_pre_action 10:04:49 INFO - Running main action method: populate_webroot 10:04:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:49 INFO - '--tppagecycles', 10:04:49 INFO - '7'], 10:04:49 INFO - 'tests': ['tsvgm']}}, 10:04:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:04:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:04:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:04:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:04:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:04:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:49 INFO - 'talos_options': ['--disable-e10s'], 10:04:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:49 INFO - 'talos_options': ['--disable-e10s'], 10:04:49 INFO - 'tests': ['damp', 'tps']}, 10:04:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:49 INFO - 'tests': ['damp', 'tps']}, 10:04:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:04:49 INFO - 'tests': ['dromaeo_dom']}, 10:04:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:04:49 INFO - 'tests': ['a11yr', 10:04:49 INFO - 'ts_paint', 10:04:49 INFO - 'tpaint', 10:04:49 INFO - 'sessionrestore', 10:04:49 INFO - 'sessionrestore_no_auto_restore', 10:04:49 INFO - 'tabpaint']}, 10:04:49 INFO - 'other-e10s': {'tests': ['a11yr', 10:04:49 INFO - 'ts_paint', 10:04:49 INFO - 'tpaint', 10:04:49 INFO - 'sessionrestore', 10:04:49 INFO - 'sessionrestore_no_auto_restore', 10:04:49 INFO - 'tabpaint']}, 10:04:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:04:49 INFO - 'ts_paint', 10:04:49 INFO - 'tpaint', 10:04:49 INFO - 'sessionrestore', 10:04:49 INFO - 'sessionrestore_no_auto_restore', 10:04:49 INFO - 'tabpaint']}, 10:04:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:04:49 INFO - 'ts_paint', 10:04:49 INFO - 'tpaint', 10:04:49 INFO - 'sessionrestore', 10:04:49 INFO - 'sessionrestore_no_auto_restore', 10:04:49 INFO - 'tabpaint']}, 10:04:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:04:49 INFO - 'tests': ['a11yr', 10:04:49 INFO - 'ts_paint', 10:04:49 INFO - 'tpaint', 10:04:49 INFO - 'sessionrestore', 10:04:49 INFO - 'sessionrestore_no_auto_restore', 10:04:49 INFO - 'tabpaint']}, 10:04:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:04:49 INFO - 'tests': ['a11yr', 10:04:49 INFO - 'ts_paint', 10:04:49 INFO - 'tpaint', 10:04:49 INFO - 'sessionrestore', 10:04:49 INFO - 'sessionrestore_no_auto_restore', 10:04:49 INFO - 'tabpaint']}, 10:04:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:04:49 INFO - 'tests': ['tsvgx', 10:04:49 INFO - 'tsvgr_opacity', 10:04:49 INFO - 'tart', 10:04:49 INFO - 'tscrollx', 10:04:49 INFO - 'cart']}, 10:04:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:04:49 INFO - 'tsvgr_opacity', 10:04:49 INFO - 'tart', 10:04:49 INFO - 'tscrollx', 10:04:49 INFO - 'cart']}, 10:04:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:49 INFO - 'talos_options': ['--disable-e10s'], 10:04:49 INFO - 'tests': ['tp5o']}, 10:04:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:49 INFO - 'tests': ['tp5o']}, 10:04:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:49 INFO - 'talos_options': ['--disable-e10s', 10:04:49 INFO - '--xperf_path', 10:04:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:49 INFO - 'tests': ['tp5n']}, 10:04:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:49 INFO - 'talos_options': ['--xperf_path', 10:04:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:49 INFO - 'tests': ['tp5n']}}, 10:04:49 INFO - 'talos.zip': {'path': '', 10:04:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:49 INFO - Running post-action listener: _resource_record_post_action 10:04:49 INFO - ##### 10:04:49 INFO - ##### Running create-virtualenv step. 10:04:49 INFO - ##### 10:04:49 INFO - Running pre-action listener: _resource_record_pre_action 10:04:49 INFO - Running main action method: create_virtualenv 10:04:49 INFO - Creating virtualenv /builds/slave/test/build/venv 10:04:49 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 10:04:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:04:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:49 INFO - Using real prefix '/usr' 10:04:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:04:49 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:51 INFO - Installing pip.................done. 10:04:51 INFO - Return code: 0 10:04:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b4454cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded410>, '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 0x1dee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dee7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', '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 10:04: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', 'pip>=1.5'] in /builds/slave/test/build 10:04: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 pip>=1.5 10:04:51 INFO - Using env: {'DISPLAY': ':0', 10:04:51 INFO - 'HOME': '/home/cltbld', 10:04:51 INFO - 'LANG': 'en_US.UTF-8', 10:04:51 INFO - 'LANGUAGE': 'en_US:en', 10:04:51 INFO - 'LOGNAME': 'cltbld', 10:04:51 INFO - 'MAIL': '/var/mail/cltbld', 10:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:51 INFO - 'MOZ_NO_REMOTE': '1', 10:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:51 INFO - 'NO_EM_RESTART': '1', 10:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:51 INFO - 'PWD': '/builds/slave/test', 10:04:51 INFO - 'SHELL': '/bin/bash', 10:04:51 INFO - 'SHLVL': '1', 10:04:51 INFO - 'TERM': 'linux', 10:04:51 INFO - 'TMOUT': '86400', 10:04:51 INFO - 'USER': 'cltbld', 10:04:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', 10:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:51 INFO - '_': '/tools/buildbot/bin/python'} 10:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:51 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 10:04:51 INFO - Cleaning up... 10:04:51 INFO - Return code: 0 10:04:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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', '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 0x7f5b4454cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded410>, '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 0x1dee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dee7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', '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 10:04: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', 'psutil>=0.7.1'] in /builds/slave/test/build 10:04: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 psutil>=0.7.1 10:04:51 INFO - Using env: {'DISPLAY': ':0', 10:04:51 INFO - 'HOME': '/home/cltbld', 10:04:51 INFO - 'LANG': 'en_US.UTF-8', 10:04:51 INFO - 'LANGUAGE': 'en_US:en', 10:04:51 INFO - 'LOGNAME': 'cltbld', 10:04:51 INFO - 'MAIL': '/var/mail/cltbld', 10:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:51 INFO - 'MOZ_NO_REMOTE': '1', 10:04:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:51 INFO - 'NO_EM_RESTART': '1', 10:04:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:51 INFO - 'PWD': '/builds/slave/test', 10:04:51 INFO - 'SHELL': '/bin/bash', 10:04:51 INFO - 'SHLVL': '1', 10:04:51 INFO - 'TERM': 'linux', 10:04:51 INFO - 'TMOUT': '86400', 10:04:51 INFO - 'USER': 'cltbld', 10:04:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', 10:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:51 INFO - '_': '/tools/buildbot/bin/python'} 10:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:52 INFO - Downloading/unpacking psutil>=0.7.1 10:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:54 INFO - Installing collected packages: psutil 10:04:54 INFO - Running setup.py install for psutil 10:04:54 INFO - building 'psutil._psutil_linux' extension 10:04:54 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 10:04:54 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 10:04:54 INFO - building 'psutil._psutil_posix' extension 10:04:54 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 10:04:54 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 10:04:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:54 INFO - Successfully installed psutil 10:04:54 INFO - Cleaning up... 10:04:54 INFO - Return code: 0 10:04:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5b4454cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded410>, '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 0x1dee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dee7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', '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 10:04:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:04:54 INFO - Using env: {'DISPLAY': ':0', 10:04:54 INFO - 'HOME': '/home/cltbld', 10:04:54 INFO - 'LANG': 'en_US.UTF-8', 10:04:54 INFO - 'LANGUAGE': 'en_US:en', 10:04:54 INFO - 'LOGNAME': 'cltbld', 10:04:54 INFO - 'MAIL': '/var/mail/cltbld', 10:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:54 INFO - 'MOZ_NO_REMOTE': '1', 10:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:54 INFO - 'NO_EM_RESTART': '1', 10:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:54 INFO - 'PWD': '/builds/slave/test', 10:04:54 INFO - 'SHELL': '/bin/bash', 10:04:54 INFO - 'SHLVL': '1', 10:04:54 INFO - 'TERM': 'linux', 10:04:54 INFO - 'TMOUT': '86400', 10:04:54 INFO - 'USER': 'cltbld', 10:04:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', 10:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:54 INFO - '_': '/tools/buildbot/bin/python'} 10:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:04:56 INFO - Installing collected packages: mozsystemmonitor 10:04:56 INFO - Running setup.py install for mozsystemmonitor 10:04:56 INFO - Successfully installed mozsystemmonitor 10:04:56 INFO - Cleaning up... 10:04:56 INFO - Return code: 0 10:04:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5b4454cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded410>, '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 0x1dee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dee7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', '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 10:04:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:04:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:04:56 INFO - Using env: {'DISPLAY': ':0', 10:04:56 INFO - 'HOME': '/home/cltbld', 10:04:56 INFO - 'LANG': 'en_US.UTF-8', 10:04:56 INFO - 'LANGUAGE': 'en_US:en', 10:04:56 INFO - 'LOGNAME': 'cltbld', 10:04:56 INFO - 'MAIL': '/var/mail/cltbld', 10:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:56 INFO - 'MOZ_NO_REMOTE': '1', 10:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:56 INFO - 'NO_EM_RESTART': '1', 10:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:56 INFO - 'PWD': '/builds/slave/test', 10:04:56 INFO - 'SHELL': '/bin/bash', 10:04:57 INFO - 'SHLVL': '1', 10:04:57 INFO - 'TERM': 'linux', 10:04:57 INFO - 'TMOUT': '86400', 10:04:57 INFO - 'USER': 'cltbld', 10:04:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', 10:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:57 INFO - '_': '/tools/buildbot/bin/python'} 10:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:59 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:04:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:59 INFO - Downloading docopt-0.6.1.tar.gz 10:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:59 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:59 INFO - Running setup.py install for blobuploader 10:04:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:04:59 INFO - Running setup.py install for requests 10:05:00 INFO - Running setup.py install for docopt 10:05:00 INFO - Successfully installed blobuploader requests docopt 10:05:00 INFO - Cleaning up... 10:05:00 INFO - Return code: 0 10:05:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:00 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 0x7f5b4454cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded410>, '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 0x1dee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dee7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', '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 10:05:00 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 10:05:00 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 10:05:00 INFO - Using env: {'DISPLAY': ':0', 10:05:00 INFO - 'HOME': '/home/cltbld', 10:05:00 INFO - 'LANG': 'en_US.UTF-8', 10:05:00 INFO - 'LANGUAGE': 'en_US:en', 10:05:00 INFO - 'LOGNAME': 'cltbld', 10:05:00 INFO - 'MAIL': '/var/mail/cltbld', 10:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:00 INFO - 'MOZ_NO_REMOTE': '1', 10:05:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:00 INFO - 'NO_EM_RESTART': '1', 10:05:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:00 INFO - 'PWD': '/builds/slave/test', 10:05:00 INFO - 'SHELL': '/bin/bash', 10:05:00 INFO - 'SHLVL': '1', 10:05:00 INFO - 'TERM': 'linux', 10:05:00 INFO - 'TMOUT': '86400', 10:05:00 INFO - 'USER': 'cltbld', 10:05:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', 10:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:00 INFO - '_': '/tools/buildbot/bin/python'} 10:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:00 INFO - Running setup.py (path:/tmp/pip-1XbARQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:00 INFO - Running setup.py (path:/tmp/pip-S3PJT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:00 INFO - Running setup.py (path:/tmp/pip-kN5RD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:00 INFO - Running setup.py (path:/tmp/pip-45H_q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:00 INFO - Running setup.py (path:/tmp/pip-W_WP9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:01 INFO - Running setup.py (path:/tmp/pip-SXZjRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:01 INFO - Running setup.py (path:/tmp/pip-mI24GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:01 INFO - Running setup.py (path:/tmp/pip-impthE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:01 INFO - Running setup.py (path:/tmp/pip-xLQ6Nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:01 INFO - Running setup.py (path:/tmp/pip-lOmVfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:01 INFO - Running setup.py (path:/tmp/pip-4EoOmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:01 INFO - Running setup.py (path:/tmp/pip-FiRZq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:01 INFO - Running setup.py (path:/tmp/pip-rM27VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:01 INFO - Running setup.py (path:/tmp/pip-PuVlNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:01 INFO - Running setup.py (path:/tmp/pip-f0jBiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:01 INFO - Running setup.py (path:/tmp/pip-FZwY1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:01 INFO - Running setup.py (path:/tmp/pip-hl4hBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:01 INFO - Running setup.py install for manifestparser 10:05:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:02 INFO - Running setup.py install for mozcrash 10:05:02 INFO - Running setup.py install for mozdebug 10:05:02 INFO - Running setup.py install for mozdevice 10:05:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:02 INFO - Running setup.py install for mozfile 10:05:02 INFO - Running setup.py install for mozhttpd 10:05:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:02 INFO - Running setup.py install for mozinfo 10:05:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:02 INFO - Running setup.py install for mozInstall 10:05:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:02 INFO - Running setup.py install for mozleak 10:05:02 INFO - Running setup.py install for mozlog 10:05:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:02 INFO - Running setup.py install for moznetwork 10:05:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:03 INFO - Running setup.py install for mozprocess 10:05:03 INFO - Running setup.py install for mozprofile 10:05:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:03 INFO - Running setup.py install for mozrunner 10:05:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:03 INFO - Running setup.py install for mozscreenshot 10:05:03 INFO - Running setup.py install for moztest 10:05:03 INFO - Running setup.py install for mozversion 10:05:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:03 INFO - Cleaning up... 10:05:03 INFO - Return code: 0 10:05:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:03 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')]} 10:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:03 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')]} 10:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:03 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 0x7f5b4454cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded410>, '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 0x1dee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dee7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', '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 10:05:03 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 10:05:03 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 10:05:03 INFO - Using env: {'DISPLAY': ':0', 10:05:03 INFO - 'HOME': '/home/cltbld', 10:05:03 INFO - 'LANG': 'en_US.UTF-8', 10:05:03 INFO - 'LANGUAGE': 'en_US:en', 10:05:03 INFO - 'LOGNAME': 'cltbld', 10:05:03 INFO - 'MAIL': '/var/mail/cltbld', 10:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:03 INFO - 'MOZ_NO_REMOTE': '1', 10:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:03 INFO - 'NO_EM_RESTART': '1', 10:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:03 INFO - 'PWD': '/builds/slave/test', 10:05:03 INFO - 'SHELL': '/bin/bash', 10:05:03 INFO - 'SHLVL': '1', 10:05:03 INFO - 'TERM': 'linux', 10:05:03 INFO - 'TMOUT': '86400', 10:05:03 INFO - 'USER': 'cltbld', 10:05:03 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', 10:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:03 INFO - '_': '/tools/buildbot/bin/python'} 10:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:03 INFO - Running setup.py (path:/tmp/pip-6oWfC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:04 INFO - Running setup.py (path:/tmp/pip-JeH9Q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:04 INFO - Running setup.py (path:/tmp/pip-5ytaEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:04 INFO - Running setup.py (path:/tmp/pip-xevjV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:04 INFO - Running setup.py (path:/tmp/pip-vWe8IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:04 INFO - Running setup.py (path:/tmp/pip-zBQtjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:04 INFO - Running setup.py (path:/tmp/pip-4hhLnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:04 INFO - Running setup.py (path:/tmp/pip-6EN1ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:04 INFO - Running setup.py (path:/tmp/pip-AS4jon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:04 INFO - Running setup.py (path:/tmp/pip-q18owv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:04 INFO - Running setup.py (path:/tmp/pip-vOSPaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:04 INFO - Running setup.py (path:/tmp/pip-a1nm88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:04 INFO - Running setup.py (path:/tmp/pip-4bHeGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:04 INFO - Running setup.py (path:/tmp/pip-ebgjkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:04 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)) 10:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:04 INFO - Running setup.py (path:/tmp/pip-pztLWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:05 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)) 10:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:05 INFO - Running setup.py (path:/tmp/pip-VMoq2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:05 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)) 10:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:05 INFO - Running setup.py (path:/tmp/pip-E6Cqhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 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)) 10:05:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:05 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 10:05:05 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 10:05:05 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 10:05:05 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 10:05:05 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 10:05:05 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 10:05:07 INFO - Downloading blessings-1.6.tar.gz 10:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:07 INFO - Installing collected packages: blessings 10:05:07 INFO - Running setup.py install for blessings 10:05:07 INFO - Successfully installed blessings 10:05:07 INFO - Cleaning up... 10:05:07 INFO - Return code: 0 10:05:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:07 INFO - Reading from file tmpfile_stdout 10:05:07 INFO - Current package versions: 10:05:07 INFO - argparse == 1.2.1 10:05:07 INFO - blessings == 1.6 10:05:07 INFO - blobuploader == 1.2.4 10:05:07 INFO - docopt == 0.6.1 10:05:07 INFO - manifestparser == 1.1 10:05:07 INFO - mozInstall == 1.12 10:05:07 INFO - mozcrash == 0.17 10:05:07 INFO - mozdebug == 0.1 10:05:07 INFO - mozdevice == 0.48 10:05:07 INFO - mozfile == 1.2 10:05:07 INFO - mozhttpd == 0.7 10:05:07 INFO - mozinfo == 0.9 10:05:07 INFO - mozleak == 0.1 10:05:07 INFO - mozlog == 3.1 10:05:07 INFO - moznetwork == 0.27 10:05:07 INFO - mozprocess == 0.22 10:05:07 INFO - mozprofile == 0.28 10:05:07 INFO - mozrunner == 6.11 10:05:07 INFO - mozscreenshot == 0.1 10:05:07 INFO - mozsystemmonitor == 0.0 10:05:07 INFO - moztest == 0.7 10:05:07 INFO - mozversion == 1.4 10:05:07 INFO - psutil == 3.1.1 10:05:07 INFO - requests == 1.2.3 10:05:07 INFO - wsgiref == 0.1.2 10:05:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:07 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 0x7f5b4454cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded410>, '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 0x1dee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dee7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', '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 10:05:07 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 10:05:07 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 10:05:07 INFO - Using env: {'DISPLAY': ':0', 10:05:07 INFO - 'HOME': '/home/cltbld', 10:05:07 INFO - 'LANG': 'en_US.UTF-8', 10:05:07 INFO - 'LANGUAGE': 'en_US:en', 10:05:07 INFO - 'LOGNAME': 'cltbld', 10:05:07 INFO - 'MAIL': '/var/mail/cltbld', 10:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:07 INFO - 'MOZ_NO_REMOTE': '1', 10:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:07 INFO - 'NO_EM_RESTART': '1', 10:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:07 INFO - 'PWD': '/builds/slave/test', 10:05:07 INFO - 'SHELL': '/bin/bash', 10:05:07 INFO - 'SHLVL': '1', 10:05:07 INFO - 'TERM': 'linux', 10:05:07 INFO - 'TMOUT': '86400', 10:05:07 INFO - 'USER': 'cltbld', 10:05:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', 10:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:07 INFO - '_': '/tools/buildbot/bin/python'} 10:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:07 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)) 10:05:07 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)) 10:05:07 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)) 10:05:07 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)) 10:05:07 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)) 10:05:07 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)) 10:05:07 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)) 10:05:07 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)) 10:05:07 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)) 10:05:07 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)) 10:05:07 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)) 10:05:07 INFO - Cleaning up... 10:05:07 INFO - Return code: 0 10:05:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b4454cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded410>, '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 0x1dee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dee7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', '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 10:05: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', 'jsonschema'] in /builds/slave/test/build 10:05: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 jsonschema 10:05:07 INFO - Using env: {'DISPLAY': ':0', 10:05:07 INFO - 'HOME': '/home/cltbld', 10:05:07 INFO - 'LANG': 'en_US.UTF-8', 10:05:07 INFO - 'LANGUAGE': 'en_US:en', 10:05:07 INFO - 'LOGNAME': 'cltbld', 10:05:07 INFO - 'MAIL': '/var/mail/cltbld', 10:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:07 INFO - 'MOZ_NO_REMOTE': '1', 10:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:07 INFO - 'NO_EM_RESTART': '1', 10:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:07 INFO - 'PWD': '/builds/slave/test', 10:05:07 INFO - 'SHELL': '/bin/bash', 10:05:07 INFO - 'SHLVL': '1', 10:05:07 INFO - 'TERM': 'linux', 10:05:07 INFO - 'TMOUT': '86400', 10:05:07 INFO - 'USER': 'cltbld', 10:05:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', 10:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:07 INFO - '_': '/tools/buildbot/bin/python'} 10:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:07 INFO - Downloading/unpacking jsonschema 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:09 INFO - Downloading/unpacking functools32 (from jsonschema) 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:10 INFO - warning: no files found matching '*.txt' 10:05:10 INFO - no previously-included directories found matching 'build' 10:05:10 INFO - no previously-included directories found matching 'dist' 10:05:10 INFO - no previously-included directories found matching '.git*' 10:05:10 INFO - Installing collected packages: jsonschema, functools32 10:05:10 INFO - Running setup.py install for functools32 10:05:10 INFO - warning: no files found matching '*.txt' 10:05:10 INFO - no previously-included directories found matching 'build' 10:05:10 INFO - no previously-included directories found matching 'dist' 10:05:10 INFO - no previously-included directories found matching '.git*' 10:05:10 INFO - Successfully installed jsonschema functools32 10:05:10 INFO - Cleaning up... 10:05:10 INFO - Return code: 0 10:05:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:05:10 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')]} 10:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:10 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')]} 10:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:10 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 0x7f5b4454cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ded410>, '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 0x1dee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dee7a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', '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 10:05:10 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 10:05:10 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 10:05:10 INFO - Using env: {'DISPLAY': ':0', 10:05:10 INFO - 'HOME': '/home/cltbld', 10:05:10 INFO - 'LANG': 'en_US.UTF-8', 10:05:10 INFO - 'LANGUAGE': 'en_US:en', 10:05:10 INFO - 'LOGNAME': 'cltbld', 10:05:10 INFO - 'MAIL': '/var/mail/cltbld', 10:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:10 INFO - 'MOZ_NO_REMOTE': '1', 10:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:10 INFO - 'NO_EM_RESTART': '1', 10:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:10 INFO - 'PWD': '/builds/slave/test', 10:05:10 INFO - 'SHELL': '/bin/bash', 10:05:10 INFO - 'SHLVL': '1', 10:05:10 INFO - 'TERM': 'linux', 10:05:10 INFO - 'TMOUT': '86400', 10:05:10 INFO - 'USER': 'cltbld', 10:05:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', 10:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:10 INFO - '_': '/tools/buildbot/bin/python'} 10:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:10 INFO - Downloading/unpacking flake8 10:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:05:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:05:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 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 10:05:12 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 10:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:13 INFO - no previously-included directories found matching 'docs/_build' 10:05:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:05:13 INFO - Running setup.py install for pep8 10:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:13 INFO - no previously-included directories found matching 'docs/_build' 10:05:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:05:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:05:13 INFO - Cleaning up... 10:05:13 INFO - Return code: 0 10:05:13 INFO - Running post-action listener: _resource_record_post_action 10:05:13 INFO - Running post-action listener: _start_resource_monitoring 10:05:13 INFO - Starting resource monitoring. 10:05:13 INFO - ##### 10:05:13 INFO - ##### Running install step. 10:05:13 INFO - ##### 10:05:13 INFO - Running pre-action listener: _resource_record_pre_action 10:05:13 INFO - Running main action method: install 10:05:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:13 INFO - Reading from file tmpfile_stdout 10:05:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:13 INFO - Reading from file tmpfile_stdout 10:05:13 INFO - Output received: 10:05:13 INFO - Usage: mozinstall [options] installer 10:05:13 INFO - Options: 10:05:13 INFO - -h, --help show this help message and exit 10:05:13 INFO - -d DEST, --destination=DEST 10:05:13 INFO - Directory to install application into. [default: 10:05:13 INFO - "/builds/slave/test"] 10:05:13 INFO - --app=APP Application being installed. [default: firefox] 10:05:13 INFO - mkdir: /builds/slave/test/build/application 10:05:13 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'] 10:05:13 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 10:05:26 INFO - Reading from file tmpfile_stdout 10:05:26 INFO - Output received: 10:05:26 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:26 INFO - Running post-action listener: _resource_record_post_action 10:05:26 INFO - ##### 10:05:26 INFO - ##### Running run-tests step. 10:05:26 INFO - ##### 10:05:26 INFO - Running pre-action listener: _resource_record_pre_action 10:05:26 INFO - Running main action method: run_tests 10:05:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:26 INFO - Python 2.7.3 10:05:26 INFO - Return code: 0 10:05:26 INFO - grabbing minidump binary from tooltool 10:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:26 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 0x1ded410>, '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 0x1dee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dee7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:26 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 10:05:26 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 10:05:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:27 INFO - Return code: 0 10:05:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:05:27 INFO - Return code: 0 10:05:27 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/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 10:05:27 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/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 10:05:27 INFO - Using env: {'DISPLAY': ':0', 10:05:27 INFO - 'HOME': '/home/cltbld', 10:05:27 INFO - 'LANG': 'en_US.UTF-8', 10:05:27 INFO - 'LANGUAGE': 'en_US:en', 10:05:27 INFO - 'LOGNAME': 'cltbld', 10:05:27 INFO - 'MAIL': '/var/mail/cltbld', 10:05:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:27 INFO - 'MOZ_NO_REMOTE': '1', 10:05:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:27 INFO - 'NO_EM_RESTART': '1', 10:05:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:27 INFO - 'PWD': '/builds/slave/test', 10:05:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:27 INFO - 'SHELL': '/bin/bash', 10:05:27 INFO - 'SHLVL': '1', 10:05:27 INFO - 'TERM': 'linux', 10:05:27 INFO - 'TMOUT': '86400', 10:05:27 INFO - 'USER': 'cltbld', 10:05:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189', 10:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:27 INFO - '_': '/tools/buildbot/bin/python'} 10:05:27 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/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 10:05:28 INFO - mozversion application_buildid: 20160617071423 10:05:28 INFO - mozversion application_changeset: d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf 10:05:28 INFO - mozversion application_display_name: Firefox 10:05:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:28 INFO - mozversion application_name: Firefox 10:05:28 INFO - mozversion application_remotingname: firefox 10:05:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:05:28 INFO - mozversion application_vendor: Mozilla 10:05:28 INFO - mozversion application_version: 48.0 10:05:28 INFO - mozversion platform_buildid: 20160617071423 10:05:28 INFO - mozversion platform_changeset: d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf 10:05:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:05:28 INFO - mozversion platform_version: 48.0 10:05:28 INFO - using testdate: 1466183128 10:05:28 INFO - actual date: 1466183128 10:05:28 INFO - starting webserver on 'localhost:60104' 10:05:28 INFO - SUITE-START | Running 2 tests 10:05:28 INFO - TEST-START | dromaeo_css 10:05:28 INFO - operating with platform_type : linux_ 10:05:28 INFO - Initialising browser for dromaeo_css test... 10:05:28 INFO - TEST-INFO | started process 14032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnCE86/profile http://localhost:60104/getInfo.html) 10:05:32 INFO - PROCESS | 14032 | __metrics Screen width/height:1600/1200 10:05:32 INFO - PROCESS | 14032 | colorDepth:24 10:05:32 INFO - PROCESS | 14032 | Browser inner width/height: 1024/697 10:05:32 INFO - PROCESS | 14032 | __metrics 10:05:33 ERROR - PROCESS | 14032 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:05:33 INFO - TEST-INFO | 14032: exit 0 10:05:33 INFO - Browser initialized. 10:05:33 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:34 INFO - TEST-INFO | started process 14122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnCE86/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:45 INFO - PROCESS | 14122 | RSS: Main: 140935168 10:05:45 INFO - PROCESS | 14122 | 10:06:37 INFO - PROCESS | 14122 | 1466183197191 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] 10:08:44 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:60104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60104/tests/dromaeo/cssquery-ext.html) 10:08:45 INFO - PROCESS | 14122 | RSS: Main: 245370880 10:08:45 INFO - PROCESS | 14122 | 10:11:47 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:60104/tests/dromaeo/cssquery-ext.html (next: http://localhost:60104/tests/dromaeo/cssquery-jquery.html) 10:11:48 INFO - PROCESS | 14122 | RSS: Main: 223653888 10:11:48 INFO - PROCESS | 14122 | 10:14:50 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:60104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60104/tests/dromaeo/cssquery-mootools.html) 10:14:50 INFO - PROCESS | 14122 | RSS: Main: 219668480 10:14:50 INFO - PROCESS | 14122 | 10:17:52 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:60104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60104/tests/dromaeo/cssquery-prototype.html) 10:17:52 INFO - PROCESS | 14122 | RSS: Main: 212504576 10:17:52 INFO - PROCESS | 14122 | 10:20:55 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:60104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60104/tests/dromaeo/cssquery-yui.html) 10:20:56 INFO - PROCESS | 14122 | RSS: Main: 208076800 10:20:56 INFO - PROCESS | 14122 | 10:23:58 INFO - PROCESS | 14122 | Cycle 1(1): loaded http://localhost:60104/tests/dromaeo/cssquery-yui.html (next: http://localhost:60104/tests/dromaeo/cssquery-dojo.html) 10:23:58 INFO - PROCESS | 14122 | RSS: Main: 254021632 10:23:58 INFO - PROCESS | 14122 | 10:23:58 INFO - PROCESS | 14122 | __start_tp_report 10:23:58 INFO - PROCESS | 14122 | _x_x_mozilla_page_load 10:23:58 INFO - PROCESS | 14122 | _x_x_mozilla_page_load_details 10:23:58 INFO - PROCESS | 14122 | |i|pagename|runs| 10:23:58 INFO - PROCESS | 14122 | |0;dojo.html;3243.6107667079955;3309.2554175310543;3320.933581328373;3322.667733226679;3351.4302568563344;5557.8888422231585;5575.0522411190095;5581.386047534773;5585.748641311141;5604.663720176793;5584.46947539983;5593.580481463886;5596.300462442195;5613.101903695409;5655.688937108468;5028.371453568295;5063.797448102072;5088.440271570124;5128.53843154116;5169.844904652848;5017.272495488152;5102.974485127569;5106.693598384109;5151.845444636649;5190.325257716491;5142.485751424865;5160.406553246387;5182.093133701606;5184.403793563732;5185.2999845021;5172.9741351293005;5186.974065129688;5191.351081114861;5193.065248255312;5217.895642087175;4946.925796113062;5012.323336349619;5061.468545802712;5062.746862656889;5074.67014644047;5481.040817856859;5579.776808927638;5609.551235901118;5630.774769009235;5631.831045068655;5985.0124729419595;5995.190649262381;6027.487663548603;6043.244594425697;6050.42520960508;5874.236349274567;6054.939450605526;6084.026555751103;6105.511559075308;6138.662373569452;5686.772529098873;5703.258576385043;5722.313322401297;5725.312962444534;5734.283214598176;6208.81373558794;6211.689415529206;6215.378462153839;6218;6218.595791273553;5761.193432919395;5974.3726908674835;6006.489448396847;6055.091736239599;6066.211392518944;6103.481204097613;6103.969480152571;6133.355997620186;6133.478654314434;6144.324124346318;6051.243594550681;6065.969670151621;6072.423119803611;6077.3314935357075;6077.574569780161;5915.704214789243;5997.670128142907;6039.214902062704;6052.57631965767;6074.9392506075255;4633.698809577434;4639.628829693616;4644.313998607076;4649.116667833168;4649.279361698942;3983.1237127831832;4142.1922725068325;4160.45914031174;4165.416841642173;4182.623563879265;5669.603127781098;5784.074548072373;5830.183774271605;5874.089516125007;5888.941110588925;6070.119832624245;6094.847628809227;6120.204373431426;6121.755129794848;6123.4488895999575;5700.971495142498;5753.453421924911;5765.971170144123;5767.134929760569;5845.473907348359;5228.215767634809;5244.763985620656;5245;5249.658772179796;5292.788288468495;6257.4681152102585;6312.495000400048;6313.936860631335;6315.8105256841445;6319.24169099711;6003.669798160969;6091.08633704939;6092.573519853568;6133.824358647991;6220.968895155495;6223.37766223374;6228.34602366745;6232.376762323913;6239.500839932885;6241.407066328691;5907.881842363215;5914.86153892229;5915.231019967377;5926.762929482772;5959.106134079922;5945.583809133319;5991.850203744942;6067.332593414632;6092.390760923872;6127.433875357673;5819.330776960534;5858.882822343615;5862.736176872137;5869.706514674334;5909.527237820878;5811.622244554091;5861.501772349398;5866.384029676822;5869.706514674334;5873.324567674772;5694.1458781183155;5847.210626565359;5903.881922361615;5919.082542205792;5956.166136740773;6000.729967151576;6019.1573179754;6032.487238584769;6039.4262545058145;6042.939570604238;5658.236138121301;5877.147813567094;5888.086371929226;5890.587658863838;5894.145348924468 10:23:58 INFO - PROCESS | 14122 | |1;ext.html;658.5192809249248;674.2684187656391;676.7766637009787;743.7619961612285;756.8864670299455;34298.48552271715;41556.58443415569;41558.33766649338;41563.58436415635;41730.582694173085;46213.7689311553;46705.766471167684;46812;46908.53091469084;46971.530284697226;8199.877001844978;8840.557972101386;8996.415233009866;9027.909720902773;10488.52801623925;10508.316959397653;10605.84091238632;10639.202059845504;10645.680629581086;10654.893451065467;10697.893021069807;10768.138548916068;10769;10769.299995500307;10772.838407423857;10599.364038157697;10627.681169564925;10657.573697052108;10676.092532134739;10677.35935843848;10474.162067034618;10563.63027294041;10596;10954.452277386099;10959;45865.08269834618;46326.07347853024;46354.53645463536;46400;46454.30318545225;3952.6245006724316;3953;4037.253108174997;4044.4135600337786;4150.667946564297;34215.828920855485;34668.47997280043;34692;34898.30203395918;35327;4620.3069539569;4659.487456379796;4665.440147182326;4667.439907211123;4670.1126785910565;339734;340744;342157.2892135548;343174;343291;40054.59945400509;40876.59123408787;66677;66840;67235.66382168057;40394.59605403908;40637.39043914343;40680.59319406827;40725;40771.59228407678;16467.258973346226;17623.559411014572;17938.372156974703;17942.730859037125;17964;15014.924925375522;15047.623809404633;15049.247537623076;15059.47291844802;15083;9306.674266400643;9411.576479058458;9427.811443771086;9468.337216394786;9502.762430939281;3566.8394922228044;3587.0852932502044;3636.4363523653874;3657.7073834093208;3701.6298370162767;1127.3461392392392;1150.0856818829052;1150.8849115088424;1204.8855358740905;1289.348878816192;35293.64706352904;35701.28597428037;36024.819875900976;36046.09884752902;36119.277614447565;1201.9278843269433;1244.3139545915335;1295.0740220742027;1303.5111833062601;1370.2737549098795;18198.363057293194;18449.446516604523;18496.907515462335;18584.349547766033;18614;460418;465610;466916;467170;467661;63659.36340636627;63954.36045639577;64206;64309;64353.678231609476;1437.6837095838898;1516.9089854608537;1529.3423827754173;1581.2963231361935;1642.04761238479;30477.39045219039;32496.512552311262;32570.51144232791;32630.184245394055;32973;50604;50915.49084509107;51020.23469647884;51064.48935510597;51135.74432127816;297090;298273;298650;299060;299127;31285.687143129187;48122.27816582684;48596.514034859196;49327;49816.75091624519;51398;51992;52420;52581.737091314295;52586.474135258155;42297;42873;43446;44257;44447.55552444434;41808.79095604624;42009.369859452745;42078.36882446705;42419.363709543766;43397.349039763794;43615.12769744651;43627.56372436235;44094.77952610217;44381.556184437744;44456.55543444524;36157.60059426742;38332.616673832905;38428.80785596054;38891;39115.2176956465;28892.133236002952;29368.853155734083;29592.260193495335;29766.553501697927;30023.849880750455 10:23:58 INFO - PROCESS | 14122 | |2;jquery.html;436.67467736536287;436.71170048357345;436.76196472922254;449.54820405492484;450.1512071786229;18435.262589496422;18485.53786155345;19082.522936926565;19171.23315067399;19338.033098345062;18548.72176917344;18658.06709664518;18839.623207535842;18869.811301886977;18875.811241887575;5647.407022262654;5657.151427285919;5775.971120144393;5783.537317014629;5835.35811060783;4331.45856767904;5744.511716504102;5819.941800582003;6050.606710563821;6332.556721029529;6298.622082675054;6302.432781049704;6326.430621244087;6329.556931014831;6331;5423.891522169554;5631.5776316776;5692.345380281279;5699.572532060112;6283.6858157091965;3921.725479216456;5484.506394424521;5545.972270138624;5562.249096371978;5727.3699893011735;13460.326983650779;13501.459941602325;13589.456421743218;13733.862661373358;13756.105853119516;2386.6300723387903;2470.4688491974134;2574.266334094774;2884.39427720179;3140.733037691799;10289.980361488539;10413.062824345769;10922.126229901589;11670.708232294175;14843.92578037103;1973.3093417303971;1993.2724555537125;2068.720722702446;2102.5794841031857;2145.1419432227076;79761.60119199425;81452;81943.59028204822;82339.17660823376;82497.58751206266;11207.551697932155;11401.942990284995;11599.76800463986;11682.532698692126;11818;16319.755203671955;16446.917765411097;16598;16632.584185395463;16645.83354166467;8987.19115279628;8992.190702836777;8993.910060899307;9046.231070358961;9106.681266155652;8745.300375969908;8951.104889510996;8960.327975401871;8970.23752981004;9033.277337812959;4930.309756634074;5034.546890779848;5120.615953803405;5152.0726269271145;5159.509846564571;1868.990655046716;1943.5238366600274;2038.347728726793;2048.989755051215;2072.295419557358;1014.6550172941088;1081.9459027048615;1100.4497751124438;1135.233717240859;1155.289496959364;18071.379649950683;18655.533611659816;18841.340553080852;19109.713354299696;19380.127894244793;1096.9012788849043;1101.8457415961773;1107.950142243601;1195.5158160944832;1219.451246938881;10699.94650026745;10786.946065269623;10799.970066601905;10802.135829133651;11027.283226590245;523867;536959;545581;551654;571246;91553;94220;95272.4816615596;95652.56521152188;97698;1119.9328040317607;1128.4132251229478;1163.6218229075585;1173.700706319883;1176.2413243457922;16800.915995419946;16940.66118677644;17093.145342733063;17180.828191717923;17205.74191387105;38845.22309553737;39491.605083948794;40041;40698.79650601728;41906.7904660487;55876;57339.71330143323;57607.71196143993;57988.71005644945;58679;8216.21945915137;8620.82758344817;8853.380263381501;8946.507942063248;9111.544422778967;10743.677689669323;13740.793888091886;13776.517821876587;13788.862111378758;13886.652833679238;11673.066154707773;11832.76334473323;11837.526498939946;11841.230320029515;11853.881461185623;11707.121965852424;11816.054715622902;11914.285142891455;12075.456604452645;12127.514899403925;12155.635330940086;12508.749825003631;12570.37148142571;12724.554640587536;12726.427310770852;8995.865062023944;9121.361504694607;9204.907950920406;9211.815763684555;9392.859107113261;12171.513139474322;12471.563495277622;12493;12520.561780338008;12654 10:23:58 INFO - PROCESS | 14122 | |3;mootools.html;1199.658097442229;1520.407041253911;1539.0919357579025;1757.4727581725488;1890.1494327552605;8277.958610206948;8369.832603347944;8415.663373465062;8440.957795211016;8447.281981031612;8325.084240733515;8474.152584741523;8507.404481686284;8508.234258916696;8526.91473085269;2388.8208384371155;2408.927732168038;2414.9396265093424;2416.6858308419883;2417.4560723837085;2435.330284171849;2466.2847774145566;2499.387650025737;2502.87485625718;2506.5112303100905;2397.3646983549374;2416.154345978911;2430.222328854767;2455.287966489716;2459.446624509489;2391.581473242193;2424.2000139953775;2438.792702620279;2451.2891261534132;2454.7667971542587;2409.3013026222375;2470.258922323314;2481.057198264648;2483.428811373394;2485.7389974052644;6939.965300173517;8119.26926576605;8675.349348798802;8698.434601750865;8744.475331480131;5204.141316682742;5303.098473259555;5319.9202011969855;5328.120860058086;5329.25390445338;3521.454174602941;3587.210813620999;3591.1740299730945;3680.0983758978955;3683.778973261586;1175.1480176871785;1187.5784096645652;1190.3572071081605;1190.422645017166;1217.6773155113901;11579.942100289529;11845.822312665317;11851.703707407383;11853.40732963357;11920;4668.5564871337165;4684.484706682262;4720.362751028636;4750.168720473903;4753.287006948985;10360.119389851796;10377.948110259551;10394.960503949696;10403.167746580255;10418.062374386342;5355.758990845421;5384.515393614593;5391.9460805391445;5395.379531353866;5398.6220964532895;4855.198892182751;4893.241547560134;4920.089783390084;4929.704217746947;4930.901381972412;3981.7013723970817;3987.5613682494904;3995.780232087263;4016.8995775105273;4021.798910054544;1215.4530461292454;1220.3166226912956;1223.614561413152;1231.1874163052341;1246.956356527517;1057.3602970202917;1071.3357718214756;1074.0601973273385;1079.5573814735922;1088.3089238333557;5911.527077833763;6005.909911351333;6013.30846952606;6054.909176362358;6086.452219300284;971.4414211828085;979.2068424575974;994.0854413939194;998.7103739915489;1059.5338051257422;4082.1223436960604;4087.6116768906904;4087.9386809197886;4110.958890411118;4139.254934111828;10579.62971296001;10958.726031849108;11000.394978276112;11018.50416731249;11055.336679799238;10746.140308775279;10861.945690271497;10881.183911206534;10889.727756805985;10902.563897444172;7873.409494287951;8004.279614834576;8288.419810613199;8444.577771111542;8461.23848853606;5858.765649373977;5949.7620095197435;5970.522358211246;6022.608530445507;6031.185789918481;9033.187013168847;9527.190188834027;9586.041395860359;9594.232461402931;9728.12446879756;9878.407295562289;9946.502674866084;10021.749456263651;10053.748656283651;10169.9491502542;7814.374850012099;7854.096778870503;7915.1293357729455;7922.207779222032;7927.445078844657;8259.710910118118;8368.079511253636;8432.915670843458;8481.27909127731;8484.533350665526;7501.324880760758;7579.734709285369;7710.807229819299;7829.491083079582;7887.921120788718;7620.161782204064;7686.50037747567;7703.961480192564;7752;7777.455578109478;7087.61018144007;7090.645467726697;7113.786586402209;7126.35862772353;7196.0645116134565;4294.76378799169;5193.558547523503;5219.269302297757;5236.5548928339995;5284.894302114013;5035.622328325464;5161.0968080585;5291.021161085211;5291.867703307448;5324.376065300121 10:23:58 INFO - PROCESS | 14122 | |4;prototype.html;363.44030193502016;363.6599779206442;363.83263698698596;366.8385910199512;367.9595244523102;6393.616383017023;6410.102585638008;6437.517186211029;6470.547061705683;6481.870362592746;6397.584157029802;6412.871742565146;6426;6427.068075129104;6430;4638.4433867935895;4753.667243292971;4876.585490233334;4881.365422495071;4896.2410826321975;4810.951890481103;4833.32333473314;4839.3466881970835;4877.000214955926;4877.829275975341;4616.238320677101;4837.685550439211;4844.515548445145;4857.125717370872;4860.927086093694;4700.600448961843;4800.5679488846;4824.541668541483;4831.951680483186;4841.2012018016985;4219.7046206765535;4224.324108142682;4237.576242375769;4241.194173107131;4256.2338779019765;6097;6104.603200791934;6105.603135796159;6107.4808641265545;6107.603005804653;5697.6866272355;5698.914516282259;5705.258316418839;5713.971430142823;5719.170720245541;6592.505562082815;6767.120274364351;6774.796756097325;6775.864482710367;6788.864222715568;4758.738269395182;4760.690555113941;4769.785359658824;4770.165221086296;4780.880477988078;7047.400970917478;7112.822179445504;7123.465740069516;7135.964320178417;7137;4938.753062346868;4952.306677065214;4955.207166853286;4963.255511673206;4966.652334336634;5030.89938201234;5040.47075057121;5042.571381432546;5047.293378926953;5052.065367906949;5528.170774383794;5737.569682273846;5740.1102829061565;5741.110127930094;5754.712264386764;6826.214985276657;6865.897011544831;6870.62211578368;6874.862502749917;6877.965610171917;1755.2364721346;1759.9032053236938;1774.9911250443665;1779.7330400440037;1781.287485006008;1114.8550688410455;1171.566520387462;1174.7004513848915;1200.8619008814098;1202.296656455983;6584.539082264196;6593.3736295051895;6612.338766123446;6612.371824676648;6613.669316534154;7006.544574602634;7032.015517827508;7042.295770422917;7049.259827718119;7050.189228238715;6580.86838263232;6589.406953374123;6594.373534514213;6595.97762346837;6609.735610575619;3735.7945313008045;3775.811209439572;3813.809309534512;3821.2357528494413;3823.063349479395;7282.271772822782;7296.744613938593;7310.926890731024;7311;7314;7084.326988936146;7140.5358651687475;7145.535540189871;7181.461390395637;7189.424846012306;7248.0939882514685;7261.164966028869;7266.781996540112;7280.126384833748;7290.270972902774;6842.281560436281;6991.056207412138;6994.545354551938;6994.685239164148;7002.1947476040905;6856.9314306856295;6864.176298844171;6867.381935625817;6869.793906182823;6873.690683919335;7214.89177662346;7227.38567221771;7254.528455650366;7267.382272506896;7269.382102521134;4975.825846095369;4976.377952755905;4981.750912454435;4984.978079493622;4986.700797952134;6961.825954351182;6993.825154371181;7004.264552222147;7005.509614326948;7007.334303241184;6753.3246675332075;6929.861402771816;6945.340192681687;6962.477814163856;6974.058502102354;6886.070380498769;6921.653917304216;6926.995585640155;6933.479989000744;6938.132733408324;6803.1836179656775;6812.82967925786;6817.795466136024;6822.658867056528;6833.384995350442;6788.558743681645;6975.093237879043;6981.057557229912;6984.755533556505;6990.580565166107;6485.156929599122;6626.469882409299;6824.624645644537;6837.726490940307;6907.930920690729 10:23:58 INFO - PROCESS | 14122 | |5;yui.html;876.8027193881378;907.4509921497494;922.8984811670717;933.6732143749692;935.7426707655394;14678.119312841223;14978.550643480687;15084.094954302736;15195;15220.086794792307;13738.72522549551;13794.862051379483;13815.585532434017;13826;13828.17030978142;772.7334069745929;919.7010971434278;924.3945215883607;931.9394239374453;955.6798472511717;939.318993729544;942.2179590939538;945.4894357047186;946.6592026870321;947.6020071569957;992.1764935103882;993.9801203975916;999.1507218863944;1001.3841487485181;1001.484235618657;804.9476784009021;941.2187884056217;990.2276224544867;991.7223177510236;992.2805965674864;728.6793810723318;729.3545212486935;729.3836707981746;729.5148726097138;730.1056206147426;13948.721025579533;13967.580972570839;13980.161190328612;14009;14017.579472615736;14384.136951782823;14701.92649036748;14822.110673359633;14864.851351486563;14934.62663433412;12020.939895300555;12154.696132596755;12180;12222.449989750483;12360;4095.651869591088;4104.774237416941;4115.444415003966;4169.791510424467;4238.915221695549;53303.46696533063;53468.46531534674;53503;53938.73030634861;55929.16106258409;11263.26788758728;11626.709332266591;11743.354115523558;11876.346800926032;11912.2257053293;21274.468138296666;21329.68005479919;21331;21337.466563336042;21343.573128537344;8534.573271336532;8698.130186981378;8716.43343182691;8735.51954642488;8920.553972301359;4787.3537072495465;4794.976025119922;4817.445993710698;4880.267959805987;5189.377274726981;3601.7118630509494;3640.9817950910074;3642.3807952648112;3642.617525159873;3648.179159689049;584.3075954993346;627.3788948940517;713.5005496152714;721.1526456413693;721.9241979592172;802.8314054048715;835.4861760017545;847.2078606502816;851.8126012277413;853.7268074216191;9353.90646093544;9358.485283309346;9421.24630029596;9441.669541566012;9521.761955951019;808.321010351296;808.9069756978023;819.8852160697508;833.4207725630629;859.2395729779065;4680.609614063696;4738.691985020962;4753.667243293005;4797.18447863864;4988.451270360258;64349.67825160844;65776;66058.66970665116;66209;66422;52351.738241309315;52621;52831.207531887056;55545.72227138838;56460.71769641126;49943.50056499461;50682.74658626683;50978.23532646939;51379;52362.476375236525;9157.450552966844;9223;9329.207017403596;9334.766630834283;9349;38659.2268154641;39578.406323904586;39700.2059958805;39838.80080599579;40403.797981009906;48027.27959080547;50282.497175029246;50596.747016264686;50851;51312.230316544534;11812.645620631394;11892.405379730806;11977.161598688008;12010.33943133136;12363.505459781509;12984;13062.34688265602;13414.664633384244;13453.327333633475;13968.720625587635;11198.720031999264;13036.739265214832;13162.736745265232;13220.537281195113;13984.790228146383;12263.76478809935;12612.936935315265;12763.553275635679;12774.614727097141;12822.23066616006;13463.974071303914;13714.314284285945;13772.24252666113;13815.240161791198;13823.861761382257;10209.9489502552;10713.517891694737;10898.400587967737;11136.721581960192;11373.260738052;10898.618548350769;10979.670609881716;11187.832182517106;11216.158788090763;11265.943670281596 10:23:58 INFO - PROCESS | 14122 | __end_tp_report 10:23:58 INFO - PROCESS | 14122 | __start_cc_report 10:23:58 INFO - PROCESS | 14122 | _x_x_mozilla_cycle_collect,837 10:23:58 INFO - PROCESS | 14122 | __end_cc_report 10:23:58 INFO - PROCESS | 14122 | __startTimestamp1466184238587__endTimestamp 10:23:58 INFO - PROCESS | 14122 | 10:23:58 INFO - PROCESS | 14122 | ------- Summary: start ------- 10:23:58 INFO - PROCESS | 14122 | Number of tests: 6 10:23:58 INFO - PROCESS | 14122 | 10:23:58 INFO - PROCESS | 14122 | [#0] dojo.html Cycles:165 Average:5625.59 Median:5866.38 stddev:641.25 (10.9%) stddev-sans-first:615.39 10:23:58 INFO - PROCESS | 14122 | Values: 3243.6 3309.3 3320.9 3322.7 3351.4 5557.9 5575.1 5581.4 5585.7 5604.7 5584.5 5593.6 5596.3 5613.1 5655.7 5028.4 5063.8 5088.4 5128.5 5169.8 5017.3 5103.0 5106.7 5151.8 5190.3 5142.5 5160.4 5182.1 5184.4 5185.3 5173.0 5187.0 5191.4 5193.1 5217.9 4946.9 5012.3 5061.5 5062.7 5074.7 5481.0 5579.8 5609.6 5630.8 5631.8 5985.0 5995.2 6027.5 6043.2 6050.4 5874.2 6054.9 6084.0 6105.5 6138.7 5686.8 5703.3 5722.3 5725.3 5734.3 6208.8 6211.7 6215.4 6218.0 6218.6 5761.2 5974.4 6006.5 6055.1 6066.2 6103.5 6104.0 6133.4 6133.5 6144.3 6051.2 6066.0 6072.4 6077.3 6077.6 5915.7 5997.7 6039.2 6052.6 6074.9 4633.7 4639.6 4644.3 4649.1 4649.3 3983.1 4142.2 4160.5 4165.4 4182.6 5669.6 5784.1 5830.2 5874.1 5888.9 6070.1 6094.8 6120.2 6121.8 6123.4 5701.0 5753.5 5766.0 5767.1 5845.5 5228.2 5244.8 5245.0 5249.7 5292.8 6257.5 6312.5 6313.9 6315.8 6319.2 6003.7 6091.1 6092.6 6133.8 6221.0 6223.4 6228.3 6232.4 6239.5 6241.4 5907.9 5914.9 5915.2 5926.8 5959.1 5945.6 5991.9 6067.3 6092.4 6127.4 5819.3 5858.9 5862.7 5869.7 5909.5 5811.6 5861.5 5866.4 5869.7 5873.3 5694.1 5847.2 5903.9 5919.1 5956.2 6000.7 6019.2 6032.5 6039.4 6042.9 5658.2 5877.1 5888.1 5890.6 5894.1 10:23:58 INFO - PROCESS | 14122 | 10:23:58 INFO - PROCESS | 14122 | [#1] ext.html Cycles:180 Average:54954.97 Median:38659.90 stddev:98801.04 (255.6%) stddev-sans-first:98994.10 10:23:58 INFO - PROCESS | 14122 | Values: 658.5 674.3 676.8 743.8 756.9 34298.5 41556.6 41558.3 41563.6 41730.6 46213.8 46705.8 46812.0 46908.5 46971.5 8199.9 8840.6 8996.4 9027.9 10488.5 10508.3 10605.8 10639.2 10645.7 10654.9 10697.9 10768.1 10769.0 10769.3 10772.8 10599.4 10627.7 10657.6 10676.1 10677.4 10474.2 10563.6 10596.0 10954.5 10959.0 45865.1 46326.1 46354.5 46400.0 46454.3 3952.6 3953.0 4037.3 4044.4 4150.7 34215.8 34668.5 34692.0 34898.3 35327.0 4620.3 4659.5 4665.4 4667.4 4670.1 339734.0 340744.0 342157.3 343174.0 343291.0 40054.6 40876.6 66677.0 66840.0 67235.7 40394.6 40637.4 40680.6 40725.0 40771.6 16467.3 17623.6 17938.4 17942.7 17964.0 15014.9 15047.6 15049.2 15059.5 15083.0 9306.7 9411.6 9427.8 9468.3 9502.8 3566.8 3587.1 3636.4 3657.7 3701.6 1127.3 1150.1 1150.9 1204.9 1289.3 35293.6 35701.3 36024.8 36046.1 36119.3 1201.9 1244.3 1295.1 1303.5 1370.3 18198.4 18449.4 18496.9 18584.3 18614.0 460418.0 465610.0 466916.0 467170.0 467661.0 63659.4 63954.4 64206.0 64309.0 64353.7 1437.7 1516.9 1529.3 1581.3 1642.0 30477.4 32496.5 32570.5 32630.2 32973.0 50604.0 50915.5 51020.2 51064.5 51135.7 297090.0 298273.0 298650.0 299060.0 299127.0 31285.7 48122.3 48596.5 49327.0 49816.8 51398.0 51992.0 52420.0 52581.7 52586.5 42297.0 42873.0 43446.0 44257.0 44447.6 41808.8 42009.4 42078.4 42419.4 43397.3 43615.1 43627.6 44094.8 44381.6 44456.6 36157.6 38332.6 38428.8 38891.0 39115.2 28892.1 29368.9 29592.3 29766.6 30023.8 10:23:58 INFO - PROCESS | 14122 | 10:23:58 INFO - PROCESS | 14122 | [#2] jquery.html Cycles:180 Average:30551.71 Median:2058.86 stddev:89801.77 (4361.7%) stddev-sans-first:90025.22 10:23:58 INFO - PROCESS | 14122 | Values: 436.7 436.7 436.8 449.5 450.2 18435.3 18485.5 19082.5 19171.2 19338.0 18548.7 18658.1 18839.6 18869.8 18875.8 5647.4 5657.2 5776.0 5783.5 5835.4 4331.5 5744.5 5819.9 6050.6 6332.6 6298.6 6302.4 6326.4 6329.6 6331.0 5423.9 5631.6 5692.3 5699.6 6283.7 3921.7 5484.5 5546.0 5562.2 5727.4 13460.3 13501.5 13589.5 13733.9 13756.1 2386.6 2470.5 2574.3 2884.4 3140.7 10290.0 10413.1 10922.1 11670.7 14843.9 1973.3 1993.3 2068.7 2102.6 2145.1 79761.6 81452.0 81943.6 82339.2 82497.6 11207.6 11401.9 11599.8 11682.5 11818.0 16319.8 16446.9 16598.0 16632.6 16645.8 8987.2 8992.2 8993.9 9046.2 9106.7 8745.3 8951.1 8960.3 8970.2 9033.3 4930.3 5034.5 5120.6 5152.1 5159.5 1869.0 1943.5 2038.3 2049.0 2072.3 1014.7 1081.9 1100.4 1135.2 1155.3 18071.4 18655.5 18841.3 19109.7 19380.1 1096.9 1101.8 1108.0 1195.5 1219.5 10699.9 10786.9 10800.0 10802.1 11027.3 523867.0 536959.0 545581.0 551654.0 571246.0 91553.0 94220.0 95272.5 95652.6 97698.0 1119.9 1128.4 1163.6 1173.7 1176.2 16800.9 16940.7 17093.1 17180.8 17205.7 38845.2 39491.6 40041.0 40698.8 41906.8 55876.0 57339.7 57607.7 57988.7 58679.0 8216.2 8620.8 8853.4 8946.5 9111.5 10743.7 13740.8 13776.5 13788.9 13886.7 11673.1 11832.8 11837.5 11841.2 11853.9 11707.1 11816.1 11914.3 12075.5 12127.5 12155.6 12508.7 12570.4 12724.6 12726.4 8995.9 9121.4 9204.9 9211.8 9392.9 12171.5 12471.6 12493.0 12520.6 12654.0 10:23:58 INFO - PROCESS | 14122 | 10:23:58 INFO - PROCESS | 14122 | [#3] mootools.html Cycles:180 Average:5782.89 Median:4874.22 stddev:3184.07 (65.3%) stddev-sans-first:3174.37 10:23:58 INFO - PROCESS | 14122 | Values: 1199.7 1520.4 1539.1 1757.5 1890.1 8278.0 8369.8 8415.7 8441.0 8447.3 8325.1 8474.2 8507.4 8508.2 8526.9 2388.8 2408.9 2414.9 2416.7 2417.5 2435.3 2466.3 2499.4 2502.9 2506.5 2397.4 2416.2 2430.2 2455.3 2459.4 2391.6 2424.2 2438.8 2451.3 2454.8 2409.3 2470.3 2481.1 2483.4 2485.7 6940.0 8119.3 8675.3 8698.4 8744.5 5204.1 5303.1 5319.9 5328.1 5329.3 3521.5 3587.2 3591.2 3680.1 3683.8 1175.1 1187.6 1190.4 1190.4 1217.7 11579.9 11845.8 11851.7 11853.4 11920.0 4668.6 4684.5 4720.4 4750.2 4753.3 10360.1 10377.9 10395.0 10403.2 10418.1 5355.8 5384.5 5391.9 5395.4 5398.6 4855.2 4893.2 4920.1 4929.7 4930.9 3981.7 3987.6 3995.8 4016.9 4021.8 1215.5 1220.3 1223.6 1231.2 1247.0 1057.4 1071.3 1074.1 1079.6 1088.3 5911.5 6005.9 6013.3 6054.9 6086.5 971.4 979.2 994.1 998.7 1059.5 4082.1 4087.6 4087.9 4111.0 4139.3 10579.6 10958.7 11000.4 11018.5 11055.3 10746.1 10861.9 10881.2 10889.7 10902.6 7873.4 8004.3 8288.4 8444.6 8461.2 5858.8 5949.8 5970.5 6022.6 6031.2 9033.2 9527.2 9586.0 9594.2 9728.1 9878.4 9946.5 10021.7 10053.7 10169.9 7814.4 7854.1 7915.1 7922.2 7927.4 8259.7 8368.1 8432.9 8481.3 8484.5 7501.3 7579.7 7710.8 7829.5 7887.9 7620.2 7686.5 7704.0 7752.0 7777.5 7087.6 7090.6 7113.8 7126.4 7196.1 4294.8 5193.6 5219.3 5236.6 5284.9 5035.6 5161.1 5291.0 5291.9 5324.4 10:23:58 INFO - PROCESS | 14122 | 10:23:58 INFO - PROCESS | 14122 | [#4] prototype.html Cycles:180 Average:5716.33 Median:6533.01 stddev:1719.12 (26.3%) stddev-sans-first:1676.34 10:23:58 INFO - PROCESS | 14122 | Values: 363.4 363.7 363.8 366.8 368.0 6393.6 6410.1 6437.5 6470.5 6481.9 6397.6 6412.9 6426.0 6427.1 6430.0 4638.4 4753.7 4876.6 4881.4 4896.2 4811.0 4833.3 4839.3 4877.0 4877.8 4616.2 4837.7 4844.5 4857.1 4860.9 4700.6 4800.6 4824.5 4832.0 4841.2 4219.7 4224.3 4237.6 4241.2 4256.2 6097.0 6104.6 6105.6 6107.5 6107.6 5697.7 5698.9 5705.3 5714.0 5719.2 6592.5 6767.1 6774.8 6775.9 6788.9 4758.7 4760.7 4769.8 4770.2 4780.9 7047.4 7112.8 7123.5 7136.0 7137.0 4938.8 4952.3 4955.2 4963.3 4966.7 5030.9 5040.5 5042.6 5047.3 5052.1 5528.2 5737.6 5740.1 5741.1 5754.7 6826.2 6865.9 6870.6 6874.9 6878.0 1755.2 1759.9 1775.0 1779.7 1781.3 1114.9 1171.6 1174.7 1200.9 1202.3 6584.5 6593.4 6612.3 6612.4 6613.7 7006.5 7032.0 7042.3 7049.3 7050.2 6580.9 6589.4 6594.4 6596.0 6609.7 3735.8 3775.8 3813.8 3821.2 3823.1 7282.3 7296.7 7310.9 7311.0 7314.0 7084.3 7140.5 7145.5 7181.5 7189.4 7248.1 7261.2 7266.8 7280.1 7290.3 6842.3 6991.1 6994.5 6994.7 7002.2 6856.9 6864.2 6867.4 6869.8 6873.7 7214.9 7227.4 7254.5 7267.4 7269.4 4975.8 4976.4 4981.8 4985.0 4986.7 6961.8 6993.8 7004.3 7005.5 7007.3 6753.3 6929.9 6945.3 6962.5 6974.1 6886.1 6921.7 6927.0 6933.5 6938.1 6803.2 6812.8 6817.8 6822.7 6833.4 6788.6 6975.1 6981.1 6984.8 6990.6 6485.2 6626.5 6824.6 6837.7 6907.9 10:23:58 INFO - PROCESS | 14122 | 10:23:58 INFO - PROCESS | 14122 | [#5] yui.html Cycles:180 Average:15464.73 Median:4791.16 stddev:17717.92 (369.8%) stddev-sans-first:17733.76 10:23:58 INFO - PROCESS | 14122 | Values: 876.8 907.5 922.9 933.7 935.7 14678.1 14978.6 15084.1 15195.0 15220.1 13738.7 13794.9 13815.6 13826.0 13828.2 772.7 919.7 924.4 931.9 955.7 939.3 942.2 945.5 946.7 947.6 992.2 994.0 999.2 1001.4 1001.5 804.9 941.2 990.2 991.7 992.3 728.7 729.4 729.4 729.5 730.1 13948.7 13967.6 13980.2 14009.0 14017.6 14384.1 14701.9 14822.1 14864.9 14934.6 12020.9 12154.7 12180.0 12222.4 12360.0 4095.7 4104.8 4115.4 4169.8 4238.9 53303.5 53468.5 53503.0 53938.7 55929.2 11263.3 11626.7 11743.4 11876.3 11912.2 21274.5 21329.7 21331.0 21337.5 21343.6 8534.6 8698.1 8716.4 8735.5 8920.6 4787.4 4795.0 4817.4 4880.3 5189.4 3601.7 3641.0 3642.4 3642.6 3648.2 584.3 627.4 713.5 721.2 721.9 802.8 835.5 847.2 851.8 853.7 9353.9 9358.5 9421.2 9441.7 9521.8 808.3 808.9 819.9 833.4 859.2 4680.6 4738.7 4753.7 4797.2 4988.5 64349.7 65776.0 66058.7 66209.0 66422.0 52351.7 52621.0 52831.2 55545.7 56460.7 49943.5 50682.7 50978.2 51379.0 52362.5 9157.5 9223.0 9329.2 9334.8 9349.0 38659.2 39578.4 39700.2 39838.8 40403.8 48027.3 50282.5 50596.7 50851.0 51312.2 11812.6 11892.4 11977.2 12010.3 12363.5 12984.0 13062.3 13414.7 13453.3 13968.7 11198.7 13036.7 13162.7 13220.5 13984.8 12263.8 12612.9 12763.6 12774.6 12822.2 13464.0 13714.3 13772.2 13815.2 13823.9 10209.9 10713.5 10898.4 11136.7 11373.3 10898.6 10979.7 11187.8 11216.2 11265.9 10:23:58 INFO - PROCESS | 14122 | -------- Summary: end -------- 10:23:58 INFO - PROCESS | 14122 | 10:23:59 INFO - TEST-INFO | 14122: exit 0 10:23:59 INFO - TEST-OK | dromaeo_css | took 1111114ms 10:23:59 INFO - TEST-START | kraken 10:23:59 INFO - operating with platform_type : linux_ 10:23:59 INFO - Initialising browser for kraken test... 10:23:59 INFO - TEST-INFO | started process 14314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjHzZng/profile http://localhost:60104/getInfo.html) 10:24:03 INFO - PROCESS | 14314 | __metrics Screen width/height:1600/1200 10:24:03 INFO - PROCESS | 14314 | colorDepth:24 10:24:03 INFO - PROCESS | 14314 | Browser inner width/height: 1024/697 10:24:03 INFO - PROCESS | 14314 | __metrics 10:24:04 ERROR - PROCESS | 14314 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:24:05 INFO - TEST-INFO | 14314: exit 0 10:24:05 INFO - Browser initialized. 10:24:05 INFO - Running cycle 1/1 for kraken test... 10:24:05 INFO - TEST-INFO | started process 14405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjHzZng/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:16 INFO - PROCESS | 14405 | RSS: Main: 140517376 10:24:16 INFO - PROCESS | 14405 | 10:24:19 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60104/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:20 INFO - PROCESS | 14405 | RSS: Main: 196874240 10:24:20 INFO - PROCESS | 14405 | 10:24:22 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60104/tests/kraken/driver.html?testName=audio-dft) 10:24:23 INFO - PROCESS | 14405 | RSS: Main: 183721984 10:24:23 INFO - PROCESS | 14405 | 10:24:26 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60104/tests/kraken/driver.html?testName=audio-fft) 10:24:26 INFO - PROCESS | 14405 | RSS: Main: 273178624 10:24:26 INFO - PROCESS | 14405 | 10:24:28 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60104/tests/kraken/driver.html?testName=audio-oscillator) 10:24:29 INFO - PROCESS | 14405 | RSS: Main: 179449856 10:24:29 INFO - PROCESS | 14405 | 10:24:31 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:32 INFO - PROCESS | 14405 | RSS: Main: 177422336 10:24:32 INFO - PROCESS | 14405 | 10:24:35 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60104/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:35 INFO - PROCESS | 14405 | RSS: Main: 212406272 10:24:35 INFO - PROCESS | 14405 | 10:24:39 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60104/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:39 INFO - PROCESS | 14405 | RSS: Main: 212086784 10:24:39 INFO - PROCESS | 14405 | 10:24:42 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60104/tests/kraken/driver.html?testName=json-parse-financial) 10:24:42 INFO - PROCESS | 14405 | RSS: Main: 211841024 10:24:42 INFO - PROCESS | 14405 | 10:24:44 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:45 INFO - PROCESS | 14405 | RSS: Main: 191983616 10:24:45 INFO - PROCESS | 14405 | 10:24:46 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60104/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:47 INFO - PROCESS | 14405 | RSS: Main: 195842048 10:24:47 INFO - PROCESS | 14405 | 10:24:49 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:24:49 INFO - PROCESS | 14405 | RSS: Main: 210132992 10:24:49 INFO - PROCESS | 14405 | 10:24:52 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:24:52 INFO - PROCESS | 14405 | RSS: Main: 218628096 10:24:52 INFO - PROCESS | 14405 | 10:24:55 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:24:56 INFO - PROCESS | 14405 | RSS: Main: 214495232 10:24:56 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | Cycle 1(1): loaded http://localhost:60104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60104/tests/kraken/driver.html?testName=ai-astar) 10:24:58 INFO - PROCESS | 14405 | RSS: Main: 275185664 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | __start_tp_report 10:24:58 INFO - PROCESS | 14405 | _x_x_mozilla_page_load 10:24:58 INFO - PROCESS | 14405 | _x_x_mozilla_page_load_details 10:24:58 INFO - PROCESS | 14405 | |i|pagename|runs| 10:24:58 INFO - PROCESS | 14405 | |0;ai-astar;110;110;110;111;110;110;106;110;109;109 10:24:58 INFO - PROCESS | 14405 | |1;audio-beat-detection;149;126;156;175;125;161;155;126;189;126 10:24:58 INFO - PROCESS | 14405 | |2;audio-dft;159;161;160;159;161;160;161;162;160;160 10:24:58 INFO - PROCESS | 14405 | |3;audio-fft;75;77;76;179;75;73;73;75;170;77 10:24:58 INFO - PROCESS | 14405 | |4;audio-oscillator;91;91;157;92;91;93;146;91;91;139 10:24:58 INFO - PROCESS | 14405 | |5;imaging-gaussian-blur;116;117;117;117;117;116;116;117;117;117 10:24:58 INFO - PROCESS | 14405 | |6;imaging-darkroom;145;145;146;146;145;146;146;145;145;145 10:24:58 INFO - PROCESS | 14405 | |7;imaging-desaturate;95;94;94;94;95;94;95;94;95;94 10:24:58 INFO - PROCESS | 14405 | |8;json-parse-financial;56;54;55;52;53;53;56;78;53;50 10:24:58 INFO - PROCESS | 14405 | |9;json-stringify-tinderbox;58;59;56;56;58;56;56;56;56;57 10:24:58 INFO - PROCESS | 14405 | |10;stanford-crypto-aes;73;72;80;78;73;72;73;73;73;73 10:24:58 INFO - PROCESS | 14405 | |11;stanford-crypto-ccm;114;116;114;115;113;111;110;119;139;132 10:24:58 INFO - PROCESS | 14405 | |12;stanford-crypto-pbkdf2;162;163;163;163;162;162;161;166;163;159 10:24:58 INFO - PROCESS | 14405 | |13;stanford-crypto-sha256-iterative;66;67;69;67;65;67;68;68;67;67 10:24:58 INFO - PROCESS | 14405 | __end_tp_report 10:24:58 INFO - PROCESS | 14405 | __start_cc_report 10:24:58 INFO - PROCESS | 14405 | _x_x_mozilla_cycle_collect,1615 10:24:58 INFO - PROCESS | 14405 | __end_cc_report 10:24:58 INFO - PROCESS | 14405 | __startTimestamp1466184298248__endTimestamp 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | ------- Summary: start ------- 10:24:58 INFO - PROCESS | 14405 | Number of tests: 14 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 10:24:58 INFO - PROCESS | 14405 | Values: 110.0 110.0 110.0 111.0 110.0 110.0 106.0 110.0 109.0 109.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:155.50 stddev:22.77 (14.6%) stddev-sans-first:24.15 10:24:58 INFO - PROCESS | 14405 | Values: 149.0 126.0 156.0 175.0 125.0 161.0 155.0 126.0 189.0 126.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 10:24:58 INFO - PROCESS | 14405 | Values: 159.0 161.0 160.0 159.0 161.0 160.0 161.0 162.0 160.0 160.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.00 stddev:41.98 (56.0%) stddev-sans-first:43.89 10:24:58 INFO - PROCESS | 14405 | Values: 75.0 77.0 76.0 179.0 75.0 73.0 73.0 75.0 170.0 77.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:91.00 stddev:27.35 (30.1%) stddev-sans-first:28.29 10:24:58 INFO - PROCESS | 14405 | Values: 91.0 91.0 157.0 92.0 91.0 93.0 146.0 91.0 91.0 139.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 10:24:58 INFO - PROCESS | 14405 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:24:58 INFO - PROCESS | 14405 | Values: 145.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:24:58 INFO - PROCESS | 14405 | Values: 95.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.50 stddev:7.94 (14.6%) stddev-sans-first:8.43 10:24:58 INFO - PROCESS | 14405 | Values: 56.0 54.0 55.0 52.0 53.0 53.0 56.0 78.0 53.0 50.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:56.50 stddev:1.14 (2.0%) stddev-sans-first:1.12 10:24:58 INFO - PROCESS | 14405 | Values: 58.0 59.0 56.0 56.0 58.0 56.0 56.0 56.0 56.0 57.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.00 stddev:2.71 (3.7%) stddev-sans-first:2.85 10:24:58 INFO - PROCESS | 14405 | Values: 73.0 72.0 80.0 78.0 73.0 72.0 73.0 73.0 73.0 73.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:115.50 stddev:9.55 (8.3%) stddev-sans-first:10.00 10:24:58 INFO - PROCESS | 14405 | Values: 114.0 116.0 114.0 115.0 113.0 111.0 110.0 119.0 139.0 132.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 10:24:58 INFO - PROCESS | 14405 | Values: 162.0 163.0 163.0 163.0 162.0 162.0 161.0 166.0 163.0 159.0 10:24:58 INFO - PROCESS | 14405 | 10:24:58 INFO - PROCESS | 14405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.09 10:24:58 INFO - PROCESS | 14405 | Values: 66.0 67.0 69.0 67.0 65.0 67.0 68.0 68.0 67.0 67.0 10:24:58 INFO - PROCESS | 14405 | -------- Summary: end -------- 10:24:58 INFO - PROCESS | 14405 | 10:24:59 INFO - TEST-INFO | 14405: exit 0 10:24:59 INFO - TEST-OK | kraken | took 59971ms 10:24:59 INFO - SUITE-END | took 1171s 10:24:59 INFO - Completed test suite (00:19:31) 10:24:59 INFO - javascript benchmark 10:24:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3243.6107667079955, 3309.2554175310543, 3320.933581328373, 3322.667733226679, 3351.4302568563344, 5557.8888422231585, 5575.0522411190095, 5581.386047534773, 5585.748641311141, 5604.663720176793, 5584.46947539983, 5593.580481463886, 5596.300462442195, 5613.101903695409, 5655.688937108468, 5028.371453568295, 5063.797448102072, 5088.440271570124, 5128.53843154116, 5169.844904652848, 5017.272495488152, 5102.974485127569, 5106.693598384109, 5151.845444636649, 5190.325257716491, 5142.485751424865, 5160.406553246387, 5182.093133701606, 5184.403793563732, 5185.2999845021, 5172.9741351293005, 5186.974065129688, 5191.351081114861, 5193.065248255312, 5217.895642087175, 4946.925796113062, 5012.323336349619, 5061.468545802712, 5062.746862656889, 5074.67014644047, 5481.040817856859, 5579.776808927638, 5609.551235901118, 5630.774769009235, 5631.831045068655, 5985.0124729419595, 5995.190649262381, 6027.487663548603, 6043.244594425697, 6050.42520960508, 5874.236349274567, 6054.939450605526, 6084.026555751103, 6105.511559075308, 6138.662373569452, 5686.772529098873, 5703.258576385043, 5722.313322401297, 5725.312962444534, 5734.283214598176, 6208.81373558794, 6211.689415529206, 6215.378462153839, 6218.0, 6218.595791273553, 5761.193432919395, 5974.3726908674835, 6006.489448396847, 6055.091736239599, 6066.211392518944, 6103.481204097613, 6103.969480152571, 6133.355997620186, 6133.478654314434, 6144.324124346318, 6051.243594550681, 6065.969670151621, 6072.423119803611, 6077.3314935357075, 6077.574569780161, 5915.704214789243, 5997.670128142907, 6039.214902062704, 6052.57631965767, 6074.9392506075255, 4633.698809577434, 4639.628829693616, 4644.313998607076, 4649.116667833168, 4649.279361698942, 3983.1237127831832, 4142.1922725068325, 4160.45914031174, 4165.416841642173, 4182.623563879265, 5669.603127781098, 5784.074548072373, 5830.183774271605, 5874.089516125007, 5888.941110588925, 6070.119832624245, 6094.847628809227, 6120.204373431426, 6121.755129794848, 6123.4488895999575, 5700.971495142498, 5753.453421924911, 5765.971170144123, 5767.134929760569, 5845.473907348359, 5228.215767634809, 5244.763985620656, 5245.0, 5249.658772179796, 5292.788288468495, 6257.4681152102585, 6312.495000400048, 6313.936860631335, 6315.8105256841445, 6319.24169099711, 6003.669798160969, 6091.08633704939, 6092.573519853568, 6133.824358647991, 6220.968895155495, 6223.37766223374, 6228.34602366745, 6232.376762323913, 6239.500839932885, 6241.407066328691, 5907.881842363215, 5914.86153892229, 5915.231019967377, 5926.762929482772, 5959.106134079922, 5945.583809133319, 5991.850203744942, 6067.332593414632, 6092.390760923872, 6127.433875357673, 5819.330776960534, 5858.882822343615, 5862.736176872137, 5869.706514674334, 5909.527237820878, 5811.622244554091, 5861.501772349398, 5866.384029676822, 5869.706514674334, 5873.324567674772, 5694.1458781183155, 5847.210626565359, 5903.881922361615, 5919.082542205792, 5956.166136740773, 6000.729967151576, 6019.1573179754, 6032.487238584769, 6039.4262545058145, 6042.939570604238, 5658.236138121301, 5877.147813567094, 5888.086371929226, 5890.587658863838, 5894.145348924468], "value": 5582.40496095404, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.5192809249248, 674.2684187656391, 676.7766637009787, 743.7619961612285, 756.8864670299455, 34298.48552271715, 41556.58443415569, 41558.33766649338, 41563.58436415635, 41730.582694173085, 46213.7689311553, 46705.766471167684, 46812.0, 46908.53091469084, 46971.530284697226, 8199.877001844978, 8840.557972101386, 8996.415233009866, 9027.909720902773, 10488.52801623925, 10508.316959397653, 10605.84091238632, 10639.202059845504, 10645.680629581086, 10654.893451065467, 10697.893021069807, 10768.138548916068, 10769.0, 10769.299995500307, 10772.838407423857, 10599.364038157697, 10627.681169564925, 10657.573697052108, 10676.092532134739, 10677.35935843848, 10474.162067034618, 10563.63027294041, 10596.0, 10954.452277386099, 10959.0, 45865.08269834618, 46326.07347853024, 46354.53645463536, 46400.0, 46454.30318545225, 3952.6245006724316, 3953.0, 4037.253108174997, 4044.4135600337786, 4150.667946564297, 34215.828920855485, 34668.47997280043, 34692.0, 34898.30203395918, 35327.0, 4620.3069539569, 4659.487456379796, 4665.440147182326, 4667.439907211123, 4670.1126785910565, 339734.0, 340744.0, 342157.2892135548, 343174.0, 343291.0, 40054.59945400509, 40876.59123408787, 66677.0, 66840.0, 67235.66382168057, 40394.59605403908, 40637.39043914343, 40680.59319406827, 40725.0, 40771.59228407678, 16467.258973346226, 17623.559411014572, 17938.372156974703, 17942.730859037125, 17964.0, 15014.924925375522, 15047.623809404633, 15049.247537623076, 15059.47291844802, 15083.0, 9306.674266400643, 9411.576479058458, 9427.811443771086, 9468.337216394786, 9502.762430939281, 3566.8394922228044, 3587.0852932502044, 3636.4363523653874, 3657.7073834093208, 3701.6298370162767, 1127.3461392392392, 1150.0856818829052, 1150.8849115088424, 1204.8855358740905, 1289.348878816192, 35293.64706352904, 35701.28597428037, 36024.819875900976, 36046.09884752902, 36119.277614447565, 1201.9278843269433, 1244.3139545915335, 1295.0740220742027, 1303.5111833062601, 1370.2737549098795, 18198.363057293194, 18449.446516604523, 18496.907515462335, 18584.349547766033, 18614.0, 460418.0, 465610.0, 466916.0, 467170.0, 467661.0, 63659.36340636627, 63954.36045639577, 64206.0, 64309.0, 64353.678231609476, 1437.6837095838898, 1516.9089854608537, 1529.3423827754173, 1581.2963231361935, 1642.04761238479, 30477.39045219039, 32496.512552311262, 32570.51144232791, 32630.184245394055, 32973.0, 50604.0, 50915.49084509107, 51020.23469647884, 51064.48935510597, 51135.74432127816, 297090.0, 298273.0, 298650.0, 299060.0, 299127.0, 31285.687143129187, 48122.27816582684, 48596.514034859196, 49327.0, 49816.75091624519, 51398.0, 51992.0, 52420.0, 52581.737091314295, 52586.474135258155, 42297.0, 42873.0, 43446.0, 44257.0, 44447.55552444434, 41808.79095604624, 42009.369859452745, 42078.36882446705, 42419.363709543766, 43397.349039763794, 43615.12769744651, 43627.56372436235, 44094.77952610217, 44381.556184437744, 44456.55543444524, 36157.60059426742, 38332.616673832905, 38428.80785596054, 38891.0, 39115.2176956465, 28892.133236002952, 29368.853155734083, 29592.260193495335, 29766.553501697927, 30023.849880750455], "value": 20491.231157709542, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.67467736536287, 436.71170048357345, 436.76196472922254, 449.54820405492484, 450.1512071786229, 18435.262589496422, 18485.53786155345, 19082.522936926565, 19171.23315067399, 19338.033098345062, 18548.72176917344, 18658.06709664518, 18839.623207535842, 18869.811301886977, 18875.811241887575, 5647.407022262654, 5657.151427285919, 5775.971120144393, 5783.537317014629, 5835.35811060783, 4331.45856767904, 5744.511716504102, 5819.941800582003, 6050.606710563821, 6332.556721029529, 6298.622082675054, 6302.432781049704, 6326.430621244087, 6329.556931014831, 6331.0, 5423.891522169554, 5631.5776316776, 5692.345380281279, 5699.572532060112, 6283.6858157091965, 3921.725479216456, 5484.506394424521, 5545.972270138624, 5562.249096371978, 5727.3699893011735, 13460.326983650779, 13501.459941602325, 13589.456421743218, 13733.862661373358, 13756.105853119516, 2386.6300723387903, 2470.4688491974134, 2574.266334094774, 2884.39427720179, 3140.733037691799, 10289.980361488539, 10413.062824345769, 10922.126229901589, 11670.708232294175, 14843.92578037103, 1973.3093417303971, 1993.2724555537125, 2068.720722702446, 2102.5794841031857, 2145.1419432227076, 79761.60119199425, 81452.0, 81943.59028204822, 82339.17660823376, 82497.58751206266, 11207.551697932155, 11401.942990284995, 11599.76800463986, 11682.532698692126, 11818.0, 16319.755203671955, 16446.917765411097, 16598.0, 16632.584185395463, 16645.83354166467, 8987.19115279628, 8992.190702836777, 8993.910060899307, 9046.231070358961, 9106.681266155652, 8745.300375969908, 8951.104889510996, 8960.327975401871, 8970.23752981004, 9033.277337812959, 4930.309756634074, 5034.546890779848, 5120.615953803405, 5152.0726269271145, 5159.509846564571, 1868.990655046716, 1943.5238366600274, 2038.347728726793, 2048.989755051215, 2072.295419557358, 1014.6550172941088, 1081.9459027048615, 1100.4497751124438, 1135.233717240859, 1155.289496959364, 18071.379649950683, 18655.533611659816, 18841.340553080852, 19109.713354299696, 19380.127894244793, 1096.9012788849043, 1101.8457415961773, 1107.950142243601, 1195.5158160944832, 1219.451246938881, 10699.94650026745, 10786.946065269623, 10799.970066601905, 10802.135829133651, 11027.283226590245, 523867.0, 536959.0, 545581.0, 551654.0, 571246.0, 91553.0, 94220.0, 95272.4816615596, 95652.56521152188, 97698.0, 1119.9328040317607, 1128.4132251229478, 1163.6218229075585, 1173.700706319883, 1176.2413243457922, 16800.915995419946, 16940.66118677644, 17093.145342733063, 17180.828191717923, 17205.74191387105, 38845.22309553737, 39491.605083948794, 40041.0, 40698.79650601728, 41906.7904660487, 55876.0, 57339.71330143323, 57607.71196143993, 57988.71005644945, 58679.0, 8216.21945915137, 8620.82758344817, 8853.380263381501, 8946.507942063248, 9111.544422778967, 10743.677689669323, 13740.793888091886, 13776.517821876587, 13788.862111378758, 13886.652833679238, 11673.066154707773, 11832.76334473323, 11837.526498939946, 11841.230320029515, 11853.881461185623, 11707.121965852424, 11816.054715622902, 11914.285142891455, 12075.456604452645, 12127.514899403925, 12155.635330940086, 12508.749825003631, 12570.37148142571, 12724.554640587536, 12726.427310770852, 8995.865062023944, 9121.361504694607, 9204.907950920406, 9211.815763684555, 9392.859107113261, 12171.513139474322, 12471.563495277622, 12493.0, 12520.561780338008, 12654.0], "value": 9490.327785228948, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1199.658097442229, 1520.407041253911, 1539.0919357579025, 1757.4727581725488, 1890.1494327552605, 8277.958610206948, 8369.832603347944, 8415.663373465062, 8440.957795211016, 8447.281981031612, 8325.084240733515, 8474.152584741523, 8507.404481686284, 8508.234258916696, 8526.91473085269, 2388.8208384371155, 2408.927732168038, 2414.9396265093424, 2416.6858308419883, 2417.4560723837085, 2435.330284171849, 2466.2847774145566, 2499.387650025737, 2502.87485625718, 2506.5112303100905, 2397.3646983549374, 2416.154345978911, 2430.222328854767, 2455.287966489716, 2459.446624509489, 2391.581473242193, 2424.2000139953775, 2438.792702620279, 2451.2891261534132, 2454.7667971542587, 2409.3013026222375, 2470.258922323314, 2481.057198264648, 2483.428811373394, 2485.7389974052644, 6939.965300173517, 8119.26926576605, 8675.349348798802, 8698.434601750865, 8744.475331480131, 5204.141316682742, 5303.098473259555, 5319.9202011969855, 5328.120860058086, 5329.25390445338, 3521.454174602941, 3587.210813620999, 3591.1740299730945, 3680.0983758978955, 3683.778973261586, 1175.1480176871785, 1187.5784096645652, 1190.3572071081605, 1190.422645017166, 1217.6773155113901, 11579.942100289529, 11845.822312665317, 11851.703707407383, 11853.40732963357, 11920.0, 4668.5564871337165, 4684.484706682262, 4720.362751028636, 4750.168720473903, 4753.287006948985, 10360.119389851796, 10377.948110259551, 10394.960503949696, 10403.167746580255, 10418.062374386342, 5355.758990845421, 5384.515393614593, 5391.9460805391445, 5395.379531353866, 5398.6220964532895, 4855.198892182751, 4893.241547560134, 4920.089783390084, 4929.704217746947, 4930.901381972412, 3981.7013723970817, 3987.5613682494904, 3995.780232087263, 4016.8995775105273, 4021.798910054544, 1215.4530461292454, 1220.3166226912956, 1223.614561413152, 1231.1874163052341, 1246.956356527517, 1057.3602970202917, 1071.3357718214756, 1074.0601973273385, 1079.5573814735922, 1088.3089238333557, 5911.527077833763, 6005.909911351333, 6013.30846952606, 6054.909176362358, 6086.452219300284, 971.4414211828085, 979.2068424575974, 994.0854413939194, 998.7103739915489, 1059.5338051257422, 4082.1223436960604, 4087.6116768906904, 4087.9386809197886, 4110.958890411118, 4139.254934111828, 10579.62971296001, 10958.726031849108, 11000.394978276112, 11018.50416731249, 11055.336679799238, 10746.140308775279, 10861.945690271497, 10881.183911206534, 10889.727756805985, 10902.563897444172, 7873.409494287951, 8004.279614834576, 8288.419810613199, 8444.577771111542, 8461.23848853606, 5858.765649373977, 5949.7620095197435, 5970.522358211246, 6022.608530445507, 6031.185789918481, 9033.187013168847, 9527.190188834027, 9586.041395860359, 9594.232461402931, 9728.12446879756, 9878.407295562289, 9946.502674866084, 10021.749456263651, 10053.748656283651, 10169.9491502542, 7814.374850012099, 7854.096778870503, 7915.1293357729455, 7922.207779222032, 7927.445078844657, 8259.710910118118, 8368.079511253636, 8432.915670843458, 8481.27909127731, 8484.533350665526, 7501.324880760758, 7579.734709285369, 7710.807229819299, 7829.491083079582, 7887.921120788718, 7620.161782204064, 7686.50037747567, 7703.961480192564, 7752.0, 7777.455578109478, 7087.61018144007, 7090.645467726697, 7113.786586402209, 7126.35862772353, 7196.0645116134565, 4294.76378799169, 5193.558547523503, 5219.269302297757, 5236.5548928339995, 5284.894302114013, 5035.622328325464, 5161.0968080585, 5291.021161085211, 5291.867703307448, 5324.376065300121], "value": 4694.093087869688, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.44030193502016, 363.6599779206442, 363.83263698698596, 366.8385910199512, 367.9595244523102, 6393.616383017023, 6410.102585638008, 6437.517186211029, 6470.547061705683, 6481.870362592746, 6397.584157029802, 6412.871742565146, 6426.0, 6427.068075129104, 6430.0, 4638.4433867935895, 4753.667243292971, 4876.585490233334, 4881.365422495071, 4896.2410826321975, 4810.951890481103, 4833.32333473314, 4839.3466881970835, 4877.000214955926, 4877.829275975341, 4616.238320677101, 4837.685550439211, 4844.515548445145, 4857.125717370872, 4860.927086093694, 4700.600448961843, 4800.5679488846, 4824.541668541483, 4831.951680483186, 4841.2012018016985, 4219.7046206765535, 4224.324108142682, 4237.576242375769, 4241.194173107131, 4256.2338779019765, 6097.0, 6104.603200791934, 6105.603135796159, 6107.4808641265545, 6107.603005804653, 5697.6866272355, 5698.914516282259, 5705.258316418839, 5713.971430142823, 5719.170720245541, 6592.505562082815, 6767.120274364351, 6774.796756097325, 6775.864482710367, 6788.864222715568, 4758.738269395182, 4760.690555113941, 4769.785359658824, 4770.165221086296, 4780.880477988078, 7047.400970917478, 7112.822179445504, 7123.465740069516, 7135.964320178417, 7137.0, 4938.753062346868, 4952.306677065214, 4955.207166853286, 4963.255511673206, 4966.652334336634, 5030.89938201234, 5040.47075057121, 5042.571381432546, 5047.293378926953, 5052.065367906949, 5528.170774383794, 5737.569682273846, 5740.1102829061565, 5741.110127930094, 5754.712264386764, 6826.214985276657, 6865.897011544831, 6870.62211578368, 6874.862502749917, 6877.965610171917, 1755.2364721346, 1759.9032053236938, 1774.9911250443665, 1779.7330400440037, 1781.287485006008, 1114.8550688410455, 1171.566520387462, 1174.7004513848915, 1200.8619008814098, 1202.296656455983, 6584.539082264196, 6593.3736295051895, 6612.338766123446, 6612.371824676648, 6613.669316534154, 7006.544574602634, 7032.015517827508, 7042.295770422917, 7049.259827718119, 7050.189228238715, 6580.86838263232, 6589.406953374123, 6594.373534514213, 6595.97762346837, 6609.735610575619, 3735.7945313008045, 3775.811209439572, 3813.809309534512, 3821.2357528494413, 3823.063349479395, 7282.271772822782, 7296.744613938593, 7310.926890731024, 7311.0, 7314.0, 7084.326988936146, 7140.5358651687475, 7145.535540189871, 7181.461390395637, 7189.424846012306, 7248.0939882514685, 7261.164966028869, 7266.781996540112, 7280.126384833748, 7290.270972902774, 6842.281560436281, 6991.056207412138, 6994.545354551938, 6994.685239164148, 7002.1947476040905, 6856.9314306856295, 6864.176298844171, 6867.381935625817, 6869.793906182823, 6873.690683919335, 7214.89177662346, 7227.38567221771, 7254.528455650366, 7267.382272506896, 7269.382102521134, 4975.825846095369, 4976.377952755905, 4981.750912454435, 4984.978079493622, 4986.700797952134, 6961.825954351182, 6993.825154371181, 7004.264552222147, 7005.509614326948, 7007.334303241184, 6753.3246675332075, 6929.861402771816, 6945.340192681687, 6962.477814163856, 6974.058502102354, 6886.070380498769, 6921.653917304216, 6926.995585640155, 6933.479989000744, 6938.132733408324, 6803.1836179656775, 6812.82967925786, 6817.795466136024, 6822.658867056528, 6833.384995350442, 6788.558743681645, 6975.093237879043, 6981.057557229912, 6984.755533556505, 6990.580565166107, 6485.156929599122, 6626.469882409299, 6824.624645644537, 6837.726490940307, 6907.930920690729], "value": 5160.0606362488015, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [876.8027193881378, 907.4509921497494, 922.8984811670717, 933.6732143749692, 935.7426707655394, 14678.119312841223, 14978.550643480687, 15084.094954302736, 15195.0, 15220.086794792307, 13738.72522549551, 13794.862051379483, 13815.585532434017, 13826.0, 13828.17030978142, 772.7334069745929, 919.7010971434278, 924.3945215883607, 931.9394239374453, 955.6798472511717, 939.318993729544, 942.2179590939538, 945.4894357047186, 946.6592026870321, 947.6020071569957, 992.1764935103882, 993.9801203975916, 999.1507218863944, 1001.3841487485181, 1001.484235618657, 804.9476784009021, 941.2187884056217, 990.2276224544867, 991.7223177510236, 992.2805965674864, 728.6793810723318, 729.3545212486935, 729.3836707981746, 729.5148726097138, 730.1056206147426, 13948.721025579533, 13967.580972570839, 13980.161190328612, 14009.0, 14017.579472615736, 14384.136951782823, 14701.92649036748, 14822.110673359633, 14864.851351486563, 14934.62663433412, 12020.939895300555, 12154.696132596755, 12180.0, 12222.449989750483, 12360.0, 4095.651869591088, 4104.774237416941, 4115.444415003966, 4169.791510424467, 4238.915221695549, 53303.46696533063, 53468.46531534674, 53503.0, 53938.73030634861, 55929.16106258409, 11263.26788758728, 11626.709332266591, 11743.354115523558, 11876.346800926032, 11912.2257053293, 21274.468138296666, 21329.68005479919, 21331.0, 21337.466563336042, 21343.573128537344, 8534.573271336532, 8698.130186981378, 8716.43343182691, 8735.51954642488, 8920.553972301359, 4787.3537072495465, 4794.976025119922, 4817.445993710698, 4880.267959805987, 5189.377274726981, 3601.7118630509494, 3640.9817950910074, 3642.3807952648112, 3642.617525159873, 3648.179159689049, 584.3075954993346, 627.3788948940517, 713.5005496152714, 721.1526456413693, 721.9241979592172, 802.8314054048715, 835.4861760017545, 847.2078606502816, 851.8126012277413, 853.7268074216191, 9353.90646093544, 9358.485283309346, 9421.24630029596, 9441.669541566012, 9521.761955951019, 808.321010351296, 808.9069756978023, 819.8852160697508, 833.4207725630629, 859.2395729779065, 4680.609614063696, 4738.691985020962, 4753.667243293005, 4797.18447863864, 4988.451270360258, 64349.67825160844, 65776.0, 66058.66970665116, 66209.0, 66422.0, 52351.738241309315, 52621.0, 52831.207531887056, 55545.72227138838, 56460.71769641126, 49943.50056499461, 50682.74658626683, 50978.23532646939, 51379.0, 52362.476375236525, 9157.450552966844, 9223.0, 9329.207017403596, 9334.766630834283, 9349.0, 38659.2268154641, 39578.406323904586, 39700.2059958805, 39838.80080599579, 40403.797981009906, 48027.27959080547, 50282.497175029246, 50596.747016264686, 50851.0, 51312.230316544534, 11812.645620631394, 11892.405379730806, 11977.161598688008, 12010.33943133136, 12363.505459781509, 12984.0, 13062.34688265602, 13414.664633384244, 13453.327333633475, 13968.720625587635, 11198.720031999264, 13036.739265214832, 13162.736745265232, 13220.537281195113, 13984.790228146383, 12263.76478809935, 12612.936935315265, 12763.553275635679, 12774.614727097141, 12822.23066616006, 13463.974071303914, 13714.314284285945, 13772.24252666113, 13815.240161791198, 13823.861761382257, 10209.9489502552, 10713.517891694737, 10898.400587967737, 11136.721581960192, 11373.260738052, 10898.618548350769, 10979.670609881716, 11187.832182517106, 11216.158788090763, 11265.943670281596], "value": 7203.837826306064, "unit": "score"}], "name": "dromaeo_css", "value": 7578.440025477239, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 106.0, 110.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 156.0, 175.0, 125.0, 161.0, 155.0, 126.0, 189.0, 126.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 159.0, 161.0, 160.0, 161.0, 162.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 179.0, 75.0, 73.0, 73.0, 75.0, 170.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 157.0, 92.0, 91.0, 93.0, 146.0, 91.0, 91.0, 139.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 52.0, 53.0, 53.0, 56.0, 78.0, 53.0, 50.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 56.0, 56.0, 58.0, 56.0, 56.0, 56.0, 56.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 80.0, 78.0, 73.0, 72.0, 73.0, 73.0, 73.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 115.0, 113.0, 111.0, 110.0, 119.0, 139.0, 132.0], "value": 118.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 162.0, 162.0, 161.0, 166.0, 163.0, 159.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 67.0, 65.0, 67.0, 68.0, 68.0, 67.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1512.9, "alertThreshold": 2.0}]} 10:24:59 INFO - Return code: 0 10:24:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:24:59 ERROR - # TBPL SUCCESS # 10:24:59 INFO - Running post-action listener: _resource_record_post_action 10:24:59 INFO - Running post-run listener: _resource_record_post_run 10:25:00 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 463527936; Read time: 8; Write time: 404524 10:25:00 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 241995776; Read time: 0; Write time: 272844 10:25:00 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220995584; Read time: 8; Write time: 131680 10:25:00 INFO - Running post-run listener: _upload_blobber_files 10:25:00 INFO - Blob upload gear active. 10:25:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:25:01 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:25:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:25:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:01 INFO - (blobuploader) - INFO - Done attempting. 10:25:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:25:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:25:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:02 INFO - (blobuploader) - INFO - Done attempting. 10:25:02 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:02 INFO - Return code: 0 10:25:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7cceed82135cdbf28a779cac76bdca636d67163ea6d00245f2643d4e67660fb28834309fa078b0a75e672e01e05ef973ef7707bde193c076863f1db8833b112", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf0df878ff59651973e1652098a9ce3e32d42483d329e620573449b802bfa92844d90bbfbe161f20305c32acef6e061a0bed137caf2efdf8ccb4ea4cf70739c0"} 10:25:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:02 INFO - Contents: 10:25:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7cceed82135cdbf28a779cac76bdca636d67163ea6d00245f2643d4e67660fb28834309fa078b0a75e672e01e05ef973ef7707bde193c076863f1db8833b112", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf0df878ff59651973e1652098a9ce3e32d42483d329e620573449b802bfa92844d90bbfbe161f20305c32acef6e061a0bed137caf2efdf8ccb4ea4cf70739c0"} 10:25:02 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:02 INFO - Copying logs to upload dir... 10:25:02 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.303194 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-17 10:25:02.616658) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 10:25:02.619967) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189 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/f7cceed82135cdbf28a779cac76bdca636d67163ea6d00245f2643d4e67660fb28834309fa078b0a75e672e01e05ef973ef7707bde193c076863f1db8833b112", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf0df878ff59651973e1652098a9ce3e32d42483d329e620573449b802bfa92844d90bbfbe161f20305c32acef6e061a0bed137caf2efdf8ccb4ea4cf70739c0"} build_url:https://queue.taskcluster.net/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/EkJXdUS5RHyJ9kOTW3Zaqg/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/f7cceed82135cdbf28a779cac76bdca636d67163ea6d00245f2643d4e67660fb28834309fa078b0a75e672e01e05ef973ef7707bde193c076863f1db8833b112", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf0df878ff59651973e1652098a9ce3e32d42483d329e620573449b802bfa92844d90bbfbe161f20305c32acef6e061a0bed137caf2efdf8ccb4ea4cf70739c0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 10:25:02.646476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:25:02.646971) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1466181960.323048-422625189 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:25:02.729115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 10:25:02.729477) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 10:25:02.729891) ========= ========= Total master_lag: 0.20 =========