builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1466183065.52 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.522372) ========= 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.523077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.523474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.565052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.565350) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1466182122.145889-580421052 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.4K=0.2s 2016-06-17 10:04:26 (58.4 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.320043 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.901921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.902324) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1466182122.145889-580421052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017539 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.956247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:25.957256) ========= 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=7de08804244eb36560b44971000001c3-1466182122.145889-580421052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 10:04:26,164 truncating revision to first 12 chars 2016-06-17 10:04:26,164 Setting DEBUG logging. 2016-06-17 10:04:26,164 attempt 1/10 2016-06-17 10:04:26,164 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,559 unpacking tar archive at: mozilla-beta-d9ea8a5c1694/testing/mozharness/ program finished with exit code 0 elapsedTime=0.740403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:26.714439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:26.714794) ========= script_repo_revision: d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:26.715263) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:26.715637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 10:04:26.727828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-17 10:04:26.728160) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1466182122.145889-580421052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:27 INFO - MultiFileLogger online at 20160617 10:04:27 in /builds/slave/test 10:04:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:27 INFO - {'append_to_log': False, 10:04:27 INFO - 'base_work_dir': '/builds/slave/test', 10:04:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:04:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:27 INFO - 'branch': 'Mozilla-Beta', 10:04:27 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:27 INFO - 'config_files': ('talos/linux_config.py',), 10:04:27 INFO - 'default_actions': ('clobber', 10:04:27 INFO - 'read-buildbot-config', 10:04:27 INFO - 'download-and-extract', 10:04:27 INFO - 'populate-webroot', 10:04:27 INFO - 'create-virtualenv', 10:04:27 INFO - 'install', 10:04:27 INFO - 'run-tests'), 10:04:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:27 INFO - 'download_minidump_stackwalk': True, 10:04:27 INFO - 'download_symbols': 'ondemand', 10:04:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:27 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:27 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:27 INFO - 'installer_path': 'installer.exe', 10:04:27 INFO - 'log_level': 'info', 10:04:27 INFO - 'log_name': 'talos', 10:04:27 INFO - 'log_to_console': True, 10:04:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:27 INFO - 'opt_config_files': (), 10:04:27 INFO - 'pip_index': False, 10:04:27 INFO - 'sps_profile': False, 10:04:27 INFO - 'sps_profile_interval': 0, 10:04:27 INFO - 'suite': 'dromaeojs-e10s', 10:04:27 INFO - 'system_bits': '32', 10:04:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:27 INFO - 'title': 'talos-linux64-ix-003', 10:04:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:27 INFO - 'use_talos_json': True, 10:04:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:27 INFO - 'work_dir': 'build'} 10:04:27 INFO - ##### 10:04:27 INFO - ##### Running clobber 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: clobber 10:04:27 INFO - rmtree: /builds/slave/test/build 10:04:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:28 INFO - Running post-action listener: _resource_record_post_action 10:04:28 INFO - ##### 10:04:28 INFO - ##### Running read-buildbot-config step. 10:04:28 INFO - ##### 10:04:28 INFO - Running pre-action listener: _resource_record_pre_action 10:04:28 INFO - Running main action method: read_buildbot_config 10:04:28 INFO - Using buildbot properties: 10:04:28 INFO - { 10:04:28 INFO - "project": "", 10:04:28 INFO - "product": "firefox", 10:04:28 INFO - "script_repo_revision": "production", 10:04:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:04:28 INFO - "repository": "", 10:04:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:04:28 INFO - "buildid": "20160617071423", 10:04:28 INFO - "pgo_build": "True", 10:04:28 INFO - "basedir": "/builds/slave/test", 10:04:28 INFO - "buildnumber": 40, 10:04:28 INFO - "slavename": "talos-linux64-ix-003", 10:04:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:04:28 INFO - "platform": "ubuntu64_hw", 10:04:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:04:28 INFO - "branch": "mozilla-beta", 10:04:28 INFO - "repo_path": "releases/mozilla-beta", 10:04:28 INFO - "revision": "d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf", 10:04:28 INFO - "stage_platform": "linux64-pgo", 10:04:28 INFO - "builduid": "c80fd51f306c4cf9834fa970e43af5ca", 10:04:28 INFO - "slavebuilddir": "test" 10:04:28 INFO - } 10:04:28 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:28 INFO - Running post-action listener: _resource_record_post_action 10:04:28 INFO - ##### 10:04:28 INFO - ##### Running download-and-extract step. 10:04:28 INFO - ##### 10:04:28 INFO - Running pre-action listener: _resource_record_pre_action 10:04:28 INFO - Running main action method: download_and_extract 10:04:28 INFO - mkdir: /builds/slave/test/build/tests 10:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:28 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:28 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:28 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:28 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:28 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:36 INFO - Downloaded 1327 bytes. 10:04:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:04:36 INFO - Using the following test package requirements: 10:04:36 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:04:36 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:36 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:04:36 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:36 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:04:36 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:36 INFO - u'jsshell-linux-x86_64.zip'], 10:04:36 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:36 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:04:36 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:04:36 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:36 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:04:36 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:36 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:04:36 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:36 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:04:36 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:04:36 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:04:36 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:36 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:36 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:36 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:36 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:36 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:37 INFO - Downloaded 24185717 bytes. 10:04:37 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:37 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:39 INFO - Return code: 0 10:04:39 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:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:39 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:39 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:39 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:39 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:39 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:40 INFO - Downloaded 24185717 bytes. 10:04:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:04:42 INFO - Return code: 0 10:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:42 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:42 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:42 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:42 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:42 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:43 INFO - Downloaded 10840145 bytes. 10:04:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:04:43 INFO - Return code: 0 10:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:43 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:43 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:43 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:43 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:43 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:45 INFO - Downloaded 55997067 bytes. 10:04:45 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:45 INFO - mkdir: /builds/slave/test/properties 10:04:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:04:45 INFO - Writing to file /builds/slave/test/properties/build_url 10:04:45 INFO - Contents: 10:04:45 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:46 INFO - Running post-action listener: _resource_record_post_action 10:04:46 INFO - Running post-action listener: set_extra_try_arguments 10:04:46 INFO - ##### 10:04:46 INFO - ##### Running populate-webroot step. 10:04:46 INFO - ##### 10:04:46 INFO - Running pre-action listener: _resource_record_pre_action 10:04:46 INFO - Running main action method: populate_webroot 10:04:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:46 INFO - '--tppagecycles', 10:04:46 INFO - '7'], 10:04:46 INFO - 'tests': ['tsvgm']}}, 10:04:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:04:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:04:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:04:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:04:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:04:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:46 INFO - 'talos_options': ['--disable-e10s'], 10:04:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:46 INFO - 'talos_options': ['--disable-e10s'], 10:04:46 INFO - 'tests': ['damp', 'tps']}, 10:04:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:46 INFO - 'tests': ['damp', 'tps']}, 10:04:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:04:46 INFO - 'tests': ['dromaeo_dom']}, 10:04:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:04:46 INFO - 'tests': ['a11yr', 10:04:46 INFO - 'ts_paint', 10:04:46 INFO - 'tpaint', 10:04:46 INFO - 'sessionrestore', 10:04:46 INFO - 'sessionrestore_no_auto_restore', 10:04:46 INFO - 'tabpaint']}, 10:04:46 INFO - 'other-e10s': {'tests': ['a11yr', 10:04:46 INFO - 'ts_paint', 10:04:46 INFO - 'tpaint', 10:04:46 INFO - 'sessionrestore', 10:04:46 INFO - 'sessionrestore_no_auto_restore', 10:04:46 INFO - 'tabpaint']}, 10:04:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:04:46 INFO - 'ts_paint', 10:04:46 INFO - 'tpaint', 10:04:46 INFO - 'sessionrestore', 10:04:46 INFO - 'sessionrestore_no_auto_restore', 10:04:46 INFO - 'tabpaint']}, 10:04:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:04:46 INFO - 'ts_paint', 10:04:46 INFO - 'tpaint', 10:04:46 INFO - 'sessionrestore', 10:04:46 INFO - 'sessionrestore_no_auto_restore', 10:04:46 INFO - 'tabpaint']}, 10:04:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:04:46 INFO - 'tests': ['a11yr', 10:04:46 INFO - 'ts_paint', 10:04:46 INFO - 'tpaint', 10:04:46 INFO - 'sessionrestore', 10:04:46 INFO - 'sessionrestore_no_auto_restore', 10:04:46 INFO - 'tabpaint']}, 10:04:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:04:46 INFO - 'tests': ['a11yr', 10:04:46 INFO - 'ts_paint', 10:04:46 INFO - 'tpaint', 10:04:46 INFO - 'sessionrestore', 10:04:46 INFO - 'sessionrestore_no_auto_restore', 10:04:46 INFO - 'tabpaint']}, 10:04:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:04:46 INFO - 'tests': ['tsvgx', 10:04:46 INFO - 'tsvgr_opacity', 10:04:46 INFO - 'tart', 10:04:46 INFO - 'tscrollx', 10:04:46 INFO - 'cart']}, 10:04:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:04:46 INFO - 'tsvgr_opacity', 10:04:46 INFO - 'tart', 10:04:46 INFO - 'tscrollx', 10:04:46 INFO - 'cart']}, 10:04:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:46 INFO - 'talos_options': ['--disable-e10s'], 10:04:46 INFO - 'tests': ['tp5o']}, 10:04:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:46 INFO - 'tests': ['tp5o']}, 10:04:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:46 INFO - 'talos_options': ['--disable-e10s', 10:04:46 INFO - '--xperf_path', 10:04:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:46 INFO - 'tests': ['tp5n']}, 10:04:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:46 INFO - 'talos_options': ['--xperf_path', 10:04:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:46 INFO - 'tests': ['tp5n']}}, 10:04:46 INFO - 'talos.zip': {'path': '', 10:04:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:46 INFO - Running post-action listener: _resource_record_post_action 10:04:46 INFO - ##### 10:04:46 INFO - ##### Running create-virtualenv step. 10:04:46 INFO - ##### 10:04:46 INFO - Running pre-action listener: _resource_record_pre_action 10:04:46 INFO - Running main action method: create_virtualenv 10:04:46 INFO - Creating virtualenv /builds/slave/test/build/venv 10:04:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:04:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:04:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:46 INFO - Using real prefix '/usr' 10:04:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:04:46 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:48 INFO - Installing pip.................done. 10:04:48 INFO - Return code: 0 10:04:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f923740ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b410>, '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 0x231c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', '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:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:04:48 INFO - Using env: {'DISPLAY': ':0', 10:04:48 INFO - 'HOME': '/home/cltbld', 10:04:48 INFO - 'LANG': 'en_US.UTF-8', 10:04:48 INFO - 'LANGUAGE': 'en_US:en', 10:04:48 INFO - 'LOGNAME': 'cltbld', 10:04:48 INFO - 'MAIL': '/var/mail/cltbld', 10:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:48 INFO - 'MOZ_NO_REMOTE': '1', 10:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:48 INFO - 'NO_EM_RESTART': '1', 10:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:48 INFO - 'PWD': '/builds/slave/test', 10:04:48 INFO - 'SHELL': '/bin/bash', 10:04:48 INFO - 'SHLVL': '1', 10:04:48 INFO - 'TERM': 'linux', 10:04:48 INFO - 'TMOUT': '86400', 10:04:48 INFO - 'USER': 'cltbld', 10:04:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', 10:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:48 INFO - '_': '/tools/buildbot/bin/python'} 10:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:04:48 INFO - Cleaning up... 10:04:48 INFO - Return code: 0 10:04:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f923740ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b410>, '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 0x231c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', '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:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:04:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:04:48 INFO - Using env: {'DISPLAY': ':0', 10:04:48 INFO - 'HOME': '/home/cltbld', 10:04:48 INFO - 'LANG': 'en_US.UTF-8', 10:04:48 INFO - 'LANGUAGE': 'en_US:en', 10:04:48 INFO - 'LOGNAME': 'cltbld', 10:04:48 INFO - 'MAIL': '/var/mail/cltbld', 10:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:48 INFO - 'MOZ_NO_REMOTE': '1', 10:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:48 INFO - 'NO_EM_RESTART': '1', 10:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:48 INFO - 'PWD': '/builds/slave/test', 10:04:48 INFO - 'SHELL': '/bin/bash', 10:04:48 INFO - 'SHLVL': '1', 10:04:48 INFO - 'TERM': 'linux', 10:04:48 INFO - 'TMOUT': '86400', 10:04:48 INFO - 'USER': 'cltbld', 10:04:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', 10:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:48 INFO - '_': '/tools/buildbot/bin/python'} 10:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:49 INFO - Downloading/unpacking psutil>=0.7.1 10:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:51 INFO - Installing collected packages: psutil 10:04:51 INFO - Running setup.py install for psutil 10:04:51 INFO - building 'psutil._psutil_linux' extension 10:04:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:04:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:04:51 INFO - building 'psutil._psutil_posix' extension 10:04:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:04:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:04:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:51 INFO - Successfully installed psutil 10:04:51 INFO - Cleaning up... 10:04:51 INFO - Return code: 0 10:04:51 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x7f923740ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b410>, '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 0x231c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', '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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 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': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', 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 - Downloading/unpacking mozsystemmonitor==0.0.0 10:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:04:53 INFO - Installing collected packages: mozsystemmonitor 10:04:53 INFO - Running setup.py install for mozsystemmonitor 10:04:54 INFO - Successfully installed mozsystemmonitor 10:04:54 INFO - Cleaning up... 10:04:54 INFO - Return code: 0 10:04:54 INFO - Installing blobuploader==1.2.4 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', '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 0x7f923740ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b410>, '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 0x231c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', 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 blobuploader==1.2.4 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 blobuploader-1.2.4.tar.gz 10:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:04:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:56 INFO - Downloading docopt-0.6.1.tar.gz 10:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:56 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:56 INFO - Running setup.py install for blobuploader 10:04:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:04:57 INFO - Running setup.py install for requests 10:04:57 INFO - Running setup.py install for docopt 10:04:57 INFO - Successfully installed blobuploader requests docopt 10:04:57 INFO - Cleaning up... 10:04:57 INFO - Return code: 0 10:04:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f923740ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b410>, '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 0x231c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', '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:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:04:57 INFO - Using env: {'DISPLAY': ':0', 10:04:57 INFO - 'HOME': '/home/cltbld', 10:04:57 INFO - 'LANG': 'en_US.UTF-8', 10:04:57 INFO - 'LANGUAGE': 'en_US:en', 10:04:57 INFO - 'LOGNAME': 'cltbld', 10:04:57 INFO - 'MAIL': '/var/mail/cltbld', 10:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:57 INFO - 'MOZ_NO_REMOTE': '1', 10:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:57 INFO - 'NO_EM_RESTART': '1', 10:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:57 INFO - 'PWD': '/builds/slave/test', 10:04:57 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': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:57 INFO - Running setup.py (path:/tmp/pip-JRtjPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:57 INFO - Running setup.py (path:/tmp/pip-jdl0_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:57 INFO - Running setup.py (path:/tmp/pip-OBUWRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:57 INFO - Running setup.py (path:/tmp/pip-u4PAcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:58 INFO - Running setup.py (path:/tmp/pip-UzUOE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:58 INFO - Running setup.py (path:/tmp/pip-5VorUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:58 INFO - Running setup.py (path:/tmp/pip-uuPzLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:58 INFO - Running setup.py (path:/tmp/pip-J07O5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:58 INFO - Running setup.py (path:/tmp/pip-mCTG5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:58 INFO - Running setup.py (path:/tmp/pip-TtYRD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:58 INFO - Running setup.py (path:/tmp/pip-hlEGdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:58 INFO - Running setup.py (path:/tmp/pip-2WxeT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:58 INFO - Running setup.py (path:/tmp/pip-Zb3PCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:58 INFO - Running setup.py (path:/tmp/pip-hojvKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:58 INFO - Running setup.py (path:/tmp/pip-knv6HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:58 INFO - Running setup.py (path:/tmp/pip-P4muv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:58 INFO - Running setup.py (path:/tmp/pip-VxB568-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:58 INFO - Running setup.py install for manifestparser 10:04:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Running setup.py install for mozcrash 10:04:59 INFO - Running setup.py install for mozdebug 10:04:59 INFO - Running setup.py install for mozdevice 10:04:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Running setup.py install for mozfile 10:04:59 INFO - Running setup.py install for mozhttpd 10:04:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Running setup.py install for mozinfo 10:04:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Running setup.py install for mozInstall 10:04:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:04:59 INFO - Running setup.py install for mozleak 10:04:59 INFO - Running setup.py install for mozlog 10:04:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:00 INFO - Running setup.py install for moznetwork 10:05:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:00 INFO - Running setup.py install for mozprocess 10:05:00 INFO - Running setup.py install for mozprofile 10:05:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:00 INFO - Running setup.py install for mozrunner 10:05:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:00 INFO - Running setup.py install for mozscreenshot 10:05:00 INFO - Running setup.py install for moztest 10:05:00 INFO - Running setup.py install for mozversion 10:05:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 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', '--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 0x7f923740ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b410>, '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 0x231c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', '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', '--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 --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': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', 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-RVyrcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:01 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:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:01 INFO - Running setup.py (path:/tmp/pip-npcfc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:01 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:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:01 INFO - Running setup.py (path:/tmp/pip-6zu6Rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:01 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:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:01 INFO - Running setup.py (path:/tmp/pip-IuroDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:01 INFO - Running setup.py (path:/tmp/pip-4NLITe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:01 INFO - Running setup.py (path:/tmp/pip-w2nvFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:01 INFO - Running setup.py (path:/tmp/pip-tks5UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:01 INFO - Running setup.py (path:/tmp/pip-S7EJUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:01 INFO - Running setup.py (path:/tmp/pip-NXNdSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:01 INFO - Running setup.py (path:/tmp/pip-zExvnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:01 INFO - Running setup.py (path:/tmp/pip-Md9Fj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:01 INFO - Running setup.py (path:/tmp/pip-VfdBa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:01 INFO - Running setup.py (path:/tmp/pip-AujXxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:01 INFO - Running setup.py (path:/tmp/pip-DVff9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:02 INFO - Running setup.py (path:/tmp/pip-92tava-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:02 INFO - Running setup.py (path:/tmp/pip-vzWrBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:02 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:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:02 INFO - Running setup.py (path:/tmp/pip-iyOlYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:04 INFO - Downloading blessings-1.6.tar.gz 10:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:04 INFO - Installing collected packages: blessings 10:05:04 INFO - Running setup.py install for blessings 10:05:04 INFO - Successfully installed blessings 10:05:04 INFO - Cleaning up... 10:05:04 INFO - Return code: 0 10:05:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:04 INFO - Reading from file tmpfile_stdout 10:05:04 INFO - Current package versions: 10:05:04 INFO - argparse == 1.2.1 10:05:04 INFO - blessings == 1.6 10:05:04 INFO - blobuploader == 1.2.4 10:05:04 INFO - docopt == 0.6.1 10:05:04 INFO - manifestparser == 1.1 10:05:04 INFO - mozInstall == 1.12 10:05:04 INFO - mozcrash == 0.17 10:05:04 INFO - mozdebug == 0.1 10:05:04 INFO - mozdevice == 0.48 10:05:04 INFO - mozfile == 1.2 10:05:04 INFO - mozhttpd == 0.7 10:05:04 INFO - mozinfo == 0.9 10:05:04 INFO - mozleak == 0.1 10:05:04 INFO - mozlog == 3.1 10:05:04 INFO - moznetwork == 0.27 10:05:04 INFO - mozprocess == 0.22 10:05:04 INFO - mozprofile == 0.28 10:05:04 INFO - mozrunner == 6.11 10:05:04 INFO - mozscreenshot == 0.1 10:05:04 INFO - mozsystemmonitor == 0.0 10:05:04 INFO - moztest == 0.7 10:05:04 INFO - mozversion == 1.4 10:05:04 INFO - psutil == 3.1.1 10:05:04 INFO - requests == 1.2.3 10:05:04 INFO - wsgiref == 0.1.2 10:05:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f923740ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b410>, '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 0x231c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', '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:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:05:04 INFO - Using env: {'DISPLAY': ':0', 10:05:04 INFO - 'HOME': '/home/cltbld', 10:05:04 INFO - 'LANG': 'en_US.UTF-8', 10:05:04 INFO - 'LANGUAGE': 'en_US:en', 10:05:04 INFO - 'LOGNAME': 'cltbld', 10:05:04 INFO - 'MAIL': '/var/mail/cltbld', 10:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:04 INFO - 'MOZ_NO_REMOTE': '1', 10:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:04 INFO - 'NO_EM_RESTART': '1', 10:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:04 INFO - 'PWD': '/builds/slave/test', 10:05:04 INFO - 'SHELL': '/bin/bash', 10:05:04 INFO - 'SHLVL': '1', 10:05:04 INFO - 'TERM': 'linux', 10:05:04 INFO - 'TMOUT': '86400', 10:05:04 INFO - 'USER': 'cltbld', 10:05:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', 10:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:04 INFO - '_': '/tools/buildbot/bin/python'} 10:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:05:04 INFO - Cleaning up... 10:05:04 INFO - Return code: 0 10:05:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f923740ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b410>, '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 0x231c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', '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:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:05:04 INFO - Using env: {'DISPLAY': ':0', 10:05:04 INFO - 'HOME': '/home/cltbld', 10:05:04 INFO - 'LANG': 'en_US.UTF-8', 10:05:04 INFO - 'LANGUAGE': 'en_US:en', 10:05:04 INFO - 'LOGNAME': 'cltbld', 10:05:04 INFO - 'MAIL': '/var/mail/cltbld', 10:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:04 INFO - 'MOZ_NO_REMOTE': '1', 10:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:04 INFO - 'NO_EM_RESTART': '1', 10:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:04 INFO - 'PWD': '/builds/slave/test', 10:05:04 INFO - 'SHELL': '/bin/bash', 10:05:04 INFO - 'SHLVL': '1', 10:05:04 INFO - 'TERM': 'linux', 10:05:04 INFO - 'TMOUT': '86400', 10:05:04 INFO - 'USER': 'cltbld', 10:05:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', 10:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:04 INFO - '_': '/tools/buildbot/bin/python'} 10:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:05 INFO - Downloading/unpacking jsonschema 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:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:06 INFO - Downloading/unpacking functools32 (from jsonschema) 10:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:07 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:07 INFO - warning: no files found matching '*.txt' 10:05:07 INFO - no previously-included directories found matching 'build' 10:05:07 INFO - no previously-included directories found matching 'dist' 10:05:07 INFO - no previously-included directories found matching '.git*' 10:05:07 INFO - Installing collected packages: jsonschema, functools32 10:05:07 INFO - Running setup.py install for functools32 10:05:07 INFO - warning: no files found matching '*.txt' 10:05:07 INFO - no previously-included directories found matching 'build' 10:05:07 INFO - no previously-included directories found matching 'dist' 10:05:07 INFO - no previously-included directories found matching '.git*' 10:05:07 INFO - Successfully installed jsonschema functools32 10:05:07 INFO - Cleaning up... 10:05:07 INFO - Return code: 0 10:05:07 INFO - Installing flake8 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f923740ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x228c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231b410>, '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 0x231c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', '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', 'flake8'] 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 flake8 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': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', 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 flake8 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 flake8-2.5.0-py2.py3-none-any.whl 10:05:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 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:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:05:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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 - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:10 INFO - no previously-included directories found matching 'docs/_build' 10:05:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:05:10 INFO - Running setup.py install for pep8 10:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:10 INFO - no previously-included directories found matching 'docs/_build' 10:05:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:05:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:05:10 INFO - Cleaning up... 10:05:10 INFO - Return code: 0 10:05:10 INFO - Running post-action listener: _resource_record_post_action 10:05:10 INFO - Running post-action listener: _start_resource_monitoring 10:05:10 INFO - Starting resource monitoring. 10:05:10 INFO - ##### 10:05:10 INFO - ##### Running install step. 10:05:10 INFO - ##### 10:05:10 INFO - Running pre-action listener: _resource_record_pre_action 10:05:10 INFO - Running main action method: install 10:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:10 INFO - Reading from file tmpfile_stdout 10:05:10 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:10 INFO - Reading from file tmpfile_stdout 10:05:10 INFO - Output received: 10:05:10 INFO - Usage: mozinstall [options] installer 10:05:10 INFO - Options: 10:05:10 INFO - -h, --help show this help message and exit 10:05:10 INFO - -d DEST, --destination=DEST 10:05:10 INFO - Directory to install application into. [default: 10:05:10 INFO - "/builds/slave/test"] 10:05:10 INFO - --app=APP Application being installed. [default: firefox] 10:05:10 INFO - mkdir: /builds/slave/test/build/application 10:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:05:24 INFO - Reading from file tmpfile_stdout 10:05:24 INFO - Output received: 10:05:24 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:24 INFO - Running post-action listener: _resource_record_post_action 10:05:24 INFO - ##### 10:05:24 INFO - ##### Running run-tests step. 10:05:24 INFO - ##### 10:05:24 INFO - Running pre-action listener: _resource_record_pre_action 10:05:24 INFO - Running main action method: run_tests 10:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:24 INFO - Python 2.7.3 10:05:24 INFO - Return code: 0 10:05:24 INFO - grabbing minidump binary from tooltool 10:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:24 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 0x231b410>, '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 0x231c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:24 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:24 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:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:24 INFO - Return code: 0 10:05:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:05:25 INFO - Return code: 0 10:05:25 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-e10s', '--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-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:05:25 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-e10s --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-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:05:25 INFO - Using env: {'DISPLAY': ':0', 10:05:25 INFO - 'HOME': '/home/cltbld', 10:05:25 INFO - 'LANG': 'en_US.UTF-8', 10:05:25 INFO - 'LANGUAGE': 'en_US:en', 10:05:25 INFO - 'LOGNAME': 'cltbld', 10:05:25 INFO - 'MAIL': '/var/mail/cltbld', 10:05:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:25 INFO - 'MOZ_NO_REMOTE': '1', 10:05:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:25 INFO - 'NO_EM_RESTART': '1', 10:05:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:25 INFO - 'PWD': '/builds/slave/test', 10:05:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:25 INFO - 'SHELL': '/bin/bash', 10:05:25 INFO - 'SHLVL': '1', 10:05:25 INFO - 'TERM': 'linux', 10:05:25 INFO - 'TMOUT': '86400', 10:05:25 INFO - 'USER': 'cltbld', 10:05:25 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1466182122.145889-580421052', 10:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:25 INFO - '_': '/tools/buildbot/bin/python'} 10:05:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--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-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:05:25 INFO - mozversion application_buildid: 20160617071423 10:05:25 INFO - mozversion application_changeset: d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf 10:05:25 INFO - mozversion application_display_name: Firefox 10:05:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:25 INFO - mozversion application_name: Firefox 10:05:25 INFO - mozversion application_remotingname: firefox 10:05:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:05:25 INFO - mozversion application_vendor: Mozilla 10:05:25 INFO - mozversion application_version: 48.0 10:05:25 INFO - mozversion platform_buildid: 20160617071423 10:05:25 INFO - mozversion platform_changeset: d9ea8a5c1694f3bb8a6e819c90f97f0fd0565adf 10:05:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:05:25 INFO - mozversion platform_version: 48.0 10:05:25 INFO - using testdate: 1466183125 10:05:25 INFO - actual date: 1466183125 10:05:25 INFO - starting webserver on 'localhost:58314' 10:05:25 INFO - SUITE-START | Running 2 tests 10:05:25 INFO - TEST-START | dromaeo_css 10:05:25 INFO - operating with platform_type : linux_ 10:05:25 INFO - Initialising browser for dromaeo_css test... 10:05:25 INFO - TEST-INFO | started process 20420 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzqHSkF/profile http://localhost:58314/getInfo.html) 10:05:28 INFO - PROCESS | 20420 | 10:05:28 INFO - PROCESS | 20420 | (process:20497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:05:29 INFO - PROCESS | 20420 | __metrics Screen width/height:1600/1200 10:05:29 INFO - PROCESS | 20420 | colorDepth:24 10:05:29 INFO - PROCESS | 20420 | Browser inner width/height: 1024/697 10:05:29 INFO - PROCESS | 20420 | __metrics 10:05:30 ERROR - PROCESS | 20420 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 10:05:31 INFO - TEST-INFO | 20420: exit 0 10:05:31 INFO - Browser initialized. 10:05:31 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:31 INFO - TEST-INFO | started process 20547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzqHSkF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:32 INFO - PROCESS | 20547 | 10:05:32 INFO - PROCESS | 20547 | (process:20615): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:05:42 INFO - PROCESS | 20547 | RSS: Main: 151314432 10:05:42 INFO - PROCESS | 20547 | 10:06:32 INFO - PROCESS | 20547 | 1466183192507 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:40 INFO - PROCESS | 20547 | Cycle 1(1): loaded http://localhost:58314/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58314/tests/dromaeo/cssquery-ext.html) 10:08:41 INFO - PROCESS | 20547 | RSS: Main: 155054080 10:08:41 INFO - PROCESS | 20547 | 10:11:42 INFO - PROCESS | 20547 | Cycle 1(1): loaded http://localhost:58314/tests/dromaeo/cssquery-ext.html (next: http://localhost:58314/tests/dromaeo/cssquery-jquery.html) 10:11:43 INFO - PROCESS | 20547 | RSS: Main: 153059328 10:11:43 INFO - PROCESS | 20547 | 10:14:45 INFO - PROCESS | 20547 | Cycle 1(1): loaded http://localhost:58314/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58314/tests/dromaeo/cssquery-mootools.html) 10:14:46 INFO - PROCESS | 20547 | RSS: Main: 152309760 10:14:46 INFO - PROCESS | 20547 | 10:17:47 INFO - PROCESS | 20547 | Cycle 1(1): loaded http://localhost:58314/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58314/tests/dromaeo/cssquery-prototype.html) 10:17:48 INFO - PROCESS | 20547 | RSS: Main: 154107904 10:17:48 INFO - PROCESS | 20547 | 10:20:50 INFO - PROCESS | 20547 | Cycle 1(1): loaded http://localhost:58314/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58314/tests/dromaeo/cssquery-yui.html) 10:20:51 INFO - PROCESS | 20547 | RSS: Main: 152494080 10:20:51 INFO - PROCESS | 20547 | 10:23:53 INFO - PROCESS | 20547 | Cycle 1(1): loaded http://localhost:58314/tests/dromaeo/cssquery-yui.html (next: http://localhost:58314/tests/dromaeo/cssquery-dojo.html) 10:23:53 INFO - PROCESS | 20547 | RSS: Main: 156549120 10:23:53 INFO - PROCESS | 20547 | 10:23:53 INFO - PROCESS | 20547 | __start_tp_report 10:23:53 INFO - PROCESS | 20547 | _x_x_mozilla_page_load 10:23:53 INFO - PROCESS | 20547 | _x_x_mozilla_page_load_details 10:23:53 INFO - PROCESS | 20547 | |i|pagename|runs| 10:23:53 INFO - PROCESS | 20547 | |0;dojo.html;3329.866805327787;3419.5212670226156;3425.8972230833074;3459;3464.705500032497;5654.886902261952;5662.518685911702;5669.348024977129;5680.886382272352;5714.3999880012625;5669.716514174285;5677.716114194294;5696.316442026952;5697.4587414195685;5702.087665973445;5141.4087379951225;5154.046501397253;5202.76587553561;5218.973905130469;5234.555062819665;5165.018646457161;5234.37187537496;5297.152455607104;5313.787448502075;5315.335583052119;5276.683398996053;5277.287566178575;5313.760880760375;5326.893462130755;5336.91994620081;5269.8946021079555;5280.973595132;5289.497497737709;5289.814856480043;5313;4982.302477653131;5106.591472682177;5173.17229243323;5195.9480405195845;5255.290535777659;5541.168824676291;5546.195801608785;5565.66606003637;5574.052411090124;5622.775088996476;6102.176206212193;6104.938950610526;6123.877522449526;6142.04798256271;6143.078538219303;6095.573309868311;6169.722362493699;6229.065640153968;6239.126522286883;6240.656763877985;5715.057015592422;5721.941440833459;5727.427257274281;5731.226284451587;5758.6544807311275;6221.657808820558;6225.719842607094;6229.283632382243;6239.500839932794;6254.655993920287;5879.764809407576;5989.520838332923;6090;6120.538559592164;6148.262208535004;6117.401149625483;6118.739199075686;6123.496663127952;6126.733522497775;6127.617148554337;6023.337432882379;6065.4541091302;6071.969640151771;6077.36187700294;6082;6067.605605635619;6112.449879510866;6140.048292514667;6269.310375858652;6279.403456671609;4638.5593368629925;4646.697964632288;4649.790759415834;4656.045510670305;4686.414198225222;4116.259073366823;4182.498100227992;4187.392828039917;4187.874363769091;4211.284081706117;5713.428657134336;5913.58604897653;5979.312379076375;6055.5458340623745;6061.8484537886025;6241.96879015602;6266.091416744638;6266.404691554295;6270.874582508324;6273.686315684197;5808.39011903744;5963.284405871236;5966.075258334965;5971.4028597140805;5982.4316689914385;5252.395974462909;5267.578593712494;5302.867428314323;5307.28351672527;5334.386545547234;6425.74297028123;6427.550071495044;6429.807105786834;6429.9678501607195;6448.774292899726;6012.669303188367;6138.109974053827;6209.844753881189;6213.00591905302;6214.347493513116;6385.3295403983775;6412.743490260337;6423.64669943139;6428.582142160744;6429.196350456193;6038.758449661965;6119.204503414528;6125.509959203342;6128.8774224516155;6129.1112788644505;5902.380250073852;6210.689465526796;6235.657038862906;6252.5935814171935;6258.374162583706;5937.673427961504;5952.702364881825;5993.850153746017;6025.0661147522205;6056.454919057306;6024.668643224665;6025.939740602713;6026.0659597762415;6026.819195424145;6034.487068599043;5882.176495290748;5944.791932282523;5952.73212705438;5970.164177015135;6051.334353221054;6079.969600151971;6097.237845269341;6112.908306375497;6124.142620033288;6125.724342404514;5932.525397968066;5944.762209511571;5973.313068997121;5984.551158663031;5985.132155837467 10:23:53 INFO - PROCESS | 20547 | |1;ext.html;674.0967104080532;677.3768133317348;678.396227357652;678.4267294136453;744.9979777199668;39572.60427395725;40824.79587602058;40837.979050523754;40872.38691419631;40893.79553102238;43033.35449968245;43635.78182109085;43745;43775;43919;8850.999999999984;9000.189982901538;9017.278617710568;9020.41367311126;9029.503377314246;8813.911860881406;8863.202311791938;8902.465852048897;9111.088891110901;9162.770930726752;9135.223506001998;9143.725688229364;9159.313051521129;9206;9223.677171299007;9019.503927283997;9127.634894604242;9159.129882661136;9175.724728258163;9186.586603602855;9092.090790920922;9174.449533027973;9202.631894724203;9207.677731279373;9212.631494740202;43958.78020609877;44102.33846492305;44221.77889110566;44222.55777442217;44293.778531107135;3943.842246310144;3976.304146774303;4066.5323487798987;4115.814788334532;4150.024744185144;33235.169120772174;33480;33677.66322336794;34470.48294275588;35058.64941350605;4360.956390436118;4443.133588950156;4446.155230506226;4470.485894122185;4510.548945105496;305930;307145.46427267947;307968;308689;309688;39804.402933956015;62193;62338.68830655818;62393.37606623876;62431.68784156141;38112.23775524474;38135.23729525394;38167.427488587695;38170.42744358837;38287;16843.32626694943;17142.40001599963;17143.142842857807;17151.142442877805;17158.39945601898;13424.798628020588;13461.596152115451;13475.258860762751;13500.797488037491;13507.797383039262;9472.194863436547;9512.857307140399;9535.094166054214;9589.232861371074;9603.087706667855;3652.698799756137;3653.415453527423;3693.8891833245048;3714.294284086069;3729.1050147964293;1215.5684731920219;1229.8278241046082;1261.1172179474404;1274.3691872522975;1295.3587973952954;34918.65081349205;35523.82238088793;35590.8220458896;36533.817330913706;38524.229515410094;1160.953561857533;1184.1474138620179;1212.8241404996227;1270.9110362274553;1358.2393859438548;16825.32698692063;17037.31850725957;17054.488365349058;17146.571335716457;17247;401811;535860;539363;544338;900134;58809.70595147082;59917;60031;60143;60216.698916506015;1528.9923550382177;1556.5408204579676;1561.9140947247784;1579.1393690438738;1579.8262191158963;30638.540421893245;31397.68602314039;32027;32098.67901320957;32463.513047303837;54523;61711;63137;63377.68311158415;63486.682566586875;302542;305801;306634;307062;307828;42565.787171063945;42855.14289714126;43021.56978430301;43064.35403468888;51424;49151.75424122856;49655.503444965085;49679.25481117714;50376;51271.48728512667;40980.3852942212;43489.34765978576;44993.32510012418;45989.080218394774;46188;42687.573124269606;43785.12429751451;44075.11849763051;44397.112057758015;45296.547034529234;42931.570684292754;43891.12217755563;44026.779866101744;44221.33667995047;44300.556994429644;38091.61908380881;38284.2343153141;38349;38556.807215964865;38798;30321;30328.696713032587;30625.540616890317;30674.539881901343;30962.845185773927 10:23:53 INFO - PROCESS | 20547 | |2;jquery.html;437.2151987183006;438.45193508114846;440.8280770499506;444.3778709806273;450.28854410032153;19343.129559169836;19682.311119110833;20313;20318.08568614412;20490.077946492405;19573.804261957375;19710.802891971078;19925.402237932885;20006.09972551235;20166.798332016675;5483.890322193553;5715.457031582014;5737.082066869301;5753.280839895013;5772.191893134965;5746.9712651436685;5824.970875145618;5847.093700476412;5861.8827623447505;6040.395960403968;6036.336003039684;6042.640405908679;6051.727672254759;6057.787977420791;6075.605085669439;5941.168236446879;6037.577369584131;6043.939560604404;6721.756475052082;6725.93274067258;5997.6701281429505;6008.3390827009;6022.5483088768515;6052.757889684407;6066.302375226861;13907.58277251674;13964.581062568139;14324.212168330738;14327.713445731131;14370.281485925661;2546.1852207293673;2579.342267721719;2589.2102908612865;2735.37086470113;3045.6802035786145;10663.146948244123;10774.461276936121;10778;10795.6221532246;11042.227044106916;2055.3011975928257;2080.8023237792536;2123.883186424746;2158.4819643285655;2170.6309927312395;72414.63792681003;76732;76820;77126.61436692836;78081.60959195225;11408.429578521207;11465.656030319104;11469.139814513945;11622.535098595961;11745.823812642817;16125.11311877858;16149.434769783002;16319.67360652804;16321.102339371448;16357.182140892908;8891.555422228863;9003.324750643596;9031.63873445068;9127.224185944136;9162.908370916339;8912.287017038621;8944.8658270126;9002.774930626656;9085.545722713838;9097.636094556276;4279.7218180818145;4450.666200035011;5023.773930173151;5169.405518365361;5182.922256166161;2110.5989861926187;2112.9471763205734;2202.306273523835;2203.2839327218717;2221.7778222177653;1057.862477877871;1073.3613499967507;1141.4178768827958;1165.1145129701488;1166.0205427440821;19175.712364314546;19318.227270909007;19589.51026224356;19603.901980490293;19935.60128797416;1110.5058249079082;1116.7822274656364;1142.657202839145;1160.5183848702693;1173.284296579086;10945;11059.944700276446;11077;11246.7188320291;11261.155413344031;509925;511771;512464;530689;532725;85475.57262213649;85537.14462855292;88420;90112.5494372524;92362;1122.0911062039775;1141.132739118276;1142.714321419645;1161.732801455653;1162.1980833225048;17447.912760436117;17751.911240443715;17923.641527169646;18010.81989180144;18152.81847181564;38045.57340306313;38903.90195746088;39273.60726392699;39934.201315974096;40736.3889541663;54709;55788.44211557833;56539;56648.433515664314;56688.43311566996;9302.348835581715;9325;9450.716478505656;9497.701446794863;9517.048295170427;12396.31820249895;13139.211647301192;13337.66655833612;13679.726405471636;14167.64580885486;12207.389630518615;12271.263724176579;12400.317982510687;12437.564685235973;12648.747025059263;11829.290242585472;12099.758004839678;12247.020238381087;12427.627171184879;12437.315947622606;12482.500699971899;12554.309512976874;12561.37193140321;12742.426590803621;13040.608781736562;8605.612747426256;8854.158854908774;8999.41503802277;9273;9342;9149.908500915171;11437.256578322382;12366;12622.305773182563;12777.105602607728 10:23:53 INFO - PROCESS | 20547 | |3;mootools.html;1487.583476626545;1492.2389581313528;1720.587059105815;1887.4998125496736;1921.9903900480494;7205.747798827029;8299;8499.872501912469;8650.783730406734;8660.263877570405;8408.747737567868;8440.95779521103;8453.365997550192;8512.659493620264;8534.317254619631;2423.369923819802;2443.2670198940336;2448.6449464827588;2457.619069044301;2459.016393442628;2404.63930410439;2421.9394515137174;2446.877656117196;2453.178185307915;2455.545724041049;2415.4444477770126;2418.2745176446997;2435.549423356676;2451.240115564172;2463.5688754467988;2397.0531640002278;2415.2029830156007;2420.261820144855;2428.8178386621075;2430.1251549442277;2406.193925035115;2424.3696638873844;2457.8402403843693;2460.8892599833052;2473.703155621319;8673.783155421102;8700.956495217546;8721.825563488757;8727.127287271285;8762.255208307302;5350.705711185883;5397.568194544427;5438.15708565173;5458.181272809071;5463.7814487420455;3570.892873213808;3584.6594573515476;3638.6543278388513;3691.741578089535;3725.8882233533036;1120.4061847220985;1135.409587014756;1147.9196456248067;1156;1157.953681852725;12367.010639148937;12417.379131043412;12420.81368779469;12425.62723118308;12451.003919686404;4697.389339385858;4781.593564546983;4814.470408255089;4839.854804355875;4880.438749543777;10326.380417174994;10400.115990140772;10411.739706507398;10422.739431514121;10431.739206519898;5386.353637563518;5397.568194544427;5403.864903377447;5426.457354264542;5427.810026649048;4945.2582112683385;4961.3798275215595;5014.674046186986;5053.646244762905;5072.822451214263;3913.295606790748;3958.2281455116554;4024.3762216856435;4040.373742069984;4119.032027473541;1246.1214843535286;1261.4323554400557;1268.6003908768707;1270.0347735720734;1281.0392205845617;894.5348418822176;964.262339310428;1091.1761619976867;1091.3615534912165;1116.832475128721;6149.385061493815;6202.193714817045;6205.627662340274;6295.496360291166;6364.236291645032;432.3234138573123;433.9479262488522;436.382518735985;442.54417949512055;448.3230322213481;4275.978620106879;4277.871663850089;4301.268784306612;4326.264535029052;4359.760213188241;10401.895981040092;10651.893481065244;10752.086072683753;10799.298045627009;10839;10718.035376816124;10721.571137154582;10724.839127413095;10742.624008159833;10770.192235582363;8187.3040791533385;8223.95888020556;8328.625211865481;8380.24577788002;8387.454815436977;6064.302605200459;6105.328413874381;6129.141920131275;6167.229096362955;6256.687165641791;9586.616535338508;9632.27757918173;9668.419894806335;9743.610255589698;9833.606655733976;9736.805263894541;9765.658201962897;9963.302568820403;9972.800543989224;10063.647772328226;7354.632268386452;7476.4392670551015;7486.251374862471;7515.661795219337;7539.736109236151;8324.458910170819;8375.706850260212;8424.62089205975;8429.452085614415;8440.915590844013;7291.927080729125;7457.291557302047;7577.280158384945;7639.57982310956;7742.225777422213;7473.701051958078;7548.207438218908;7549.282818132268;7613.771586852404;7658.5787781670315;7202.747903823551;7235.746748863765;7252.818679533054;7255.383292420203;7275.6362181889635;5156.226566014978;5201.713905735221;5322.8935421292135;5367.248585198154;5367.329083864517;5249.580033597379;5271.288376069181;5274.97362513185;5282.577393808409;5474.3704473986 10:23:53 INFO - PROCESS | 20547 | |4;prototype.html;356.95359603251575;361.2684314263616;363.30064625595753;363.56009228833113;364.08614377911437;6563.573367731095;6603.900941485869;6654;6689.498287628429;6721.563098398607;6505.512086593512;6609.504287178457;6637.900431493519;6645.833854153649;6652.833679158023;4972.428170760355;4980.6762560433635;4987.326710894019;4992.700437973725;4998.5501304882555;4978.452370239271;4981.875453113683;4984.127777638917;4997.175466048116;5006.574441172486;4950.207966725325;4956.2565615157655;4958.305837182797;4960.60315174787;4963;4857.222844344923;4922.876928076791;4949.876253093666;4953.504649535053;4965.503449655023;4252.936205956913;4276.893077673052;4280.315149576084;4291.635211007068;4292.399064131024;6233.376662333731;6282.497400208018;6306.87386252277;6318.4313411793155;6329.556931014831;5744.540436765049;5745.856353591152;5755.65466072037;5755.798547050875;5761.337446193699;6935.89596156053;6939.097917270773;6949.061876646639;6950.54821436605;6959.582425054513;4699.036697477009;4786.497417771154;4795.160846851822;4797.9520204797855;4798.688085274481;7279.090113735783;7280.745173918887;7294.416446684252;7302.050733404676;7381.446391520603;4883.804647814048;4891.070696567641;4892.68197567157;4895.559399653977;4897.510248975145;4934.605231581465;4954.380702412199;4964.205727083721;4977.65156439053;4996.125678006334;5747.195392645033;5747.712614369349;5749.425057494217;5749.8562535936935;5758.884822303614;6804.727810887509;6964.721411143599;6999.405050570656;7006.614636195059;7006.789796306119;1710.4099085815374;1726.7668864703355;1739.4781565530543;1740.9129543522772;1745.3280487012337;1091.1979694924225;1115.486876037032;1119.1270808769173;1124.6513580789817;1130.4347826086957;6631.966840165768;6830.692618832164;6886.758963436356;6890.173179218526;6907.309269073053;7287.890681639779;7304.817379565553;7332;7353.411727061823;7357.337839594462;6867.141607299088;6868.725250989904;6880.449564034865;6888.345607167411;6888.931110688929;3914.6868250539887;3968.3253846846105;3970.4242884782125;3974.3044967130636;3975.5030621172355;7479.513831601037;7588.317051465395;7684.538927664358;7689.38484921205;7690.230976902377;7433.182349941502;7454.180040195574;7537.54774713519;7545.283198096172;7548.282913123245;7609.277118673717;7620.695172193161;7621.6570254338685;7637.579933103621;7667.348275396542;7205.567665940061;7274.381677557255;7278.708851645875;7328.377087947584;7339.559626422431;7153.3919616833155;7178.353948144692;7187.460940429384;7191.3887319578425;7193.280671932765;7612.8477430449975;7616.314531692175;7632.580208088609;7638.388928885787;7655.69377224927;4991.9500804991485;5052.317937078595;5054.772535235997;5062.316587260672;5070.569001634754;7042.753503627348;7194.532355396883;7201;7214.2064372917885;7222.458315626244;7098.680559374738;7099.112610923635;7119.074520312533;7129.144502659714;7131.714731410685;7106.822329441805;7111.146662400545;7113.146422429341;7116.679749411393;7122.394596459359;6982.581045137104;6983.615901125284;6992.895106573304;6993.965030174817;7000.124984376953;6970.965145174242;7104.751333703295;7138.535995160506;7140.892886606601;7156.677949492389;6840.247572767091;6954.304569543207;7004.579725216503;7008.474364422586;7011.3339232772805 10:23:53 INFO - PROCESS | 20547 | |5;yui.html;834.5326617094428;852.9658813647454;862.4178679391412;899.9100089991001;946.110655983376;16818.49544513665;17190.57023574411;17217.741733874;17349.826501734995;17394.47816565502;16333.59166020847;16418.589535261595;16467.258973346197;16544.75182872258;16556.420525281617;917.3716004536881;923.2475532441056;942.0297093993164;951.2057432044252;952.6618050592044;935.8876934767837;936.7892224249523;939.4551160327028;939.5865819039601;942.3733217410414;969.4135048295785;970.5244430229172;974.0454354732367;975;978.6917121106865;957.5595226195924;963.7397902566303;964.6768332608584;968.8595153702673;969.5103972493916;712.2770388056127;715.5206011971991;716.451914285572;716.7421175836425;717.9174394944544;15450.381984720598;15479;15483.845161548354;15558.144302063381;15571.532854014284;14380.64048398788;14466.638334041629;14485.130892146504;14506.854931450656;14675.559733208021;11991.16061875669;12267.26396416209;12295.877041229653;12368;12678.619641410773;4071.633552980246;4151.481064866892;4219.43037689911;4242.787860606988;4249.660027197817;60764.86831556741;61725.382746172414;61945.380546194414;62843.6857815708;62913.37086629121;11529.942350288195;11723.237989530653;11822.763544729058;11826.349550774617;11893.345865977455;20390.59218815645;20438.489037773877;20492.18031278732;20502.692459613118;20575;8281.37889658278;8452.704155354533;8480.194381533744;8541.829163416822;8570.100139485388;4466.4640243171025;4542.386777785023;4785.784639691222;5006.148954677714;5015.27278544609;3632.891013269606;3691.464737613031;3691.7600355976774;3693.0028892198957;3703.037210325335;687.6492988575862;689.8171984424132;692.1037256752518;695.9408450281682;707.6320313437087;762.9427792915553;768.2547580544843;790.5572879187673;794.984100318002;841.2554888923347;9899.901000989898;10390.740231494274;10597.84103238452;10615.946920265349;10632.096271816827;707.4446559450806;766.9846603067907;815.9877601835977;835.7868743470498;869.4088020146361;4867.123917694849;4879.780409881564;4918.704877707349;4949.554540091409;4958.42978057528;66999;67447;67714.3228567708;68005;68037;54882;55746.16380754292;55925.72037139788;57790;59620.40379596235;48915.75542122267;48981;49648;53402.73298633482;54514.45485545094;10157.79684406293;10200.744981375525;10420.843687344848;10477.633282835064;10526;37778.244435111694;37899.81050094732;38622;39429.408558872216;40885;45702.77148614236;46349.536504634525;47083;47608.04783904372;47775.52224477711;12818.74362512726;12850.807237891626;13007.284599346749;13027.348632568523;13123.671908202372;13475.326233688473;14465.638359041108;14911.105333680014;14941.925290373478;15060.171690557125;12978.415971281504;13558.11872228302;13579.9036886264;13901.304934753423;14112.576622701336;13370.532031378854;13542.661433464242;13604.86395136036;13710.862891370958;13751.793723094363;13150.539731109366;13304.334783260992;13354.532591359255;13685.521006764715;13867.098638588459;11299.887001129884;11305.547778088785;11438.485268162785;11446.94276528612;12113.15207935436;11328.773424531299;11564.132690048113;11620.941895290469;11813.350265735467;11817.70455738579 10:23:53 INFO - PROCESS | 20547 | __end_tp_report 10:23:53 INFO - PROCESS | 20547 | __start_cc_report 10:23:53 INFO - PROCESS | 20547 | _x_x_mozilla_cycle_collect,343 10:23:53 INFO - PROCESS | 20547 | __end_cc_report 10:23:53 INFO - PROCESS | 20547 | __startTimestamp1466184233529__endTimestamp 10:23:53 INFO - PROCESS | 20547 | 10:23:53 INFO - PROCESS | 20547 | ------- Summary: start ------- 10:23:53 INFO - PROCESS | 20547 | Number of tests: 6 10:23:53 INFO - PROCESS | 20547 | 10:23:53 INFO - PROCESS | 20547 | [#0] dojo.html Cycles:165 Average:5722.69 Median:5979.31 stddev:650.95 (10.9%) stddev-sans-first:625.29 10:23:53 INFO - PROCESS | 20547 | Values: 3329.9 3419.5 3425.9 3459.0 3464.7 5654.9 5662.5 5669.3 5680.9 5714.4 5669.7 5677.7 5696.3 5697.5 5702.1 5141.4 5154.0 5202.8 5219.0 5234.6 5165.0 5234.4 5297.2 5313.8 5315.3 5276.7 5277.3 5313.8 5326.9 5336.9 5269.9 5281.0 5289.5 5289.8 5313.0 4982.3 5106.6 5173.2 5195.9 5255.3 5541.2 5546.2 5565.7 5574.1 5622.8 6102.2 6104.9 6123.9 6142.0 6143.1 6095.6 6169.7 6229.1 6239.1 6240.7 5715.1 5721.9 5727.4 5731.2 5758.7 6221.7 6225.7 6229.3 6239.5 6254.7 5879.8 5989.5 6090.0 6120.5 6148.3 6117.4 6118.7 6123.5 6126.7 6127.6 6023.3 6065.5 6072.0 6077.4 6082.0 6067.6 6112.4 6140.0 6269.3 6279.4 4638.6 4646.7 4649.8 4656.0 4686.4 4116.3 4182.5 4187.4 4187.9 4211.3 5713.4 5913.6 5979.3 6055.5 6061.8 6242.0 6266.1 6266.4 6270.9 6273.7 5808.4 5963.3 5966.1 5971.4 5982.4 5252.4 5267.6 5302.9 5307.3 5334.4 6425.7 6427.6 6429.8 6430.0 6448.8 6012.7 6138.1 6209.8 6213.0 6214.3 6385.3 6412.7 6423.6 6428.6 6429.2 6038.8 6119.2 6125.5 6128.9 6129.1 5902.4 6210.7 6235.7 6252.6 6258.4 5937.7 5952.7 5993.9 6025.1 6056.5 6024.7 6025.9 6026.1 6026.8 6034.5 5882.2 5944.8 5952.7 5970.2 6051.3 6080.0 6097.2 6112.9 6124.1 6125.7 5932.5 5944.8 5973.3 5984.6 5985.1 10:23:53 INFO - PROCESS | 20547 | 10:23:53 INFO - PROCESS | 20547 | [#1] ext.html Cycles:180 Average:57248.43 Median:42893.36 stddev:115177.63 (268.5%) stddev-sans-first:115422.40 10:23:53 INFO - PROCESS | 20547 | Values: 674.1 677.4 678.4 678.4 745.0 39572.6 40824.8 40838.0 40872.4 40893.8 43033.4 43635.8 43745.0 43775.0 43919.0 8851.0 9000.2 9017.3 9020.4 9029.5 8813.9 8863.2 8902.5 9111.1 9162.8 9135.2 9143.7 9159.3 9206.0 9223.7 9019.5 9127.6 9159.1 9175.7 9186.6 9092.1 9174.4 9202.6 9207.7 9212.6 43958.8 44102.3 44221.8 44222.6 44293.8 3943.8 3976.3 4066.5 4115.8 4150.0 33235.2 33480.0 33677.7 34470.5 35058.6 4361.0 4443.1 4446.2 4470.5 4510.5 305930.0 307145.5 307968.0 308689.0 309688.0 39804.4 62193.0 62338.7 62393.4 62431.7 38112.2 38135.2 38167.4 38170.4 38287.0 16843.3 17142.4 17143.1 17151.1 17158.4 13424.8 13461.6 13475.3 13500.8 13507.8 9472.2 9512.9 9535.1 9589.2 9603.1 3652.7 3653.4 3693.9 3714.3 3729.1 1215.6 1229.8 1261.1 1274.4 1295.4 34918.7 35523.8 35590.8 36533.8 38524.2 1161.0 1184.1 1212.8 1270.9 1358.2 16825.3 17037.3 17054.5 17146.6 17247.0 401811.0 535860.0 539363.0 544338.0 900134.0 58809.7 59917.0 60031.0 60143.0 60216.7 1529.0 1556.5 1561.9 1579.1 1579.8 30638.5 31397.7 32027.0 32098.7 32463.5 54523.0 61711.0 63137.0 63377.7 63486.7 302542.0 305801.0 306634.0 307062.0 307828.0 42565.8 42855.1 43021.6 43064.4 51424.0 49151.8 49655.5 49679.3 50376.0 51271.5 40980.4 43489.3 44993.3 45989.1 46188.0 42687.6 43785.1 44075.1 44397.1 45296.5 42931.6 43891.1 44026.8 44221.3 44300.6 38091.6 38284.2 38349.0 38556.8 38798.0 30321.0 30328.7 30625.5 30674.5 30962.8 10:23:53 INFO - PROCESS | 20547 | 10:23:53 INFO - PROCESS | 20547 | [#2] jquery.html Cycles:180 Average:29587.38 Median:2186.47 stddev:85299.93 (3901.3%) stddev-sans-first:85511.13 10:23:53 INFO - PROCESS | 20547 | Values: 437.2 438.5 440.8 444.4 450.3 19343.1 19682.3 20313.0 20318.1 20490.1 19573.8 19710.8 19925.4 20006.1 20166.8 5483.9 5715.5 5737.1 5753.3 5772.2 5747.0 5825.0 5847.1 5861.9 6040.4 6036.3 6042.6 6051.7 6057.8 6075.6 5941.2 6037.6 6043.9 6721.8 6725.9 5997.7 6008.3 6022.5 6052.8 6066.3 13907.6 13964.6 14324.2 14327.7 14370.3 2546.2 2579.3 2589.2 2735.4 3045.7 10663.1 10774.5 10778.0 10795.6 11042.2 2055.3 2080.8 2123.9 2158.5 2170.6 72414.6 76732.0 76820.0 77126.6 78081.6 11408.4 11465.7 11469.1 11622.5 11745.8 16125.1 16149.4 16319.7 16321.1 16357.2 8891.6 9003.3 9031.6 9127.2 9162.9 8912.3 8944.9 9002.8 9085.5 9097.6 4279.7 4450.7 5023.8 5169.4 5182.9 2110.6 2112.9 2202.3 2203.3 2221.8 1057.9 1073.4 1141.4 1165.1 1166.0 19175.7 19318.2 19589.5 19603.9 19935.6 1110.5 1116.8 1142.7 1160.5 1173.3 10945.0 11059.9 11077.0 11246.7 11261.2 509925.0 511771.0 512464.0 530689.0 532725.0 85475.6 85537.1 88420.0 90112.5 92362.0 1122.1 1141.1 1142.7 1161.7 1162.2 17447.9 17751.9 17923.6 18010.8 18152.8 38045.6 38903.9 39273.6 39934.2 40736.4 54709.0 55788.4 56539.0 56648.4 56688.4 9302.3 9325.0 9450.7 9497.7 9517.0 12396.3 13139.2 13337.7 13679.7 14167.6 12207.4 12271.3 12400.3 12437.6 12648.7 11829.3 12099.8 12247.0 12427.6 12437.3 12482.5 12554.3 12561.4 12742.4 13040.6 8605.6 8854.2 8999.4 9273.0 9342.0 9149.9 11437.3 12366.0 12622.3 12777.1 10:23:53 INFO - PROCESS | 20547 | 10:23:53 INFO - PROCESS | 20547 | [#3] mootools.html Cycles:180 Average:5810.06 Median:4988.03 stddev:3220.49 (64.6%) stddev-sans-first:3213.14 10:23:53 INFO - PROCESS | 20547 | Values: 1487.6 1492.2 1720.6 1887.5 1922.0 7205.7 8299.0 8499.9 8650.8 8660.3 8408.7 8441.0 8453.4 8512.7 8534.3 2423.4 2443.3 2448.6 2457.6 2459.0 2404.6 2421.9 2446.9 2453.2 2455.5 2415.4 2418.3 2435.5 2451.2 2463.6 2397.1 2415.2 2420.3 2428.8 2430.1 2406.2 2424.4 2457.8 2460.9 2473.7 8673.8 8701.0 8721.8 8727.1 8762.3 5350.7 5397.6 5438.2 5458.2 5463.8 3570.9 3584.7 3638.7 3691.7 3725.9 1120.4 1135.4 1147.9 1156.0 1158.0 12367.0 12417.4 12420.8 12425.6 12451.0 4697.4 4781.6 4814.5 4839.9 4880.4 10326.4 10400.1 10411.7 10422.7 10431.7 5386.4 5397.6 5403.9 5426.5 5427.8 4945.3 4961.4 5014.7 5053.6 5072.8 3913.3 3958.2 4024.4 4040.4 4119.0 1246.1 1261.4 1268.6 1270.0 1281.0 894.5 964.3 1091.2 1091.4 1116.8 6149.4 6202.2 6205.6 6295.5 6364.2 432.3 433.9 436.4 442.5 448.3 4276.0 4277.9 4301.3 4326.3 4359.8 10401.9 10651.9 10752.1 10799.3 10839.0 10718.0 10721.6 10724.8 10742.6 10770.2 8187.3 8224.0 8328.6 8380.2 8387.5 6064.3 6105.3 6129.1 6167.2 6256.7 9586.6 9632.3 9668.4 9743.6 9833.6 9736.8 9765.7 9963.3 9972.8 10063.6 7354.6 7476.4 7486.3 7515.7 7539.7 8324.5 8375.7 8424.6 8429.5 8440.9 7291.9 7457.3 7577.3 7639.6 7742.2 7473.7 7548.2 7549.3 7613.8 7658.6 7202.7 7235.7 7252.8 7255.4 7275.6 5156.2 5201.7 5322.9 5367.2 5367.3 5249.6 5271.3 5275.0 5282.6 5474.4 10:23:53 INFO - PROCESS | 20547 | 10:23:53 INFO - PROCESS | 20547 | [#4] prototype.html Cycles:180 Average:5878.14 Median:6763.15 stddev:1811.60 (26.8%) stddev-sans-first:1768.65 10:23:53 INFO - PROCESS | 20547 | Values: 357.0 361.3 363.3 363.6 364.1 6563.6 6603.9 6654.0 6689.5 6721.6 6505.5 6609.5 6637.9 6645.8 6652.8 4972.4 4980.7 4987.3 4992.7 4998.6 4978.5 4981.9 4984.1 4997.2 5006.6 4950.2 4956.3 4958.3 4960.6 4963.0 4857.2 4922.9 4949.9 4953.5 4965.5 4252.9 4276.9 4280.3 4291.6 4292.4 6233.4 6282.5 6306.9 6318.4 6329.6 5744.5 5745.9 5755.7 5755.8 5761.3 6935.9 6939.1 6949.1 6950.5 6959.6 4699.0 4786.5 4795.2 4798.0 4798.7 7279.1 7280.7 7294.4 7302.1 7381.4 4883.8 4891.1 4892.7 4895.6 4897.5 4934.6 4954.4 4964.2 4977.7 4996.1 5747.2 5747.7 5749.4 5749.9 5758.9 6804.7 6964.7 6999.4 7006.6 7006.8 1710.4 1726.8 1739.5 1740.9 1745.3 1091.2 1115.5 1119.1 1124.7 1130.4 6632.0 6830.7 6886.8 6890.2 6907.3 7287.9 7304.8 7332.0 7353.4 7357.3 6867.1 6868.7 6880.4 6888.3 6888.9 3914.7 3968.3 3970.4 3974.3 3975.5 7479.5 7588.3 7684.5 7689.4 7690.2 7433.2 7454.2 7537.5 7545.3 7548.3 7609.3 7620.7 7621.7 7637.6 7667.3 7205.6 7274.4 7278.7 7328.4 7339.6 7153.4 7178.4 7187.5 7191.4 7193.3 7612.8 7616.3 7632.6 7638.4 7655.7 4992.0 5052.3 5054.8 5062.3 5070.6 7042.8 7194.5 7201.0 7214.2 7222.5 7098.7 7099.1 7119.1 7129.1 7131.7 7106.8 7111.1 7113.1 7116.7 7122.4 6982.6 6983.6 6992.9 6994.0 7000.1 6971.0 7104.8 7138.5 7140.9 7156.7 6840.2 6954.3 7004.6 7008.5 7011.3 10:23:53 INFO - PROCESS | 20547 | 10:23:53 INFO - PROCESS | 20547 | [#5] yui.html Cycles:180 Average:16041.45 Median:4185.46 stddev:18325.89 (437.8%) stddev-sans-first:18341.71 10:23:53 INFO - PROCESS | 20547 | Values: 834.5 853.0 862.4 899.9 946.1 16818.5 17190.6 17217.7 17349.8 17394.5 16333.6 16418.6 16467.3 16544.8 16556.4 917.4 923.2 942.0 951.2 952.7 935.9 936.8 939.5 939.6 942.4 969.4 970.5 974.0 975.0 978.7 957.6 963.7 964.7 968.9 969.5 712.3 715.5 716.5 716.7 717.9 15450.4 15479.0 15483.8 15558.1 15571.5 14380.6 14466.6 14485.1 14506.9 14675.6 11991.2 12267.3 12295.9 12368.0 12678.6 4071.6 4151.5 4219.4 4242.8 4249.7 60764.9 61725.4 61945.4 62843.7 62913.4 11529.9 11723.2 11822.8 11826.3 11893.3 20390.6 20438.5 20492.2 20502.7 20575.0 8281.4 8452.7 8480.2 8541.8 8570.1 4466.5 4542.4 4785.8 5006.1 5015.3 3632.9 3691.5 3691.8 3693.0 3703.0 687.6 689.8 692.1 695.9 707.6 762.9 768.3 790.6 795.0 841.3 9899.9 10390.7 10597.8 10615.9 10632.1 707.4 767.0 816.0 835.8 869.4 4867.1 4879.8 4918.7 4949.6 4958.4 66999.0 67447.0 67714.3 68005.0 68037.0 54882.0 55746.2 55925.7 57790.0 59620.4 48915.8 48981.0 49648.0 53402.7 54514.5 10157.8 10200.7 10420.8 10477.6 10526.0 37778.2 37899.8 38622.0 39429.4 40885.0 45702.8 46349.5 47083.0 47608.0 47775.5 12818.7 12850.8 13007.3 13027.3 13123.7 13475.3 14465.6 14911.1 14941.9 15060.2 12978.4 13558.1 13579.9 13901.3 14112.6 13370.5 13542.7 13604.9 13710.9 13751.8 13150.5 13304.3 13354.5 13685.5 13867.1 11299.9 11305.5 11438.5 11446.9 12113.2 11328.8 11564.1 11620.9 11813.4 11817.7 10:23:53 INFO - PROCESS | 20547 | -------- Summary: end -------- 10:23:53 INFO - PROCESS | 20547 | 10:23:54 INFO - TEST-INFO | 20547: exit 0 10:23:54 INFO - TEST-OK | dromaeo_css | took 1109009ms 10:23:54 INFO - TEST-START | kraken 10:23:54 INFO - operating with platform_type : linux_ 10:23:54 INFO - Initialising browser for kraken test... 10:23:54 INFO - TEST-INFO | started process 20793 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOIFGVP/profile http://localhost:58314/getInfo.html) 10:23:57 INFO - PROCESS | 20793 | 10:23:57 INFO - PROCESS | 20793 | (process:20870): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:23:58 INFO - PROCESS | 20793 | __metrics Screen width/height:1600/1200 10:23:58 INFO - PROCESS | 20793 | colorDepth:24 10:23:58 INFO - PROCESS | 20793 | Browser inner width/height: 1024/697 10:23:58 INFO - PROCESS | 20793 | __metrics 10:23:59 ERROR - PROCESS | 20793 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 10:24:00 INFO - TEST-INFO | 20793: exit 0 10:24:00 INFO - Browser initialized. 10:24:00 INFO - Running cycle 1/1 for kraken test... 10:24:00 INFO - TEST-INFO | started process 20920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOIFGVP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:01 INFO - PROCESS | 20920 | 10:24:01 INFO - PROCESS | 20920 | (process:20988): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:24:11 INFO - PROCESS | 20920 | RSS: Main: 151531520 10:24:11 INFO - PROCESS | 20920 | 10:24:14 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58314/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:15 INFO - PROCESS | 20920 | RSS: Main: 156688384 10:24:15 INFO - PROCESS | 20920 | 10:24:17 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58314/tests/kraken/driver.html?testName=audio-dft) 10:24:18 INFO - PROCESS | 20920 | RSS: Main: 156479488 10:24:18 INFO - PROCESS | 20920 | 10:24:21 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58314/tests/kraken/driver.html?testName=audio-fft) 10:24:21 INFO - PROCESS | 20920 | RSS: Main: 156872704 10:24:21 INFO - PROCESS | 20920 | 10:24:24 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58314/tests/kraken/driver.html?testName=audio-oscillator) 10:24:24 INFO - PROCESS | 20920 | RSS: Main: 156798976 10:24:24 INFO - PROCESS | 20920 | 10:24:26 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58314/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:27 INFO - PROCESS | 20920 | RSS: Main: 156770304 10:24:27 INFO - PROCESS | 20920 | 10:24:30 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58314/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:31 INFO - PROCESS | 20920 | RSS: Main: 156962816 10:24:31 INFO - PROCESS | 20920 | 10:24:34 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58314/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:35 INFO - PROCESS | 20920 | RSS: Main: 156921856 10:24:35 INFO - PROCESS | 20920 | 10:24:37 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58314/tests/kraken/driver.html?testName=json-parse-financial) 10:24:38 INFO - PROCESS | 20920 | RSS: Main: 156659712 10:24:38 INFO - PROCESS | 20920 | 10:24:39 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58314/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:40 INFO - PROCESS | 20920 | RSS: Main: 156397568 10:24:40 INFO - PROCESS | 20920 | 10:24:42 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58314/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:42 INFO - PROCESS | 20920 | RSS: Main: 156270592 10:24:42 INFO - PROCESS | 20920 | 10:24:44 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58314/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:24:45 INFO - PROCESS | 20920 | RSS: Main: 156655616 10:24:45 INFO - PROCESS | 20920 | 10:24:47 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:24:48 INFO - PROCESS | 20920 | RSS: Main: 156844032 10:24:48 INFO - PROCESS | 20920 | 10:24:51 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:24:51 INFO - PROCESS | 20920 | RSS: Main: 156930048 10:24:51 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | Cycle 1(1): loaded http://localhost:58314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58314/tests/kraken/driver.html?testName=ai-astar) 10:24:53 INFO - PROCESS | 20920 | RSS: Main: 158334976 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | __start_tp_report 10:24:53 INFO - PROCESS | 20920 | _x_x_mozilla_page_load 10:24:53 INFO - PROCESS | 20920 | _x_x_mozilla_page_load_details 10:24:53 INFO - PROCESS | 20920 | |i|pagename|runs| 10:24:53 INFO - PROCESS | 20920 | |0;ai-astar;109;113;103;112;115;113;100;112;110;113 10:24:53 INFO - PROCESS | 20920 | |1;audio-beat-detection;154;129;151;169;126;157;156;130;179;131 10:24:53 INFO - PROCESS | 20920 | |2;audio-dft;161;161;162;162;162;162;164;162;162;162 10:24:53 INFO - PROCESS | 20920 | |3;audio-fft;76;79;78;174;73;72;78;76;171;76 10:24:53 INFO - PROCESS | 20920 | |4;audio-oscillator;92;93;156;91;91;92;149;92;91;138 10:24:53 INFO - PROCESS | 20920 | |5;imaging-gaussian-blur;120;117;117;121;119;117;120;120;120;120 10:24:53 INFO - PROCESS | 20920 | |6;imaging-darkroom;146;146;146;145;147;145;148;146;146;146 10:24:53 INFO - PROCESS | 20920 | |7;imaging-desaturate;95;95;95;95;100;94;94;95;95;100 10:24:53 INFO - PROCESS | 20920 | |8;json-parse-financial;59;58;56;54;55;55;56;85;55;54 10:24:53 INFO - PROCESS | 20920 | |9;json-stringify-tinderbox;58;57;57;57;57;57;61;57;56;58 10:24:53 INFO - PROCESS | 20920 | |10;stanford-crypto-aes;73;74;73;83;79;75;75;75;76;84 10:24:53 INFO - PROCESS | 20920 | |11;stanford-crypto-ccm;125;124;115;116;121;115;115;114;129;128 10:24:53 INFO - PROCESS | 20920 | |12;stanford-crypto-pbkdf2;163;166;166;167;166;166;165;165;166;162 10:24:53 INFO - PROCESS | 20920 | |13;stanford-crypto-sha256-iterative;68;66;68;66;67;67;67;69;67;66 10:24:53 INFO - PROCESS | 20920 | __end_tp_report 10:24:53 INFO - PROCESS | 20920 | __start_cc_report 10:24:53 INFO - PROCESS | 20920 | _x_x_mozilla_cycle_collect,866 10:24:53 INFO - PROCESS | 20920 | __end_cc_report 10:24:53 INFO - PROCESS | 20920 | __startTimestamp1466184293847__endTimestamp 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | ------- Summary: start ------- 10:24:53 INFO - PROCESS | 20920 | Number of tests: 14 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.50 stddev:4.83 (4.3%) stddev-sans-first:5.11 10:24:53 INFO - PROCESS | 20920 | Values: 109.0 113.0 103.0 112.0 115.0 113.0 100.0 112.0 110.0 113.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:155.00 stddev:18.41 (11.9%) stddev-sans-first:19.40 10:24:53 INFO - PROCESS | 20920 | Values: 154.0 129.0 151.0 169.0 126.0 157.0 156.0 130.0 179.0 131.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 10:24:53 INFO - PROCESS | 20920 | Values: 161.0 161.0 162.0 162.0 162.0 162.0 164.0 162.0 162.0 162.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:40.75 (53.6%) stddev-sans-first:42.62 10:24:53 INFO - PROCESS | 20920 | Values: 76.0 79.0 78.0 174.0 73.0 72.0 78.0 76.0 171.0 76.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:91.50 stddev:27.37 (29.9%) stddev-sans-first:28.37 10:24:53 INFO - PROCESS | 20920 | Values: 92.0 93.0 156.0 91.0 91.0 92.0 149.0 92.0 91.0 138.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#5] imaging-gaussian-blur Cycles:10 Average:119.10 Median:120.00 stddev:1.52 (1.3%) stddev-sans-first:1.58 10:24:53 INFO - PROCESS | 20920 | Values: 120.0 117.0 117.0 121.0 119.0 117.0 120.0 120.0 120.0 120.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 10:24:53 INFO - PROCESS | 20920 | Values: 146.0 146.0 146.0 145.0 147.0 145.0 148.0 146.0 146.0 146.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.25 (2.4%) stddev-sans-first:2.37 10:24:53 INFO - PROCESS | 20920 | Values: 95.0 95.0 95.0 95.0 100.0 94.0 94.0 95.0 95.0 100.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:56.00 stddev:9.38 (16.8%) stddev-sans-first:9.95 10:24:53 INFO - PROCESS | 20920 | Values: 59.0 58.0 56.0 54.0 55.0 55.0 56.0 85.0 55.0 54.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#9] json-stringify-tinderbox Cycles:10 Average:57.50 Median:57.00 stddev:1.35 (2.4%) stddev-sans-first:1.42 10:24:53 INFO - PROCESS | 20920 | Values: 58.0 57.0 57.0 57.0 57.0 57.0 61.0 57.0 56.0 58.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:75.50 stddev:3.97 (5.3%) stddev-sans-first:3.98 10:24:53 INFO - PROCESS | 20920 | Values: 73.0 74.0 73.0 83.0 79.0 75.0 75.0 75.0 76.0 84.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:122.50 stddev:5.90 (4.8%) stddev-sans-first:6.00 10:24:53 INFO - PROCESS | 20920 | Values: 125.0 124.0 115.0 116.0 121.0 115.0 115.0 114.0 129.0 128.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:166.00 stddev:1.55 (0.9%) stddev-sans-first:1.42 10:24:53 INFO - PROCESS | 20920 | Values: 163.0 166.0 166.0 167.0 166.0 166.0 165.0 165.0 166.0 162.0 10:24:53 INFO - PROCESS | 20920 | 10:24:53 INFO - PROCESS | 20920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 10:24:53 INFO - PROCESS | 20920 | Values: 68.0 66.0 68.0 66.0 67.0 67.0 67.0 69.0 67.0 66.0 10:24:53 INFO - PROCESS | 20920 | -------- Summary: end -------- 10:24:53 INFO - PROCESS | 20920 | 10:24:54 INFO - TEST-INFO | 20920: exit 0 10:24:54 INFO - TEST-OK | kraken | took 60563ms 10:24:54 INFO - SUITE-END | took 1169s 10:24:55 INFO - Completed test suite (00:19:29) 10:24:55 INFO - javascript benchmark 10:24:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.866805327787, 3419.5212670226156, 3425.8972230833074, 3459.0, 3464.705500032497, 5654.886902261952, 5662.518685911702, 5669.348024977129, 5680.886382272352, 5714.3999880012625, 5669.716514174285, 5677.716114194294, 5696.316442026952, 5697.4587414195685, 5702.087665973445, 5141.4087379951225, 5154.046501397253, 5202.76587553561, 5218.973905130469, 5234.555062819665, 5165.018646457161, 5234.37187537496, 5297.152455607104, 5313.787448502075, 5315.335583052119, 5276.683398996053, 5277.287566178575, 5313.760880760375, 5326.893462130755, 5336.91994620081, 5269.8946021079555, 5280.973595132, 5289.497497737709, 5289.814856480043, 5313.0, 4982.302477653131, 5106.591472682177, 5173.17229243323, 5195.9480405195845, 5255.290535777659, 5541.168824676291, 5546.195801608785, 5565.66606003637, 5574.052411090124, 5622.775088996476, 6102.176206212193, 6104.938950610526, 6123.877522449526, 6142.04798256271, 6143.078538219303, 6095.573309868311, 6169.722362493699, 6229.065640153968, 6239.126522286883, 6240.656763877985, 5715.057015592422, 5721.941440833459, 5727.427257274281, 5731.226284451587, 5758.6544807311275, 6221.657808820558, 6225.719842607094, 6229.283632382243, 6239.500839932794, 6254.655993920287, 5879.764809407576, 5989.520838332923, 6090.0, 6120.538559592164, 6148.262208535004, 6117.401149625483, 6118.739199075686, 6123.496663127952, 6126.733522497775, 6127.617148554337, 6023.337432882379, 6065.4541091302, 6071.969640151771, 6077.36187700294, 6082.0, 6067.605605635619, 6112.449879510866, 6140.048292514667, 6269.310375858652, 6279.403456671609, 4638.5593368629925, 4646.697964632288, 4649.790759415834, 4656.045510670305, 4686.414198225222, 4116.259073366823, 4182.498100227992, 4187.392828039917, 4187.874363769091, 4211.284081706117, 5713.428657134336, 5913.58604897653, 5979.312379076375, 6055.5458340623745, 6061.8484537886025, 6241.96879015602, 6266.091416744638, 6266.404691554295, 6270.874582508324, 6273.686315684197, 5808.39011903744, 5963.284405871236, 5966.075258334965, 5971.4028597140805, 5982.4316689914385, 5252.395974462909, 5267.578593712494, 5302.867428314323, 5307.28351672527, 5334.386545547234, 6425.74297028123, 6427.550071495044, 6429.807105786834, 6429.9678501607195, 6448.774292899726, 6012.669303188367, 6138.109974053827, 6209.844753881189, 6213.00591905302, 6214.347493513116, 6385.3295403983775, 6412.743490260337, 6423.64669943139, 6428.582142160744, 6429.196350456193, 6038.758449661965, 6119.204503414528, 6125.509959203342, 6128.8774224516155, 6129.1112788644505, 5902.380250073852, 6210.689465526796, 6235.657038862906, 6252.5935814171935, 6258.374162583706, 5937.673427961504, 5952.702364881825, 5993.850153746017, 6025.0661147522205, 6056.454919057306, 6024.668643224665, 6025.939740602713, 6026.0659597762415, 6026.819195424145, 6034.487068599043, 5882.176495290748, 5944.791932282523, 5952.73212705438, 5970.164177015135, 6051.334353221054, 6079.969600151971, 6097.237845269341, 6112.908306375497, 6124.142620033288, 6125.724342404514, 5932.525397968066, 5944.762209511571, 5973.313068997121, 5984.551158663031, 5985.132155837467], "value": 5679.2688727046525, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.0967104080532, 677.3768133317348, 678.396227357652, 678.4267294136453, 744.9979777199668, 39572.60427395725, 40824.79587602058, 40837.979050523754, 40872.38691419631, 40893.79553102238, 43033.35449968245, 43635.78182109085, 43745.0, 43775.0, 43919.0, 8850.999999999984, 9000.189982901538, 9017.278617710568, 9020.41367311126, 9029.503377314246, 8813.911860881406, 8863.202311791938, 8902.465852048897, 9111.088891110901, 9162.770930726752, 9135.223506001998, 9143.725688229364, 9159.313051521129, 9206.0, 9223.677171299007, 9019.503927283997, 9127.634894604242, 9159.129882661136, 9175.724728258163, 9186.586603602855, 9092.090790920922, 9174.449533027973, 9202.631894724203, 9207.677731279373, 9212.631494740202, 43958.78020609877, 44102.33846492305, 44221.77889110566, 44222.55777442217, 44293.778531107135, 3943.842246310144, 3976.304146774303, 4066.5323487798987, 4115.814788334532, 4150.024744185144, 33235.169120772174, 33480.0, 33677.66322336794, 34470.48294275588, 35058.64941350605, 4360.956390436118, 4443.133588950156, 4446.155230506226, 4470.485894122185, 4510.548945105496, 305930.0, 307145.46427267947, 307968.0, 308689.0, 309688.0, 39804.402933956015, 62193.0, 62338.68830655818, 62393.37606623876, 62431.68784156141, 38112.23775524474, 38135.23729525394, 38167.427488587695, 38170.42744358837, 38287.0, 16843.32626694943, 17142.40001599963, 17143.142842857807, 17151.142442877805, 17158.39945601898, 13424.798628020588, 13461.596152115451, 13475.258860762751, 13500.797488037491, 13507.797383039262, 9472.194863436547, 9512.857307140399, 9535.094166054214, 9589.232861371074, 9603.087706667855, 3652.698799756137, 3653.415453527423, 3693.8891833245048, 3714.294284086069, 3729.1050147964293, 1215.5684731920219, 1229.8278241046082, 1261.1172179474404, 1274.3691872522975, 1295.3587973952954, 34918.65081349205, 35523.82238088793, 35590.8220458896, 36533.817330913706, 38524.229515410094, 1160.953561857533, 1184.1474138620179, 1212.8241404996227, 1270.9110362274553, 1358.2393859438548, 16825.32698692063, 17037.31850725957, 17054.488365349058, 17146.571335716457, 17247.0, 401811.0, 535860.0, 539363.0, 544338.0, 900134.0, 58809.70595147082, 59917.0, 60031.0, 60143.0, 60216.698916506015, 1528.9923550382177, 1556.5408204579676, 1561.9140947247784, 1579.1393690438738, 1579.8262191158963, 30638.540421893245, 31397.68602314039, 32027.0, 32098.67901320957, 32463.513047303837, 54523.0, 61711.0, 63137.0, 63377.68311158415, 63486.682566586875, 302542.0, 305801.0, 306634.0, 307062.0, 307828.0, 42565.787171063945, 42855.14289714126, 43021.56978430301, 43064.35403468888, 51424.0, 49151.75424122856, 49655.503444965085, 49679.25481117714, 50376.0, 51271.48728512667, 40980.3852942212, 43489.34765978576, 44993.32510012418, 45989.080218394774, 46188.0, 42687.573124269606, 43785.12429751451, 44075.11849763051, 44397.112057758015, 45296.547034529234, 42931.570684292754, 43891.12217755563, 44026.779866101744, 44221.33667995047, 44300.556994429644, 38091.61908380881, 38284.2343153141, 38349.0, 38556.807215964865, 38798.0, 30321.0, 30328.696713032587, 30625.540616890317, 30674.539881901343, 30962.845185773927], "value": 20079.143367702516, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.2151987183006, 438.45193508114846, 440.8280770499506, 444.3778709806273, 450.28854410032153, 19343.129559169836, 19682.311119110833, 20313.0, 20318.08568614412, 20490.077946492405, 19573.804261957375, 19710.802891971078, 19925.402237932885, 20006.09972551235, 20166.798332016675, 5483.890322193553, 5715.457031582014, 5737.082066869301, 5753.280839895013, 5772.191893134965, 5746.9712651436685, 5824.970875145618, 5847.093700476412, 5861.8827623447505, 6040.395960403968, 6036.336003039684, 6042.640405908679, 6051.727672254759, 6057.787977420791, 6075.605085669439, 5941.168236446879, 6037.577369584131, 6043.939560604404, 6721.756475052082, 6725.93274067258, 5997.6701281429505, 6008.3390827009, 6022.5483088768515, 6052.757889684407, 6066.302375226861, 13907.58277251674, 13964.581062568139, 14324.212168330738, 14327.713445731131, 14370.281485925661, 2546.1852207293673, 2579.342267721719, 2589.2102908612865, 2735.37086470113, 3045.6802035786145, 10663.146948244123, 10774.461276936121, 10778.0, 10795.6221532246, 11042.227044106916, 2055.3011975928257, 2080.8023237792536, 2123.883186424746, 2158.4819643285655, 2170.6309927312395, 72414.63792681003, 76732.0, 76820.0, 77126.61436692836, 78081.60959195225, 11408.429578521207, 11465.656030319104, 11469.139814513945, 11622.535098595961, 11745.823812642817, 16125.11311877858, 16149.434769783002, 16319.67360652804, 16321.102339371448, 16357.182140892908, 8891.555422228863, 9003.324750643596, 9031.63873445068, 9127.224185944136, 9162.908370916339, 8912.287017038621, 8944.8658270126, 9002.774930626656, 9085.545722713838, 9097.636094556276, 4279.7218180818145, 4450.666200035011, 5023.773930173151, 5169.405518365361, 5182.922256166161, 2110.5989861926187, 2112.9471763205734, 2202.306273523835, 2203.2839327218717, 2221.7778222177653, 1057.862477877871, 1073.3613499967507, 1141.4178768827958, 1165.1145129701488, 1166.0205427440821, 19175.712364314546, 19318.227270909007, 19589.51026224356, 19603.901980490293, 19935.60128797416, 1110.5058249079082, 1116.7822274656364, 1142.657202839145, 1160.5183848702693, 1173.284296579086, 10945.0, 11059.944700276446, 11077.0, 11246.7188320291, 11261.155413344031, 509925.0, 511771.0, 512464.0, 530689.0, 532725.0, 85475.57262213649, 85537.14462855292, 88420.0, 90112.5494372524, 92362.0, 1122.0911062039775, 1141.132739118276, 1142.714321419645, 1161.732801455653, 1162.1980833225048, 17447.912760436117, 17751.911240443715, 17923.641527169646, 18010.81989180144, 18152.81847181564, 38045.57340306313, 38903.90195746088, 39273.60726392699, 39934.201315974096, 40736.3889541663, 54709.0, 55788.44211557833, 56539.0, 56648.433515664314, 56688.43311566996, 9302.348835581715, 9325.0, 9450.716478505656, 9497.701446794863, 9517.048295170427, 12396.31820249895, 13139.211647301192, 13337.66655833612, 13679.726405471636, 14167.64580885486, 12207.389630518615, 12271.263724176579, 12400.317982510687, 12437.564685235973, 12648.747025059263, 11829.290242585472, 12099.758004839678, 12247.020238381087, 12427.627171184879, 12437.315947622606, 12482.500699971899, 12554.309512976874, 12561.37193140321, 12742.426590803621, 13040.608781736562, 8605.612747426256, 8854.158854908774, 8999.41503802277, 9273.0, 9342.0, 9149.908500915171, 11437.256578322382, 12366.0, 12622.305773182563, 12777.105602607728], "value": 9577.835358739876, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.583476626545, 1492.2389581313528, 1720.587059105815, 1887.4998125496736, 1921.9903900480494, 7205.747798827029, 8299.0, 8499.872501912469, 8650.783730406734, 8660.263877570405, 8408.747737567868, 8440.95779521103, 8453.365997550192, 8512.659493620264, 8534.317254619631, 2423.369923819802, 2443.2670198940336, 2448.6449464827588, 2457.619069044301, 2459.016393442628, 2404.63930410439, 2421.9394515137174, 2446.877656117196, 2453.178185307915, 2455.545724041049, 2415.4444477770126, 2418.2745176446997, 2435.549423356676, 2451.240115564172, 2463.5688754467988, 2397.0531640002278, 2415.2029830156007, 2420.261820144855, 2428.8178386621075, 2430.1251549442277, 2406.193925035115, 2424.3696638873844, 2457.8402403843693, 2460.8892599833052, 2473.703155621319, 8673.783155421102, 8700.956495217546, 8721.825563488757, 8727.127287271285, 8762.255208307302, 5350.705711185883, 5397.568194544427, 5438.15708565173, 5458.181272809071, 5463.7814487420455, 3570.892873213808, 3584.6594573515476, 3638.6543278388513, 3691.741578089535, 3725.8882233533036, 1120.4061847220985, 1135.409587014756, 1147.9196456248067, 1156.0, 1157.953681852725, 12367.010639148937, 12417.379131043412, 12420.81368779469, 12425.62723118308, 12451.003919686404, 4697.389339385858, 4781.593564546983, 4814.470408255089, 4839.854804355875, 4880.438749543777, 10326.380417174994, 10400.115990140772, 10411.739706507398, 10422.739431514121, 10431.739206519898, 5386.353637563518, 5397.568194544427, 5403.864903377447, 5426.457354264542, 5427.810026649048, 4945.2582112683385, 4961.3798275215595, 5014.674046186986, 5053.646244762905, 5072.822451214263, 3913.295606790748, 3958.2281455116554, 4024.3762216856435, 4040.373742069984, 4119.032027473541, 1246.1214843535286, 1261.4323554400557, 1268.6003908768707, 1270.0347735720734, 1281.0392205845617, 894.5348418822176, 964.262339310428, 1091.1761619976867, 1091.3615534912165, 1116.832475128721, 6149.385061493815, 6202.193714817045, 6205.627662340274, 6295.496360291166, 6364.236291645032, 432.3234138573123, 433.9479262488522, 436.382518735985, 442.54417949512055, 448.3230322213481, 4275.978620106879, 4277.871663850089, 4301.268784306612, 4326.264535029052, 4359.760213188241, 10401.895981040092, 10651.893481065244, 10752.086072683753, 10799.298045627009, 10839.0, 10718.035376816124, 10721.571137154582, 10724.839127413095, 10742.624008159833, 10770.192235582363, 8187.3040791533385, 8223.95888020556, 8328.625211865481, 8380.24577788002, 8387.454815436977, 6064.302605200459, 6105.328413874381, 6129.141920131275, 6167.229096362955, 6256.687165641791, 9586.616535338508, 9632.27757918173, 9668.419894806335, 9743.610255589698, 9833.606655733976, 9736.805263894541, 9765.658201962897, 9963.302568820403, 9972.800543989224, 10063.647772328226, 7354.632268386452, 7476.4392670551015, 7486.251374862471, 7515.661795219337, 7539.736109236151, 8324.458910170819, 8375.706850260212, 8424.62089205975, 8429.452085614415, 8440.915590844013, 7291.927080729125, 7457.291557302047, 7577.280158384945, 7639.57982310956, 7742.225777422213, 7473.701051958078, 7548.207438218908, 7549.282818132268, 7613.771586852404, 7658.5787781670315, 7202.747903823551, 7235.746748863765, 7252.818679533054, 7255.383292420203, 7275.6362181889635, 5156.226566014978, 5201.713905735221, 5322.8935421292135, 5367.248585198154, 5367.329083864517, 5249.580033597379, 5271.288376069181, 5274.97362513185, 5282.577393808409, 5474.3704473986], "value": 4621.928825953573, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.95359603251575, 361.2684314263616, 363.30064625595753, 363.56009228833113, 364.08614377911437, 6563.573367731095, 6603.900941485869, 6654.0, 6689.498287628429, 6721.563098398607, 6505.512086593512, 6609.504287178457, 6637.900431493519, 6645.833854153649, 6652.833679158023, 4972.428170760355, 4980.6762560433635, 4987.326710894019, 4992.700437973725, 4998.5501304882555, 4978.452370239271, 4981.875453113683, 4984.127777638917, 4997.175466048116, 5006.574441172486, 4950.207966725325, 4956.2565615157655, 4958.305837182797, 4960.60315174787, 4963.0, 4857.222844344923, 4922.876928076791, 4949.876253093666, 4953.504649535053, 4965.503449655023, 4252.936205956913, 4276.893077673052, 4280.315149576084, 4291.635211007068, 4292.399064131024, 6233.376662333731, 6282.497400208018, 6306.87386252277, 6318.4313411793155, 6329.556931014831, 5744.540436765049, 5745.856353591152, 5755.65466072037, 5755.798547050875, 5761.337446193699, 6935.89596156053, 6939.097917270773, 6949.061876646639, 6950.54821436605, 6959.582425054513, 4699.036697477009, 4786.497417771154, 4795.160846851822, 4797.9520204797855, 4798.688085274481, 7279.090113735783, 7280.745173918887, 7294.416446684252, 7302.050733404676, 7381.446391520603, 4883.804647814048, 4891.070696567641, 4892.68197567157, 4895.559399653977, 4897.510248975145, 4934.605231581465, 4954.380702412199, 4964.205727083721, 4977.65156439053, 4996.125678006334, 5747.195392645033, 5747.712614369349, 5749.425057494217, 5749.8562535936935, 5758.884822303614, 6804.727810887509, 6964.721411143599, 6999.405050570656, 7006.614636195059, 7006.789796306119, 1710.4099085815374, 1726.7668864703355, 1739.4781565530543, 1740.9129543522772, 1745.3280487012337, 1091.1979694924225, 1115.486876037032, 1119.1270808769173, 1124.6513580789817, 1130.4347826086957, 6631.966840165768, 6830.692618832164, 6886.758963436356, 6890.173179218526, 6907.309269073053, 7287.890681639779, 7304.817379565553, 7332.0, 7353.411727061823, 7357.337839594462, 6867.141607299088, 6868.725250989904, 6880.449564034865, 6888.345607167411, 6888.931110688929, 3914.6868250539887, 3968.3253846846105, 3970.4242884782125, 3974.3044967130636, 3975.5030621172355, 7479.513831601037, 7588.317051465395, 7684.538927664358, 7689.38484921205, 7690.230976902377, 7433.182349941502, 7454.180040195574, 7537.54774713519, 7545.283198096172, 7548.282913123245, 7609.277118673717, 7620.695172193161, 7621.6570254338685, 7637.579933103621, 7667.348275396542, 7205.567665940061, 7274.381677557255, 7278.708851645875, 7328.377087947584, 7339.559626422431, 7153.3919616833155, 7178.353948144692, 7187.460940429384, 7191.3887319578425, 7193.280671932765, 7612.8477430449975, 7616.314531692175, 7632.580208088609, 7638.388928885787, 7655.69377224927, 4991.9500804991485, 5052.317937078595, 5054.772535235997, 5062.316587260672, 5070.569001634754, 7042.753503627348, 7194.532355396883, 7201.0, 7214.2064372917885, 7222.458315626244, 7098.680559374738, 7099.112610923635, 7119.074520312533, 7129.144502659714, 7131.714731410685, 7106.822329441805, 7111.146662400545, 7113.146422429341, 7116.679749411393, 7122.394596459359, 6982.581045137104, 6983.615901125284, 6992.895106573304, 6993.965030174817, 7000.124984376953, 6970.965145174242, 7104.751333703295, 7138.535995160506, 7140.892886606601, 7156.677949492389, 6840.247572767091, 6954.304569543207, 7004.579725216503, 7008.474364422586, 7011.3339232772805], "value": 5279.411874745905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.5326617094428, 852.9658813647454, 862.4178679391412, 899.9100089991001, 946.110655983376, 16818.49544513665, 17190.57023574411, 17217.741733874, 17349.826501734995, 17394.47816565502, 16333.59166020847, 16418.589535261595, 16467.258973346197, 16544.75182872258, 16556.420525281617, 917.3716004536881, 923.2475532441056, 942.0297093993164, 951.2057432044252, 952.6618050592044, 935.8876934767837, 936.7892224249523, 939.4551160327028, 939.5865819039601, 942.3733217410414, 969.4135048295785, 970.5244430229172, 974.0454354732367, 975.0, 978.6917121106865, 957.5595226195924, 963.7397902566303, 964.6768332608584, 968.8595153702673, 969.5103972493916, 712.2770388056127, 715.5206011971991, 716.451914285572, 716.7421175836425, 717.9174394944544, 15450.381984720598, 15479.0, 15483.845161548354, 15558.144302063381, 15571.532854014284, 14380.64048398788, 14466.638334041629, 14485.130892146504, 14506.854931450656, 14675.559733208021, 11991.16061875669, 12267.26396416209, 12295.877041229653, 12368.0, 12678.619641410773, 4071.633552980246, 4151.481064866892, 4219.43037689911, 4242.787860606988, 4249.660027197817, 60764.86831556741, 61725.382746172414, 61945.380546194414, 62843.6857815708, 62913.37086629121, 11529.942350288195, 11723.237989530653, 11822.763544729058, 11826.349550774617, 11893.345865977455, 20390.59218815645, 20438.489037773877, 20492.18031278732, 20502.692459613118, 20575.0, 8281.37889658278, 8452.704155354533, 8480.194381533744, 8541.829163416822, 8570.100139485388, 4466.4640243171025, 4542.386777785023, 4785.784639691222, 5006.148954677714, 5015.27278544609, 3632.891013269606, 3691.464737613031, 3691.7600355976774, 3693.0028892198957, 3703.037210325335, 687.6492988575862, 689.8171984424132, 692.1037256752518, 695.9408450281682, 707.6320313437087, 762.9427792915553, 768.2547580544843, 790.5572879187673, 794.984100318002, 841.2554888923347, 9899.901000989898, 10390.740231494274, 10597.84103238452, 10615.946920265349, 10632.096271816827, 707.4446559450806, 766.9846603067907, 815.9877601835977, 835.7868743470498, 869.4088020146361, 4867.123917694849, 4879.780409881564, 4918.704877707349, 4949.554540091409, 4958.42978057528, 66999.0, 67447.0, 67714.3228567708, 68005.0, 68037.0, 54882.0, 55746.16380754292, 55925.72037139788, 57790.0, 59620.40379596235, 48915.75542122267, 48981.0, 49648.0, 53402.73298633482, 54514.45485545094, 10157.79684406293, 10200.744981375525, 10420.843687344848, 10477.633282835064, 10526.0, 37778.244435111694, 37899.81050094732, 38622.0, 39429.408558872216, 40885.0, 45702.77148614236, 46349.536504634525, 47083.0, 47608.04783904372, 47775.52224477711, 12818.74362512726, 12850.807237891626, 13007.284599346749, 13027.348632568523, 13123.671908202372, 13475.326233688473, 14465.638359041108, 14911.105333680014, 14941.925290373478, 15060.171690557125, 12978.415971281504, 13558.11872228302, 13579.9036886264, 13901.304934753423, 14112.576622701336, 13370.532031378854, 13542.661433464242, 13604.86395136036, 13710.862891370958, 13751.793723094363, 13150.539731109366, 13304.334783260992, 13354.532591359255, 13685.521006764715, 13867.098638588459, 11299.887001129884, 11305.547778088785, 11438.485268162785, 11446.94276528612, 12113.15207935436, 11328.773424531299, 11564.132690048113, 11620.941895290469, 11813.350265735467, 11817.70455738579], "value": 7405.880015518819, "unit": "score"}], "name": "dromaeo_css", "value": 7630.527165483317, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 103.0, 112.0, 115.0, 113.0, 100.0, 112.0, 110.0, 113.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 151.0, 169.0, 126.0, 157.0, 156.0, 130.0, 179.0, 131.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 164.0, 162.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 78.0, 174.0, 73.0, 72.0, 78.0, 76.0, 171.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 156.0, 91.0, 91.0, 92.0, 149.0, 92.0, 91.0, 138.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 117.0, 117.0, 121.0, 119.0, 117.0, 120.0, 120.0, 120.0, 120.0], "value": 119.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 145.0, 148.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 100.0, 94.0, 94.0, 95.0, 95.0, 100.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 56.0, 54.0, 55.0, 55.0, 56.0, 85.0, 55.0, 54.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 61.0, 57.0, 56.0, 58.0], "value": 57.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 83.0, 79.0, 75.0, 75.0, 75.0, 76.0, 84.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 115.0, 116.0, 121.0, 115.0, 115.0, 114.0, 129.0, 128.0], "value": 120.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 166.0, 167.0, 166.0, 166.0, 165.0, 165.0, 166.0, 162.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 66.0, 67.0, 67.0, 67.0, 69.0, 67.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1530.4, "alertThreshold": 2.0}]} 10:24:55 INFO - Return code: 0 10:24:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:24:55 ERROR - # TBPL SUCCESS # 10:24:55 INFO - Running post-action listener: _resource_record_post_action 10:24:55 INFO - Running post-run listener: _resource_record_post_run 10:24:56 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 462532608; Read time: 64; Write time: 373184 10:24:56 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242348032; Read time: 0; Write time: 248456 10:24:56 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 220180480; Read time: 64; Write time: 124728 10:24:56 INFO - Running post-run listener: _upload_blobber_files 10:24:56 INFO - Blob upload gear active. 10:24:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:24:56 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:24:56 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:24:56 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:24:56 INFO - (blobuploader) - INFO - Open directory for files ... 10:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:24:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:24:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:57 INFO - (blobuploader) - INFO - Done attempting. 10:24:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:24:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:24:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:58 INFO - (blobuploader) - INFO - Done attempting. 10:24:58 INFO - (blobuploader) - INFO - Iteration through files over. 10:24:58 INFO - Return code: 0 10:24:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:24:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:24:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29f619a58d5d8a042e130f978d05c2303ce74df68eaf491a666ade24c2af905d03e6cc2ae28b13249cfa3f5875d6338947fe9d403917d29eab71e09a838e4ed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38300ef6941e2284325cd7389e4873e87059d42444b523c814e6cd0e2cc0c92a99fa0289d62f6d758c32e5b61bc2a961f2218e520434124318e61696f31da5ee"} 10:24:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:24:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:24:58 INFO - Contents: 10:24:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29f619a58d5d8a042e130f978d05c2303ce74df68eaf491a666ade24c2af905d03e6cc2ae28b13249cfa3f5875d6338947fe9d403917d29eab71e09a838e4ed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38300ef6941e2284325cd7389e4873e87059d42444b523c814e6cd0e2cc0c92a99fa0289d62f6d758c32e5b61bc2a961f2218e520434124318e61696f31da5ee"} 10:24:58 INFO - Running post-run listener: copy_logs_to_upload_dir 10:24:58 INFO - Copying logs to upload dir... 10:24:58 INFO - mkdir: /builds/slave/test/build/upload/logs 10:24:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.738920 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-17 10:24:58.492556) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 10:24:58.496111) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1466182122.145889-580421052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29f619a58d5d8a042e130f978d05c2303ce74df68eaf491a666ade24c2af905d03e6cc2ae28b13249cfa3f5875d6338947fe9d403917d29eab71e09a838e4ed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38300ef6941e2284325cd7389e4873e87059d42444b523c814e6cd0e2cc0c92a99fa0289d62f6d758c32e5b61bc2a961f2218e520434124318e61696f31da5ee"} 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.011316 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29f619a58d5d8a042e130f978d05c2303ce74df68eaf491a666ade24c2af905d03e6cc2ae28b13249cfa3f5875d6338947fe9d403917d29eab71e09a838e4ed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38300ef6941e2284325cd7389e4873e87059d42444b523c814e6cd0e2cc0c92a99fa0289d62f6d758c32e5b61bc2a961f2218e520434124318e61696f31da5ee"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 10:24:58.522056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:24:58.522433) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1466182122.145889-580421052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 10:24:58.607875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 10:24:58.608383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 10:24:58.609060) ========= ========= Total master_lag: 0.19 =========