builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1464027153.37 results: success (0) buildid: 20160522193137 builduid: c858fb39af334cefa248ec2a3b22030a revision: 2e8129bd6590404ff56ea35ac30d719cf7f566ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.369635) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.370069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.370380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.551798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.552129) ========= 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=cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 11:12:35-- 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% 113M=0s 2016-05-23 11:12:35 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110705 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.697115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.697526) ========= 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=cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021886 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.764584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:12:33.764953) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2e8129bd6590404ff56ea35ac30d719cf7f566ae --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 2e8129bd6590404ff56ea35ac30d719cf7f566ae --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=cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 11:12:35,604 truncating revision to first 12 chars 2016-05-23 11:12:35,605 Setting DEBUG logging. 2016-05-23 11:12:35,605 attempt 1/10 2016-05-23 11:12:35,605 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2e8129bd6590?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 11:12:36,856 unpacking tar archive at: mozilla-beta-2e8129bd6590/testing/mozharness/ program finished with exit code 0 elapsedTime=1.542722 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:12:35.324208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:35.324594) ========= script_repo_revision: 2e8129bd6590404ff56ea35ac30d719cf7f566ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:35.325069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:35.325384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:35.334250) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-05-23 11:12:35.334575) ========= /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=cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:12:37 INFO - MultiFileLogger online at 20160523 11:12:37 in /builds/slave/test 11:12:37 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 11:12:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:37 INFO - {'append_to_log': False, 11:12:37 INFO - 'base_work_dir': '/builds/slave/test', 11:12:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:12:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:37 INFO - 'branch': 'Mozilla-Beta', 11:12:37 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:37 INFO - 'config_files': ('talos/linux_config.py',), 11:12:37 INFO - 'default_actions': ('clobber', 11:12:37 INFO - 'read-buildbot-config', 11:12:37 INFO - 'download-and-extract', 11:12:37 INFO - 'populate-webroot', 11:12:37 INFO - 'create-virtualenv', 11:12:37 INFO - 'install', 11:12:37 INFO - 'run-tests'), 11:12:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:37 INFO - 'download_minidump_stackwalk': True, 11:12:37 INFO - 'download_symbols': 'ondemand', 11:12:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:12:37 INFO - 'tooltool.py': '/tools/tooltool.py', 11:12:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:12:37 INFO - '/tools/misc-python/virtualenv.py')}, 11:12:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:37 INFO - 'installer_path': 'installer.exe', 11:12:37 INFO - 'log_level': 'info', 11:12:37 INFO - 'log_name': 'talos', 11:12:37 INFO - 'log_to_console': True, 11:12:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:12:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:12:37 INFO - 'opt_config_files': (), 11:12:37 INFO - 'pip_index': False, 11:12:37 INFO - 'sps_profile': False, 11:12:37 INFO - 'sps_profile_interval': 0, 11:12:37 INFO - 'suite': 'dromaeojs-e10s', 11:12:37 INFO - 'system_bits': '32', 11:12:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:37 INFO - 'title': 'talos-linux64-ix-054', 11:12:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:37 INFO - 'use_talos_json': True, 11:12:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:37 INFO - 'work_dir': 'build'} 11:12:37 INFO - ##### 11:12:37 INFO - ##### Running clobber step. 11:12:37 INFO - ##### 11:12:37 INFO - Running pre-action listener: _resource_record_pre_action 11:12:37 INFO - Running main action method: clobber 11:12:37 INFO - rmtree: /builds/slave/test/build 11:12:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:37 INFO - Running post-action listener: _resource_record_post_action 11:12:37 INFO - ##### 11:12:37 INFO - ##### Running read-buildbot-config step. 11:12:37 INFO - ##### 11:12:37 INFO - Running pre-action listener: _resource_record_pre_action 11:12:37 INFO - Running main action method: read_buildbot_config 11:12:37 INFO - Using buildbot properties: 11:12:37 INFO - { 11:12:37 INFO - "project": "", 11:12:37 INFO - "product": "firefox", 11:12:37 INFO - "script_repo_revision": "production", 11:12:37 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:12:37 INFO - "repository": "", 11:12:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 11:12:37 INFO - "buildid": "20160522193137", 11:12:37 INFO - "pgo_build": "True", 11:12:37 INFO - "basedir": "/builds/slave/test", 11:12:37 INFO - "buildnumber": 114, 11:12:37 INFO - "slavename": "talos-linux64-ix-054", 11:12:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:12:37 INFO - "platform": "ubuntu64_hw", 11:12:37 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:12:37 INFO - "branch": "mozilla-beta", 11:12:37 INFO - "repo_path": "releases/mozilla-beta", 11:12:37 INFO - "revision": "2e8129bd6590404ff56ea35ac30d719cf7f566ae", 11:12:37 INFO - "stage_platform": "linux64-pgo", 11:12:37 INFO - "builduid": "c858fb39af334cefa248ec2a3b22030a", 11:12:37 INFO - "slavebuilddir": "test" 11:12:37 INFO - } 11:12:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 11:12:37 INFO - Running post-action listener: _resource_record_post_action 11:12:37 INFO - ##### 11:12:37 INFO - ##### Running download-and-extract step. 11:12:37 INFO - ##### 11:12:37 INFO - Running pre-action listener: _resource_record_pre_action 11:12:37 INFO - Running main action method: download_and_extract 11:12:37 INFO - mkdir: /builds/slave/test/build/tests 11:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:37 INFO - https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:12:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:12:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:12:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:12:45 INFO - Downloaded 1412 bytes. 11:12:45 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:12:45 INFO - Using the following test package requirements: 11:12:45 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:12:45 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:45 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:12:45 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:45 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 11:12:45 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:45 INFO - u'jsshell-linux-x86_64.zip'], 11:12:45 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:45 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:12:45 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:12:45 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:45 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 11:12:45 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:45 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 11:12:45 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:45 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:12:45 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:12:45 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:45 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:12:45 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:45 INFO - https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:12:56 INFO - Downloaded 23364942 bytes. 11:12:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:12:57 INFO - Return code: 0 11:12:57 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:12: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')]} 11:12:57 INFO - https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 11:12:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:13:27 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip: timed out 11:13:27 INFO - retry: attempt #1 caught exception: timed out 11:13:27 INFO - retry: Failed, sleeping 30 seconds before retrying 11:13:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 11:13:58 INFO - Downloaded 23364942 bytes. 11:13:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:13:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:14:00 INFO - Return code: 0 11:14: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')]} 11:14:00 INFO - https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:14:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:14:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:14:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 11:14:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:14:01 INFO - Downloaded 10845194 bytes. 11:14:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:14:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:14:01 INFO - Return code: 0 11:14:01 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')]} 11:14:01 INFO - https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:14:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:14:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:14:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:14:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:14:02 INFO - Downloaded 53800139 bytes. 11:14:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:14:02 INFO - mkdir: /builds/slave/test/properties 11:14:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:14:02 INFO - Writing to file /builds/slave/test/properties/build_url 11:14:02 INFO - Contents: 11:14:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 11:14:03 INFO - Running post-action listener: _resource_record_post_action 11:14:03 INFO - Running post-action listener: set_extra_try_arguments 11:14:03 INFO - ##### 11:14:03 INFO - ##### Running populate-webroot step. 11:14:03 INFO - ##### 11:14:03 INFO - Running pre-action listener: _resource_record_pre_action 11:14:03 INFO - Running main action method: populate_webroot 11:14:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:14:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:14:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:14:03 INFO - '--tppagecycles', 11:14:03 INFO - '7'], 11:14:03 INFO - 'tests': ['tsvgm']}}, 11:14:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:14:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:14:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:14:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:14:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:14:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:14:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:03 INFO - 'talos_options': ['--e10s'], 11:14:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:03 INFO - 'tests': ['damp', 'tps']}, 11:14:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:03 INFO - 'talos_options': ['--e10s'], 11:14:03 INFO - 'tests': ['damp', 'tps']}, 11:14:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:14:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:14:03 INFO - 'other': {'tests': ['a11yr', 11:14:03 INFO - 'ts_paint', 11:14:03 INFO - 'tpaint', 11:14:03 INFO - 'sessionrestore', 11:14:03 INFO - 'sessionrestore_no_auto_restore', 11:14:03 INFO - 'tabpaint']}, 11:14:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:14:03 INFO - 'tests': ['a11yr', 11:14:03 INFO - 'ts_paint', 11:14:03 INFO - 'tpaint', 11:14:03 INFO - 'sessionrestore', 11:14:03 INFO - 'sessionrestore_no_auto_restore', 11:14:03 INFO - 'tabpaint']}, 11:14:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:14:03 INFO - 'tests': ['a11yr', 11:14:03 INFO - 'ts_paint', 11:14:03 INFO - 'tpaint', 11:14:03 INFO - 'sessionrestore', 11:14:03 INFO - 'sessionrestore_no_auto_restore', 11:14:03 INFO - 'tabpaint']}, 11:14:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:14:03 INFO - 'tests': ['a11yr', 11:14:03 INFO - 'ts_paint', 11:14:03 INFO - 'tpaint', 11:14:03 INFO - 'sessionrestore', 11:14:03 INFO - 'sessionrestore_no_auto_restore', 11:14:03 INFO - 'tabpaint']}, 11:14:03 INFO - 'other_l64': {'tests': ['a11yr', 11:14:03 INFO - 'ts_paint', 11:14:03 INFO - 'tpaint', 11:14:03 INFO - 'sessionrestore', 11:14:03 INFO - 'sessionrestore_no_auto_restore', 11:14:03 INFO - 'tabpaint']}, 11:14:03 INFO - 'other_nol64': {'tests': ['a11yr', 11:14:03 INFO - 'ts_paint', 11:14:03 INFO - 'tpaint', 11:14:03 INFO - 'sessionrestore', 11:14:03 INFO - 'sessionrestore_no_auto_restore', 11:14:03 INFO - 'tabpaint']}, 11:14:03 INFO - 'svgr': {'tests': ['tsvgx', 11:14:03 INFO - 'tsvgr_opacity', 11:14:03 INFO - 'tart', 11:14:03 INFO - 'tscrollx', 11:14:03 INFO - 'cart']}, 11:14:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:14:03 INFO - 'tests': ['tsvgx', 11:14:03 INFO - 'tsvgr_opacity', 11:14:03 INFO - 'tart', 11:14:03 INFO - 'tscrollx', 11:14:03 INFO - 'cart']}, 11:14:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:03 INFO - 'tests': ['tp5o']}, 11:14:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:03 INFO - 'talos_options': ['--e10s'], 11:14:03 INFO - 'tests': ['tp5o']}, 11:14:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:03 INFO - 'talos_options': ['--xperf_path', 11:14:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:03 INFO - 'tests': ['tp5n']}, 11:14:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:03 INFO - 'talos_options': ['--e10s', 11:14:03 INFO - '--xperf_path', 11:14:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:03 INFO - 'tests': ['tp5n']}}, 11:14:03 INFO - 'talos.zip': {'path': '', 11:14:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:14:03 INFO - Running post-action listener: _resource_record_post_action 11:14:03 INFO - ##### 11:14:03 INFO - ##### Running create-virtualenv step. 11:14:03 INFO - ##### 11:14:03 INFO - Running pre-action listener: _resource_record_pre_action 11:14:03 INFO - Running main action method: create_virtualenv 11:14:03 INFO - Creating virtualenv /builds/slave/test/build/venv 11:14:03 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 11:14:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:14:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:14:03 INFO - Using real prefix '/usr' 11:14:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:14:04 INFO - Installing distribute.............................................................................................................................................................................................done. 11:14:06 INFO - Installing pip.................done. 11:14:06 INFO - Return code: 0 11:14:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:14:06 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')]} 11:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:06 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')]} 11:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:06 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 0x7fd9ab5f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c160>, '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 0x146d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d4f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', '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 11:14:06 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 11:14:06 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 11:14:06 INFO - Using env: {'DISPLAY': ':0', 11:14:06 INFO - 'HOME': '/home/cltbld', 11:14:06 INFO - 'LANG': 'en_US.UTF-8', 11:14:06 INFO - 'LANGUAGE': 'en_US:en', 11:14:06 INFO - 'LOGNAME': 'cltbld', 11:14:06 INFO - 'MAIL': '/var/mail/cltbld', 11:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:06 INFO - 'MOZ_NO_REMOTE': '1', 11:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:06 INFO - 'NO_EM_RESTART': '1', 11:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:06 INFO - 'PWD': '/builds/slave/test', 11:14:06 INFO - 'SHELL': '/bin/bash', 11:14:06 INFO - 'SHLVL': '1', 11:14:06 INFO - 'TERM': 'linux', 11:14:06 INFO - 'TMOUT': '86400', 11:14:06 INFO - 'USER': 'cltbld', 11:14:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', 11:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:06 INFO - '_': '/tools/buildbot/bin/python'} 11:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:06 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 11:14:06 INFO - Cleaning up... 11:14:06 INFO - Return code: 0 11:14:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:14:06 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')]} 11:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:06 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')]} 11:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:06 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 0x7fd9ab5f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c160>, '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 0x146d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d4f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', '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 11:14:06 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 11:14:06 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 11:14:06 INFO - Using env: {'DISPLAY': ':0', 11:14:06 INFO - 'HOME': '/home/cltbld', 11:14:06 INFO - 'LANG': 'en_US.UTF-8', 11:14:06 INFO - 'LANGUAGE': 'en_US:en', 11:14:06 INFO - 'LOGNAME': 'cltbld', 11:14:06 INFO - 'MAIL': '/var/mail/cltbld', 11:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:06 INFO - 'MOZ_NO_REMOTE': '1', 11:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:06 INFO - 'NO_EM_RESTART': '1', 11:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:06 INFO - 'PWD': '/builds/slave/test', 11:14:06 INFO - 'SHELL': '/bin/bash', 11:14:06 INFO - 'SHLVL': '1', 11:14:06 INFO - 'TERM': 'linux', 11:14:06 INFO - 'TMOUT': '86400', 11:14:06 INFO - 'USER': 'cltbld', 11:14:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', 11:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:06 INFO - '_': '/tools/buildbot/bin/python'} 11:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:06 INFO - Downloading/unpacking psutil>=0.7.1 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:14:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:08 INFO - Installing collected packages: psutil 11:14:08 INFO - Running setup.py install for psutil 11:14:08 INFO - building 'psutil._psutil_linux' extension 11:14:08 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 11:14:08 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 11:14:08 INFO - building 'psutil._psutil_posix' extension 11:14:08 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 11:14:08 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 11:14:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:09 INFO - Successfully installed psutil 11:14:09 INFO - Cleaning up... 11:14:09 INFO - Return code: 0 11:14:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:14:09 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')]} 11:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:09 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')]} 11:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:09 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 0x7fd9ab5f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c160>, '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 0x146d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d4f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', '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 11:14:09 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 11:14:09 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 11:14:09 INFO - Using env: {'DISPLAY': ':0', 11:14:09 INFO - 'HOME': '/home/cltbld', 11:14:09 INFO - 'LANG': 'en_US.UTF-8', 11:14:09 INFO - 'LANGUAGE': 'en_US:en', 11:14:09 INFO - 'LOGNAME': 'cltbld', 11:14:09 INFO - 'MAIL': '/var/mail/cltbld', 11:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:09 INFO - 'MOZ_NO_REMOTE': '1', 11:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:09 INFO - 'NO_EM_RESTART': '1', 11:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:09 INFO - 'PWD': '/builds/slave/test', 11:14:09 INFO - 'SHELL': '/bin/bash', 11:14:09 INFO - 'SHLVL': '1', 11:14:09 INFO - 'TERM': 'linux', 11:14:09 INFO - 'TMOUT': '86400', 11:14:09 INFO - 'USER': 'cltbld', 11:14:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', 11:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:09 INFO - '_': '/tools/buildbot/bin/python'} 11:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14: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 11:14:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:14:11 INFO - Installing collected packages: mozsystemmonitor 11:14:11 INFO - Running setup.py install for mozsystemmonitor 11:14:11 INFO - Successfully installed mozsystemmonitor 11:14:11 INFO - Cleaning up... 11:14:11 INFO - Return code: 0 11:14:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:11 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 0x7fd9ab5f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c160>, '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 0x146d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d4f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', '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 11:14:11 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 11:14:11 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 11:14:11 INFO - Using env: {'DISPLAY': ':0', 11:14:11 INFO - 'HOME': '/home/cltbld', 11:14:11 INFO - 'LANG': 'en_US.UTF-8', 11:14:11 INFO - 'LANGUAGE': 'en_US:en', 11:14:11 INFO - 'LOGNAME': 'cltbld', 11:14:11 INFO - 'MAIL': '/var/mail/cltbld', 11:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:11 INFO - 'MOZ_NO_REMOTE': '1', 11:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:11 INFO - 'NO_EM_RESTART': '1', 11:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:11 INFO - 'PWD': '/builds/slave/test', 11:14:11 INFO - 'SHELL': '/bin/bash', 11:14:11 INFO - 'SHLVL': '1', 11:14:11 INFO - 'TERM': 'linux', 11:14:11 INFO - 'TMOUT': '86400', 11:14:11 INFO - 'USER': 'cltbld', 11:14:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', 11:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:11 INFO - '_': '/tools/buildbot/bin/python'} 11:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:11 INFO - Downloading/unpacking blobuploader==1.2.4 11:14:11 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 11:14:11 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 11:14:11 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 11:14:11 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 11:14:11 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 11:14:11 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 11:14:13 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14:13 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 11:14:13 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 11:14:13 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 11:14:13 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 11:14:13 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 11:14:13 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 11:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:14:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14:13 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 11:14:13 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 11:14:13 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 11:14:13 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 11:14:13 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 11:14:13 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 11:14:14 INFO - Downloading docopt-0.6.1.tar.gz 11:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:14 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:14 INFO - Running setup.py install for blobuploader 11:14:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:14:14 INFO - Running setup.py install for requests 11:14:14 INFO - Running setup.py install for docopt 11:14:14 INFO - Successfully installed blobuploader requests docopt 11:14:14 INFO - Cleaning up... 11:14:14 INFO - Return code: 0 11:14:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:14 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')]} 11:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:14 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')]} 11:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:14 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 0x7fd9ab5f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c160>, '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 0x146d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d4f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', '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 11:14:14 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 11:14:14 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 11:14:14 INFO - Using env: {'DISPLAY': ':0', 11:14:14 INFO - 'HOME': '/home/cltbld', 11:14:14 INFO - 'LANG': 'en_US.UTF-8', 11:14:14 INFO - 'LANGUAGE': 'en_US:en', 11:14:14 INFO - 'LOGNAME': 'cltbld', 11:14:14 INFO - 'MAIL': '/var/mail/cltbld', 11:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:14 INFO - 'MOZ_NO_REMOTE': '1', 11:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:14 INFO - 'NO_EM_RESTART': '1', 11:14:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:14 INFO - 'PWD': '/builds/slave/test', 11:14:14 INFO - 'SHELL': '/bin/bash', 11:14:14 INFO - 'SHLVL': '1', 11:14:14 INFO - 'TERM': 'linux', 11:14:14 INFO - 'TMOUT': '86400', 11:14:14 INFO - 'USER': 'cltbld', 11:14:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', 11:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:14 INFO - '_': '/tools/buildbot/bin/python'} 11:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:15 INFO - Running setup.py (path:/tmp/pip-x9oApE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:15 INFO - Running setup.py (path:/tmp/pip-TnDXvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:15 INFO - Running setup.py (path:/tmp/pip-AAjzXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:15 INFO - Running setup.py (path:/tmp/pip-GhVxE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:15 INFO - Running setup.py (path:/tmp/pip-ehrRNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:15 INFO - Running setup.py (path:/tmp/pip-CLEIWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:15 INFO - Running setup.py (path:/tmp/pip-_a9vno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:15 INFO - Running setup.py (path:/tmp/pip-VnSId8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:15 INFO - Running setup.py (path:/tmp/pip-cg2m97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:15 INFO - Running setup.py (path:/tmp/pip-NSRBUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:15 INFO - Running setup.py (path:/tmp/pip-lc5lLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:15 INFO - Running setup.py (path:/tmp/pip-Xu3zJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:15 INFO - Running setup.py (path:/tmp/pip-OFuq4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:15 INFO - Running setup.py (path:/tmp/pip-4gkZtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:16 INFO - Running setup.py (path:/tmp/pip-gJ8VEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:16 INFO - Running setup.py (path:/tmp/pip-r9MqWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:16 INFO - Running setup.py (path:/tmp/pip-_jO6es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:16 INFO - Running setup.py install for manifestparser 11:14:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:14:16 INFO - Running setup.py install for mozcrash 11:14:16 INFO - Running setup.py install for mozdebug 11:14:16 INFO - Running setup.py install for mozdevice 11:14:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:14:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:14:16 INFO - Running setup.py install for mozfile 11:14:16 INFO - Running setup.py install for mozhttpd 11:14:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:14:16 INFO - Running setup.py install for mozinfo 11:14:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:14:16 INFO - Running setup.py install for mozInstall 11:14:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:14:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:14:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:14:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:14:17 INFO - Running setup.py install for mozleak 11:14:17 INFO - Running setup.py install for mozlog 11:14:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:14:17 INFO - Running setup.py install for moznetwork 11:14:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:14:17 INFO - Running setup.py install for mozprocess 11:14:17 INFO - Running setup.py install for mozprofile 11:14:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:14:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:14:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:14:17 INFO - Running setup.py install for mozrunner 11:14:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:14:17 INFO - Running setup.py install for mozscreenshot 11:14:17 INFO - Running setup.py install for moztest 11:14:17 INFO - Running setup.py install for mozversion 11:14:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:14:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:18 INFO - Cleaning up... 11:14:18 INFO - Return code: 0 11:14:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:18 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 0x7fd9ab5f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c160>, '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 0x146d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d4f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', '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 11:14:18 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 11:14:18 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 11:14:18 INFO - Using env: {'DISPLAY': ':0', 11:14:18 INFO - 'HOME': '/home/cltbld', 11:14:18 INFO - 'LANG': 'en_US.UTF-8', 11:14:18 INFO - 'LANGUAGE': 'en_US:en', 11:14:18 INFO - 'LOGNAME': 'cltbld', 11:14:18 INFO - 'MAIL': '/var/mail/cltbld', 11:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:18 INFO - 'MOZ_NO_REMOTE': '1', 11:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:18 INFO - 'NO_EM_RESTART': '1', 11:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:18 INFO - 'PWD': '/builds/slave/test', 11:14:18 INFO - 'SHELL': '/bin/bash', 11:14:18 INFO - 'SHLVL': '1', 11:14:18 INFO - 'TERM': 'linux', 11:14:18 INFO - 'TMOUT': '86400', 11:14:18 INFO - 'USER': 'cltbld', 11:14:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', 11:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:18 INFO - '_': '/tools/buildbot/bin/python'} 11:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:18 INFO - Running setup.py (path:/tmp/pip-NCdmGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:18 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)) 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:18 INFO - Running setup.py (path:/tmp/pip-RypnMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:18 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)) 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:18 INFO - Running setup.py (path:/tmp/pip-8iqHoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:18 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)) 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:18 INFO - Running setup.py (path:/tmp/pip-bTIaO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:18 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)) 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:18 INFO - Running setup.py (path:/tmp/pip-tNqeBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:18 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)) 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:18 INFO - Running setup.py (path:/tmp/pip-vcHSUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:18 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)) 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:18 INFO - Running setup.py (path:/tmp/pip-3fdpNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:18 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)) 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:18 INFO - Running setup.py (path:/tmp/pip-eajTrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:18 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)) 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:18 INFO - Running setup.py (path:/tmp/pip-UHAsTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:18 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)) 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:18 INFO - Running setup.py (path:/tmp/pip-YlxPYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:18 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)) 11:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:18 INFO - Running setup.py (path:/tmp/pip-JeBgi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:19 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)) 11:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:19 INFO - Running setup.py (path:/tmp/pip-07eIFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:19 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)) 11:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:19 INFO - Running setup.py (path:/tmp/pip-J8LGWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:19 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)) 11:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:19 INFO - Running setup.py (path:/tmp/pip-k8bO1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:19 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)) 11:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:19 INFO - Running setup.py (path:/tmp/pip-ZipFmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:19 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)) 11:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:19 INFO - Running setup.py (path:/tmp/pip-SZdScM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:19 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)) 11:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:19 INFO - Running setup.py (path:/tmp/pip-F9FCjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:19 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)) 11:14:19 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)) 11:14:19 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)) 11:14:19 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)) 11:14:19 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)) 11:14:19 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)) 11:14:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:19 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 11:14:19 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 11:14:19 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 11:14:19 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 11:14:19 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 11:14:19 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 11:14:21 INFO - Downloading blessings-1.6.tar.gz 11:14:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:21 INFO - Installing collected packages: blessings 11:14:21 INFO - Running setup.py install for blessings 11:14:21 INFO - Successfully installed blessings 11:14:21 INFO - Cleaning up... 11:14:21 INFO - Return code: 0 11:14:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:14:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:21 INFO - Reading from file tmpfile_stdout 11:14:21 INFO - Current package versions: 11:14:21 INFO - argparse == 1.2.1 11:14:21 INFO - blessings == 1.6 11:14:21 INFO - blobuploader == 1.2.4 11:14:21 INFO - docopt == 0.6.1 11:14:21 INFO - manifestparser == 1.1 11:14:21 INFO - mozInstall == 1.12 11:14:21 INFO - mozcrash == 0.17 11:14:21 INFO - mozdebug == 0.1 11:14:21 INFO - mozdevice == 0.48 11:14:21 INFO - mozfile == 1.2 11:14:21 INFO - mozhttpd == 0.7 11:14:21 INFO - mozinfo == 0.9 11:14:21 INFO - mozleak == 0.1 11:14:21 INFO - mozlog == 3.1 11:14:21 INFO - moznetwork == 0.27 11:14:21 INFO - mozprocess == 0.22 11:14:21 INFO - mozprofile == 0.28 11:14:21 INFO - mozrunner == 6.11 11:14:21 INFO - mozscreenshot == 0.1 11:14:21 INFO - mozsystemmonitor == 0.0 11:14:21 INFO - moztest == 0.7 11:14:21 INFO - mozversion == 1.4 11:14:21 INFO - psutil == 3.1.1 11:14:21 INFO - requests == 1.2.3 11:14:21 INFO - wsgiref == 0.1.2 11:14:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:21 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')]} 11:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:21 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')]} 11:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:21 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 0x7fd9ab5f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c160>, '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 0x146d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d4f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', '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 11:14:21 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 11:14:21 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 11:14:21 INFO - Using env: {'DISPLAY': ':0', 11:14:21 INFO - 'HOME': '/home/cltbld', 11:14:21 INFO - 'LANG': 'en_US.UTF-8', 11:14:21 INFO - 'LANGUAGE': 'en_US:en', 11:14:21 INFO - 'LOGNAME': 'cltbld', 11:14:21 INFO - 'MAIL': '/var/mail/cltbld', 11:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:21 INFO - 'MOZ_NO_REMOTE': '1', 11:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:21 INFO - 'NO_EM_RESTART': '1', 11:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:21 INFO - 'PWD': '/builds/slave/test', 11:14:21 INFO - 'SHELL': '/bin/bash', 11:14:21 INFO - 'SHLVL': '1', 11:14:21 INFO - 'TERM': 'linux', 11:14:21 INFO - 'TMOUT': '86400', 11:14:21 INFO - 'USER': 'cltbld', 11:14:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', 11:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:21 INFO - '_': '/tools/buildbot/bin/python'} 11:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:22 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)) 11:14:22 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)) 11:14:22 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)) 11:14:22 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)) 11:14:22 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)) 11:14:22 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)) 11:14:22 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)) 11:14:22 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)) 11:14:22 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)) 11:14:22 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)) 11:14:22 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)) 11:14:22 INFO - Cleaning up... 11:14:22 INFO - Return code: 0 11:14:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:22 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 0x7fd9ab5f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c160>, '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 0x146d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d4f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', '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 11:14:22 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 11:14:22 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 11:14:22 INFO - Using env: {'DISPLAY': ':0', 11:14:22 INFO - 'HOME': '/home/cltbld', 11:14:22 INFO - 'LANG': 'en_US.UTF-8', 11:14:22 INFO - 'LANGUAGE': 'en_US:en', 11:14:22 INFO - 'LOGNAME': 'cltbld', 11:14:22 INFO - 'MAIL': '/var/mail/cltbld', 11:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:22 INFO - 'MOZ_NO_REMOTE': '1', 11:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:22 INFO - 'NO_EM_RESTART': '1', 11:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:22 INFO - 'PWD': '/builds/slave/test', 11:14:22 INFO - 'SHELL': '/bin/bash', 11:14:22 INFO - 'SHLVL': '1', 11:14:22 INFO - 'TERM': 'linux', 11:14:22 INFO - 'TMOUT': '86400', 11:14:22 INFO - 'USER': 'cltbld', 11:14:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', 11:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:22 INFO - '_': '/tools/buildbot/bin/python'} 11:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:22 INFO - Downloading/unpacking jsonschema 11:14:22 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 11:14:22 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 11:14:22 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 11:14:22 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 11:14:22 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 11:14:22 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 11:14:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:14:24 INFO - Downloading/unpacking functools32 (from jsonschema) 11:14:24 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 11:14:24 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 11:14:24 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 11:14:24 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 11:14:24 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 11:14:24 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 11:14:24 INFO - Downloading functools32-3.2.3-2.tar.gz 11:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:14:24 INFO - warning: no files found matching '*.txt' 11:14:24 INFO - no previously-included directories found matching 'build' 11:14:24 INFO - no previously-included directories found matching 'dist' 11:14:24 INFO - no previously-included directories found matching '.git*' 11:14:24 INFO - Installing collected packages: jsonschema, functools32 11:14:24 INFO - Running setup.py install for functools32 11:14:24 INFO - warning: no files found matching '*.txt' 11:14:24 INFO - no previously-included directories found matching 'build' 11:14:24 INFO - no previously-included directories found matching 'dist' 11:14:24 INFO - no previously-included directories found matching '.git*' 11:14:24 INFO - Successfully installed jsonschema functools32 11:14:24 INFO - Cleaning up... 11:14:24 INFO - Return code: 0 11:14:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:14: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')]} 11:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14: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')]} 11:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:24 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 0x7fd9ab5f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c160>, '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 0x146d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d4f0>, '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': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', '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 11:14:24 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 11:14:24 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 11:14:24 INFO - Using env: {'DISPLAY': ':0', 11:14:24 INFO - 'HOME': '/home/cltbld', 11:14:24 INFO - 'LANG': 'en_US.UTF-8', 11:14:24 INFO - 'LANGUAGE': 'en_US:en', 11:14:24 INFO - 'LOGNAME': 'cltbld', 11:14:24 INFO - 'MAIL': '/var/mail/cltbld', 11:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:24 INFO - 'MOZ_NO_REMOTE': '1', 11:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:24 INFO - 'NO_EM_RESTART': '1', 11:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:24 INFO - 'PWD': '/builds/slave/test', 11:14:24 INFO - 'SHELL': '/bin/bash', 11:14:24 INFO - 'SHLVL': '1', 11:14:24 INFO - 'TERM': 'linux', 11:14:24 INFO - 'TMOUT': '86400', 11:14:24 INFO - 'USER': 'cltbld', 11:14:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', 11:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:24 INFO - '_': '/tools/buildbot/bin/python'} 11:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:24 INFO - Downloading/unpacking flake8 11:14:24 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 11:14:24 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 11:14:24 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 11:14:24 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 11:14:24 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 11:14:24 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 11:14:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:14:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:14:26 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 11:14:26 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 11:14:26 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 11:14:26 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 11:14:26 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 11:14:26 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 11:14:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:14:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:14:26 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 11:14:26 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 11:14:26 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 11:14:26 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 11:14:26 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 11:14:26 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 11:14:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:14:27 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 11:14:27 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 11:14:27 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 11:14:27 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 11:14:27 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 11:14:27 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 11:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:14:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:14:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:14:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:14:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:14:27 INFO - no previously-included directories found matching 'docs/_build' 11:14:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:14:27 INFO - Running setup.py install for pep8 11:14:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:14:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:14:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:14:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:14:27 INFO - no previously-included directories found matching 'docs/_build' 11:14:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:14:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:14:27 INFO - Cleaning up... 11:14:27 INFO - Return code: 0 11:14:27 INFO - Running post-action listener: _resource_record_post_action 11:14:27 INFO - Running post-action listener: _start_resource_monitoring 11:14:27 INFO - Starting resource monitoring. 11:14:27 INFO - ##### 11:14:27 INFO - ##### Running install step. 11:14:27 INFO - ##### 11:14:27 INFO - Running pre-action listener: _resource_record_pre_action 11:14:27 INFO - Running main action method: install 11:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:27 INFO - Reading from file tmpfile_stdout 11:14:27 INFO - Detecting whether we're running mozinstall >=1.0... 11:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:14:27 INFO - Reading from file tmpfile_stdout 11:14:27 INFO - Output received: 11:14:27 INFO - Usage: mozinstall [options] installer 11:14:27 INFO - Options: 11:14:27 INFO - -h, --help show this help message and exit 11:14:27 INFO - -d DEST, --destination=DEST 11:14:27 INFO - Directory to install application into. [default: 11:14:27 INFO - "/builds/slave/test"] 11:14:27 INFO - --app=APP Application being installed. [default: firefox] 11:14:27 INFO - mkdir: /builds/slave/test/build/application 11:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:14:40 INFO - Reading from file tmpfile_stdout 11:14:40 INFO - Output received: 11:14:40 INFO - /builds/slave/test/build/application/firefox/firefox 11:14:40 INFO - Running post-action listener: _resource_record_post_action 11:14:40 INFO - ##### 11:14:40 INFO - ##### Running run-tests step. 11:14:40 INFO - ##### 11:14:40 INFO - Running pre-action listener: _resource_record_pre_action 11:14:40 INFO - Running main action method: run_tests 11:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:14:40 INFO - Python 2.7.3 11:14:40 INFO - Return code: 0 11:14:40 INFO - grabbing minidump binary from tooltool 11:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:40 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 0x146c160>, '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 0x146d060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:14:40 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 11:14:40 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 11:14:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:14:40 INFO - Return code: 0 11:14:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:14:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:14:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:14:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:14:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:14:41 INFO - Return code: 0 11:14:41 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/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 11:14:41 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/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 11:14:41 INFO - Using env: {'DISPLAY': ':0', 11:14:41 INFO - 'HOME': '/home/cltbld', 11:14:41 INFO - 'LANG': 'en_US.UTF-8', 11:14:41 INFO - 'LANGUAGE': 'en_US:en', 11:14:41 INFO - 'LOGNAME': 'cltbld', 11:14:41 INFO - 'MAIL': '/var/mail/cltbld', 11:14:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:14:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:41 INFO - 'MOZ_NO_REMOTE': '1', 11:14:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:41 INFO - 'NO_EM_RESTART': '1', 11:14:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:41 INFO - 'PWD': '/builds/slave/test', 11:14:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:14:41 INFO - 'SHELL': '/bin/bash', 11:14:41 INFO - 'SHLVL': '1', 11:14:41 INFO - 'TERM': 'linux', 11:14:41 INFO - 'TMOUT': '86400', 11:14:41 INFO - 'USER': 'cltbld', 11:14:41 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700', 11:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:41 INFO - '_': '/tools/buildbot/bin/python'} 11:14:41 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/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 11:14:41 INFO - mozversion application_buildid: 20160522193137 11:14:41 INFO - mozversion application_changeset: 2e8129bd6590404ff56ea35ac30d719cf7f566ae 11:14:41 INFO - mozversion application_display_name: Firefox 11:14:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:14:41 INFO - mozversion application_name: Firefox 11:14:41 INFO - mozversion application_remotingname: firefox 11:14:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:14:41 INFO - mozversion application_vendor: Mozilla 11:14:41 INFO - mozversion application_version: 47.0 11:14:41 INFO - mozversion platform_buildid: 20160522193137 11:14:41 INFO - mozversion platform_changeset: 2e8129bd6590404ff56ea35ac30d719cf7f566ae 11:14:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:14:41 INFO - mozversion platform_version: 47.0 11:14:41 INFO - using testdate: 1464027281 11:14:41 INFO - actual date: 1464027281 11:14:41 INFO - starting webserver on 'localhost:37140' 11:14:41 INFO - SUITE-START | Running 2 tests 11:14:41 INFO - TEST-START | dromaeo_css 11:14:41 INFO - operating with platform_type : linux_ 11:14:41 INFO - Initialising browser for dromaeo_css test... 11:14:41 INFO - TEST-INFO | started process 15636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNEl58j/profile http://localhost:37140/getInfo.html) 11:14:45 INFO - PROCESS | 15636 | 11:14:45 INFO - PROCESS | 15636 | (process:15710): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:14:46 INFO - PROCESS | 15636 | __metrics Screen width/height:1600/1200 11:14:46 INFO - PROCESS | 15636 | colorDepth:24 11:14:46 INFO - PROCESS | 15636 | Browser inner width/height: 1024/697 11:14:46 INFO - PROCESS | 15636 | __metrics 11:14:47 ERROR - PROCESS | 15636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:14:47 INFO - TEST-INFO | 15636: exit 0 11:14:47 INFO - Browser initialized. 11:14:47 INFO - Running cycle 1/1 for dromaeo_css test... 11:14:47 INFO - TEST-INFO | started process 15760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNEl58j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:49 INFO - PROCESS | 15760 | 11:14:49 INFO - PROCESS | 15760 | (process:15829): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:14:59 INFO - PROCESS | 15760 | RSS: Main: 149700608 11:14:59 INFO - PROCESS | 15760 | 11:15:49 INFO - PROCESS | 15760 | 1464027349386 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] 11:17:57 INFO - PROCESS | 15760 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37140/tests/dromaeo/cssquery-ext.html) 11:17:58 INFO - PROCESS | 15760 | RSS: Main: 153944064 11:17:58 INFO - PROCESS | 15760 | 11:21:00 INFO - PROCESS | 15760 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-ext.html (next: http://localhost:37140/tests/dromaeo/cssquery-jquery.html) 11:21:00 INFO - PROCESS | 15760 | RSS: Main: 152625152 11:21:00 INFO - PROCESS | 15760 | 11:24:02 INFO - PROCESS | 15760 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37140/tests/dromaeo/cssquery-mootools.html) 11:24:03 INFO - PROCESS | 15760 | RSS: Main: 152305664 11:24:03 INFO - PROCESS | 15760 | 11:27:04 INFO - PROCESS | 15760 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37140/tests/dromaeo/cssquery-prototype.html) 11:27:05 INFO - PROCESS | 15760 | RSS: Main: 152571904 11:27:05 INFO - PROCESS | 15760 | 11:30:07 INFO - PROCESS | 15760 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37140/tests/dromaeo/cssquery-yui.html) 11:30:08 INFO - PROCESS | 15760 | RSS: Main: 151773184 11:30:08 INFO - PROCESS | 15760 | 11:33:10 INFO - PROCESS | 15760 | Cycle 1(1): loaded http://localhost:37140/tests/dromaeo/cssquery-yui.html (next: http://localhost:37140/tests/dromaeo/cssquery-dojo.html) 11:33:10 INFO - PROCESS | 15760 | RSS: Main: 155951104 11:33:10 INFO - PROCESS | 15760 | 11:33:10 INFO - PROCESS | 15760 | __start_tp_report 11:33:10 INFO - PROCESS | 15760 | _x_x_mozilla_page_load 11:33:10 INFO - PROCESS | 15760 | _x_x_mozilla_page_load_details 11:33:10 INFO - PROCESS | 15760 | |i|pagename|runs| 11:33:10 INFO - PROCESS | 15760 | |0;dojo.html;3319.9668003319966;3357.7145942594893;3364.865405383785;3386.8137252451106;3397.6092749333834;5516.9448305516935;5530.087535556629;5541.501264886159;5547.889042219158;5567.359753628334;5539.501444869961;5559.666420014802;5566.332040155177;5566.415526369734;5585.525230355414;4986.825461108853;5014.423341315741;5017.2724954881705;5086.593072554187;5140.845774626749;4957.380327459067;5017.0467611153945;5056.898862022757;5116.795328186868;5126.41046279677;5142.460041695625;5174.741262936857;5183.50756678115;5191.766370513336;5204.115300398941;5114.079465696173;5119.4880511948695;5145.048166089248;5159.974200128975;5193.143131383298;5006.499350065001;5079.644424890259;5095.235714642796;5116.232565115225;5148.407933087706;5408.188771684239;5411.945880541183;5430.42980487051;5457.399686034533;5458.699771512565;5924.911126333109;6016.458518733291;6025.969870150665;6035.486983606399;6040.788572399989;6045;6066.575339726221;6092.329843717188;6124.571280010401;6132.172156758869;5659.320881494247;5682.6590404575445;5684.317881854204;5684.658920464827;5685.346185188715;5980.940190598125;6006.579539432285;6070;6169.136320915076;6202.379762023852;5892.1161825726485;5993.430624090704;5994.460498555151;6005.759769609167;6026.156338112668;6038.396160384014;6042.728077236535;6054.122152287893;6054.878902421927;6054.969725151434;5859.794907178313;5993.670348130895;6003.7898673546215;6013.098035294741;6013.248343957005;5971.253593300838;5990.64056156632;5992.041273396236;5992.400759923973;6030.969845150747;4486.057927835126;4494.752788596658;4501.347304640874;4502.549745025472;4523;3953.446517487554;4023.436718859362;4050.6354428101613;4102.528209255914;4113.979430102891;5579.330480342385;5649.774009039593;5681.801136960186;5728.570357223225;5771.422857714195;6052.152698622196;6057.3336932937345;6057.3336932937345;6067.514598832083;6072.574919755575;5559.11054231321;5637.098064309691;5664.858378540487;5693.3168019837885;5701.942980570224;5056.747162641853;5083.771230294646;5089.745512724349;5115.053715062725;5116.104681680691;6203.751849925952;6205.844853878599;6206.286277078104;6218.284897236786;6222.408871157233;5904.586678932434;5949.315828679757;6079.148919151234;6084.69576521181;6085.513158947362;6059.848503787441;6096.207493025879;6117.979653188475;6126.365000174519;6129.662868542273;5911.408859114054;5912.201852749824;5917.733701983335;5919.6744179070565;5936.020556608284;5910.645361278337;5938.910916336172;6018.398160183947;6120.969395152996;6147.877042459215;5842.678652674143;5872.29532456108;5872.500837428866;5887.3523912370465;5890.734916928663;5872.794452194153;5882.088276317007;5894.764209431574;5896.204012458264;5903.881922361443;5645.1532270159805;5716.628419152742;5788.13178023283;5808.5062769665055;5810.750688601971;5848.64908105515;5857.9121313179485;5873.177755114373;5891.38140495259;5893.44012318829;5558.944410556004;5749.597528173155;5750.0512415450985;5753.626014309057;5753.683547404933 11:33:10 INFO - PROCESS | 15760 | |1;ext.html;497.2590839648924;534.9625526213165;540.2301720048929;540.9829520501457;545.2720617975003;38793;39162.60837391625;39179;39238;39251.0187245319;42325.36511952323;42866.57133428665;42887.35668964968;43008.35487467691;43021.139577208436;8827.95586022069;9105.089491050909;9158.313126515504;9198.862017069716;9228.538573071353;9003.549822508849;9100.180983711465;9154.176124148826;9308.674196403128;9309.441433513977;9226.953865230698;9274.582643781046;9311.022342654025;9314.673986410477;9358.438493690366;9156.6795162169;9272.490013049279;9299.953500232523;9323.440593564408;9356.111169438893;9131.086891310882;9221.953890230507;9224.215941644969;9267.72196834096;9271.490068046254;41173.38239926403;41229.38155927663;41512.37731434031;41522.37716434256;41550.1689966199;3208.5508028875975;3825.215830754689;3837.9424308635394;4079.4084857695766;4320.848770293056;30233.697663023308;33090.33819323624;33441;33593.16017099592;34633.82683086594;4348.282533381988;4388.29787234041;4415.050764085737;4472.709273897186;4484.910301793979;285066;286605;287789;288197.5590122057;291946;46650.533494665295;68685.65657171782;69633.65183174153;69835.30164698287;69904.6504767473;46804;47175.87708553123;47416.5258347419;47537.76231118822;47655.76172119186;16126;16240.350385984428;16250.674986500204;16252.918735406247;16385.754213686803;12727.618171454871;12800.487980480862;12804;12888.162269452456;12900.548480803127;16204.189790510427;16248.187590620422;16367.672646547002;16393.262303196385;16491.67016659684;6358.8410289742205;6526.118973938553;6592.703328350236;6657.7669781557415;6667.63328016954;979.9363041402286;1053.3521884041259;1084.2464487181492;1125.2067292558727;1134.5631931706187;29916;29993;30466.54300185499;30563.541546876815;31323.843380783404;1138.5332013874438;1156.115571587736;1160.2400427719856;1186.4601606269127;1253.4923356040817;14912.552623421314;15287.312070956834;15302.387904483696;15710.764338534931;15713.292901819446;412018;486320;487936;488212;513273;54465.1830222547;54795.726021369635;54938.175927361124;55032;55368.446315537134;1470.6176394137601;1473.5505670770303;1473.6536913825244;1498.3257534109694;1507.6306304955137;29154.854225729585;29324.266893327836;29532.704672952994;30001.849990749906;30082.84958575193;45852.541474584825;45926.77036614929;46461.76769116133;50754.238686419;50893.49106508888;260809;264627;264642;265722;265807;31735.523967140973;32159.51760723544;32186.517202242452;32198;33349.83325083359;46117.76941115273;46273.30590041085;46473.76763116163;47195.52804471911;47896;39686.801565991984;39754.602453976244;39925.20149596933;40178.39732403958;40913.59086409098;37964.15842077737;38550.2289954205;38607.6139238604;38666.613333867426;39445;37333;37960.62039379571;38847.805760971016;38945;39011.2197756049;34254.82872585621;34668.06904044881;34878.82560587181;35083;35218.47172292366;26957.59563606508;27557.31106722348;27891;28312.292192695346;28779.42441151207 11:33:10 INFO - PROCESS | 15760 | |2;jquery.html;364.45877871361023;378.14916438014467;379.29829814842543;386.5129936280286;387.10964781003685;17832.28670853166;17976.82023179768;18495.81504184958;18671.439856804285;18696.439106826783;16563.751543726823;16633.168341582932;16845.747313790303;16852.325906963706;16882.831171688278;5504.64219825711;5744.4829965303115;5775.249217601706;5777.42225777421;5793.681347525884;5118.718470484122;5313.388960269561;5347.973260133714;5358.732063396815;5648.15277708345;5217.947820521803;5256.132738098228;5303.867403314909;5309.946900531003;5315.255864179018;5557.138643510262;5574.358948720868;5584.385717571064;5604.775808967616;5643.548516118701;5333.973330133364;5346.652467589594;5346.866328341784;5355.223492593591;5588.413216612238;13304.401301941436;13480.5281815136;13524.93237533816;13606.931965340209;13618.387172577257;2165.545235500547;2395.844270122454;2405.6391541268777;2427.6237183236626;2433.9878300608384;10223.131033862057;10225.335353202017;10328.58685652573;10373.066424021874;12993.610191694264;1961.4802077449488;1965.1451618545977;1979.1588574855773;1995.7106219598222;1999.1603526518898;61593.99999999955;64884.675576622285;65131.67434162846;67653.66173169152;69153;9534.95232523833;10236.897631023743;10709.518071686793;10763.94618026905;10854.511546980404;15255.694886102438;15405.537833865003;15408.383664653513;15430.228488575527;15437.073775573277;7591.810204744926;7828.256315650005;7859.567723775247;7860.410469214832;7914.604269786488;7529.134149572759;7577.688804914444;7603.2776886195725;7639.961800190964;7647.579383133981;4656.254999200111;4744.810207591727;4756.524347565216;4760.09558183944;4784.330193772875;1767.2400867627043;1773.9290428382978;1822.6172503774092;1857.7956424793263;1869.3363855831255;909.3270979475272;1007.2445665750687;1054.628982322977;1098.7857367813199;1161.2665281121235;16257.674846503003;17253.56866078358;17429.825701743073;17457.21442535089;19268.518287042654;1030.3251370352432;1079.7678499122726;1098.23123813331;1102.1293178389144;1121.3832392184265;10029.788501638455;10473.528691208914;10563.63027294041;10568.577256909792;10676.039156475954;449262;450171;473913;480075;480310;79080.20919790729;79759;81406.59296703598;81509.59245203737;82173.58913205395;1105.6406667832987;1114.3648120571359;1118.1725523112839;1126.0541145437871;1135.0465608888574;16179.838201618304;16314.836851631331;16358;16392.67214655724;16695.415660451825;34874.12814679552;36952.63047369492;37208.25583488369;37253;37273.6272637281;52355.47644523506;52365.476345237585;52555.47444525659;52662;52985;8020.478668886503;8455.534945578052;8552.914470855461;8587.184217499327;8899.332550058902;7715.8071048222;10156.18750499973;10473.581056757645;12647.810282845949;13576.1854288743;11606.361650109326;12072.637820865388;12135.817962730389;12238.694032649255;12414.379281035732;11039.39283339424;11711.707207319885;11793.174477786473;12187.817182742088;12201.328926909106;12273.877261227273;12417.503299867903;12518.624441266777;12522;12725.427355769198;8637.95681021616;8925.330600204881;8974.37179397462;9138.771530711785;9201.941776695765;10351.275410721177;11841.763164736829;11927.284362938251;11930.642080737245;12031.63905082849 11:33:10 INFO - PROCESS | 15760 | |3;mootools.html;1583.2558697412214;1594.9122798246096;1857.127150239387;1954.4527532290963;1985.8113479219478;7074.787756367305;7877.094134174572;8148.633311500982;8347.958260208698;8349.123342049088;8004.639791209395;8156.062052863923;8209.055958564766;8213.91786082139;8228.300594449463;2493.7132229793624;2510.134003768697;2518.9244322670256;2521.722610512851;2530.165045534969;2452.31335226137;2494.052260141144;2500.274920273128;2501.487195124995;2504.7745702886737;2404.663347131403;2419.5402873453986;2420.467497150633;2427.4780922101745;2440.572899742538;2438.7073551173885;2450.656908032877;2472.0235506974736;2502.174282486775;2507.360623041131;2449.546833835728;2460.3849037740565;2464.7904928080957;2477.677901872763;2506.310764539748;8534.615942282611;8585.785355366103;8616.26761725254;8616.698415555487;8621.698240561613;5058.974705126488;5089.770960306758;5117.309163262949;5120.769565369567;5131.846044618667;3218.7907785993834;3236.255661197914;3266.869325226988;3331.4003479373705;3376.5272861799367;1059.3749687684226;1081.9342947197006;1093.6937657455846;2082.5730725201447;2115.577663575213;11494.31034137946;11543.711407214803;11577.594784182513;11581.594644187413;11619.593314233962;4410.69125161242;4427.490838553543;4487.169873573399;4505.774711264424;4537.296719008559;9357.859632105525;9363.204127649225;9365.344425890258;9387.202087822476;9413.294002949806;5110.897782044412;5161.045206636784;5163.561097306771;5177.715225662625;5180.145276029413;4032.919341613151;4511.819527218874;4551.886202844956;4585.312203169485;4741.431028276629;3541.0793193769805;3606.8196590170387;3615.9819200903826;3633.94549081764;3654.780713157219;1026.1329176845554;1029.7271223125877;1039.9808187975825;1051.4007016000805;1081.6754973507916;1454.861788130126;1469.80157678712;1473.3664524254673;1480.052766229614;1530.739774238382;8019.679212831421;8048.59757012147;8058.11360750317;8066.153053929253;8094.473859199251;527.3645257464823;537.1244870860472;550.4660479335039;563.0484481226714;566.6486778197461;6192.845178870474;6241.063840423973;6251.218597675291;6281.748730050746;6306.4639505642535;10214.285000050073;10476.266661333633;10515.106215971575;10535;10592.89407105919;10067.69796906094;10273.383596984206;10303.639372621923;10381.532831022621;10514.73713157162;8155.021397432346;8179.959100204461;8191.672333106609;8217.01395832492;8229.95885020571;7706.961465192639;7795.766127016199;7820.921790782247;7934.1272460030505;7971.880421793562;9123.817523649623;9272.350935434455;9331.113544213289;9446.811063778823;9512.191463725661;9387.530623468936;9462.526873656427;9519.143277105093;9789.31474796786;9805.656802011896;6280.277768056732;6882.346177113166;7119.323664251888;7189.1013623297085;7344.449166312655;8087.353011759163;8105.432619716563;8133.227343402367;8143.51138931666;8154.1030486647605;7219.9278007221355;7355.852882942419;7393.07586551681;7423.554586724814;7446.73936412223;7326.974223608806;7505.624718763931;7549.886751698838;7564.848703025798;7654.349380302737;7783.299503044753;7827.765167044998;7873.566953817366;7877.803054923673;7877.960610197141;6928.826779330557;7144.963980222735;7168.605726685082;7202.315780000891;7220.422366210585;7171.641417929187;7199;7208.855822883618;7219.241979592067;7239.638018099179 11:33:10 INFO - PROCESS | 15760 | |4;prototype.html;348.258210012673;350.6511021533573;355.28764826522826;362.9437437197232;371.168582375479;6481.254655714594;6569.080328753967;6610.669466526672;6610.768623098186;6624.966875165617;6413.230412350525;6414.839629009277;6418.935810641892;6429.646369449679;6431.163948686664;4735.5974742146955;4889.902201955959;4912.656114072016;4953.653244272902;4956.826511072113;4907.803687852482;4919.11455937931;4927.753612319388;4933.383327084114;4950.529699678525;4836.250381190921;4865.245886887538;4877.122118018773;4880.267959806022;4907.1657818171;4896.706197628136;4911.042346742404;4921.286413470062;4921.4340350859575;4925.679830810986;4312.827486900552;4325.783710814447;4332.28517294646;4334.479862416499;4336.21948049351;5930.258717660293;6143.877122457526;6163.753449862045;6166.105914642351;6179.19670442844;5663.405342439026;5676.035074037423;5756.5682573807135;5773.336066352381;5791.362950075489;6893.103896493424;6926.411255043327;6935.3411425914455;6944.826379340507;7002.75490357835;4761.857144285677;4764.309175169581;4777.044591081798;4781.115493633689;4784.473707892129;7119.074520312378;7149.535280206822;7153.463490238253;7159.642017899084;7190.46071544631;4727.101850648366;4770.499097594772;4847.903041939141;4861.270809378621;4876.683015603974;4950.059488697136;4994.950050499521;4998.2002879539095;5002.274670172805;5015.724135172528;5765.827025189251;5772.336181339116;5773.88452230953;5775.306963164448;5789.768409263583;6912.481563882729;6930.3762661359715;6931.861362772716;6942.965285173542;6945.791626251221;1734.2022669572139;1765.5081456169517;1765.6556971390712;1765.9823401765818;1776.2273411066228;1123.612353737959;1133.1331531378503;1158.6697791129488;1160.1241062997383;1169.05306701572;6468;6486.2216534016225;6501.707423165969;6504.219493660697;6507.479401647857;7005.719771209095;7016.719331226694;7025.648717564101;7039.964800176069;7045.330693584101;6491.837704057436;6491.902621460682;6493.285738568754;6494.090827284184;6513.2509761377105;3809.5802937745752;3839.788811615332;3870.1292209252692;3878.2825177342283;3878.806059697004;7237.710491580277;7312.122545294599;7320.816979575553;7338.266173382619;7338.743143989935;7217.9639101805205;7263.745768898063;7263.782086537412;7277.781666550012;7305.1233851938105;7279.308465695751;7289.963550182215;7290.4896657233485;7301.123865136217;7315.268473152642;6968.0941477607585;7109;7111.43108551325;7120.465965052538;7142.785716428515;6955.061066756126;6959.234484206834;6969.7909062728195;6972.372486476242;6979.267176946348;7170.462215333975;7240.674169662483;7265.9273407267365;7266.818329541804;7270.6728197232305;4921.0157968407175;4926.901461970812;4927.285543596086;4928.162212423968;4940.728259945594;6929.514933954575;7015.859682806417;7057.788266352018;7060.8940865886025;7083.929160708327;6953.33943275388;6979.441644668313;6980.581165130108;6985.126859142607;6987.825304367431;6942.479314051568;6969.7909062728195;6977.825554361181;6978.441724662116;6988.336108069725;6792.558483698544;6821.829454263683;6841.692123854538;6842.486813489108;6846;6849.212340580897;6991.091158149611;7003.789886303419;7010.964945175241;7018.964905175441;6764.526483146329;6764.5603035802515;6779.389854912884;6781;6782.016607591971 11:33:10 INFO - PROCESS | 15760 | |5;yui.html;833.3666413525721;841.9663213471462;842.8187939592987;863.0420233540768;881.0924747510065;14230.288485575718;14579.781303280446;14581.416743330254;14620.268986550684;14658.633534161638;14068.78896816546;14167.574972750808;14202.502912398068;14207.573772786807;14217.502387416442;900.8783814185083;917.5458148216642;928.4058202750246;955.2119501411329;959.6065613098631;948.6964171465133;955.6368579939614;958.9520523973808;960.5005397193455;961.3943215774052;985.428451498133;1000.5397517142123;1003.2024540490328;1004.1414590525105;1005.0301459091975;986.6497393425338;995.044757033249;995.2386424385351;995.5470261031213;997.7555498902778;732.8864026075913;734.0384096833112;735.4153448008846;735.6763024269304;737.6533029476137;14298.57104286873;14410.567682969528;14457.132572045712;14539.054961427473;15017.474388396464;13693.246871422069;13973.510927117604;14019.158850469004;14071.085379450304;14080.577582672537;11186.944065279702;11341.773164536664;11355.148363872742;11492.885071149265;11508.194426390157;3845.3270677631303;3906.902327441837;3979.98010009951;3991.3015222335976;4026.2551427985622;53722.462775372136;53820.192697109575;53896.46103538953;54014.72992635012;54044.45955540433;9760.267979901393;10011;10031.799364012679;10103.242256830767;10247.897521024694;19707.704384434244;19722.408327750192;19753.50616234577;19757.110930008184;19783.505412364808;8001.599920003977;8087.312578430781;8104.918950810416;8105.311048560939;8264.793380165544;4692.577668009895;4847.321375007502;4857.441394239708;4891.413030436371;4895.4370247422;3297.868085276562;3338;3339.9499007514905;3354.6309905910816;3356.44618637922;576.4235764235764;589.0104624231247;589.5990726306068;596.242771679964;598.6916737879995;688.5180373738403;703.3775109028444;713.1869668577825;718.192033961793;726.9164046134762;8750.737477875675;8763.167499087576;8778.780530486789;9049;9076.954615227014;540.3623724005632;597.1401182297565;599.9820005399845;665.5540787672271;694.004104110603;4009.799510024487;4039.798010099542;4102.979485102555;4109.815058322323;4242.193983143193;62807.37192628015;66523.33476665268;66947;68468;68692.656536717;54200;57083;58130.128048079314;61325.38674613286;62679;53176;54142.729286353315;57918.710406447695;57952.420475795545;59718.40281597216;8424.663013479392;8427.620757065824;8603.612837422455;8781.956090219508;9227.723168304961;35133.297334053685;35344.64655353517;35640;37328.44007339838;37569.248615027;45311.54688453073;48406.27390589073;49282;49862.252066219764;50552.74723626505;12735.108542401942;12882.03384746129;12968;13150.473981041034;13346.466141354236;12973.481060757842;13470.730585388434;13500.189988600716;13589.32053397346;13593.86406135926;12265.816012759995;12304.938475307566;12387.814182787086;12618.55835045769;12620.684482887635;12017.158798884344;12023;12047.096467765128;12184.268943863397;12284.1401101922;11760.647180584596;11934.522619095485;12432.254064756144;12519.812202816784;12742.936285318514;10051.296409251283;10650.8402373966;10681;11041.72395690082;11410.828837567276;10291.742706432398;10303.615321080075;10307.175425966054;10373.170146388422;10507.422091785025 11:33:10 INFO - PROCESS | 15760 | __end_tp_report 11:33:10 INFO - PROCESS | 15760 | __start_cc_report 11:33:10 INFO - PROCESS | 15760 | _x_x_mozilla_cycle_collect,324 11:33:10 INFO - PROCESS | 15760 | __end_cc_report 11:33:10 INFO - PROCESS | 15760 | __startTimestamp1464028390579__endTimestamp 11:33:10 INFO - PROCESS | 15760 | 11:33:10 INFO - PROCESS | 15760 | ------- Summary: start ------- 11:33:10 INFO - PROCESS | 15760 | Number of tests: 6 11:33:10 INFO - PROCESS | 15760 | 11:33:10 INFO - PROCESS | 15760 | [#0] dojo.html Cycles:165 Average:5567.17 Median:5788.13 stddev:630.84 (10.9%) stddev-sans-first:607.64 11:33:10 INFO - PROCESS | 15760 | Values: 3320.0 3357.7 3364.9 3386.8 3397.6 5516.9 5530.1 5541.5 5547.9 5567.4 5539.5 5559.7 5566.3 5566.4 5585.5 4986.8 5014.4 5017.3 5086.6 5140.8 4957.4 5017.0 5056.9 5116.8 5126.4 5142.5 5174.7 5183.5 5191.8 5204.1 5114.1 5119.5 5145.0 5160.0 5193.1 5006.5 5079.6 5095.2 5116.2 5148.4 5408.2 5411.9 5430.4 5457.4 5458.7 5924.9 6016.5 6026.0 6035.5 6040.8 6045.0 6066.6 6092.3 6124.6 6132.2 5659.3 5682.7 5684.3 5684.7 5685.3 5980.9 6006.6 6070.0 6169.1 6202.4 5892.1 5993.4 5994.5 6005.8 6026.2 6038.4 6042.7 6054.1 6054.9 6055.0 5859.8 5993.7 6003.8 6013.1 6013.2 5971.3 5990.6 5992.0 5992.4 6031.0 4486.1 4494.8 4501.3 4502.5 4523.0 3953.4 4023.4 4050.6 4102.5 4114.0 5579.3 5649.8 5681.8 5728.6 5771.4 6052.2 6057.3 6057.3 6067.5 6072.6 5559.1 5637.1 5664.9 5693.3 5701.9 5056.7 5083.8 5089.7 5115.1 5116.1 6203.8 6205.8 6206.3 6218.3 6222.4 5904.6 5949.3 6079.1 6084.7 6085.5 6059.8 6096.2 6118.0 6126.4 6129.7 5911.4 5912.2 5917.7 5919.7 5936.0 5910.6 5938.9 6018.4 6121.0 6147.9 5842.7 5872.3 5872.5 5887.4 5890.7 5872.8 5882.1 5894.8 5896.2 5903.9 5645.2 5716.6 5788.1 5808.5 5810.8 5848.6 5857.9 5873.2 5891.4 5893.4 5558.9 5749.6 5750.1 5753.6 5753.7 11:33:10 INFO - PROCESS | 15760 | 11:33:10 INFO - PROCESS | 15760 | [#1] ext.html Cycles:180 Average:51287.54 Median:39348.01 stddev:94305.75 (239.7%) stddev-sans-first:94493.20 11:33:10 INFO - PROCESS | 15760 | Values: 497.3 535.0 540.2 541.0 545.3 38793.0 39162.6 39179.0 39238.0 39251.0 42325.4 42866.6 42887.4 43008.4 43021.1 8828.0 9105.1 9158.3 9198.9 9228.5 9003.5 9100.2 9154.2 9308.7 9309.4 9227.0 9274.6 9311.0 9314.7 9358.4 9156.7 9272.5 9300.0 9323.4 9356.1 9131.1 9222.0 9224.2 9267.7 9271.5 41173.4 41229.4 41512.4 41522.4 41550.2 3208.6 3825.2 3837.9 4079.4 4320.8 30233.7 33090.3 33441.0 33593.2 34633.8 4348.3 4388.3 4415.1 4472.7 4484.9 285066.0 286605.0 287789.0 288197.6 291946.0 46650.5 68685.7 69633.7 69835.3 69904.7 46804.0 47175.9 47416.5 47537.8 47655.8 16126.0 16240.4 16250.7 16252.9 16385.8 12727.6 12800.5 12804.0 12888.2 12900.5 16204.2 16248.2 16367.7 16393.3 16491.7 6358.8 6526.1 6592.7 6657.8 6667.6 979.9 1053.4 1084.2 1125.2 1134.6 29916.0 29993.0 30466.5 30563.5 31323.8 1138.5 1156.1 1160.2 1186.5 1253.5 14912.6 15287.3 15302.4 15710.8 15713.3 412018.0 486320.0 487936.0 488212.0 513273.0 54465.2 54795.7 54938.2 55032.0 55368.4 1470.6 1473.6 1473.7 1498.3 1507.6 29154.9 29324.3 29532.7 30001.8 30082.8 45852.5 45926.8 46461.8 50754.2 50893.5 260809.0 264627.0 264642.0 265722.0 265807.0 31735.5 32159.5 32186.5 32198.0 33349.8 46117.8 46273.3 46473.8 47195.5 47896.0 39686.8 39754.6 39925.2 40178.4 40913.6 37964.2 38550.2 38607.6 38666.6 39445.0 37333.0 37960.6 38847.8 38945.0 39011.2 34254.8 34668.1 34878.8 35083.0 35218.5 26957.6 27557.3 27891.0 28312.3 28779.4 11:33:10 INFO - PROCESS | 15760 | 11:33:10 INFO - PROCESS | 15760 | [#2] jquery.html Cycles:180 Average:26827.81 Median:1997.44 stddev:76628.25 (3836.3%) stddev-sans-first:76817.45 11:33:10 INFO - PROCESS | 15760 | Values: 364.5 378.1 379.3 386.5 387.1 17832.3 17976.8 18495.8 18671.4 18696.4 16563.8 16633.2 16845.7 16852.3 16882.8 5504.6 5744.5 5775.2 5777.4 5793.7 5118.7 5313.4 5348.0 5358.7 5648.2 5217.9 5256.1 5303.9 5309.9 5315.3 5557.1 5574.4 5584.4 5604.8 5643.5 5334.0 5346.7 5346.9 5355.2 5588.4 13304.4 13480.5 13524.9 13606.9 13618.4 2165.5 2395.8 2405.6 2427.6 2434.0 10223.1 10225.3 10328.6 10373.1 12993.6 1961.5 1965.1 1979.2 1995.7 1999.2 61594.0 64884.7 65131.7 67653.7 69153.0 9535.0 10236.9 10709.5 10763.9 10854.5 15255.7 15405.5 15408.4 15430.2 15437.1 7591.8 7828.3 7859.6 7860.4 7914.6 7529.1 7577.7 7603.3 7640.0 7647.6 4656.3 4744.8 4756.5 4760.1 4784.3 1767.2 1773.9 1822.6 1857.8 1869.3 909.3 1007.2 1054.6 1098.8 1161.3 16257.7 17253.6 17429.8 17457.2 19268.5 1030.3 1079.8 1098.2 1102.1 1121.4 10029.8 10473.5 10563.6 10568.6 10676.0 449262.0 450171.0 473913.0 480075.0 480310.0 79080.2 79759.0 81406.6 81509.6 82173.6 1105.6 1114.4 1118.2 1126.1 1135.0 16179.8 16314.8 16358.0 16392.7 16695.4 34874.1 36952.6 37208.3 37253.0 37273.6 52355.5 52365.5 52555.5 52662.0 52985.0 8020.5 8455.5 8552.9 8587.2 8899.3 7715.8 10156.2 10473.6 12647.8 13576.2 11606.4 12072.6 12135.8 12238.7 12414.4 11039.4 11711.7 11793.2 12187.8 12201.3 12273.9 12417.5 12518.6 12522.0 12725.4 8638.0 8925.3 8974.4 9138.8 9201.9 10351.3 11841.8 11927.3 11930.6 12031.6 11:33:10 INFO - PROCESS | 15760 | 11:33:10 INFO - PROCESS | 15760 | [#3] mootools.html Cycles:180 Average:5909.16 Median:532.24 stddev:3095.79 (581.6%) stddev-sans-first:3087.40 11:33:10 INFO - PROCESS | 15760 | Values: 1583.3 1594.9 1857.1 1954.5 1985.8 7074.8 7877.1 8148.6 8348.0 8349.1 8004.6 8156.1 8209.1 8213.9 8228.3 2493.7 2510.1 2518.9 2521.7 2530.2 2452.3 2494.1 2500.3 2501.5 2504.8 2404.7 2419.5 2420.5 2427.5 2440.6 2438.7 2450.7 2472.0 2502.2 2507.4 2449.5 2460.4 2464.8 2477.7 2506.3 8534.6 8585.8 8616.3 8616.7 8621.7 5059.0 5089.8 5117.3 5120.8 5131.8 3218.8 3236.3 3266.9 3331.4 3376.5 1059.4 1081.9 1093.7 2082.6 2115.6 11494.3 11543.7 11577.6 11581.6 11619.6 4410.7 4427.5 4487.2 4505.8 4537.3 9357.9 9363.2 9365.3 9387.2 9413.3 5110.9 5161.0 5163.6 5177.7 5180.1 4032.9 4511.8 4551.9 4585.3 4741.4 3541.1 3606.8 3616.0 3633.9 3654.8 1026.1 1029.7 1040.0 1051.4 1081.7 1454.9 1469.8 1473.4 1480.1 1530.7 8019.7 8048.6 8058.1 8066.2 8094.5 527.4 537.1 550.5 563.0 566.6 6192.8 6241.1 6251.2 6281.7 6306.5 10214.3 10476.3 10515.1 10535.0 10592.9 10067.7 10273.4 10303.6 10381.5 10514.7 8155.0 8180.0 8191.7 8217.0 8230.0 7707.0 7795.8 7820.9 7934.1 7971.9 9123.8 9272.4 9331.1 9446.8 9512.2 9387.5 9462.5 9519.1 9789.3 9805.7 6280.3 6882.3 7119.3 7189.1 7344.4 8087.4 8105.4 8133.2 8143.5 8154.1 7219.9 7355.9 7393.1 7423.6 7446.7 7327.0 7505.6 7549.9 7564.8 7654.3 7783.3 7827.8 7873.6 7877.8 7878.0 6928.8 7145.0 7168.6 7202.3 7220.4 7171.6 7199.0 7208.9 7219.2 7239.6 11:33:10 INFO - PROCESS | 15760 | 11:33:10 INFO - PROCESS | 15760 | [#4] prototype.html Cycles:180 Average:5749.06 Median:6493.69 stddev:1733.19 (26.7%) stddev-sans-first:1689.99 11:33:10 INFO - PROCESS | 15760 | Values: 348.3 350.7 355.3 362.9 371.2 6481.3 6569.1 6610.7 6610.8 6625.0 6413.2 6414.8 6418.9 6429.6 6431.2 4735.6 4889.9 4912.7 4953.7 4956.8 4907.8 4919.1 4927.8 4933.4 4950.5 4836.3 4865.2 4877.1 4880.3 4907.2 4896.7 4911.0 4921.3 4921.4 4925.7 4312.8 4325.8 4332.3 4334.5 4336.2 5930.3 6143.9 6163.8 6166.1 6179.2 5663.4 5676.0 5756.6 5773.3 5791.4 6893.1 6926.4 6935.3 6944.8 7002.8 4761.9 4764.3 4777.0 4781.1 4784.5 7119.1 7149.5 7153.5 7159.6 7190.5 4727.1 4770.5 4847.9 4861.3 4876.7 4950.1 4995.0 4998.2 5002.3 5015.7 5765.8 5772.3 5773.9 5775.3 5789.8 6912.5 6930.4 6931.9 6943.0 6945.8 1734.2 1765.5 1765.7 1766.0 1776.2 1123.6 1133.1 1158.7 1160.1 1169.1 6468.0 6486.2 6501.7 6504.2 6507.5 7005.7 7016.7 7025.6 7040.0 7045.3 6491.8 6491.9 6493.3 6494.1 6513.3 3809.6 3839.8 3870.1 3878.3 3878.8 7237.7 7312.1 7320.8 7338.3 7338.7 7218.0 7263.7 7263.8 7277.8 7305.1 7279.3 7290.0 7290.5 7301.1 7315.3 6968.1 7109.0 7111.4 7120.5 7142.8 6955.1 6959.2 6969.8 6972.4 6979.3 7170.5 7240.7 7265.9 7266.8 7270.7 4921.0 4926.9 4927.3 4928.2 4940.7 6929.5 7015.9 7057.8 7060.9 7083.9 6953.3 6979.4 6980.6 6985.1 6987.8 6942.5 6969.8 6977.8 6978.4 6988.3 6792.6 6821.8 6841.7 6842.5 6846.0 6849.2 6991.1 7003.8 7011.0 7019.0 6764.5 6764.6 6779.4 6781.0 6782.0 11:33:10 INFO - PROCESS | 15760 | 11:33:10 INFO - PROCESS | 15760 | [#5] yui.html Cycles:180 Average:15355.82 Median:4106.40 stddev:18286.81 (445.3%) stddev-sans-first:18305.59 11:33:10 INFO - PROCESS | 15760 | Values: 833.4 842.0 842.8 863.0 881.1 14230.3 14579.8 14581.4 14620.3 14658.6 14068.8 14167.6 14202.5 14207.6 14217.5 900.9 917.5 928.4 955.2 959.6 948.7 955.6 959.0 960.5 961.4 985.4 1000.5 1003.2 1004.1 1005.0 986.6 995.0 995.2 995.5 997.8 732.9 734.0 735.4 735.7 737.7 14298.6 14410.6 14457.1 14539.1 15017.5 13693.2 13973.5 14019.2 14071.1 14080.6 11186.9 11341.8 11355.1 11492.9 11508.2 3845.3 3906.9 3980.0 3991.3 4026.3 53722.5 53820.2 53896.5 54014.7 54044.5 9760.3 10011.0 10031.8 10103.2 10247.9 19707.7 19722.4 19753.5 19757.1 19783.5 8001.6 8087.3 8104.9 8105.3 8264.8 4692.6 4847.3 4857.4 4891.4 4895.4 3297.9 3338.0 3339.9 3354.6 3356.4 576.4 589.0 589.6 596.2 598.7 688.5 703.4 713.2 718.2 726.9 8750.7 8763.2 8778.8 9049.0 9077.0 540.4 597.1 600.0 665.6 694.0 4009.8 4039.8 4103.0 4109.8 4242.2 62807.4 66523.3 66947.0 68468.0 68692.7 54200.0 57083.0 58130.1 61325.4 62679.0 53176.0 54142.7 57918.7 57952.4 59718.4 8424.7 8427.6 8603.6 8782.0 9227.7 35133.3 35344.6 35640.0 37328.4 37569.2 45311.5 48406.3 49282.0 49862.3 50552.7 12735.1 12882.0 12968.0 13150.5 13346.5 12973.5 13470.7 13500.2 13589.3 13593.9 12265.8 12304.9 12387.8 12618.6 12620.7 12017.2 12023.0 12047.1 12184.3 12284.1 11760.6 11934.5 12432.3 12519.8 12742.9 10051.3 10650.8 10681.0 11041.7 11410.8 10291.7 10303.6 10307.2 10373.2 10507.4 11:33:10 INFO - PROCESS | 15760 | -------- Summary: end -------- 11:33:10 INFO - PROCESS | 15760 | 11:33:11 INFO - TEST-INFO | 15760: exit 0 11:33:11 INFO - TEST-OK | dromaeo_css | took 1109237ms 11:33:11 INFO - TEST-START | kraken 11:33:11 INFO - operating with platform_type : linux_ 11:33:11 INFO - Initialising browser for kraken test... 11:33:11 INFO - TEST-INFO | started process 16004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFejTj1/profile http://localhost:37140/getInfo.html) 11:33:15 INFO - PROCESS | 16004 | 11:33:15 INFO - PROCESS | 16004 | (process:16084): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:33:15 INFO - PROCESS | 16004 | __metrics Screen width/height:1600/1200 11:33:15 INFO - PROCESS | 16004 | colorDepth:24 11:33:15 INFO - PROCESS | 16004 | Browser inner width/height: 1024/697 11:33:15 INFO - PROCESS | 16004 | __metrics 11:33:16 ERROR - PROCESS | 16004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:33:17 INFO - TEST-INFO | 16004: exit 0 11:33:17 INFO - Browser initialized. 11:33:17 INFO - Running cycle 1/1 for kraken test... 11:33:17 INFO - TEST-INFO | started process 16134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFejTj1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:19 INFO - PROCESS | 16134 | 11:33:19 INFO - PROCESS | 16134 | (process:16203): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:33:29 INFO - PROCESS | 16134 | RSS: Main: 150093824 11:33:29 INFO - PROCESS | 16134 | 11:33:31 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37140/tests/kraken/driver.html?testName=audio-beat-detection) 11:33:32 INFO - PROCESS | 16134 | RSS: Main: 153513984 11:33:32 INFO - PROCESS | 16134 | 11:33:35 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37140/tests/kraken/driver.html?testName=audio-dft) 11:33:35 INFO - PROCESS | 16134 | RSS: Main: 153694208 11:33:35 INFO - PROCESS | 16134 | 11:33:38 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37140/tests/kraken/driver.html?testName=audio-fft) 11:33:39 INFO - PROCESS | 16134 | RSS: Main: 154415104 11:33:39 INFO - PROCESS | 16134 | 11:33:41 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37140/tests/kraken/driver.html?testName=audio-oscillator) 11:33:41 INFO - PROCESS | 16134 | RSS: Main: 154763264 11:33:41 INFO - PROCESS | 16134 | 11:33:44 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37140/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:33:44 INFO - PROCESS | 16134 | RSS: Main: 154701824 11:33:44 INFO - PROCESS | 16134 | 11:33:47 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37140/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:48 INFO - PROCESS | 16134 | RSS: Main: 154820608 11:33:48 INFO - PROCESS | 16134 | 11:33:51 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37140/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:52 INFO - PROCESS | 16134 | RSS: Main: 154488832 11:33:52 INFO - PROCESS | 16134 | 11:33:55 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37140/tests/kraken/driver.html?testName=json-parse-financial) 11:33:55 INFO - PROCESS | 16134 | RSS: Main: 154800128 11:33:55 INFO - PROCESS | 16134 | 11:33:57 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37140/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:57 INFO - PROCESS | 16134 | RSS: Main: 154710016 11:33:57 INFO - PROCESS | 16134 | 11:33:59 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:34:00 INFO - PROCESS | 16134 | RSS: Main: 154259456 11:34:00 INFO - PROCESS | 16134 | 11:34:02 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:34:02 INFO - PROCESS | 16134 | RSS: Main: 154898432 11:34:02 INFO - PROCESS | 16134 | 11:34:05 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:34:05 INFO - PROCESS | 16134 | RSS: Main: 155602944 11:34:05 INFO - PROCESS | 16134 | 11:34:08 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:34:08 INFO - PROCESS | 16134 | RSS: Main: 155471872 11:34:08 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | Cycle 1(1): loaded http://localhost:37140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37140/tests/kraken/driver.html?testName=ai-astar) 11:34:10 INFO - PROCESS | 16134 | RSS: Main: 157114368 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | __start_tp_report 11:34:10 INFO - PROCESS | 16134 | _x_x_mozilla_page_load 11:34:10 INFO - PROCESS | 16134 | _x_x_mozilla_page_load_details 11:34:10 INFO - PROCESS | 16134 | |i|pagename|runs| 11:34:10 INFO - PROCESS | 16134 | |0;ai-astar;110;105;112;112;110;123;113;113;111;110 11:34:10 INFO - PROCESS | 16134 | |1;audio-beat-detection;166;124;159;170;127;156;154;126;174;127 11:34:10 INFO - PROCESS | 16134 | |2;audio-dft;163;162;161;162;164;162;162;163;166;162 11:34:10 INFO - PROCESS | 16134 | |3;audio-fft;76;77;73;160;76;79;77;80;171;77 11:34:10 INFO - PROCESS | 16134 | |4;audio-oscillator;93;94;152;93;93;93;151;93;92;144 11:34:10 INFO - PROCESS | 16134 | |5;imaging-gaussian-blur;117;117;119;117;118;117;117;116;118;118 11:34:10 INFO - PROCESS | 16134 | |6;imaging-darkroom;147;147;147;147;148;147;147;147;148;146 11:34:10 INFO - PROCESS | 16134 | |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;95 11:34:10 INFO - PROCESS | 16134 | |8;json-parse-financial;59;55;59;58;59;55;57;59;60;54 11:34:10 INFO - PROCESS | 16134 | |9;json-stringify-tinderbox;66;64;64;66;70;65;66;65;63;65 11:34:10 INFO - PROCESS | 16134 | |10;stanford-crypto-aes;77;79;81;80;79;79;86;79;79;78 11:34:10 INFO - PROCESS | 16134 | |11;stanford-crypto-ccm;121;120;117;118;116;117;121;117;120;126 11:34:10 INFO - PROCESS | 16134 | |12;stanford-crypto-pbkdf2;156;148;142;145;147;140;156;147;147;148 11:34:10 INFO - PROCESS | 16134 | |13;stanford-crypto-sha256-iterative;71;68;71;67;69;68;67;66;68;70 11:34:10 INFO - PROCESS | 16134 | __end_tp_report 11:34:10 INFO - PROCESS | 16134 | __start_cc_report 11:34:10 INFO - PROCESS | 16134 | _x_x_mozilla_cycle_collect,834 11:34:10 INFO - PROCESS | 16134 | __end_cc_report 11:34:10 INFO - PROCESS | 16134 | __startTimestamp1464028450909__endTimestamp 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | ------- Summary: start ------- 11:34:10 INFO - PROCESS | 16134 | Number of tests: 14 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:4.53 (4.0%) stddev-sans-first:4.76 11:34:10 INFO - PROCESS | 16134 | Values: 110.0 105.0 112.0 112.0 110.0 123.0 113.0 113.0 111.0 110.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:157.50 stddev:20.13 (12.8%) stddev-sans-first:20.30 11:34:10 INFO - PROCESS | 16134 | Values: 166.0 124.0 159.0 170.0 127.0 156.0 154.0 126.0 174.0 127.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:1.42 (0.9%) stddev-sans-first:1.50 11:34:10 INFO - PROCESS | 16134 | Values: 163.0 162.0 161.0 162.0 164.0 162.0 162.0 163.0 166.0 162.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#3] audio-fft Cycles:10 Average:94.60 Median:77.00 stddev:37.50 (48.7%) stddev-sans-first:39.17 11:34:10 INFO - PROCESS | 16134 | Values: 76.0 77.0 73.0 160.0 76.0 79.0 77.0 80.0 171.0 77.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.00 stddev:27.13 (29.2%) stddev-sans-first:28.09 11:34:10 INFO - PROCESS | 16134 | Values: 93.0 94.0 152.0 93.0 93.0 93.0 151.0 93.0 92.0 144.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 11:34:10 INFO - PROCESS | 16134 | Values: 117.0 117.0 119.0 117.0 118.0 117.0 117.0 116.0 118.0 118.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:34:10 INFO - PROCESS | 16134 | Values: 147.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 148.0 146.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:34:10 INFO - PROCESS | 16134 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:59.00 stddev:2.12 (3.6%) stddev-sans-first:2.18 11:34:10 INFO - PROCESS | 16134 | Values: 59.0 55.0 59.0 58.0 59.0 55.0 57.0 59.0 60.0 54.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:1.90 (2.9%) stddev-sans-first:2.00 11:34:10 INFO - PROCESS | 16134 | Values: 66.0 64.0 64.0 66.0 70.0 65.0 66.0 65.0 63.0 65.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.00 stddev:2.45 (3.1%) stddev-sans-first:2.40 11:34:10 INFO - PROCESS | 16134 | Values: 77.0 79.0 81.0 80.0 79.0 79.0 86.0 79.0 79.0 78.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:120.00 stddev:2.98 (2.5%) stddev-sans-first:3.10 11:34:10 INFO - PROCESS | 16134 | Values: 121.0 120.0 117.0 118.0 116.0 117.0 121.0 117.0 120.0 126.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:147.50 stddev:5.15 (3.5%) stddev-sans-first:4.47 11:34:10 INFO - PROCESS | 16134 | Values: 156.0 148.0 142.0 145.0 147.0 140.0 156.0 147.0 147.0 148.0 11:34:10 INFO - PROCESS | 16134 | 11:34:10 INFO - PROCESS | 16134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.72 (2.5%) stddev-sans-first:1.56 11:34:10 INFO - PROCESS | 16134 | Values: 71.0 68.0 71.0 67.0 69.0 68.0 67.0 66.0 68.0 70.0 11:34:10 INFO - PROCESS | 16134 | -------- Summary: end -------- 11:34:10 INFO - PROCESS | 16134 | 11:34:11 INFO - TEST-INFO | 16134: exit 0 11:34:11 INFO - TEST-OK | kraken | took 60621ms 11:34:11 INFO - SUITE-END | took 1169s 11:34:12 INFO - Completed test suite (00:19:30) 11:34:12 INFO - javascript benchmark 11:34:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3319.9668003319966, 3357.7145942594893, 3364.865405383785, 3386.8137252451106, 3397.6092749333834, 5516.9448305516935, 5530.087535556629, 5541.501264886159, 5547.889042219158, 5567.359753628334, 5539.501444869961, 5559.666420014802, 5566.332040155177, 5566.415526369734, 5585.525230355414, 4986.825461108853, 5014.423341315741, 5017.2724954881705, 5086.593072554187, 5140.845774626749, 4957.380327459067, 5017.0467611153945, 5056.898862022757, 5116.795328186868, 5126.41046279677, 5142.460041695625, 5174.741262936857, 5183.50756678115, 5191.766370513336, 5204.115300398941, 5114.079465696173, 5119.4880511948695, 5145.048166089248, 5159.974200128975, 5193.143131383298, 5006.499350065001, 5079.644424890259, 5095.235714642796, 5116.232565115225, 5148.407933087706, 5408.188771684239, 5411.945880541183, 5430.42980487051, 5457.399686034533, 5458.699771512565, 5924.911126333109, 6016.458518733291, 6025.969870150665, 6035.486983606399, 6040.788572399989, 6045.0, 6066.575339726221, 6092.329843717188, 6124.571280010401, 6132.172156758869, 5659.320881494247, 5682.6590404575445, 5684.317881854204, 5684.658920464827, 5685.346185188715, 5980.940190598125, 6006.579539432285, 6070.0, 6169.136320915076, 6202.379762023852, 5892.1161825726485, 5993.430624090704, 5994.460498555151, 6005.759769609167, 6026.156338112668, 6038.396160384014, 6042.728077236535, 6054.122152287893, 6054.878902421927, 6054.969725151434, 5859.794907178313, 5993.670348130895, 6003.7898673546215, 6013.098035294741, 6013.248343957005, 5971.253593300838, 5990.64056156632, 5992.041273396236, 5992.400759923973, 6030.969845150747, 4486.057927835126, 4494.752788596658, 4501.347304640874, 4502.549745025472, 4523.0, 3953.446517487554, 4023.436718859362, 4050.6354428101613, 4102.528209255914, 4113.979430102891, 5579.330480342385, 5649.774009039593, 5681.801136960186, 5728.570357223225, 5771.422857714195, 6052.152698622196, 6057.3336932937345, 6057.3336932937345, 6067.514598832083, 6072.574919755575, 5559.11054231321, 5637.098064309691, 5664.858378540487, 5693.3168019837885, 5701.942980570224, 5056.747162641853, 5083.771230294646, 5089.745512724349, 5115.053715062725, 5116.104681680691, 6203.751849925952, 6205.844853878599, 6206.286277078104, 6218.284897236786, 6222.408871157233, 5904.586678932434, 5949.315828679757, 6079.148919151234, 6084.69576521181, 6085.513158947362, 6059.848503787441, 6096.207493025879, 6117.979653188475, 6126.365000174519, 6129.662868542273, 5911.408859114054, 5912.201852749824, 5917.733701983335, 5919.6744179070565, 5936.020556608284, 5910.645361278337, 5938.910916336172, 6018.398160183947, 6120.969395152996, 6147.877042459215, 5842.678652674143, 5872.29532456108, 5872.500837428866, 5887.3523912370465, 5890.734916928663, 5872.794452194153, 5882.088276317007, 5894.764209431574, 5896.204012458264, 5903.881922361443, 5645.1532270159805, 5716.628419152742, 5788.13178023283, 5808.5062769665055, 5810.750688601971, 5848.64908105515, 5857.9121313179485, 5873.177755114373, 5891.38140495259, 5893.44012318829, 5558.944410556004, 5749.597528173155, 5750.0512415450985, 5753.626014309057, 5753.683547404933], "unit": "score", "name": "dojo.html", "value": 5525.359004304631}, {"lowerIsBetter": false, "replicates": [497.2590839648924, 534.9625526213165, 540.2301720048929, 540.9829520501457, 545.2720617975003, 38793.0, 39162.60837391625, 39179.0, 39238.0, 39251.0187245319, 42325.36511952323, 42866.57133428665, 42887.35668964968, 43008.35487467691, 43021.139577208436, 8827.95586022069, 9105.089491050909, 9158.313126515504, 9198.862017069716, 9228.538573071353, 9003.549822508849, 9100.180983711465, 9154.176124148826, 9308.674196403128, 9309.441433513977, 9226.953865230698, 9274.582643781046, 9311.022342654025, 9314.673986410477, 9358.438493690366, 9156.6795162169, 9272.490013049279, 9299.953500232523, 9323.440593564408, 9356.111169438893, 9131.086891310882, 9221.953890230507, 9224.215941644969, 9267.72196834096, 9271.490068046254, 41173.38239926403, 41229.38155927663, 41512.37731434031, 41522.37716434256, 41550.1689966199, 3208.5508028875975, 3825.215830754689, 3837.9424308635394, 4079.4084857695766, 4320.848770293056, 30233.697663023308, 33090.33819323624, 33441.0, 33593.16017099592, 34633.82683086594, 4348.282533381988, 4388.29787234041, 4415.050764085737, 4472.709273897186, 4484.910301793979, 285066.0, 286605.0, 287789.0, 288197.5590122057, 291946.0, 46650.533494665295, 68685.65657171782, 69633.65183174153, 69835.30164698287, 69904.6504767473, 46804.0, 47175.87708553123, 47416.5258347419, 47537.76231118822, 47655.76172119186, 16126.0, 16240.350385984428, 16250.674986500204, 16252.918735406247, 16385.754213686803, 12727.618171454871, 12800.487980480862, 12804.0, 12888.162269452456, 12900.548480803127, 16204.189790510427, 16248.187590620422, 16367.672646547002, 16393.262303196385, 16491.67016659684, 6358.8410289742205, 6526.118973938553, 6592.703328350236, 6657.7669781557415, 6667.63328016954, 979.9363041402286, 1053.3521884041259, 1084.2464487181492, 1125.2067292558727, 1134.5631931706187, 29916.0, 29993.0, 30466.54300185499, 30563.541546876815, 31323.843380783404, 1138.5332013874438, 1156.115571587736, 1160.2400427719856, 1186.4601606269127, 1253.4923356040817, 14912.552623421314, 15287.312070956834, 15302.387904483696, 15710.764338534931, 15713.292901819446, 412018.0, 486320.0, 487936.0, 488212.0, 513273.0, 54465.1830222547, 54795.726021369635, 54938.175927361124, 55032.0, 55368.446315537134, 1470.6176394137601, 1473.5505670770303, 1473.6536913825244, 1498.3257534109694, 1507.6306304955137, 29154.854225729585, 29324.266893327836, 29532.704672952994, 30001.849990749906, 30082.84958575193, 45852.541474584825, 45926.77036614929, 46461.76769116133, 50754.238686419, 50893.49106508888, 260809.0, 264627.0, 264642.0, 265722.0, 265807.0, 31735.523967140973, 32159.51760723544, 32186.517202242452, 32198.0, 33349.83325083359, 46117.76941115273, 46273.30590041085, 46473.76763116163, 47195.52804471911, 47896.0, 39686.801565991984, 39754.602453976244, 39925.20149596933, 40178.39732403958, 40913.59086409098, 37964.15842077737, 38550.2289954205, 38607.6139238604, 38666.613333867426, 39445.0, 37333.0, 37960.62039379571, 38847.805760971016, 38945.0, 39011.2197756049, 34254.82872585621, 34668.06904044881, 34878.82560587181, 35083.0, 35218.47172292366, 26957.59563606508, 27557.31106722348, 27891.0, 28312.292192695346, 28779.42441151207], "unit": "score", "name": "ext.html", "value": 19347.19210446276}, {"lowerIsBetter": false, "replicates": [364.45877871361023, 378.14916438014467, 379.29829814842543, 386.5129936280286, 387.10964781003685, 17832.28670853166, 17976.82023179768, 18495.81504184958, 18671.439856804285, 18696.439106826783, 16563.751543726823, 16633.168341582932, 16845.747313790303, 16852.325906963706, 16882.831171688278, 5504.64219825711, 5744.4829965303115, 5775.249217601706, 5777.42225777421, 5793.681347525884, 5118.718470484122, 5313.388960269561, 5347.973260133714, 5358.732063396815, 5648.15277708345, 5217.947820521803, 5256.132738098228, 5303.867403314909, 5309.946900531003, 5315.255864179018, 5557.138643510262, 5574.358948720868, 5584.385717571064, 5604.775808967616, 5643.548516118701, 5333.973330133364, 5346.652467589594, 5346.866328341784, 5355.223492593591, 5588.413216612238, 13304.401301941436, 13480.5281815136, 13524.93237533816, 13606.931965340209, 13618.387172577257, 2165.545235500547, 2395.844270122454, 2405.6391541268777, 2427.6237183236626, 2433.9878300608384, 10223.131033862057, 10225.335353202017, 10328.58685652573, 10373.066424021874, 12993.610191694264, 1961.4802077449488, 1965.1451618545977, 1979.1588574855773, 1995.7106219598222, 1999.1603526518898, 61593.99999999955, 64884.675576622285, 65131.67434162846, 67653.66173169152, 69153.0, 9534.95232523833, 10236.897631023743, 10709.518071686793, 10763.94618026905, 10854.511546980404, 15255.694886102438, 15405.537833865003, 15408.383664653513, 15430.228488575527, 15437.073775573277, 7591.810204744926, 7828.256315650005, 7859.567723775247, 7860.410469214832, 7914.604269786488, 7529.134149572759, 7577.688804914444, 7603.2776886195725, 7639.961800190964, 7647.579383133981, 4656.254999200111, 4744.810207591727, 4756.524347565216, 4760.09558183944, 4784.330193772875, 1767.2400867627043, 1773.9290428382978, 1822.6172503774092, 1857.7956424793263, 1869.3363855831255, 909.3270979475272, 1007.2445665750687, 1054.628982322977, 1098.7857367813199, 1161.2665281121235, 16257.674846503003, 17253.56866078358, 17429.825701743073, 17457.21442535089, 19268.518287042654, 1030.3251370352432, 1079.7678499122726, 1098.23123813331, 1102.1293178389144, 1121.3832392184265, 10029.788501638455, 10473.528691208914, 10563.63027294041, 10568.577256909792, 10676.039156475954, 449262.0, 450171.0, 473913.0, 480075.0, 480310.0, 79080.20919790729, 79759.0, 81406.59296703598, 81509.59245203737, 82173.58913205395, 1105.6406667832987, 1114.3648120571359, 1118.1725523112839, 1126.0541145437871, 1135.0465608888574, 16179.838201618304, 16314.836851631331, 16358.0, 16392.67214655724, 16695.415660451825, 34874.12814679552, 36952.63047369492, 37208.25583488369, 37253.0, 37273.6272637281, 52355.47644523506, 52365.476345237585, 52555.47444525659, 52662.0, 52985.0, 8020.478668886503, 8455.534945578052, 8552.914470855461, 8587.184217499327, 8899.332550058902, 7715.8071048222, 10156.18750499973, 10473.581056757645, 12647.810282845949, 13576.1854288743, 11606.361650109326, 12072.637820865388, 12135.817962730389, 12238.694032649255, 12414.379281035732, 11039.39283339424, 11711.707207319885, 11793.174477786473, 12187.817182742088, 12201.328926909106, 12273.877261227273, 12417.503299867903, 12518.624441266777, 12522.0, 12725.427355769198, 8637.95681021616, 8925.330600204881, 8974.37179397462, 9138.771530711785, 9201.941776695765, 10351.275410721177, 11841.763164736829, 11927.284362938251, 11930.642080737245, 12031.63905082849], "unit": "score", "name": "jquery.html", "value": 8802.324108545534}, {"lowerIsBetter": false, "replicates": [1583.2558697412214, 1594.9122798246096, 1857.127150239387, 1954.4527532290963, 1985.8113479219478, 7074.787756367305, 7877.094134174572, 8148.633311500982, 8347.958260208698, 8349.123342049088, 8004.639791209395, 8156.062052863923, 8209.055958564766, 8213.91786082139, 8228.300594449463, 2493.7132229793624, 2510.134003768697, 2518.9244322670256, 2521.722610512851, 2530.165045534969, 2452.31335226137, 2494.052260141144, 2500.274920273128, 2501.487195124995, 2504.7745702886737, 2404.663347131403, 2419.5402873453986, 2420.467497150633, 2427.4780922101745, 2440.572899742538, 2438.7073551173885, 2450.656908032877, 2472.0235506974736, 2502.174282486775, 2507.360623041131, 2449.546833835728, 2460.3849037740565, 2464.7904928080957, 2477.677901872763, 2506.310764539748, 8534.615942282611, 8585.785355366103, 8616.26761725254, 8616.698415555487, 8621.698240561613, 5058.974705126488, 5089.770960306758, 5117.309163262949, 5120.769565369567, 5131.846044618667, 3218.7907785993834, 3236.255661197914, 3266.869325226988, 3331.4003479373705, 3376.5272861799367, 1059.3749687684226, 1081.9342947197006, 1093.6937657455846, 2082.5730725201447, 2115.577663575213, 11494.31034137946, 11543.711407214803, 11577.594784182513, 11581.594644187413, 11619.593314233962, 4410.69125161242, 4427.490838553543, 4487.169873573399, 4505.774711264424, 4537.296719008559, 9357.859632105525, 9363.204127649225, 9365.344425890258, 9387.202087822476, 9413.294002949806, 5110.897782044412, 5161.045206636784, 5163.561097306771, 5177.715225662625, 5180.145276029413, 4032.919341613151, 4511.819527218874, 4551.886202844956, 4585.312203169485, 4741.431028276629, 3541.0793193769805, 3606.8196590170387, 3615.9819200903826, 3633.94549081764, 3654.780713157219, 1026.1329176845554, 1029.7271223125877, 1039.9808187975825, 1051.4007016000805, 1081.6754973507916, 1454.861788130126, 1469.80157678712, 1473.3664524254673, 1480.052766229614, 1530.739774238382, 8019.679212831421, 8048.59757012147, 8058.11360750317, 8066.153053929253, 8094.473859199251, 527.3645257464823, 537.1244870860472, 550.4660479335039, 563.0484481226714, 566.6486778197461, 6192.845178870474, 6241.063840423973, 6251.218597675291, 6281.748730050746, 6306.4639505642535, 10214.285000050073, 10476.266661333633, 10515.106215971575, 10535.0, 10592.89407105919, 10067.69796906094, 10273.383596984206, 10303.639372621923, 10381.532831022621, 10514.73713157162, 8155.021397432346, 8179.959100204461, 8191.672333106609, 8217.01395832492, 8229.95885020571, 7706.961465192639, 7795.766127016199, 7820.921790782247, 7934.1272460030505, 7971.880421793562, 9123.817523649623, 9272.350935434455, 9331.113544213289, 9446.811063778823, 9512.191463725661, 9387.530623468936, 9462.526873656427, 9519.143277105093, 9789.31474796786, 9805.656802011896, 6280.277768056732, 6882.346177113166, 7119.323664251888, 7189.1013623297085, 7344.449166312655, 8087.353011759163, 8105.432619716563, 8133.227343402367, 8143.51138931666, 8154.1030486647605, 7219.9278007221355, 7355.852882942419, 7393.07586551681, 7423.554586724814, 7446.73936412223, 7326.974223608806, 7505.624718763931, 7549.886751698838, 7564.848703025798, 7654.349380302737, 7783.299503044753, 7827.765167044998, 7873.566953817366, 7877.803054923673, 7877.960610197141, 6928.826779330557, 7144.963980222735, 7168.605726685082, 7202.315780000891, 7220.422366210585, 7171.641417929187, 7199.0, 7208.855822883618, 7219.241979592067, 7239.638018099179], "unit": "score", "name": "mootools.html", "value": 4792.985152785107}, {"lowerIsBetter": false, "replicates": [348.258210012673, 350.6511021533573, 355.28764826522826, 362.9437437197232, 371.168582375479, 6481.254655714594, 6569.080328753967, 6610.669466526672, 6610.768623098186, 6624.966875165617, 6413.230412350525, 6414.839629009277, 6418.935810641892, 6429.646369449679, 6431.163948686664, 4735.5974742146955, 4889.902201955959, 4912.656114072016, 4953.653244272902, 4956.826511072113, 4907.803687852482, 4919.11455937931, 4927.753612319388, 4933.383327084114, 4950.529699678525, 4836.250381190921, 4865.245886887538, 4877.122118018773, 4880.267959806022, 4907.1657818171, 4896.706197628136, 4911.042346742404, 4921.286413470062, 4921.4340350859575, 4925.679830810986, 4312.827486900552, 4325.783710814447, 4332.28517294646, 4334.479862416499, 4336.21948049351, 5930.258717660293, 6143.877122457526, 6163.753449862045, 6166.105914642351, 6179.19670442844, 5663.405342439026, 5676.035074037423, 5756.5682573807135, 5773.336066352381, 5791.362950075489, 6893.103896493424, 6926.411255043327, 6935.3411425914455, 6944.826379340507, 7002.75490357835, 4761.857144285677, 4764.309175169581, 4777.044591081798, 4781.115493633689, 4784.473707892129, 7119.074520312378, 7149.535280206822, 7153.463490238253, 7159.642017899084, 7190.46071544631, 4727.101850648366, 4770.499097594772, 4847.903041939141, 4861.270809378621, 4876.683015603974, 4950.059488697136, 4994.950050499521, 4998.2002879539095, 5002.274670172805, 5015.724135172528, 5765.827025189251, 5772.336181339116, 5773.88452230953, 5775.306963164448, 5789.768409263583, 6912.481563882729, 6930.3762661359715, 6931.861362772716, 6942.965285173542, 6945.791626251221, 1734.2022669572139, 1765.5081456169517, 1765.6556971390712, 1765.9823401765818, 1776.2273411066228, 1123.612353737959, 1133.1331531378503, 1158.6697791129488, 1160.1241062997383, 1169.05306701572, 6468.0, 6486.2216534016225, 6501.707423165969, 6504.219493660697, 6507.479401647857, 7005.719771209095, 7016.719331226694, 7025.648717564101, 7039.964800176069, 7045.330693584101, 6491.837704057436, 6491.902621460682, 6493.285738568754, 6494.090827284184, 6513.2509761377105, 3809.5802937745752, 3839.788811615332, 3870.1292209252692, 3878.2825177342283, 3878.806059697004, 7237.710491580277, 7312.122545294599, 7320.816979575553, 7338.266173382619, 7338.743143989935, 7217.9639101805205, 7263.745768898063, 7263.782086537412, 7277.781666550012, 7305.1233851938105, 7279.308465695751, 7289.963550182215, 7290.4896657233485, 7301.123865136217, 7315.268473152642, 6968.0941477607585, 7109.0, 7111.43108551325, 7120.465965052538, 7142.785716428515, 6955.061066756126, 6959.234484206834, 6969.7909062728195, 6972.372486476242, 6979.267176946348, 7170.462215333975, 7240.674169662483, 7265.9273407267365, 7266.818329541804, 7270.6728197232305, 4921.0157968407175, 4926.901461970812, 4927.285543596086, 4928.162212423968, 4940.728259945594, 6929.514933954575, 7015.859682806417, 7057.788266352018, 7060.8940865886025, 7083.929160708327, 6953.33943275388, 6979.441644668313, 6980.581165130108, 6985.126859142607, 6987.825304367431, 6942.479314051568, 6969.7909062728195, 6977.825554361181, 6978.441724662116, 6988.336108069725, 6792.558483698544, 6821.829454263683, 6841.692123854538, 6842.486813489108, 6846.0, 6849.212340580897, 6991.091158149611, 7003.789886303419, 7010.964945175241, 7018.964905175441, 6764.526483146329, 6764.5603035802515, 6779.389854912884, 6781.0, 6782.016607591971], "unit": "score", "name": "prototype.html", "value": 5182.278385349265}, {"lowerIsBetter": false, "replicates": [833.3666413525721, 841.9663213471462, 842.8187939592987, 863.0420233540768, 881.0924747510065, 14230.288485575718, 14579.781303280446, 14581.416743330254, 14620.268986550684, 14658.633534161638, 14068.78896816546, 14167.574972750808, 14202.502912398068, 14207.573772786807, 14217.502387416442, 900.8783814185083, 917.5458148216642, 928.4058202750246, 955.2119501411329, 959.6065613098631, 948.6964171465133, 955.6368579939614, 958.9520523973808, 960.5005397193455, 961.3943215774052, 985.428451498133, 1000.5397517142123, 1003.2024540490328, 1004.1414590525105, 1005.0301459091975, 986.6497393425338, 995.044757033249, 995.2386424385351, 995.5470261031213, 997.7555498902778, 732.8864026075913, 734.0384096833112, 735.4153448008846, 735.6763024269304, 737.6533029476137, 14298.57104286873, 14410.567682969528, 14457.132572045712, 14539.054961427473, 15017.474388396464, 13693.246871422069, 13973.510927117604, 14019.158850469004, 14071.085379450304, 14080.577582672537, 11186.944065279702, 11341.773164536664, 11355.148363872742, 11492.885071149265, 11508.194426390157, 3845.3270677631303, 3906.902327441837, 3979.98010009951, 3991.3015222335976, 4026.2551427985622, 53722.462775372136, 53820.192697109575, 53896.46103538953, 54014.72992635012, 54044.45955540433, 9760.267979901393, 10011.0, 10031.799364012679, 10103.242256830767, 10247.897521024694, 19707.704384434244, 19722.408327750192, 19753.50616234577, 19757.110930008184, 19783.505412364808, 8001.599920003977, 8087.312578430781, 8104.918950810416, 8105.311048560939, 8264.793380165544, 4692.577668009895, 4847.321375007502, 4857.441394239708, 4891.413030436371, 4895.4370247422, 3297.868085276562, 3338.0, 3339.9499007514905, 3354.6309905910816, 3356.44618637922, 576.4235764235764, 589.0104624231247, 589.5990726306068, 596.242771679964, 598.6916737879995, 688.5180373738403, 703.3775109028444, 713.1869668577825, 718.192033961793, 726.9164046134762, 8750.737477875675, 8763.167499087576, 8778.780530486789, 9049.0, 9076.954615227014, 540.3623724005632, 597.1401182297565, 599.9820005399845, 665.5540787672271, 694.004104110603, 4009.799510024487, 4039.798010099542, 4102.979485102555, 4109.815058322323, 4242.193983143193, 62807.37192628015, 66523.33476665268, 66947.0, 68468.0, 68692.656536717, 54200.0, 57083.0, 58130.128048079314, 61325.38674613286, 62679.0, 53176.0, 54142.729286353315, 57918.710406447695, 57952.420475795545, 59718.40281597216, 8424.663013479392, 8427.620757065824, 8603.612837422455, 8781.956090219508, 9227.723168304961, 35133.297334053685, 35344.64655353517, 35640.0, 37328.44007339838, 37569.248615027, 45311.54688453073, 48406.27390589073, 49282.0, 49862.252066219764, 50552.74723626505, 12735.108542401942, 12882.03384746129, 12968.0, 13150.473981041034, 13346.466141354236, 12973.481060757842, 13470.730585388434, 13500.189988600716, 13589.32053397346, 13593.86406135926, 12265.816012759995, 12304.938475307566, 12387.814182787086, 12618.55835045769, 12620.684482887635, 12017.158798884344, 12023.0, 12047.096467765128, 12184.268943863397, 12284.1401101922, 11760.647180584596, 11934.522619095485, 12432.254064756144, 12519.812202816784, 12742.936285318514, 10051.296409251283, 10650.8402373966, 10681.0, 11041.72395690082, 11410.828837567276, 10291.742706432398, 10303.615321080075, 10307.175425966054, 10373.170146388422, 10507.422091785025], "unit": "score", "name": "yui.html", "value": 6914.490859500742}], "name": "dromaeo_css", "value": 7380.45088824968}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 112.0, 112.0, 110.0, 123.0, 113.0, 113.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [166.0, 124.0, 159.0, 170.0, 127.0, 156.0, 154.0, 126.0, 174.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 162.0, 164.0, 162.0, 162.0, 163.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 73.0, 160.0, 76.0, 79.0, 77.0, 80.0, 171.0, 77.0], "unit": "score", "name": "audio-fft", "value": 94.6}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 152.0, 93.0, 93.0, 93.0, 151.0, 93.0, 92.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 119.0, 117.0, 118.0, 117.0, 117.0, 116.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 55.0, 59.0, 58.0, 59.0, 55.0, 57.0, 59.0, 60.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 64.0, 66.0, 70.0, 65.0, 66.0, 65.0, 63.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 81.0, 80.0, 79.0, 79.0, 86.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 117.0, 118.0, 116.0, 117.0, 121.0, 117.0, 120.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [156.0, 148.0, 142.0, 145.0, 147.0, 140.0, 156.0, 147.0, 147.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 71.0, 67.0, 69.0, 68.0, 67.0, 66.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1525.8}]} 11:34:12 INFO - Return code: 0 11:34:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:34:12 ERROR - # TBPL SUCCESS # 11:34:12 INFO - Running post-action listener: _resource_record_post_action 11:34:12 INFO - Running post-run listener: _resource_record_post_run 11:34:13 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 464556032; Read time: 40; Write time: 419084 11:34:13 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 248590336; Read time: 0; Write time: 301788 11:34:13 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 215965696; Read time: 40; Write time: 117296 11:34:13 INFO - Running post-run listener: _upload_blobber_files 11:34:13 INFO - Blob upload gear active. 11:34:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:34:13 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 11:34:13 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'] 11:34:13 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 11:34:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:34:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:34:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:34:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:14 INFO - (blobuploader) - INFO - Done attempting. 11:34:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:34:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:34:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:34:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:15 INFO - (blobuploader) - INFO - Done attempting. 11:34:15 INFO - (blobuploader) - INFO - Iteration through files over. 11:34:15 INFO - Return code: 0 11:34:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:34:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:34:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be2b8b60526048829a37017505d4bbcfabf15969adffd513fbd041a713a19c30e6c12e4be535262d60a4fd1ee0fedf8d6422246ab6b693f11bf6e83b7b6fe02a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f462f844accf713e32d73fbb920e9d01ca580c855e4231180f2d5b4dbf5f2eecd148b2ebd099a16bf01a8de02ef20cc8bbe1aa475221b6ac4acc957c1612cef"} 11:34:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:34:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:34:15 INFO - Contents: 11:34:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/be2b8b60526048829a37017505d4bbcfabf15969adffd513fbd041a713a19c30e6c12e4be535262d60a4fd1ee0fedf8d6422246ab6b693f11bf6e83b7b6fe02a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f462f844accf713e32d73fbb920e9d01ca580c855e4231180f2d5b4dbf5f2eecd148b2ebd099a16bf01a8de02ef20cc8bbe1aa475221b6ac4acc957c1612cef"} 11:34:15 INFO - Running post-run listener: copy_logs_to_upload_dir 11:34:15 INFO - Copying logs to upload dir... 11:34:15 INFO - mkdir: /builds/slave/test/build/upload/logs 11:34:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1298.337657 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-05-23 11:34:14.042319) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:14.045871) ========= 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=cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700 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/be2b8b60526048829a37017505d4bbcfabf15969adffd513fbd041a713a19c30e6c12e4be535262d60a4fd1ee0fedf8d6422246ab6b693f11bf6e83b7b6fe02a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f462f844accf713e32d73fbb920e9d01ca580c855e4231180f2d5b4dbf5f2eecd148b2ebd099a16bf01a8de02ef20cc8bbe1aa475221b6ac4acc957c1612cef"} build_url:https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.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/be2b8b60526048829a37017505d4bbcfabf15969adffd513fbd041a713a19c30e6c12e4be535262d60a4fd1ee0fedf8d6422246ab6b693f11bf6e83b7b6fe02a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f462f844accf713e32d73fbb920e9d01ca580c855e4231180f2d5b4dbf5f2eecd148b2ebd099a16bf01a8de02ef20cc8bbe1aa475221b6ac4acc957c1612cef"}' ========= master_lag: 0.62 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:34:14.679860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:34:14.680175) ========= 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=cbe409c6de289db6ac707de3000001d4-1464026045.283431-1448165700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 1.63 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:34:16.314693) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:34:16.315038) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:34:16.315737) ========= ========= Total master_lag: 2.72 =========