builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1464027153.17 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.171427) ========= 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.172040) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.172487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.209691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.209977) ========= 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=db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 11:12:33-- 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% 43.0M=0s 2016-05-23 11:12:33 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.358392 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.588735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.589502) ========= 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=db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017908 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.651552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:33.652263) ========= 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=db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 11:12:33,898 truncating revision to first 12 chars 2016-05-23 11:12:33,898 Setting DEBUG logging. 2016-05-23 11:12:33,898 attempt 1/10 2016-05-23 11:12:33,898 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:34,157 unpacking tar archive at: mozilla-beta-2e8129bd6590/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534991 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:34.203795) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:34.204553) ========= script_repo_revision: 2e8129bd6590404ff56ea35ac30d719cf7f566ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:34.205564) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:34.206252) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 11:12:34.218125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-23 11:12:34.218448) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:12:34 INFO - MultiFileLogger online at 20160523 11:12:34 in /builds/slave/test 11:12:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:12:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:34 INFO - {'append_to_log': False, 11:12:34 INFO - 'base_work_dir': '/builds/slave/test', 11:12:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:12:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:34 INFO - 'branch': 'Mozilla-Beta', 11:12:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:34 INFO - 'config_files': ('talos/linux_config.py',), 11:12:34 INFO - 'default_actions': ('clobber', 11:12:34 INFO - 'read-buildbot-config', 11:12:34 INFO - 'download-and-extract', 11:12:34 INFO - 'populate-webroot', 11:12:34 INFO - 'create-virtualenv', 11:12:34 INFO - 'install', 11:12:34 INFO - 'run-tests'), 11:12:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:34 INFO - 'download_minidump_stackwalk': True, 11:12:34 INFO - 'download_symbols': 'ondemand', 11:12:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:12:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:12:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:12:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:12:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:34 INFO - 'installer_path': 'installer.exe', 11:12:34 INFO - 'log_level': 'info', 11:12:34 INFO - 'log_name': 'talos', 11:12:34 INFO - 'log_to_console': True, 11:12:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:12:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:12:34 INFO - 'opt_config_files': (), 11:12:34 INFO - 'pip_index': False, 11:12:34 INFO - 'sps_profile': False, 11:12:34 INFO - 'sps_profile_interval': 0, 11:12:34 INFO - 'suite': 'dromaeojs', 11:12:34 INFO - 'system_bits': '32', 11:12:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:34 INFO - 'title': 'talos-linux64-ix-031', 11:12:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:34 INFO - 'use_talos_json': True, 11:12:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:34 INFO - 'work_dir': 'build'} 11:12:34 INFO - ##### 11:12:34 INFO - ##### Running clobber step. 11:12:34 INFO - ##### 11:12:34 INFO - Running pre-action listener: _resource_record_pre_action 11:12:34 INFO - Running main action method: clobber 11:12:34 INFO - rmtree: /builds/slave/test/build 11:12:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:35 INFO - Running post-action listener: _resource_record_post_action 11:12:35 INFO - ##### 11:12:35 INFO - ##### Running read-buildbot-config step. 11:12:35 INFO - ##### 11:12:35 INFO - Running pre-action listener: _resource_record_pre_action 11:12:35 INFO - Running main action method: read_buildbot_config 11:12:35 INFO - Using buildbot properties: 11:12:35 INFO - { 11:12:35 INFO - "project": "", 11:12:35 INFO - "product": "firefox", 11:12:35 INFO - "script_repo_revision": "production", 11:12:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:12:35 INFO - "repository": "", 11:12:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:12:35 INFO - "buildid": "20160522193137", 11:12:35 INFO - "pgo_build": "True", 11:12:35 INFO - "basedir": "/builds/slave/test", 11:12:35 INFO - "buildnumber": 105, 11:12:35 INFO - "slavename": "talos-linux64-ix-031", 11:12:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:12:35 INFO - "platform": "ubuntu64_hw", 11:12:35 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:12:35 INFO - "branch": "mozilla-beta", 11:12:35 INFO - "repo_path": "releases/mozilla-beta", 11:12:35 INFO - "revision": "2e8129bd6590404ff56ea35ac30d719cf7f566ae", 11:12:35 INFO - "stage_platform": "linux64-pgo", 11:12:35 INFO - "builduid": "c858fb39af334cefa248ec2a3b22030a", 11:12:35 INFO - "slavebuilddir": "test" 11:12:35 INFO - } 11:12:35 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:35 INFO - Running post-action listener: _resource_record_post_action 11:12:35 INFO - ##### 11:12:35 INFO - ##### Running download-and-extract step. 11:12:35 INFO - ##### 11:12:35 INFO - Running pre-action listener: _resource_record_pre_action 11:12:35 INFO - Running main action method: download_and_extract 11:12:35 INFO - mkdir: /builds/slave/test/build/tests 11:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:35 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:35 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:35 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:35 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:35 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:36 INFO - Downloaded 1412 bytes. 11:12:36 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 11:12:36 INFO - Using the following test package requirements: 11:12:36 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:12:36 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:36 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:12:36 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:36 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 11:12:36 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:36 INFO - u'jsshell-linux-x86_64.zip'], 11:12:36 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:36 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:12:36 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:12:36 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:36 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 11:12:36 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:36 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 11:12:36 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:36 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:12:36 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 11:12:36 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 11:12:36 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:12:36 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:36 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:36 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:36 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:36 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:36 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:37 INFO - Downloaded 23364942 bytes. 11:12:37 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:37 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:38 INFO - Return code: 0 11:12:38 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:38 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:38 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:38 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:38 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:38 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:38 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:50 INFO - Downloaded 23364942 bytes. 11:12:50 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:50 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:51 INFO - Return code: 0 11:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:51 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:12:51 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:12:51 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:12:51 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:12:51 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:12:52 INFO - Downloaded 10845194 bytes. 11:12:52 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:12:52 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:12:53 INFO - Return code: 0 11:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:53 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:12:53 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:12:53 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:12:53 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:12:53 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:12:54 INFO - Downloaded 53800139 bytes. 11:12:54 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:12:54 INFO - mkdir: /builds/slave/test/properties 11:12:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:54 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:54 INFO - Contents: 11:12:54 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:12:55 INFO - Running post-action listener: _resource_record_post_action 11:12:55 INFO - Running post-action listener: set_extra_try_arguments 11:12:55 INFO - ##### 11:12:55 INFO - ##### Running populate-webroot step. 11:12:55 INFO - ##### 11:12:55 INFO - Running pre-action listener: _resource_record_pre_action 11:12:55 INFO - Running main action method: populate_webroot 11:12:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:55 INFO - '--tppagecycles', 11:12:55 INFO - '7'], 11:12:55 INFO - 'tests': ['tsvgm']}}, 11:12:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:12:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:12:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:12:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:12:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:55 INFO - 'talos_options': ['--e10s'], 11:12:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:55 INFO - 'tests': ['damp', 'tps']}, 11:12:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:55 INFO - 'talos_options': ['--e10s'], 11:12:55 INFO - 'tests': ['damp', 'tps']}, 11:12:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:12:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:55 INFO - 'other': {'tests': ['a11yr', 11:12:55 INFO - 'ts_paint', 11:12:55 INFO - 'tpaint', 11:12:55 INFO - 'sessionrestore', 11:12:55 INFO - 'sessionrestore_no_auto_restore', 11:12:55 INFO - 'tabpaint']}, 11:12:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:12:55 INFO - 'tests': ['a11yr', 11:12:55 INFO - 'ts_paint', 11:12:55 INFO - 'tpaint', 11:12:55 INFO - 'sessionrestore', 11:12:55 INFO - 'sessionrestore_no_auto_restore', 11:12:55 INFO - 'tabpaint']}, 11:12:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:12:55 INFO - 'tests': ['a11yr', 11:12:55 INFO - 'ts_paint', 11:12:55 INFO - 'tpaint', 11:12:55 INFO - 'sessionrestore', 11:12:55 INFO - 'sessionrestore_no_auto_restore', 11:12:55 INFO - 'tabpaint']}, 11:12:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:12:55 INFO - 'tests': ['a11yr', 11:12:55 INFO - 'ts_paint', 11:12:55 INFO - 'tpaint', 11:12:55 INFO - 'sessionrestore', 11:12:55 INFO - 'sessionrestore_no_auto_restore', 11:12:55 INFO - 'tabpaint']}, 11:12:55 INFO - 'other_l64': {'tests': ['a11yr', 11:12:55 INFO - 'ts_paint', 11:12:55 INFO - 'tpaint', 11:12:55 INFO - 'sessionrestore', 11:12:55 INFO - 'sessionrestore_no_auto_restore', 11:12:55 INFO - 'tabpaint']}, 11:12:55 INFO - 'other_nol64': {'tests': ['a11yr', 11:12:55 INFO - 'ts_paint', 11:12:55 INFO - 'tpaint', 11:12:55 INFO - 'sessionrestore', 11:12:55 INFO - 'sessionrestore_no_auto_restore', 11:12:55 INFO - 'tabpaint']}, 11:12:55 INFO - 'svgr': {'tests': ['tsvgx', 11:12:55 INFO - 'tsvgr_opacity', 11:12:55 INFO - 'tart', 11:12:55 INFO - 'tscrollx', 11:12:55 INFO - 'cart']}, 11:12:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:12:55 INFO - 'tests': ['tsvgx', 11:12:55 INFO - 'tsvgr_opacity', 11:12:55 INFO - 'tart', 11:12:55 INFO - 'tscrollx', 11:12:55 INFO - 'cart']}, 11:12:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:55 INFO - 'tests': ['tp5o']}, 11:12:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:55 INFO - 'talos_options': ['--e10s'], 11:12:55 INFO - 'tests': ['tp5o']}, 11:12:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:55 INFO - 'talos_options': ['--xperf_path', 11:12:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:55 INFO - 'tests': ['tp5n']}, 11:12:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:55 INFO - 'talos_options': ['--e10s', 11:12:55 INFO - '--xperf_path', 11:12:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:55 INFO - 'tests': ['tp5n']}}, 11:12:55 INFO - 'talos.zip': {'path': '', 11:12:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:55 INFO - Running post-action listener: _resource_record_post_action 11:12:55 INFO - ##### 11:12:55 INFO - ##### Running create-virtualenv step. 11:12:55 INFO - ##### 11:12:55 INFO - Running pre-action listener: _resource_record_pre_action 11:12:55 INFO - Running main action method: create_virtualenv 11:12:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:55 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:12:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:55 INFO - Using real prefix '/usr' 11:12:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:57 INFO - Installing pip.................done. 11:12:57 INFO - Return code: 0 11:12:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:57 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 0x7f5843e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2955160>, '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 0x2956060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29564f0>, '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': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', '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:12:57 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:12:57 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:12:57 INFO - Using env: {'DISPLAY': ':0', 11:12:57 INFO - 'HOME': '/home/cltbld', 11:12:57 INFO - 'LANG': 'en_US.UTF-8', 11:12:57 INFO - 'LANGUAGE': 'en_US:en', 11:12:57 INFO - 'LOGNAME': 'cltbld', 11:12:57 INFO - 'MAIL': '/var/mail/cltbld', 11:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:57 INFO - 'MOZ_NO_REMOTE': '1', 11:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:57 INFO - 'NO_EM_RESTART': '1', 11:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:57 INFO - 'PWD': '/builds/slave/test', 11:12:57 INFO - 'SHELL': '/bin/bash', 11:12:57 INFO - 'SHLVL': '1', 11:12:57 INFO - 'TERM': 'linux', 11:12:57 INFO - 'TMOUT': '86400', 11:12:57 INFO - 'USER': 'cltbld', 11:12:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', 11:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:57 INFO - '_': '/tools/buildbot/bin/python'} 11:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:57 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:12:57 INFO - Cleaning up... 11:12:57 INFO - Return code: 0 11:12:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:57 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 0x7f5843e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2955160>, '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 0x2956060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29564f0>, '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': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', '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:12:57 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:12:57 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:12:57 INFO - Using env: {'DISPLAY': ':0', 11:12:57 INFO - 'HOME': '/home/cltbld', 11:12:57 INFO - 'LANG': 'en_US.UTF-8', 11:12:57 INFO - 'LANGUAGE': 'en_US:en', 11:12:57 INFO - 'LOGNAME': 'cltbld', 11:12:57 INFO - 'MAIL': '/var/mail/cltbld', 11:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:57 INFO - 'MOZ_NO_REMOTE': '1', 11:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:57 INFO - 'NO_EM_RESTART': '1', 11:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:57 INFO - 'PWD': '/builds/slave/test', 11:12:57 INFO - 'SHELL': '/bin/bash', 11:12:57 INFO - 'SHLVL': '1', 11:12:57 INFO - 'TERM': 'linux', 11:12:57 INFO - 'TMOUT': '86400', 11:12:57 INFO - 'USER': 'cltbld', 11:12:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', 11:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:57 INFO - '_': '/tools/buildbot/bin/python'} 11:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:58 INFO - Downloading/unpacking psutil>=0.7.1 11:12:58 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:12:58 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:12:58 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:12:58 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:12:58 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:12:58 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:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:00 INFO - Installing collected packages: psutil 11:13:00 INFO - Running setup.py install for psutil 11:13:00 INFO - building 'psutil._psutil_linux' extension 11:13:00 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:13:00 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:13:00 INFO - building 'psutil._psutil_posix' extension 11:13:00 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:13:00 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:13:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:00 INFO - Successfully installed psutil 11:13:00 INFO - Cleaning up... 11:13:00 INFO - Return code: 0 11:13:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:13: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:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:00 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 0x7f5843e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2955160>, '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 0x2956060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29564f0>, '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': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', '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:13:00 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:13:00 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:13:00 INFO - Using env: {'DISPLAY': ':0', 11:13:00 INFO - 'HOME': '/home/cltbld', 11:13:00 INFO - 'LANG': 'en_US.UTF-8', 11:13:00 INFO - 'LANGUAGE': 'en_US:en', 11:13:00 INFO - 'LOGNAME': 'cltbld', 11:13:00 INFO - 'MAIL': '/var/mail/cltbld', 11:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:00 INFO - 'MOZ_NO_REMOTE': '1', 11:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:00 INFO - 'NO_EM_RESTART': '1', 11:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:00 INFO - 'PWD': '/builds/slave/test', 11:13:00 INFO - 'SHELL': '/bin/bash', 11:13:00 INFO - 'SHLVL': '1', 11:13:00 INFO - 'TERM': 'linux', 11:13:00 INFO - 'TMOUT': '86400', 11:13:00 INFO - 'USER': 'cltbld', 11:13:00 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', 11:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:00 INFO - '_': '/tools/buildbot/bin/python'} 11:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:13:00 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:13:00 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:13:00 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:13:00 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:13:00 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:13:00 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:13:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:02 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:13:02 INFO - Installing collected packages: mozsystemmonitor 11:13:02 INFO - Running setup.py install for mozsystemmonitor 11:13:02 INFO - Successfully installed mozsystemmonitor 11:13:02 INFO - Cleaning up... 11:13:02 INFO - Return code: 0 11:13:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13:02 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:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:02 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:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:02 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 0x7f5843e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2955160>, '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 0x2956060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29564f0>, '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': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', '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:13:02 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:13:02 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:13:02 INFO - Using env: {'DISPLAY': ':0', 11:13:02 INFO - 'HOME': '/home/cltbld', 11:13:02 INFO - 'LANG': 'en_US.UTF-8', 11:13:02 INFO - 'LANGUAGE': 'en_US:en', 11:13:02 INFO - 'LOGNAME': 'cltbld', 11:13:02 INFO - 'MAIL': '/var/mail/cltbld', 11:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:02 INFO - 'MOZ_NO_REMOTE': '1', 11:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:02 INFO - 'NO_EM_RESTART': '1', 11:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:02 INFO - 'PWD': '/builds/slave/test', 11:13:02 INFO - 'SHELL': '/bin/bash', 11:13:02 INFO - 'SHLVL': '1', 11:13:02 INFO - 'TERM': 'linux', 11:13:02 INFO - 'TMOUT': '86400', 11:13:02 INFO - 'USER': 'cltbld', 11:13:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', 11:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:02 INFO - '_': '/tools/buildbot/bin/python'} 11:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:03 INFO - Downloading/unpacking blobuploader==1.2.4 11:13:03 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:13:03 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:13:03 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:13:03 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:13:03 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:13:03 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:13:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:05 INFO - Downloading docopt-0.6.1.tar.gz 11:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:05 INFO - Running setup.py install for blobuploader 11:13:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:05 INFO - Running setup.py install for requests 11:13:06 INFO - Running setup.py install for docopt 11:13:06 INFO - Successfully installed blobuploader requests docopt 11:13:06 INFO - Cleaning up... 11:13:06 INFO - Return code: 0 11:13:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13: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:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:06 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 0x7f5843e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2955160>, '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 0x2956060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29564f0>, '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': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', '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:13:06 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:13:06 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:13:06 INFO - Using env: {'DISPLAY': ':0', 11:13:06 INFO - 'HOME': '/home/cltbld', 11:13:06 INFO - 'LANG': 'en_US.UTF-8', 11:13:06 INFO - 'LANGUAGE': 'en_US:en', 11:13:06 INFO - 'LOGNAME': 'cltbld', 11:13:06 INFO - 'MAIL': '/var/mail/cltbld', 11:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:06 INFO - 'MOZ_NO_REMOTE': '1', 11:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:06 INFO - 'NO_EM_RESTART': '1', 11:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:06 INFO - 'PWD': '/builds/slave/test', 11:13:06 INFO - 'SHELL': '/bin/bash', 11:13:06 INFO - 'SHLVL': '1', 11:13:06 INFO - 'TERM': 'linux', 11:13:06 INFO - 'TMOUT': '86400', 11:13:06 INFO - 'USER': 'cltbld', 11:13:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', 11:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:06 INFO - '_': '/tools/buildbot/bin/python'} 11:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:06 INFO - Running setup.py (path:/tmp/pip-J8Moav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:06 INFO - Running setup.py (path:/tmp/pip-6E7oNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:06 INFO - Running setup.py (path:/tmp/pip-L_QCOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:06 INFO - Running setup.py (path:/tmp/pip-j4kCFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:06 INFO - Running setup.py (path:/tmp/pip-VoBoB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:06 INFO - Running setup.py (path:/tmp/pip-BpcSb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:07 INFO - Running setup.py (path:/tmp/pip-ULdO7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:07 INFO - Running setup.py (path:/tmp/pip-cH7PtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:07 INFO - Running setup.py (path:/tmp/pip-ksfOvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:07 INFO - Running setup.py (path:/tmp/pip-Fw4gJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:07 INFO - Running setup.py (path:/tmp/pip-TB6VgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:07 INFO - Running setup.py (path:/tmp/pip-9Ttujd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:07 INFO - Running setup.py (path:/tmp/pip-x7iy0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:07 INFO - Running setup.py (path:/tmp/pip-yloVim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:07 INFO - Running setup.py (path:/tmp/pip-nlyOcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:07 INFO - Running setup.py (path:/tmp/pip-MExUr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:07 INFO - Running setup.py (path:/tmp/pip-wKVixA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:07 INFO - Running setup.py install for manifestparser 11:13:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:07 INFO - Running setup.py install for mozcrash 11:13:08 INFO - Running setup.py install for mozdebug 11:13:08 INFO - Running setup.py install for mozdevice 11:13:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Running setup.py install for mozfile 11:13:08 INFO - Running setup.py install for mozhttpd 11:13:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Running setup.py install for mozinfo 11:13:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Running setup.py install for mozInstall 11:13:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Running setup.py install for mozleak 11:13:08 INFO - Running setup.py install for mozlog 11:13:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:08 INFO - Running setup.py install for moznetwork 11:13:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:09 INFO - Running setup.py install for mozprocess 11:13:09 INFO - Running setup.py install for mozprofile 11:13:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:09 INFO - Running setup.py install for mozrunner 11:13:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:09 INFO - Running setup.py install for mozscreenshot 11:13:09 INFO - Running setup.py install for moztest 11:13:09 INFO - Running setup.py install for mozversion 11:13:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:09 INFO - Cleaning up... 11:13:09 INFO - Return code: 0 11:13:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13: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:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:09 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 0x7f5843e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2955160>, '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 0x2956060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29564f0>, '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': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', '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:13:09 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:13:09 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:13:09 INFO - Using env: {'DISPLAY': ':0', 11:13:09 INFO - 'HOME': '/home/cltbld', 11:13:09 INFO - 'LANG': 'en_US.UTF-8', 11:13:09 INFO - 'LANGUAGE': 'en_US:en', 11:13:09 INFO - 'LOGNAME': 'cltbld', 11:13:09 INFO - 'MAIL': '/var/mail/cltbld', 11:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:09 INFO - 'MOZ_NO_REMOTE': '1', 11:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:09 INFO - 'NO_EM_RESTART': '1', 11:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:09 INFO - 'PWD': '/builds/slave/test', 11:13:09 INFO - 'SHELL': '/bin/bash', 11:13:09 INFO - 'SHLVL': '1', 11:13:09 INFO - 'TERM': 'linux', 11:13:09 INFO - 'TMOUT': '86400', 11:13:09 INFO - 'USER': 'cltbld', 11:13:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', 11:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:09 INFO - '_': '/tools/buildbot/bin/python'} 11:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:09 INFO - Running setup.py (path:/tmp/pip-C6OYXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:09 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:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:09 INFO - Running setup.py (path:/tmp/pip-SI1zIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:10 INFO - Running setup.py (path:/tmp/pip-zAYihf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:10 INFO - Running setup.py (path:/tmp/pip-CAfwtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:10 INFO - Running setup.py (path:/tmp/pip-oELEXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:10 INFO - Running setup.py (path:/tmp/pip-pmeX0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:10 INFO - Running setup.py (path:/tmp/pip-hxaxtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:10 INFO - Running setup.py (path:/tmp/pip-ZbR7hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:10 INFO - Running setup.py (path:/tmp/pip-xYYggR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:10 INFO - Running setup.py (path:/tmp/pip-W0wLjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:10 INFO - Running setup.py (path:/tmp/pip-thb9Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:10 INFO - Running setup.py (path:/tmp/pip-pVpClw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:10 INFO - Running setup.py (path:/tmp/pip-_ThUoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:10 INFO - Running setup.py (path:/tmp/pip-jMNgw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:10 INFO - Running setup.py (path:/tmp/pip-CUKMFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:10 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:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:10 INFO - Running setup.py (path:/tmp/pip-TphhUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:11 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:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:11 INFO - Running setup.py (path:/tmp/pip-6H5FIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:11 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:13:11 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:13:11 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:13:11 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:13:11 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:13:11 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:13:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13: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:13: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:13: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:13: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:13: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:13: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:13:12 INFO - Downloading blessings-1.6.tar.gz 11:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:13 INFO - Installing collected packages: blessings 11:13:13 INFO - Running setup.py install for blessings 11:13:13 INFO - Successfully installed blessings 11:13:13 INFO - Cleaning up... 11:13:13 INFO - Return code: 0 11:13:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:13 INFO - Reading from file tmpfile_stdout 11:13:13 INFO - Current package versions: 11:13:13 INFO - argparse == 1.2.1 11:13:13 INFO - blessings == 1.6 11:13:13 INFO - blobuploader == 1.2.4 11:13:13 INFO - docopt == 0.6.1 11:13:13 INFO - manifestparser == 1.1 11:13:13 INFO - mozInstall == 1.12 11:13:13 INFO - mozcrash == 0.17 11:13:13 INFO - mozdebug == 0.1 11:13:13 INFO - mozdevice == 0.48 11:13:13 INFO - mozfile == 1.2 11:13:13 INFO - mozhttpd == 0.7 11:13:13 INFO - mozinfo == 0.9 11:13:13 INFO - mozleak == 0.1 11:13:13 INFO - mozlog == 3.1 11:13:13 INFO - moznetwork == 0.27 11:13:13 INFO - mozprocess == 0.22 11:13:13 INFO - mozprofile == 0.28 11:13:13 INFO - mozrunner == 6.11 11:13:13 INFO - mozscreenshot == 0.1 11:13:13 INFO - mozsystemmonitor == 0.0 11:13:13 INFO - moztest == 0.7 11:13:13 INFO - mozversion == 1.4 11:13:13 INFO - psutil == 3.1.1 11:13:13 INFO - requests == 1.2.3 11:13:13 INFO - wsgiref == 0.1.2 11:13:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:13 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:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:13 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:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:13 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 0x7f5843e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2955160>, '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 0x2956060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29564f0>, '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': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', '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:13:13 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:13:13 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:13:13 INFO - Using env: {'DISPLAY': ':0', 11:13:13 INFO - 'HOME': '/home/cltbld', 11:13:13 INFO - 'LANG': 'en_US.UTF-8', 11:13:13 INFO - 'LANGUAGE': 'en_US:en', 11:13:13 INFO - 'LOGNAME': 'cltbld', 11:13:13 INFO - 'MAIL': '/var/mail/cltbld', 11:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:13 INFO - 'MOZ_NO_REMOTE': '1', 11:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:13 INFO - 'NO_EM_RESTART': '1', 11:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:13 INFO - 'PWD': '/builds/slave/test', 11:13:13 INFO - 'SHELL': '/bin/bash', 11:13:13 INFO - 'SHLVL': '1', 11:13:13 INFO - 'TERM': 'linux', 11:13:13 INFO - 'TMOUT': '86400', 11:13:13 INFO - 'USER': 'cltbld', 11:13:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', 11:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:13 INFO - '_': '/tools/buildbot/bin/python'} 11:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:13 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:13:13 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:13:13 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:13:13 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:13:13 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:13:13 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:13:13 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:13:13 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:13:13 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:13:13 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:13:13 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:13:13 INFO - Cleaning up... 11:13:13 INFO - Return code: 0 11:13:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13:13 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:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:13 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:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:13 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 0x7f5843e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2955160>, '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 0x2956060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29564f0>, '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': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', '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:13:13 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:13:13 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:13:13 INFO - Using env: {'DISPLAY': ':0', 11:13:13 INFO - 'HOME': '/home/cltbld', 11:13:13 INFO - 'LANG': 'en_US.UTF-8', 11:13:13 INFO - 'LANGUAGE': 'en_US:en', 11:13:13 INFO - 'LOGNAME': 'cltbld', 11:13:13 INFO - 'MAIL': '/var/mail/cltbld', 11:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:13 INFO - 'MOZ_NO_REMOTE': '1', 11:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:13 INFO - 'NO_EM_RESTART': '1', 11:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:13 INFO - 'PWD': '/builds/slave/test', 11:13:13 INFO - 'SHELL': '/bin/bash', 11:13:13 INFO - 'SHLVL': '1', 11:13:13 INFO - 'TERM': 'linux', 11:13:13 INFO - 'TMOUT': '86400', 11:13:13 INFO - 'USER': 'cltbld', 11:13:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', 11:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:13 INFO - '_': '/tools/buildbot/bin/python'} 11:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:13 INFO - Downloading/unpacking jsonschema 11:13: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:13: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:13: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:13: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:13: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:13: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:13:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:16 INFO - Downloading/unpacking functools32 (from jsonschema) 11:13:16 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:13:16 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:13:16 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:13:16 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:13:16 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:13:16 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:13:16 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:16 INFO - warning: no files found matching '*.txt' 11:13:16 INFO - no previously-included directories found matching 'build' 11:13:16 INFO - no previously-included directories found matching 'dist' 11:13:16 INFO - no previously-included directories found matching '.git*' 11:13:16 INFO - Installing collected packages: jsonschema, functools32 11:13:16 INFO - Running setup.py install for functools32 11:13:16 INFO - warning: no files found matching '*.txt' 11:13:16 INFO - no previously-included directories found matching 'build' 11:13:16 INFO - no previously-included directories found matching 'dist' 11:13:16 INFO - no previously-included directories found matching '.git*' 11:13:16 INFO - Successfully installed jsonschema functools32 11:13:16 INFO - Cleaning up... 11:13:16 INFO - Return code: 0 11:13:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:13:16 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:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:16 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:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:16 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 0x7f5843e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c6410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2955160>, '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 0x2956060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29564f0>, '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': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', '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:13:16 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:13:16 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:13:16 INFO - Using env: {'DISPLAY': ':0', 11:13:16 INFO - 'HOME': '/home/cltbld', 11:13:16 INFO - 'LANG': 'en_US.UTF-8', 11:13:16 INFO - 'LANGUAGE': 'en_US:en', 11:13:16 INFO - 'LOGNAME': 'cltbld', 11:13:16 INFO - 'MAIL': '/var/mail/cltbld', 11:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:16 INFO - 'MOZ_NO_REMOTE': '1', 11:13:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:16 INFO - 'NO_EM_RESTART': '1', 11:13:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:16 INFO - 'PWD': '/builds/slave/test', 11:13:16 INFO - 'SHELL': '/bin/bash', 11:13:16 INFO - 'SHLVL': '1', 11:13:16 INFO - 'TERM': 'linux', 11:13:16 INFO - 'TMOUT': '86400', 11:13:16 INFO - 'USER': 'cltbld', 11:13:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', 11:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:16 INFO - '_': '/tools/buildbot/bin/python'} 11:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:16 INFO - Downloading/unpacking flake8 11:13:16 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:13:16 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:13:16 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:13:16 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:13:16 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:13:16 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:13:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:13:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:13:18 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:13:18 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:13:18 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:13:18 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:13:18 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:13:18 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:13:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:13:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:13:18 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:13:18 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:13:18 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:13:18 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:13:18 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:13:18 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:13:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:13: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:13: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:13: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:13: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:13: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:13: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:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:13:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:19 INFO - no previously-included directories found matching 'docs/_build' 11:13:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:13:19 INFO - Running setup.py install for pep8 11:13:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:19 INFO - no previously-included directories found matching 'docs/_build' 11:13:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:13:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:13:19 INFO - Cleaning up... 11:13:19 INFO - Return code: 0 11:13:19 INFO - Running post-action listener: _resource_record_post_action 11:13:19 INFO - Running post-action listener: _start_resource_monitoring 11:13:19 INFO - Starting resource monitoring. 11:13:19 INFO - ##### 11:13:19 INFO - ##### Running install step. 11:13:19 INFO - ##### 11:13:19 INFO - Running pre-action listener: _resource_record_pre_action 11:13:19 INFO - Running main action method: install 11:13:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:19 INFO - Reading from file tmpfile_stdout 11:13:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:19 INFO - Reading from file tmpfile_stdout 11:13:19 INFO - Output received: 11:13:19 INFO - Usage: mozinstall [options] installer 11:13:19 INFO - Options: 11:13:19 INFO - -h, --help show this help message and exit 11:13:19 INFO - -d DEST, --destination=DEST 11:13:19 INFO - Directory to install application into. [default: 11:13:19 INFO - "/builds/slave/test"] 11:13:19 INFO - --app=APP Application being installed. [default: firefox] 11:13:19 INFO - mkdir: /builds/slave/test/build/application 11:13:19 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:13:19 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:13:32 INFO - Reading from file tmpfile_stdout 11:13:32 INFO - Output received: 11:13:32 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:32 INFO - Running post-action listener: _resource_record_post_action 11:13:32 INFO - ##### 11:13:32 INFO - ##### Running run-tests step. 11:13:32 INFO - ##### 11:13:32 INFO - Running pre-action listener: _resource_record_pre_action 11:13:32 INFO - Running main action method: run_tests 11:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:32 INFO - Python 2.7.3 11:13:32 INFO - Return code: 0 11:13:32 INFO - grabbing minidump binary from tooltool 11:13:32 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:13:32 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 0x2955160>, '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 0x2956060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29564f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:32 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:13:32 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:13:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:32 INFO - Return code: 0 11:13:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:13:33 INFO - Return code: 0 11:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:13:33 INFO - Using env: {'DISPLAY': ':0', 11:13:33 INFO - 'HOME': '/home/cltbld', 11:13:33 INFO - 'LANG': 'en_US.UTF-8', 11:13:33 INFO - 'LANGUAGE': 'en_US:en', 11:13:33 INFO - 'LOGNAME': 'cltbld', 11:13:33 INFO - 'MAIL': '/var/mail/cltbld', 11:13:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:33 INFO - 'MOZ_NO_REMOTE': '1', 11:13:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:33 INFO - 'NO_EM_RESTART': '1', 11:13:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:33 INFO - 'PWD': '/builds/slave/test', 11:13:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:33 INFO - 'SHELL': '/bin/bash', 11:13:33 INFO - 'SHLVL': '1', 11:13:33 INFO - 'TERM': 'linux', 11:13:33 INFO - 'TMOUT': '86400', 11:13:33 INFO - 'USER': 'cltbld', 11:13:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590', 11:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:33 INFO - '_': '/tools/buildbot/bin/python'} 11:13:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jf9NEy_lSXOqwvipa8dCig/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:13:33 INFO - mozversion application_buildid: 20160522193137 11:13:33 INFO - mozversion application_changeset: 2e8129bd6590404ff56ea35ac30d719cf7f566ae 11:13:33 INFO - mozversion application_display_name: Firefox 11:13:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:33 INFO - mozversion application_name: Firefox 11:13:33 INFO - mozversion application_remotingname: firefox 11:13:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:13:33 INFO - mozversion application_vendor: Mozilla 11:13:33 INFO - mozversion application_version: 47.0 11:13:33 INFO - mozversion platform_buildid: 20160522193137 11:13:33 INFO - mozversion platform_changeset: 2e8129bd6590404ff56ea35ac30d719cf7f566ae 11:13:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:13:33 INFO - mozversion platform_version: 47.0 11:13:33 INFO - using testdate: 1464027213 11:13:33 INFO - actual date: 1464027213 11:13:33 INFO - starting webserver on 'localhost:42771' 11:13:33 INFO - SUITE-START | Running 2 tests 11:13:33 INFO - TEST-START | dromaeo_css 11:13:33 INFO - operating with platform_type : linux_ 11:13:33 INFO - Initialising browser for dromaeo_css test... 11:13:33 INFO - TEST-INFO | started process 24575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1dJzwG/profile http://localhost:42771/getInfo.html) 11:13:37 INFO - PROCESS | 24575 | __metrics Screen width/height:1600/1200 11:13:37 INFO - PROCESS | 24575 | colorDepth:24 11:13:37 INFO - PROCESS | 24575 | Browser inner width/height: 1024/697 11:13:37 INFO - PROCESS | 24575 | __metrics 11:13:38 INFO - PROCESS | 24575 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:39 INFO - TEST-INFO | 24575: exit 0 11:13:39 INFO - Browser initialized. 11:13:39 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:39 INFO - TEST-INFO | started process 24669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1dJzwG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:51 INFO - PROCESS | 24669 | RSS: Main: 138919936 11:13:51 INFO - PROCESS | 24669 | 11:14:42 INFO - PROCESS | 24669 | 1464027282830 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:16:50 INFO - PROCESS | 24669 | Cycle 1(1): loaded http://localhost:42771/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42771/tests/dromaeo/cssquery-ext.html) 11:16:51 INFO - PROCESS | 24669 | RSS: Main: 253030400 11:16:51 INFO - PROCESS | 24669 | 11:19:53 INFO - PROCESS | 24669 | Cycle 1(1): loaded http://localhost:42771/tests/dromaeo/cssquery-ext.html (next: http://localhost:42771/tests/dromaeo/cssquery-jquery.html) 11:19:53 INFO - PROCESS | 24669 | RSS: Main: 219414528 11:19:53 INFO - PROCESS | 24669 | 11:22:55 INFO - PROCESS | 24669 | Cycle 1(1): loaded http://localhost:42771/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42771/tests/dromaeo/cssquery-mootools.html) 11:22:56 INFO - PROCESS | 24669 | RSS: Main: 216690688 11:22:56 INFO - PROCESS | 24669 | 11:25:57 INFO - PROCESS | 24669 | Cycle 1(1): loaded http://localhost:42771/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42771/tests/dromaeo/cssquery-prototype.html) 11:25:58 INFO - PROCESS | 24669 | RSS: Main: 207544320 11:25:58 INFO - PROCESS | 24669 | 11:29:00 INFO - PROCESS | 24669 | Cycle 1(1): loaded http://localhost:42771/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42771/tests/dromaeo/cssquery-yui.html) 11:29:01 INFO - PROCESS | 24669 | RSS: Main: 210419712 11:29:01 INFO - PROCESS | 24669 | 11:32:03 INFO - PROCESS | 24669 | Cycle 1(1): loaded http://localhost:42771/tests/dromaeo/cssquery-yui.html (next: http://localhost:42771/tests/dromaeo/cssquery-dojo.html) 11:32:03 INFO - PROCESS | 24669 | RSS: Main: 254255104 11:32:03 INFO - PROCESS | 24669 | 11:32:03 INFO - PROCESS | 24669 | __start_tp_report 11:32:03 INFO - PROCESS | 24669 | _x_x_mozilla_page_load 11:32:03 INFO - PROCESS | 24669 | _x_x_mozilla_page_load_details 11:32:03 INFO - PROCESS | 24669 | |i|pagename|runs| 11:32:03 INFO - PROCESS | 24669 | |0;dojo.html;3282.5568548245983;3343.548620936173;3357.647447018063;3366.141633883359;3391.9830400848;5388.703621300831;5398.892022159559;5409.810656627019;5433.510984011438;5447.400785913546;5388.7305634718205;5422.674639521621;5428.0500912340285;5438.700871452069;5441.075017247068;4802.855914322576;4887.047025829965;4929.383827021622;4945.9258111128365;4988.575971042465;4843.128236917353;4935.555799978001;4939.777710003041;4942.357493525855;4946.035523073002;4850.151223535885;4899.902001959958;4911.656184067117;4914.434839993393;4940;4959.256111583255;4966.826161084345;4982.302477653096;4984.57631101355;4986.750662466862;4769.308450274725;4777.5700186982995;4885.43817460993;4894.5105489451125;4918.704877707349;5206.713630750307;5213.687178769248;5232.424433312332;5253.86865328366;5259.894802103975;5687.061634830248;5699.430056994309;5743.310802703661;5758.3090029196765;5765.365809760923;5835.708214589296;5858.50202732764;5877.970610146965;5887.970560147215;5891.587588868781;5505.366882808448;5508.476694713996;5510.283663123849;5514.834554963358;5535.806246781343;5726.9713651431475;5787.5080618147085;5902.675352855548;5939.07944268639;5973.432523910222;5676.8864622707315;5677.545796336283;5679.148127780866;5679.886402271932;5695.914561281584;5752.827415177551;5757.280339957505;5760.855978600569;5763.711814409263;5766.596338256366;5660.886782264414;5670.716464176775;5734.225879506297;5768.480836724715;5779.566532510079;5770.221020162308;5790.7973220937065;5792.478676919098;5793.768249269982;5794.797182098607;4363.432753741993;4385.188740083095;4394.802233899482;4404.185225733249;4424.31423129409;3900.8244628991765;3939.290927632996;3999.2201520703184;4009.037830920558;4042.676585873182;5413.756380962866;5471.06991811393;5476.315460567429;5476.91784623231;5498.835034948958;5597.720113994284;5853.151293062482;5858.707064646751;5889.734961926723;5894.440028197314;5349.117395629755;5363.597730170253;5406.135018397038;5415.783368665288;5449.4005659377435;4932.309476673268;4934.777934992934;4935.531124543163;4937.802487900443;4958.057968985881;5844.795432159854;5962.791302304486;5966.701664916737;5968.820935371946;5972.522198224132;5813.738381772915;5851.414858514115;5853.912191317048;5865.208196893364;5867.119932010232;5988.850278743066;5991.970040149771;6001.159837622824;6001.189839371804;6005.189299444519;5623.971880140573;5634.352049514358;5704.686242256716;5761.452661997104;5763.135529670583;5855.2973643163095;5876.1773351731645;5879.5002424794375;5881.470667639933;5885.970570147122;5688.089905615082;5708.172315014383;5708.200851880657;5710.143478478261;5712.171735098304;5550.139728342114;5633.971830140823;5682.9147562785765;5708.315002199763;5763.4812866842185;5534.584906131976;5553.555715542828;5563.332400112013;5573.749181286771;5579;5636.408177141505;5673.489385955284;5689.061304884648;5710.486056254957;5715.428457154251;5358.678479291255;5366.892662146657;5415.6479828811;5539.861503462445;5550.333959924835 11:32:03 INFO - PROCESS | 24669 | |1;ext.html;553.4741995104652;557.3479029535443;559.1361346719318;560.8990381731288;595.9761609535622;31685;32240.193995150134;39197.02007449812;39977.20045599086;40098.799506002426;43614;44305.335419968724;44447.11105777883;44449.33326000105;44555.33167002498;8976.46141231525;9182.86225706615;9195.21840643546;9196.310276729271;9202.4478531288;9162.267018638493;9325.580348884283;9351.018143094945;9365.76585585359;9378.531073446335;9368.484733339663;9460.526973651324;9480.194183494412;9484;9486.9525652372;9323.533823308808;9418.670346537907;9427.670031548898;9430.3398762086;9434.433933963985;9127.269818414577;9266.675666351646;9284.72145835626;9290.814183716355;9293.02423245563;44561.77719111416;45098;45276;45437.09125817498;45709.54290457086;3749.3251214781603;3814.256220037094;3833.310004199243;3990.0423898264207;4150.5552863457815;33674.663253367646;33703.83148084269;33743.662563374295;33830.1542461438;34173.145671358165;4175.478065241845;4182.2681030819485;4261.488621365456;4276.465441819772;4313.978430107861;224704;225467;225931;226331;227401;44834;45336;64583.354166458674;65919.67040164769;66082.66958665175;43604.781976089915;43712.78143609261;43839;43892;43895.56104438915;14984.400623975136;15197.544073677807;15201.543953681406;15207.543773686808;15245.542633721006;11936.820947685792;11944.880551194377;12011.519539218334;12044.698882528008;12045.819312710317;14993;15455.381784728484;15515.456959006606;15526.223688815515;15688.294026768823;5616.719164041863;5798.159266906275;5817.185594016841;5819.388964158702;5827.35899051104;956.1251454918811;1053.0785562632695;1065.6962765611763;1070.25617196048;1122.7866705325962;29638.407231855672;29796.255093622833;30351.089467316015;30362.392752144835;30566.235844104074;1088.6189833558349;1163.784699830534;1200.8979236764799;1241.2304371289858;1288.3880156925386;15556.688866222612;15566.766498502531;15689;15982.200889955455;16062.277197526138;346195;346383;346412;348499.54501365;348550;58111.12833307504;58567.414325856196;58653.41346586565;58711;58765.41234587685;1328.747537967783;1481.5111013365563;1491.4556186991888;1519.3770554072778;1522.8477152284684;26844.865775670998;27458.925042226656;29340.7065929338;29418;30060.248493786956;47112.7644361776;47566.52433475621;47667.28499072586;47668;48036.279455808886;202824;203207;203679;204081;204375;29631;34584;34643.82678086594;34815.303693926486;35063.12342191364;40586;41210.79394603008;41763.373549397395;51524;52508.737456312476;37961.4305785419;39091;39587.604123958394;40491;40953.385699215134;38763;38902.2219555613;39272.60727392689;39770;39900.80049599733;38828.6117138825;38961.16789190732;39178.2164356717;40018.199636007696;40199.397009045475;35037.47443788294;35789.46315805213;36651.633483665886;36668.63331366652;36795;27374.589381159698;27487.17538473849;27640.634761964262;27652.308692282855;28140.85929570339 11:32:03 INFO - PROCESS | 24669 | |2;jquery.html;379.75316044571025;384.7537575951391;385.30452533177623;386.2371815664062;391.6357787257851;17299.56751081222;19011.334603288888;19375;19463.124159412826;19501.21995120197;18829.246830126813;18927.242910283607;19135.808641913576;19138.23447062116;19204.807951920477;5468.125099984003;5666.51834594058;5691.08942569189;5725.627834190765;5731.770729170828;4028.0131367814924;6026.789062382817;6282.7172777224905;6304.180456540644;6311.305756366819;5953.226080609515;6226.346233645448;6237.937620623781;6269.561130720851;6270.059491076329;6146.938530614681;6157.692115394212;6166.907496387557;6184.257889053298;6195.2565692117005;3811.123441608446;3921.8627348042683;5277;5508.228847961289;5514.365847927459;20948.476288092766;20999.160033598637;21064.262750803802;21365.465863353384;21378;2327.895244713992;2468.679071720665;2685.9194224173307;2759.9172024839086;2763.6821765496825;13092.149010314299;13433.462661493528;13508.527201547899;13671.589852304447;13839.515616953358;1888.3202047263112;1929.951751206217;1944.0182707732647;1961.928997330545;1979.7462830164368;61853.690731546056;63999.36000639981;64150.35849641537;64532.677336613015;64643;9829;10179.796404072025;10220.437875916896;10339.63811266602;10419.374837509773;14707.117572945657;14712.411503539739;14797.704045919236;14820.777688334683;14833.480828171178;7815.921840781633;8069.6368663410285;8112;8136.389770767216;8195.672173113127;7837.3338266246865;7860.960695196487;7884.448088633741;7912.169222231582;7931.920680793118;6177.598456100429;6183.072539119078;6185.257769067741;6304.873902522016;6315.905261421082;1714.5884987602885;1731.809500954894;1772.97340539892;1797.730340448943;1804.6841802684478;1064.4837253931837;1077.498962982217;1084.4848696869083;1128.0975219824109;1197.3953153657521;16317.020978741313;16319.673606527804;17551;18230.908845455688;18539.165737541844;992.9106380425796;1034.6430481483876;1041.9895801041891;1067.9359238445563;1072.5763323487336;10451.634192803367;10714.946425267979;10773.946130269454;10787.137029037658;10802.919708029134;461184;465624;471886;471886;474093;66054.66972665106;67840.6607966957;68490.3150968484;69181.65409172921;69380.30619693738;1024.4212020208558;1081.2107161771794;1090.6346373964811;1092.8360745888021;1098.4837126550508;15892.60268493297;16191.109488977749;16264.918675406547;16301;16466.83533164653;31260.531092034093;32779.34441311208;33506.32987340288;34282.65717342795;34577.654223457444;45621;45800.770996144805;45829.31256031229;45877.54122458733;45964.54035459603;8136.480318027803;8281.792955176168;8344.499330040217;8811.647534098563;8998.775030624287;9583.856242156235;12132.575359862363;12486.625401237978;12616.684582885502;13648.24934628605;11795.938365547141;11812;11965.282083075042;12337;12348.506059757508;11330.830037549607;11513.53945842157;11644;11920.940395297968;12127.332996685267;12025.218360806519;12151.574694885636;12278.877211227773;12354.320512371905;12810.743785124432;8935.731928042169;9058.176994504674;9061.954690226507;9139.360244782802;9150.679726209552;10542.789144217226;11839.70400739954;11878.524859005543;11974.880251197377;11990.220635658654 11:32:03 INFO - PROCESS | 24669 | |3;mootools.html;1447.6163816588612;1548.6825200833828;1581.42278068505;1819.8180181981804;1934.322986954566;7959.641816118274;8299.336053115743;8311.501309921408;8323.33413326934;8326.209010144026;8091.757247282576;8264.545450000247;8270.627821748021;8276.337892968548;8279.296259817922;2386.4391867911027;2404.5311164322966;2409.518096380722;2409.650600662903;2410.505846301513;2475.789557887582;2490.252924122765;2518.49630073985;2519.5590771614984;2531.455737016541;2435.7320694723567;2440.9755902441016;2449.522343143079;2458.1642241637837;2468.2101727447225;2411.903523859061;2419.4677171022436;2425.6967879015124;2437.475942672325;2444.095684596693;2436.744141865114;2467.7902378297867;2472.2336075816556;2488.738682438336;2490.2778194323623;8452.154784521561;8468.957655211685;8492.065872753992;8497.830043399097;8507.744767656981;5062.190049592047;5229.058769421503;5237.371515418175;5240.3187585614005;5241.161414173714;3278.622958359795;3289.243474000993;3345.063382252949;3368.9326213475592;3395.219099607104;1028.388109075099;1049.2917280835406;1065.957361705531;2028.2799606139904;2056.4858785303672;11376.431178441046;11459.885401145964;11463.54145834174;11465.254758440675;11504.194706370557;4430.601245887886;4462.995825939202;4472.418585583853;4494.685372023927;4553.886152846206;9124.863127053099;9133.862992055125;9187.908120918839;9191.586378612978;9235.1688348049;4983.202687569971;5021.573166280907;5052.494750524992;5062.873428164326;5065.873353166126;3953.347697629916;4553.590176884097;4658.976705116453;4670.486246512949;4716.716996980193;3524.84138213781;3580.7135429165605;3609.4405367168133;3636.781793092423;3661.688756455678;1075.5643964194514;1103.696483467053;1110.8843774418685;1112.3881864974232;1116.084810455435;1432.749268877942;1439.3954539093606;1465.8167729033871;1478.8964772465824;1530.2960638106595;8133.633986470623;8144.674213031531;8194.590270486571;8198.631061602242;8198.754037378889;550.0923476264117;551.583554416413;554.7614525753884;555.4861752878571;556.6771272661928;5977.970110149508;6001.549883758736;6027.60820546663;6030.879382412327;6031.035034394564;10334.224933130045;10519.211059170593;10535.736606584744;10633.627823026158;10659.520321585547;10253.128484078938;10338;10389.428721304954;10472;10516.737081573021;7981.68073277074;8056.355491560661;8061;8079.838403231903;8144.674213031412;7731;7791.766247012599;7794.727184548514;7912.28789408956;7939.642716077906;9315.208207302456;9343.252539796664;9470.195033422237;9477.478738669164;9583.616655333708;9502.572384242863;9566.282528810229;9718.70843874685;9733.659321923698;9940.850887236842;6002.639841609517;6146.385361463817;6740;7094.787156385317;7222.494425390172;8002.759917202493;8036.156203598538;8056.758297251092;8072;8082.191780822106;7077.7168913242895;7270.854582908418;7286.380657643947;7364;7366.079240094989;7147.749828755968;7157.57054576727;7186.065811444479;7266.89099663516;7284.854302913806;7468.5145465544565;7651.196624354363;7652.617369131633;7655.732049378245;7662.9654996574745;7071.151461824614;7114.359707626339;7129.572225666477;7131.393831524379;7137.714491420493;6924.896126558207;7015.473839462163;7029.683664235019;7031.964840175767;7040.823979400351 11:32:03 INFO - PROCESS | 24669 | |4;prototype.html;352.5293732866623;357.5780578916879;358.3263464686389;361.5877899194917;373.5666626713012;6111.358307377717;6112.449879510848;6124.510039196864;6137.601055931367;6155.507559395249;6023.397660233974;6038.4867286280605;6046.939530604704;6052.788152414666;6054.636721796695;4424.668149888755;4561.429821272341;4636.4436267647925;4669.719816810985;4680.882977925554;4688.249880019198;4702.106599746037;4714.127886341038;4719.150552900476;4741.431028276612;4693.8357157499495;4699.177643912319;4702.98885739566;4704.1767690654;4715.386999690053;4432.3573081903105;4544.795484203202;4638.1883170445035;4650.232711602582;4651.79066941985;4137.420761093449;4144.191882582898;4148.91702165958;4154.439150714645;4165.437665915093;5717.342505611867;5723.856903577403;5725.255716756795;5727.198192253088;5731;5458.072127738294;5462.20797984294;5464.207689884945;5467.753951072172;5477.67133971963;6348.809535713936;6349.396807303298;6383.648899310536;6386.2336519617475;6391.680415979183;4333.328334108218;4508.706934049309;4510.751908645023;4525.886852828673;4583.03756211196;6661.200655921272;6692.130023097015;6699.196096468455;6713.69788359525;6720.462363010996;4547.15877562652;4550.658700597469;4554.020885509632;4555.931661025087;4556.521565235669;4615.14619795339;4618.03021365517;4622.352870598119;4623.838165664186;4624.190766615896;5344.144936810092;5345.492178243061;5346.545543628835;5356.732163391893;5359.169328754049;6321.936780632135;6456.0961465394885;6456.192975878015;6463.967680161569;6472.967635161888;1645.9588510287338;1659.7012537743321;1669.8914570553118;1670.6742185273754;1671.3398207707887;1001.6444162322271;1087.7987572298991;1092;1110.189561620022;1112.1603189591967;6066.696665166724;6096.786612468631;6099.2680878294;6107.267127944675;6114.724837382329;6610.471162307004;6611.71071641035;6618.768343107968;6623.6688165592495;6643.966780166068;6093.542984276109;6099.512039036867;6103.969480152571;6106.419890110433;6109.816705498843;3547.396942519778;3580.910477238038;3581.8925432237074;3583.086312990171;3590;6730.629815360105;6801.081853949752;6950.374466297956;6960.269171736996;6964.199117101598;6873;6880.759173428906;6893.103896493424;6917.89623155653;6922.653867306614;6918.792436226921;6929.549579277331;6929.722811087601;6933.583984960817;6938.653067346511;6732.057511948233;6736.730530778714;6737.461003119836;6738.157730283715;6744.5616034957575;6462.192225971754;6583.736650533925;6615.66921653925;6617.07360969455;6626.768063117768;6862.794116176523;6893.93106068953;6899.48253880971;6904.689288982108;6904.758333458305;4530.501644819002;4537.6143027843;4538.863834084983;4539.954600453953;4543.432070991126;6726.428253598303;6751.257361690308;6803.455723542006;6803.727850885909;6806.6256355900905;6331.841703957253;6497.25281592604;6515.967420162869;6518.250401203923;6523.347665233438;6463.515236357386;6482.351764823668;6491.156149700509;6497.642629655415;6519.054737063005;6329.177206963065;6371.23545174582;6378.712957916998;6381.936180638134;6390.201224846895;6514.51141164424;6519.119918810899;6524.739010439719;6527.640979746159;6531.673416329069;6055.939440605537;6148.661823599745;6186.907196392148;6291.465225455888;6310.305866354789 11:32:03 INFO - PROCESS | 24669 | |5;yui.html;803.285076282109;803.2890891560969;812.7277362083698;821.7493664432345;829.6971605364043;15908.681826363465;16476.42332518359;16511.42210022648;16522.00867947924;16526.173691315416;14815.851841481583;14970.775438368433;14988.925055374735;14995.100293982368;15007.174605396698;746.045062320231;864.567716141929;880.4277219807128;892.388713731093;899.649136836631;891.0287786312917;897.578138275013;899.5277479323343;901.0673952459206;901.6303315640589;793.0998316910319;924.6994726713812;924.8242833861578;927.0636656976469;929.0848514213494;905.6377449020412;916.5188276155005;918.8805455290769;919.4299534288783;919.5632074764467;674.164036594624;674.5547938360659;675.2976904019813;675.8310422394402;676.1885737115481;14327.57017289483;14343.497977570734;14373.137611743328;14482.782758258634;14512.201828899406;12583.245005299712;12778.233306001577;12888.097833151684;13220.537281195113;13221.537246196336;10721.14230861537;10745.14038876888;10823.080038196762;10842.078423334026;11022.44887755617;3793.734438589272;3884.7280690351686;3896.084420161288;3903.043754280191;3905.5508616509183;47887.76056119697;48538.51461485375;50843;51384.486155138715;51641.99999999962;10112.089911907817;10213.131883789812;10292.176625869912;10330.483475826179;10348.586056557653;19806.801931980495;19922.701159482618;19967.900160499106;19985.60028799416;19987.500312492302;8590.914090859136;8600.5699715014;8649.870251946226;8791.428557143765;8896.021437641853;4706.811727530929;4741.2651039088305;4777.259524773596;4816.470188279286;4840.370751802243;3230.596175478065;3233.4018206631376;3248.902532924016;3258.0714496368896;3265.804051756902;574.8821491594213;575.6258432019221;585.0755805826783;605.7062324772481;631.2961048430966;658.5061204096927;729.1614643160408;744.5086243079542;749.598964553961;766.6550052476408;8693.956530217309;8734.825303493895;8796.60415281301;8806.911930880737;8816.118388161132;564.6724899558246;668.9866202675919;680.129434324066;710.3393843725385;748.4087570818992;4032.9395059074136;4106.691998100155;4150.8547200848425;4246.341817018367;4250.702450828412;59599.70200148971;59635.40364596385;59672.701636492406;60979.695101525096;63619.68190159019;53199;54750.45249547533;55002.44997550053;55196.72401637966;59066.70466647639;46648.76675616668;46808.063838723036;47077;47116;48156.5184348152;9114.908850911672;9159.313051521029;9253.86119208199;9325.160735533835;9394.201492873182;35010.124746881535;36829.26341473102;36932;37448.251034979694;38043.42934856035;39633.40549891696;39684.801575991936;44537.55462445334;46490;47056.29415558838;11058.447077645924;11093.722656933642;11308.208425410143;11802.291862488279;11846.940765296464;9527.38072025316;11674.066074713832;11910.583129590423;12998.090133690552;13194.604161875159;10343.327683700536;10436.634717785144;10444.425556594157;10513.9474302628;10743.677689669323;10364.740881478023;10632.787344253225;10712.73218169552;10789.082927951213;10862.239643224899;11056.557737690402;11081.11351091927;11124.276922000045;11346.716332091764;11375.033122184706;8642.740717778477;8909.910900891167;8997.550122493718;9167.312451566293;9189.264858811146;9165.312601554777;9257.768555786159;9270.119338662817;9429.481378524248;9520.619175232912 11:32:03 INFO - PROCESS | 24669 | __end_tp_report 11:32:03 INFO - PROCESS | 24669 | __start_cc_report 11:32:03 INFO - PROCESS | 24669 | _x_x_mozilla_cycle_collect,853 11:32:03 INFO - PROCESS | 24669 | __end_cc_report 11:32:03 INFO - PROCESS | 24669 | __startTimestamp1464028323872__endTimestamp 11:32:03 INFO - PROCESS | 24669 | 11:32:03 INFO - PROCESS | 24669 | ------- Summary: start ------- 11:32:03 INFO - PROCESS | 24669 | Number of tests: 6 11:32:03 INFO - PROCESS | 24669 | 11:32:03 INFO - PROCESS | 24669 | [#0] dojo.html Cycles:165 Average:5373.99 Median:5553.56 stddev:588.79 (10.6%) stddev-sans-first:567.28 11:32:03 INFO - PROCESS | 24669 | Values: 3282.6 3343.5 3357.6 3366.1 3392.0 5388.7 5398.9 5409.8 5433.5 5447.4 5388.7 5422.7 5428.1 5438.7 5441.1 4802.9 4887.0 4929.4 4945.9 4988.6 4843.1 4935.6 4939.8 4942.4 4946.0 4850.2 4899.9 4911.7 4914.4 4940.0 4959.3 4966.8 4982.3 4984.6 4986.8 4769.3 4777.6 4885.4 4894.5 4918.7 5206.7 5213.7 5232.4 5253.9 5259.9 5687.1 5699.4 5743.3 5758.3 5765.4 5835.7 5858.5 5878.0 5888.0 5891.6 5505.4 5508.5 5510.3 5514.8 5535.8 5727.0 5787.5 5902.7 5939.1 5973.4 5676.9 5677.5 5679.1 5679.9 5695.9 5752.8 5757.3 5760.9 5763.7 5766.6 5660.9 5670.7 5734.2 5768.5 5779.6 5770.2 5790.8 5792.5 5793.8 5794.8 4363.4 4385.2 4394.8 4404.2 4424.3 3900.8 3939.3 3999.2 4009.0 4042.7 5413.8 5471.1 5476.3 5476.9 5498.8 5597.7 5853.2 5858.7 5889.7 5894.4 5349.1 5363.6 5406.1 5415.8 5449.4 4932.3 4934.8 4935.5 4937.8 4958.1 5844.8 5962.8 5966.7 5968.8 5972.5 5813.7 5851.4 5853.9 5865.2 5867.1 5988.9 5992.0 6001.2 6001.2 6005.2 5624.0 5634.4 5704.7 5761.5 5763.1 5855.3 5876.2 5879.5 5881.5 5886.0 5688.1 5708.2 5708.2 5710.1 5712.2 5550.1 5634.0 5682.9 5708.3 5763.5 5534.6 5553.6 5563.3 5573.7 5579.0 5636.4 5673.5 5689.1 5710.5 5715.4 5358.7 5366.9 5415.6 5539.9 5550.3 11:32:03 INFO - PROCESS | 24669 | 11:32:03 INFO - PROCESS | 24669 | [#1] ext.html Cycles:180 Average:44097.09 Median:39187.62 stddev:69651.33 (177.7%) stddev-sans-first:69769.98 11:32:03 INFO - PROCESS | 24669 | Values: 553.5 557.3 559.1 560.9 596.0 31685.0 32240.2 39197.0 39977.2 40098.8 43614.0 44305.3 44447.1 44449.3 44555.3 8976.5 9182.9 9195.2 9196.3 9202.4 9162.3 9325.6 9351.0 9365.8 9378.5 9368.5 9460.5 9480.2 9484.0 9487.0 9323.5 9418.7 9427.7 9430.3 9434.4 9127.3 9266.7 9284.7 9290.8 9293.0 44561.8 45098.0 45276.0 45437.1 45709.5 3749.3 3814.3 3833.3 3990.0 4150.6 33674.7 33703.8 33743.7 33830.2 34173.1 4175.5 4182.3 4261.5 4276.5 4314.0 224704.0 225467.0 225931.0 226331.0 227401.0 44834.0 45336.0 64583.4 65919.7 66082.7 43604.8 43712.8 43839.0 43892.0 43895.6 14984.4 15197.5 15201.5 15207.5 15245.5 11936.8 11944.9 12011.5 12044.7 12045.8 14993.0 15455.4 15515.5 15526.2 15688.3 5616.7 5798.2 5817.2 5819.4 5827.4 956.1 1053.1 1065.7 1070.3 1122.8 29638.4 29796.3 30351.1 30362.4 30566.2 1088.6 1163.8 1200.9 1241.2 1288.4 15556.7 15566.8 15689.0 15982.2 16062.3 346195.0 346383.0 346412.0 348499.5 348550.0 58111.1 58567.4 58653.4 58711.0 58765.4 1328.7 1481.5 1491.5 1519.4 1522.8 26844.9 27458.9 29340.7 29418.0 30060.2 47112.8 47566.5 47667.3 47668.0 48036.3 202824.0 203207.0 203679.0 204081.0 204375.0 29631.0 34584.0 34643.8 34815.3 35063.1 40586.0 41210.8 41763.4 51524.0 52508.7 37961.4 39091.0 39587.6 40491.0 40953.4 38763.0 38902.2 39272.6 39770.0 39900.8 38828.6 38961.2 39178.2 40018.2 40199.4 35037.5 35789.5 36651.6 36668.6 36795.0 27374.6 27487.2 27640.6 27652.3 28140.9 11:32:03 INFO - PROCESS | 24669 | 11:32:03 INFO - PROCESS | 24669 | [#2] jquery.html Cycles:180 Average:26669.94 Median:21371.73 stddev:76558.41 (358.2%) stddev-sans-first:76747.72 11:32:03 INFO - PROCESS | 24669 | Values: 379.8 384.8 385.3 386.2 391.6 17299.6 19011.3 19375.0 19463.1 19501.2 18829.2 18927.2 19135.8 19138.2 19204.8 5468.1 5666.5 5691.1 5725.6 5731.8 4028.0 6026.8 6282.7 6304.2 6311.3 5953.2 6226.3 6237.9 6269.6 6270.1 6146.9 6157.7 6166.9 6184.3 6195.3 3811.1 3921.9 5277.0 5508.2 5514.4 20948.5 20999.2 21064.3 21365.5 21378.0 2327.9 2468.7 2685.9 2759.9 2763.7 13092.1 13433.5 13508.5 13671.6 13839.5 1888.3 1930.0 1944.0 1961.9 1979.7 61853.7 63999.4 64150.4 64532.7 64643.0 9829.0 10179.8 10220.4 10339.6 10419.4 14707.1 14712.4 14797.7 14820.8 14833.5 7815.9 8069.6 8112.0 8136.4 8195.7 7837.3 7861.0 7884.4 7912.2 7931.9 6177.6 6183.1 6185.3 6304.9 6315.9 1714.6 1731.8 1773.0 1797.7 1804.7 1064.5 1077.5 1084.5 1128.1 1197.4 16317.0 16319.7 17551.0 18230.9 18539.2 992.9 1034.6 1042.0 1067.9 1072.6 10451.6 10714.9 10773.9 10787.1 10802.9 461184.0 465624.0 471886.0 471886.0 474093.0 66054.7 67840.7 68490.3 69181.7 69380.3 1024.4 1081.2 1090.6 1092.8 1098.5 15892.6 16191.1 16264.9 16301.0 16466.8 31260.5 32779.3 33506.3 34282.7 34577.7 45621.0 45800.8 45829.3 45877.5 45964.5 8136.5 8281.8 8344.5 8811.6 8998.8 9583.9 12132.6 12486.6 12616.7 13648.2 11795.9 11812.0 11965.3 12337.0 12348.5 11330.8 11513.5 11644.0 11920.9 12127.3 12025.2 12151.6 12278.9 12354.3 12810.7 8935.7 9058.2 9062.0 9139.4 9150.7 10542.8 11839.7 11878.5 11974.9 11990.2 11:32:03 INFO - PROCESS | 24669 | 11:32:03 INFO - PROCESS | 24669 | [#3] mootools.html Cycles:180 Average:5870.19 Median:550.84 stddev:3090.69 (561.1%) stddev-sans-first:3081.48 11:32:03 INFO - PROCESS | 24669 | Values: 1447.6 1548.7 1581.4 1819.8 1934.3 7959.6 8299.3 8311.5 8323.3 8326.2 8091.8 8264.5 8270.6 8276.3 8279.3 2386.4 2404.5 2409.5 2409.7 2410.5 2475.8 2490.3 2518.5 2519.6 2531.5 2435.7 2441.0 2449.5 2458.2 2468.2 2411.9 2419.5 2425.7 2437.5 2444.1 2436.7 2467.8 2472.2 2488.7 2490.3 8452.2 8469.0 8492.1 8497.8 8507.7 5062.2 5229.1 5237.4 5240.3 5241.2 3278.6 3289.2 3345.1 3368.9 3395.2 1028.4 1049.3 1066.0 2028.3 2056.5 11376.4 11459.9 11463.5 11465.3 11504.2 4430.6 4463.0 4472.4 4494.7 4553.9 9124.9 9133.9 9187.9 9191.6 9235.2 4983.2 5021.6 5052.5 5062.9 5065.9 3953.3 4553.6 4659.0 4670.5 4716.7 3524.8 3580.7 3609.4 3636.8 3661.7 1075.6 1103.7 1110.9 1112.4 1116.1 1432.7 1439.4 1465.8 1478.9 1530.3 8133.6 8144.7 8194.6 8198.6 8198.8 550.1 551.6 554.8 555.5 556.7 5978.0 6001.5 6027.6 6030.9 6031.0 10334.2 10519.2 10535.7 10633.6 10659.5 10253.1 10338.0 10389.4 10472.0 10516.7 7981.7 8056.4 8061.0 8079.8 8144.7 7731.0 7791.8 7794.7 7912.3 7939.6 9315.2 9343.3 9470.2 9477.5 9583.6 9502.6 9566.3 9718.7 9733.7 9940.9 6002.6 6146.4 6740.0 7094.8 7222.5 8002.8 8036.2 8056.8 8072.0 8082.2 7077.7 7270.9 7286.4 7364.0 7366.1 7147.7 7157.6 7186.1 7266.9 7284.9 7468.5 7651.2 7652.6 7655.7 7663.0 7071.2 7114.4 7129.6 7131.4 7137.7 6924.9 7015.5 7029.7 7032.0 7040.8 11:32:03 INFO - PROCESS | 24669 | 11:32:03 INFO - PROCESS | 24669 | [#4] prototype.html Cycles:180 Average:5400.76 Median:6101.74 stddev:1625.85 (26.6%) stddev-sans-first:1585.64 11:32:03 INFO - PROCESS | 24669 | Values: 352.5 357.6 358.3 361.6 373.6 6111.4 6112.4 6124.5 6137.6 6155.5 6023.4 6038.5 6046.9 6052.8 6054.6 4424.7 4561.4 4636.4 4669.7 4680.9 4688.2 4702.1 4714.1 4719.2 4741.4 4693.8 4699.2 4703.0 4704.2 4715.4 4432.4 4544.8 4638.2 4650.2 4651.8 4137.4 4144.2 4148.9 4154.4 4165.4 5717.3 5723.9 5725.3 5727.2 5731.0 5458.1 5462.2 5464.2 5467.8 5477.7 6348.8 6349.4 6383.6 6386.2 6391.7 4333.3 4508.7 4510.8 4525.9 4583.0 6661.2 6692.1 6699.2 6713.7 6720.5 4547.2 4550.7 4554.0 4555.9 4556.5 4615.1 4618.0 4622.4 4623.8 4624.2 5344.1 5345.5 5346.5 5356.7 5359.2 6321.9 6456.1 6456.2 6464.0 6473.0 1646.0 1659.7 1669.9 1670.7 1671.3 1001.6 1087.8 1092.0 1110.2 1112.2 6066.7 6096.8 6099.3 6107.3 6114.7 6610.5 6611.7 6618.8 6623.7 6644.0 6093.5 6099.5 6104.0 6106.4 6109.8 3547.4 3580.9 3581.9 3583.1 3590.0 6730.6 6801.1 6950.4 6960.3 6964.2 6873.0 6880.8 6893.1 6917.9 6922.7 6918.8 6929.5 6929.7 6933.6 6938.7 6732.1 6736.7 6737.5 6738.2 6744.6 6462.2 6583.7 6615.7 6617.1 6626.8 6862.8 6893.9 6899.5 6904.7 6904.8 4530.5 4537.6 4538.9 4540.0 4543.4 6726.4 6751.3 6803.5 6803.7 6806.6 6331.8 6497.3 6516.0 6518.3 6523.3 6463.5 6482.4 6491.2 6497.6 6519.1 6329.2 6371.2 6378.7 6381.9 6390.2 6514.5 6519.1 6524.7 6527.6 6531.7 6055.9 6148.7 6186.9 6291.5 6310.3 11:32:03 INFO - PROCESS | 24669 | 11:32:03 INFO - PROCESS | 24669 | [#5] yui.html Cycles:180 Average:14367.02 Median:26332.51 stddev:16641.17 (63.2%) stddev-sans-first:16656.68 11:32:03 INFO - PROCESS | 24669 | Values: 803.3 803.3 812.7 821.7 829.7 15908.7 16476.4 16511.4 16522.0 16526.2 14815.9 14970.8 14988.9 14995.1 15007.2 746.0 864.6 880.4 892.4 899.6 891.0 897.6 899.5 901.1 901.6 793.1 924.7 924.8 927.1 929.1 905.6 916.5 918.9 919.4 919.6 674.2 674.6 675.3 675.8 676.2 14327.6 14343.5 14373.1 14482.8 14512.2 12583.2 12778.2 12888.1 13220.5 13221.5 10721.1 10745.1 10823.1 10842.1 11022.4 3793.7 3884.7 3896.1 3903.0 3905.6 47887.8 48538.5 50843.0 51384.5 51642.0 10112.1 10213.1 10292.2 10330.5 10348.6 19806.8 19922.7 19967.9 19985.6 19987.5 8590.9 8600.6 8649.9 8791.4 8896.0 4706.8 4741.3 4777.3 4816.5 4840.4 3230.6 3233.4 3248.9 3258.1 3265.8 574.9 575.6 585.1 605.7 631.3 658.5 729.2 744.5 749.6 766.7 8694.0 8734.8 8796.6 8806.9 8816.1 564.7 669.0 680.1 710.3 748.4 4032.9 4106.7 4150.9 4246.3 4250.7 59599.7 59635.4 59672.7 60979.7 63619.7 53199.0 54750.5 55002.4 55196.7 59066.7 46648.8 46808.1 47077.0 47116.0 48156.5 9114.9 9159.3 9253.9 9325.2 9394.2 35010.1 36829.3 36932.0 37448.3 38043.4 39633.4 39684.8 44537.6 46490.0 47056.3 11058.4 11093.7 11308.2 11802.3 11846.9 9527.4 11674.1 11910.6 12998.1 13194.6 10343.3 10436.6 10444.4 10513.9 10743.7 10364.7 10632.8 10712.7 10789.1 10862.2 11056.6 11081.1 11124.3 11346.7 11375.0 8642.7 8909.9 8997.6 9167.3 9189.3 9165.3 9257.8 9270.1 9429.5 9520.6 11:32:03 INFO - PROCESS | 24669 | -------- Summary: end -------- 11:32:03 INFO - PROCESS | 24669 | 11:32:04 INFO - TEST-INFO | 24669: exit 0 11:32:04 INFO - TEST-OK | dromaeo_css | took 1110690ms 11:32:04 INFO - TEST-START | kraken 11:32:04 INFO - operating with platform_type : linux_ 11:32:04 INFO - Initialising browser for kraken test... 11:32:04 INFO - TEST-INFO | started process 24869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRpMDXG/profile http://localhost:42771/getInfo.html) 11:32:08 INFO - PROCESS | 24869 | __metrics Screen width/height:1600/1200 11:32:08 INFO - PROCESS | 24869 | colorDepth:24 11:32:08 INFO - PROCESS | 24869 | Browser inner width/height: 1024/697 11:32:08 INFO - PROCESS | 24869 | __metrics 11:32:09 INFO - PROCESS | 24869 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:32:10 INFO - TEST-INFO | 24869: exit 0 11:32:10 INFO - Browser initialized. 11:32:10 INFO - Running cycle 1/1 for kraken test... 11:32:10 INFO - TEST-INFO | started process 24956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRpMDXG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:21 INFO - PROCESS | 24956 | RSS: Main: 138809344 11:32:21 INFO - PROCESS | 24956 | 11:32:24 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42771/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:25 INFO - PROCESS | 24956 | RSS: Main: 176435200 11:32:25 INFO - PROCESS | 24956 | 11:32:27 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42771/tests/kraken/driver.html?testName=audio-dft) 11:32:28 INFO - PROCESS | 24956 | RSS: Main: 174526464 11:32:28 INFO - PROCESS | 24956 | 11:32:31 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42771/tests/kraken/driver.html?testName=audio-fft) 11:32:31 INFO - PROCESS | 24956 | RSS: Main: 170889216 11:32:31 INFO - PROCESS | 24956 | 11:32:33 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42771/tests/kraken/driver.html?testName=audio-oscillator) 11:32:34 INFO - PROCESS | 24956 | RSS: Main: 172101632 11:32:34 INFO - PROCESS | 24956 | 11:32:36 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42771/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:37 INFO - PROCESS | 24956 | RSS: Main: 169775104 11:32:37 INFO - PROCESS | 24956 | 11:32:40 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42771/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:40 INFO - PROCESS | 24956 | RSS: Main: 169644032 11:32:40 INFO - PROCESS | 24956 | 11:32:43 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42771/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:44 INFO - PROCESS | 24956 | RSS: Main: 170409984 11:32:44 INFO - PROCESS | 24956 | 11:32:47 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42771/tests/kraken/driver.html?testName=json-parse-financial) 11:32:47 INFO - PROCESS | 24956 | RSS: Main: 170442752 11:32:47 INFO - PROCESS | 24956 | 11:32:49 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42771/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:49 INFO - PROCESS | 24956 | RSS: Main: 176390144 11:32:49 INFO - PROCESS | 24956 | 11:32:51 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42771/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:52 INFO - PROCESS | 24956 | RSS: Main: 172810240 11:32:52 INFO - PROCESS | 24956 | 11:32:54 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42771/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:54 INFO - PROCESS | 24956 | RSS: Main: 179458048 11:32:54 INFO - PROCESS | 24956 | 11:32:57 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:57 INFO - PROCESS | 24956 | RSS: Main: 183431168 11:32:57 INFO - PROCESS | 24956 | 11:33:00 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:00 INFO - PROCESS | 24956 | RSS: Main: 182603776 11:33:00 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:42771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42771/tests/kraken/driver.html?testName=ai-astar) 11:33:02 INFO - PROCESS | 24956 | RSS: Main: 244490240 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | __start_tp_report 11:33:02 INFO - PROCESS | 24956 | _x_x_mozilla_page_load 11:33:02 INFO - PROCESS | 24956 | _x_x_mozilla_page_load_details 11:33:02 INFO - PROCESS | 24956 | |i|pagename|runs| 11:33:02 INFO - PROCESS | 24956 | |0;ai-astar;108;110;106;110;112;111;98;110;109;108 11:33:02 INFO - PROCESS | 24956 | |1;audio-beat-detection;155;132;151;171;133;155;158;130;167;133 11:33:02 INFO - PROCESS | 24956 | |2;audio-dft;162;161;162;161;162;161;161;164;161;162 11:33:02 INFO - PROCESS | 24956 | |3;audio-fft;76;74;76;159;76;76;75;76;164;76 11:33:02 INFO - PROCESS | 24956 | |4;audio-oscillator;93;93;154;93;94;92;146;93;94;135 11:33:02 INFO - PROCESS | 24956 | |5;imaging-gaussian-blur;117;117;116;117;116;117;116;117;117;116 11:33:02 INFO - PROCESS | 24956 | |6;imaging-darkroom;145;145;146;145;145;145;146;145;146;146 11:33:02 INFO - PROCESS | 24956 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;96;95 11:33:02 INFO - PROCESS | 24956 | |8;json-parse-financial;58;58;58;55;58;56;56;57;56;55 11:33:02 INFO - PROCESS | 24956 | |9;json-stringify-tinderbox;63;63;62;64;64;64;65;64;64;64 11:33:02 INFO - PROCESS | 24956 | |10;stanford-crypto-aes;79;79;78;78;78;85;78;78;85;80 11:33:02 INFO - PROCESS | 24956 | |11;stanford-crypto-ccm;112;118;111;121;116;113;114;116;119;115 11:33:02 INFO - PROCESS | 24956 | |12;stanford-crypto-pbkdf2;144;138;149;147;147;138;146;147;135;146 11:33:02 INFO - PROCESS | 24956 | |13;stanford-crypto-sha256-iterative;67;66;67;68;66;70;64;67;67;66 11:33:02 INFO - PROCESS | 24956 | __end_tp_report 11:33:02 INFO - PROCESS | 24956 | __start_cc_report 11:33:02 INFO - PROCESS | 24956 | _x_x_mozilla_cycle_collect,1023 11:33:02 INFO - PROCESS | 24956 | __end_cc_report 11:33:02 INFO - PROCESS | 24956 | __startTimestamp1464028382812__endTimestamp 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | ------- Summary: start ------- 11:33:02 INFO - PROCESS | 24956 | Number of tests: 14 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.97 (3.6%) stddev-sans-first:4.21 11:33:02 INFO - PROCESS | 24956 | Values: 108.0 110.0 106.0 110.0 112.0 111.0 98.0 110.0 109.0 108.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:155.00 stddev:15.36 (9.9%) stddev-sans-first:16.12 11:33:02 INFO - PROCESS | 24956 | Values: 155.0 132.0 151.0 171.0 133.0 155.0 158.0 130.0 167.0 133.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 11:33:02 INFO - PROCESS | 24956 | Values: 162.0 161.0 162.0 161.0 162.0 161.0 161.0 164.0 161.0 162.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:36.23 (47.7%) stddev-sans-first:37.92 11:33:02 INFO - PROCESS | 24956 | Values: 76.0 74.0 76.0 159.0 76.0 76.0 75.0 76.0 164.0 76.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.00 stddev:25.46 (27.4%) stddev-sans-first:26.36 11:33:02 INFO - PROCESS | 24956 | Values: 93.0 93.0 154.0 93.0 94.0 92.0 146.0 93.0 94.0 135.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:33:02 INFO - PROCESS | 24956 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:33:02 INFO - PROCESS | 24956 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:33:02 INFO - PROCESS | 24956 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.50 stddev:1.25 (2.2%) stddev-sans-first:1.24 11:33:02 INFO - PROCESS | 24956 | Values: 58.0 58.0 58.0 55.0 58.0 56.0 56.0 57.0 56.0 55.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 11:33:02 INFO - PROCESS | 24956 | Values: 63.0 63.0 62.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:2.82 (3.6%) stddev-sans-first:2.98 11:33:02 INFO - PROCESS | 24956 | Values: 79.0 79.0 78.0 78.0 78.0 85.0 78.0 78.0 85.0 80.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:116.00 stddev:3.17 (2.7%) stddev-sans-first:3.10 11:33:02 INFO - PROCESS | 24956 | Values: 112.0 118.0 111.0 121.0 116.0 113.0 114.0 116.0 119.0 115.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:146.50 stddev:4.85 (3.3%) stddev-sans-first:5.15 11:33:02 INFO - PROCESS | 24956 | Values: 144.0 138.0 149.0 147.0 147.0 138.0 146.0 147.0 135.0 146.0 11:33:02 INFO - PROCESS | 24956 | 11:33:02 INFO - PROCESS | 24956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.55 (2.3%) stddev-sans-first:1.64 11:33:02 INFO - PROCESS | 24956 | Values: 67.0 66.0 67.0 68.0 66.0 70.0 64.0 67.0 67.0 66.0 11:33:02 INFO - PROCESS | 24956 | -------- Summary: end -------- 11:33:02 INFO - PROCESS | 24956 | 11:33:03 INFO - TEST-INFO | 24956: exit 0 11:33:03 INFO - TEST-OK | kraken | took 59222ms 11:33:03 INFO - SUITE-END | took 1169s 11:33:03 INFO - Completed test suite (00:19:30) 11:33:03 INFO - javascript benchmark 11:33:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3282.5568548245983, 3343.548620936173, 3357.647447018063, 3366.141633883359, 3391.9830400848, 5388.703621300831, 5398.892022159559, 5409.810656627019, 5433.510984011438, 5447.400785913546, 5388.7305634718205, 5422.674639521621, 5428.0500912340285, 5438.700871452069, 5441.075017247068, 4802.855914322576, 4887.047025829965, 4929.383827021622, 4945.9258111128365, 4988.575971042465, 4843.128236917353, 4935.555799978001, 4939.777710003041, 4942.357493525855, 4946.035523073002, 4850.151223535885, 4899.902001959958, 4911.656184067117, 4914.434839993393, 4940.0, 4959.256111583255, 4966.826161084345, 4982.302477653096, 4984.57631101355, 4986.750662466862, 4769.308450274725, 4777.5700186982995, 4885.43817460993, 4894.5105489451125, 4918.704877707349, 5206.713630750307, 5213.687178769248, 5232.424433312332, 5253.86865328366, 5259.894802103975, 5687.061634830248, 5699.430056994309, 5743.310802703661, 5758.3090029196765, 5765.365809760923, 5835.708214589296, 5858.50202732764, 5877.970610146965, 5887.970560147215, 5891.587588868781, 5505.366882808448, 5508.476694713996, 5510.283663123849, 5514.834554963358, 5535.806246781343, 5726.9713651431475, 5787.5080618147085, 5902.675352855548, 5939.07944268639, 5973.432523910222, 5676.8864622707315, 5677.545796336283, 5679.148127780866, 5679.886402271932, 5695.914561281584, 5752.827415177551, 5757.280339957505, 5760.855978600569, 5763.711814409263, 5766.596338256366, 5660.886782264414, 5670.716464176775, 5734.225879506297, 5768.480836724715, 5779.566532510079, 5770.221020162308, 5790.7973220937065, 5792.478676919098, 5793.768249269982, 5794.797182098607, 4363.432753741993, 4385.188740083095, 4394.802233899482, 4404.185225733249, 4424.31423129409, 3900.8244628991765, 3939.290927632996, 3999.2201520703184, 4009.037830920558, 4042.676585873182, 5413.756380962866, 5471.06991811393, 5476.315460567429, 5476.91784623231, 5498.835034948958, 5597.720113994284, 5853.151293062482, 5858.707064646751, 5889.734961926723, 5894.440028197314, 5349.117395629755, 5363.597730170253, 5406.135018397038, 5415.783368665288, 5449.4005659377435, 4932.309476673268, 4934.777934992934, 4935.531124543163, 4937.802487900443, 4958.057968985881, 5844.795432159854, 5962.791302304486, 5966.701664916737, 5968.820935371946, 5972.522198224132, 5813.738381772915, 5851.414858514115, 5853.912191317048, 5865.208196893364, 5867.119932010232, 5988.850278743066, 5991.970040149771, 6001.159837622824, 6001.189839371804, 6005.189299444519, 5623.971880140573, 5634.352049514358, 5704.686242256716, 5761.452661997104, 5763.135529670583, 5855.2973643163095, 5876.1773351731645, 5879.5002424794375, 5881.470667639933, 5885.970570147122, 5688.089905615082, 5708.172315014383, 5708.200851880657, 5710.143478478261, 5712.171735098304, 5550.139728342114, 5633.971830140823, 5682.9147562785765, 5708.315002199763, 5763.4812866842185, 5534.584906131976, 5553.555715542828, 5563.332400112013, 5573.749181286771, 5579.0, 5636.408177141505, 5673.489385955284, 5689.061304884648, 5710.486056254957, 5715.428457154251, 5358.678479291255, 5366.892662146657, 5415.6479828811, 5539.861503462445, 5550.333959924835], "unit": "score", "name": "dojo.html", "value": 5336.814772045072}, {"lowerIsBetter": false, "replicates": [553.4741995104652, 557.3479029535443, 559.1361346719318, 560.8990381731288, 595.9761609535622, 31685.0, 32240.193995150134, 39197.02007449812, 39977.20045599086, 40098.799506002426, 43614.0, 44305.335419968724, 44447.11105777883, 44449.33326000105, 44555.33167002498, 8976.46141231525, 9182.86225706615, 9195.21840643546, 9196.310276729271, 9202.4478531288, 9162.267018638493, 9325.580348884283, 9351.018143094945, 9365.76585585359, 9378.531073446335, 9368.484733339663, 9460.526973651324, 9480.194183494412, 9484.0, 9486.9525652372, 9323.533823308808, 9418.670346537907, 9427.670031548898, 9430.3398762086, 9434.433933963985, 9127.269818414577, 9266.675666351646, 9284.72145835626, 9290.814183716355, 9293.02423245563, 44561.77719111416, 45098.0, 45276.0, 45437.09125817498, 45709.54290457086, 3749.3251214781603, 3814.256220037094, 3833.310004199243, 3990.0423898264207, 4150.5552863457815, 33674.663253367646, 33703.83148084269, 33743.662563374295, 33830.1542461438, 34173.145671358165, 4175.478065241845, 4182.2681030819485, 4261.488621365456, 4276.465441819772, 4313.978430107861, 224704.0, 225467.0, 225931.0, 226331.0, 227401.0, 44834.0, 45336.0, 64583.354166458674, 65919.67040164769, 66082.66958665175, 43604.781976089915, 43712.78143609261, 43839.0, 43892.0, 43895.56104438915, 14984.400623975136, 15197.544073677807, 15201.543953681406, 15207.543773686808, 15245.542633721006, 11936.820947685792, 11944.880551194377, 12011.519539218334, 12044.698882528008, 12045.819312710317, 14993.0, 15455.381784728484, 15515.456959006606, 15526.223688815515, 15688.294026768823, 5616.719164041863, 5798.159266906275, 5817.185594016841, 5819.388964158702, 5827.35899051104, 956.1251454918811, 1053.0785562632695, 1065.6962765611763, 1070.25617196048, 1122.7866705325962, 29638.407231855672, 29796.255093622833, 30351.089467316015, 30362.392752144835, 30566.235844104074, 1088.6189833558349, 1163.784699830534, 1200.8979236764799, 1241.2304371289858, 1288.3880156925386, 15556.688866222612, 15566.766498502531, 15689.0, 15982.200889955455, 16062.277197526138, 346195.0, 346383.0, 346412.0, 348499.54501365, 348550.0, 58111.12833307504, 58567.414325856196, 58653.41346586565, 58711.0, 58765.41234587685, 1328.747537967783, 1481.5111013365563, 1491.4556186991888, 1519.3770554072778, 1522.8477152284684, 26844.865775670998, 27458.925042226656, 29340.7065929338, 29418.0, 30060.248493786956, 47112.7644361776, 47566.52433475621, 47667.28499072586, 47668.0, 48036.279455808886, 202824.0, 203207.0, 203679.0, 204081.0, 204375.0, 29631.0, 34584.0, 34643.82678086594, 34815.303693926486, 35063.12342191364, 40586.0, 41210.79394603008, 41763.373549397395, 51524.0, 52508.737456312476, 37961.4305785419, 39091.0, 39587.604123958394, 40491.0, 40953.385699215134, 38763.0, 38902.2219555613, 39272.60727392689, 39770.0, 39900.80049599733, 38828.6117138825, 38961.16789190732, 39178.2164356717, 40018.199636007696, 40199.397009045475, 35037.47443788294, 35789.46315805213, 36651.633483665886, 36668.63331366652, 36795.0, 27374.589381159698, 27487.17538473849, 27640.634761964262, 27652.308692282855, 28140.85929570339], "unit": "score", "name": "ext.html", "value": 18776.14658877347}, {"lowerIsBetter": false, "replicates": [379.75316044571025, 384.7537575951391, 385.30452533177623, 386.2371815664062, 391.6357787257851, 17299.56751081222, 19011.334603288888, 19375.0, 19463.124159412826, 19501.21995120197, 18829.246830126813, 18927.242910283607, 19135.808641913576, 19138.23447062116, 19204.807951920477, 5468.125099984003, 5666.51834594058, 5691.08942569189, 5725.627834190765, 5731.770729170828, 4028.0131367814924, 6026.789062382817, 6282.7172777224905, 6304.180456540644, 6311.305756366819, 5953.226080609515, 6226.346233645448, 6237.937620623781, 6269.561130720851, 6270.059491076329, 6146.938530614681, 6157.692115394212, 6166.907496387557, 6184.257889053298, 6195.2565692117005, 3811.123441608446, 3921.8627348042683, 5277.0, 5508.228847961289, 5514.365847927459, 20948.476288092766, 20999.160033598637, 21064.262750803802, 21365.465863353384, 21378.0, 2327.895244713992, 2468.679071720665, 2685.9194224173307, 2759.9172024839086, 2763.6821765496825, 13092.149010314299, 13433.462661493528, 13508.527201547899, 13671.589852304447, 13839.515616953358, 1888.3202047263112, 1929.951751206217, 1944.0182707732647, 1961.928997330545, 1979.7462830164368, 61853.690731546056, 63999.36000639981, 64150.35849641537, 64532.677336613015, 64643.0, 9829.0, 10179.796404072025, 10220.437875916896, 10339.63811266602, 10419.374837509773, 14707.117572945657, 14712.411503539739, 14797.704045919236, 14820.777688334683, 14833.480828171178, 7815.921840781633, 8069.6368663410285, 8112.0, 8136.389770767216, 8195.672173113127, 7837.3338266246865, 7860.960695196487, 7884.448088633741, 7912.169222231582, 7931.920680793118, 6177.598456100429, 6183.072539119078, 6185.257769067741, 6304.873902522016, 6315.905261421082, 1714.5884987602885, 1731.809500954894, 1772.97340539892, 1797.730340448943, 1804.6841802684478, 1064.4837253931837, 1077.498962982217, 1084.4848696869083, 1128.0975219824109, 1197.3953153657521, 16317.020978741313, 16319.673606527804, 17551.0, 18230.908845455688, 18539.165737541844, 992.9106380425796, 1034.6430481483876, 1041.9895801041891, 1067.9359238445563, 1072.5763323487336, 10451.634192803367, 10714.946425267979, 10773.946130269454, 10787.137029037658, 10802.919708029134, 461184.0, 465624.0, 471886.0, 471886.0, 474093.0, 66054.66972665106, 67840.6607966957, 68490.3150968484, 69181.65409172921, 69380.30619693738, 1024.4212020208558, 1081.2107161771794, 1090.6346373964811, 1092.8360745888021, 1098.4837126550508, 15892.60268493297, 16191.109488977749, 16264.918675406547, 16301.0, 16466.83533164653, 31260.531092034093, 32779.34441311208, 33506.32987340288, 34282.65717342795, 34577.654223457444, 45621.0, 45800.770996144805, 45829.31256031229, 45877.54122458733, 45964.54035459603, 8136.480318027803, 8281.792955176168, 8344.499330040217, 8811.647534098563, 8998.775030624287, 9583.856242156235, 12132.575359862363, 12486.625401237978, 12616.684582885502, 13648.24934628605, 11795.938365547141, 11812.0, 11965.282083075042, 12337.0, 12348.506059757508, 11330.830037549607, 11513.53945842157, 11644.0, 11920.940395297968, 12127.332996685267, 12025.218360806519, 12151.574694885636, 12278.877211227773, 12354.320512371905, 12810.743785124432, 8935.731928042169, 9058.176994504674, 9061.954690226507, 9139.360244782802, 9150.679726209552, 10542.789144217226, 11839.70400739954, 11878.524859005543, 11974.880251197377, 11990.220635658654], "unit": "score", "name": "jquery.html", "value": 9057.476721764237}, {"lowerIsBetter": false, "replicates": [1447.6163816588612, 1548.6825200833828, 1581.42278068505, 1819.8180181981804, 1934.322986954566, 7959.641816118274, 8299.336053115743, 8311.501309921408, 8323.33413326934, 8326.209010144026, 8091.757247282576, 8264.545450000247, 8270.627821748021, 8276.337892968548, 8279.296259817922, 2386.4391867911027, 2404.5311164322966, 2409.518096380722, 2409.650600662903, 2410.505846301513, 2475.789557887582, 2490.252924122765, 2518.49630073985, 2519.5590771614984, 2531.455737016541, 2435.7320694723567, 2440.9755902441016, 2449.522343143079, 2458.1642241637837, 2468.2101727447225, 2411.903523859061, 2419.4677171022436, 2425.6967879015124, 2437.475942672325, 2444.095684596693, 2436.744141865114, 2467.7902378297867, 2472.2336075816556, 2488.738682438336, 2490.2778194323623, 8452.154784521561, 8468.957655211685, 8492.065872753992, 8497.830043399097, 8507.744767656981, 5062.190049592047, 5229.058769421503, 5237.371515418175, 5240.3187585614005, 5241.161414173714, 3278.622958359795, 3289.243474000993, 3345.063382252949, 3368.9326213475592, 3395.219099607104, 1028.388109075099, 1049.2917280835406, 1065.957361705531, 2028.2799606139904, 2056.4858785303672, 11376.431178441046, 11459.885401145964, 11463.54145834174, 11465.254758440675, 11504.194706370557, 4430.601245887886, 4462.995825939202, 4472.418585583853, 4494.685372023927, 4553.886152846206, 9124.863127053099, 9133.862992055125, 9187.908120918839, 9191.586378612978, 9235.1688348049, 4983.202687569971, 5021.573166280907, 5052.494750524992, 5062.873428164326, 5065.873353166126, 3953.347697629916, 4553.590176884097, 4658.976705116453, 4670.486246512949, 4716.716996980193, 3524.84138213781, 3580.7135429165605, 3609.4405367168133, 3636.781793092423, 3661.688756455678, 1075.5643964194514, 1103.696483467053, 1110.8843774418685, 1112.3881864974232, 1116.084810455435, 1432.749268877942, 1439.3954539093606, 1465.8167729033871, 1478.8964772465824, 1530.2960638106595, 8133.633986470623, 8144.674213031531, 8194.590270486571, 8198.631061602242, 8198.754037378889, 550.0923476264117, 551.583554416413, 554.7614525753884, 555.4861752878571, 556.6771272661928, 5977.970110149508, 6001.549883758736, 6027.60820546663, 6030.879382412327, 6031.035034394564, 10334.224933130045, 10519.211059170593, 10535.736606584744, 10633.627823026158, 10659.520321585547, 10253.128484078938, 10338.0, 10389.428721304954, 10472.0, 10516.737081573021, 7981.68073277074, 8056.355491560661, 8061.0, 8079.838403231903, 8144.674213031412, 7731.0, 7791.766247012599, 7794.727184548514, 7912.28789408956, 7939.642716077906, 9315.208207302456, 9343.252539796664, 9470.195033422237, 9477.478738669164, 9583.616655333708, 9502.572384242863, 9566.282528810229, 9718.70843874685, 9733.659321923698, 9940.850887236842, 6002.639841609517, 6146.385361463817, 6740.0, 7094.787156385317, 7222.494425390172, 8002.759917202493, 8036.156203598538, 8056.758297251092, 8072.0, 8082.191780822106, 7077.7168913242895, 7270.854582908418, 7286.380657643947, 7364.0, 7366.079240094989, 7147.749828755968, 7157.57054576727, 7186.065811444479, 7266.89099663516, 7284.854302913806, 7468.5145465544565, 7651.196624354363, 7652.617369131633, 7655.732049378245, 7662.9654996574745, 7071.151461824614, 7114.359707626339, 7129.572225666477, 7131.393831524379, 7137.714491420493, 6924.896126558207, 7015.473839462163, 7029.683664235019, 7031.964840175767, 7040.823979400351], "unit": "score", "name": "mootools.html", "value": 4758.893253570325}, {"lowerIsBetter": false, "replicates": [352.5293732866623, 357.5780578916879, 358.3263464686389, 361.5877899194917, 373.5666626713012, 6111.358307377717, 6112.449879510848, 6124.510039196864, 6137.601055931367, 6155.507559395249, 6023.397660233974, 6038.4867286280605, 6046.939530604704, 6052.788152414666, 6054.636721796695, 4424.668149888755, 4561.429821272341, 4636.4436267647925, 4669.719816810985, 4680.882977925554, 4688.249880019198, 4702.106599746037, 4714.127886341038, 4719.150552900476, 4741.431028276612, 4693.8357157499495, 4699.177643912319, 4702.98885739566, 4704.1767690654, 4715.386999690053, 4432.3573081903105, 4544.795484203202, 4638.1883170445035, 4650.232711602582, 4651.79066941985, 4137.420761093449, 4144.191882582898, 4148.91702165958, 4154.439150714645, 4165.437665915093, 5717.342505611867, 5723.856903577403, 5725.255716756795, 5727.198192253088, 5731.0, 5458.072127738294, 5462.20797984294, 5464.207689884945, 5467.753951072172, 5477.67133971963, 6348.809535713936, 6349.396807303298, 6383.648899310536, 6386.2336519617475, 6391.680415979183, 4333.328334108218, 4508.706934049309, 4510.751908645023, 4525.886852828673, 4583.03756211196, 6661.200655921272, 6692.130023097015, 6699.196096468455, 6713.69788359525, 6720.462363010996, 4547.15877562652, 4550.658700597469, 4554.020885509632, 4555.931661025087, 4556.521565235669, 4615.14619795339, 4618.03021365517, 4622.352870598119, 4623.838165664186, 4624.190766615896, 5344.144936810092, 5345.492178243061, 5346.545543628835, 5356.732163391893, 5359.169328754049, 6321.936780632135, 6456.0961465394885, 6456.192975878015, 6463.967680161569, 6472.967635161888, 1645.9588510287338, 1659.7012537743321, 1669.8914570553118, 1670.6742185273754, 1671.3398207707887, 1001.6444162322271, 1087.7987572298991, 1092.0, 1110.189561620022, 1112.1603189591967, 6066.696665166724, 6096.786612468631, 6099.2680878294, 6107.267127944675, 6114.724837382329, 6610.471162307004, 6611.71071641035, 6618.768343107968, 6623.6688165592495, 6643.966780166068, 6093.542984276109, 6099.512039036867, 6103.969480152571, 6106.419890110433, 6109.816705498843, 3547.396942519778, 3580.910477238038, 3581.8925432237074, 3583.086312990171, 3590.0, 6730.629815360105, 6801.081853949752, 6950.374466297956, 6960.269171736996, 6964.199117101598, 6873.0, 6880.759173428906, 6893.103896493424, 6917.89623155653, 6922.653867306614, 6918.792436226921, 6929.549579277331, 6929.722811087601, 6933.583984960817, 6938.653067346511, 6732.057511948233, 6736.730530778714, 6737.461003119836, 6738.157730283715, 6744.5616034957575, 6462.192225971754, 6583.736650533925, 6615.66921653925, 6617.07360969455, 6626.768063117768, 6862.794116176523, 6893.93106068953, 6899.48253880971, 6904.689288982108, 6904.758333458305, 4530.501644819002, 4537.6143027843, 4538.863834084983, 4539.954600453953, 4543.432070991126, 6726.428253598303, 6751.257361690308, 6803.455723542006, 6803.727850885909, 6806.6256355900905, 6331.841703957253, 6497.25281592604, 6515.967420162869, 6518.250401203923, 6523.347665233438, 6463.515236357386, 6482.351764823668, 6491.156149700509, 6497.642629655415, 6519.054737063005, 6329.177206963065, 6371.23545174582, 6378.712957916998, 6381.936180638134, 6390.201224846895, 6514.51141164424, 6519.119918810899, 6524.739010439719, 6527.640979746159, 6531.673416329069, 6055.939440605537, 6148.661823599745, 6186.907196392148, 6291.465225455888, 6310.305866354789], "unit": "score", "name": "prototype.html", "value": 4878.068889989812}, {"lowerIsBetter": false, "replicates": [803.285076282109, 803.2890891560969, 812.7277362083698, 821.7493664432345, 829.6971605364043, 15908.681826363465, 16476.42332518359, 16511.42210022648, 16522.00867947924, 16526.173691315416, 14815.851841481583, 14970.775438368433, 14988.925055374735, 14995.100293982368, 15007.174605396698, 746.045062320231, 864.567716141929, 880.4277219807128, 892.388713731093, 899.649136836631, 891.0287786312917, 897.578138275013, 899.5277479323343, 901.0673952459206, 901.6303315640589, 793.0998316910319, 924.6994726713812, 924.8242833861578, 927.0636656976469, 929.0848514213494, 905.6377449020412, 916.5188276155005, 918.8805455290769, 919.4299534288783, 919.5632074764467, 674.164036594624, 674.5547938360659, 675.2976904019813, 675.8310422394402, 676.1885737115481, 14327.57017289483, 14343.497977570734, 14373.137611743328, 14482.782758258634, 14512.201828899406, 12583.245005299712, 12778.233306001577, 12888.097833151684, 13220.537281195113, 13221.537246196336, 10721.14230861537, 10745.14038876888, 10823.080038196762, 10842.078423334026, 11022.44887755617, 3793.734438589272, 3884.7280690351686, 3896.084420161288, 3903.043754280191, 3905.5508616509183, 47887.76056119697, 48538.51461485375, 50843.0, 51384.486155138715, 51641.99999999962, 10112.089911907817, 10213.131883789812, 10292.176625869912, 10330.483475826179, 10348.586056557653, 19806.801931980495, 19922.701159482618, 19967.900160499106, 19985.60028799416, 19987.500312492302, 8590.914090859136, 8600.5699715014, 8649.870251946226, 8791.428557143765, 8896.021437641853, 4706.811727530929, 4741.2651039088305, 4777.259524773596, 4816.470188279286, 4840.370751802243, 3230.596175478065, 3233.4018206631376, 3248.902532924016, 3258.0714496368896, 3265.804051756902, 574.8821491594213, 575.6258432019221, 585.0755805826783, 605.7062324772481, 631.2961048430966, 658.5061204096927, 729.1614643160408, 744.5086243079542, 749.598964553961, 766.6550052476408, 8693.956530217309, 8734.825303493895, 8796.60415281301, 8806.911930880737, 8816.118388161132, 564.6724899558246, 668.9866202675919, 680.129434324066, 710.3393843725385, 748.4087570818992, 4032.9395059074136, 4106.691998100155, 4150.8547200848425, 4246.341817018367, 4250.702450828412, 59599.70200148971, 59635.40364596385, 59672.701636492406, 60979.695101525096, 63619.68190159019, 53199.0, 54750.45249547533, 55002.44997550053, 55196.72401637966, 59066.70466647639, 46648.76675616668, 46808.063838723036, 47077.0, 47116.0, 48156.5184348152, 9114.908850911672, 9159.313051521029, 9253.86119208199, 9325.160735533835, 9394.201492873182, 35010.124746881535, 36829.26341473102, 36932.0, 37448.251034979694, 38043.42934856035, 39633.40549891696, 39684.801575991936, 44537.55462445334, 46490.0, 47056.29415558838, 11058.447077645924, 11093.722656933642, 11308.208425410143, 11802.291862488279, 11846.940765296464, 9527.38072025316, 11674.066074713832, 11910.583129590423, 12998.090133690552, 13194.604161875159, 10343.327683700536, 10436.634717785144, 10444.425556594157, 10513.9474302628, 10743.677689669323, 10364.740881478023, 10632.787344253225, 10712.73218169552, 10789.082927951213, 10862.239643224899, 11056.557737690402, 11081.11351091927, 11124.276922000045, 11346.716332091764, 11375.033122184706, 8642.740717778477, 8909.910900891167, 8997.550122493718, 9167.312451566293, 9189.264858811146, 9165.312601554777, 9257.768555786159, 9270.119338662817, 9429.481378524248, 9520.619175232912], "unit": "score", "name": "yui.html", "value": 6608.115783370234}], "name": "dromaeo_css", "value": 7199.361460495553}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 106.0, 110.0, 112.0, 111.0, 98.0, 110.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [155.0, 132.0, 151.0, 171.0, 133.0, 155.0, 158.0, 130.0, 167.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 164.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 76.0, 159.0, 76.0, 76.0, 75.0, 76.0, 164.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 154.0, 93.0, 94.0, 92.0, 146.0, 93.0, 94.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 55.0, 58.0, 56.0, 56.0, 57.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 62.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [79.0, 79.0, 78.0, 78.0, 78.0, 85.0, 78.0, 78.0, 85.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [112.0, 118.0, 111.0, 121.0, 116.0, 113.0, 114.0, 116.0, 119.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.5}, {"lowerIsBetter": true, "replicates": [144.0, 138.0, 149.0, 147.0, 147.0, 138.0, 146.0, 147.0, 135.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 68.0, 66.0, 70.0, 64.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1503.3999999999999}]} 11:33:04 INFO - Return code: 0 11:33:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:33:04 INFO - # TBPL SUCCESS # 11:33:04 INFO - Running post-action listener: _resource_record_post_action 11:33:04 INFO - Running post-run listener: _resource_record_post_run 11:33:05 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 20480; Write bytes: 450650112; Read time: 428; Write time: 431400 11:33:05 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 4096; Write bytes: 237502464; Read time: 220; Write time: 308532 11:33:05 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 213147648; Read time: 208; Write time: 122868 11:33:05 INFO - Running post-run listener: _upload_blobber_files 11:33:05 INFO - Blob upload gear active. 11:33:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:05 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:33:05 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:33:05 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:33:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:33:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:06 INFO - (blobuploader) - INFO - Done attempting. 11:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:33:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:07 INFO - (blobuploader) - INFO - Done attempting. 11:33:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:07 INFO - Return code: 0 11:33:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfa9dc20c033b2d9338cc4d40d0aa5670b8dd1233f9b13168692945b31165001b495cd1e32302c6cc31bfcced6fbc69b2a0d2ba587ba25d580814e90bf255b6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a677cb1f9208c614c6afce2e44f2d7af1e58596acac6267753c022bc4b9494d3dfb29fa6f1e788d06a4ec9cccd83ce4276864897fbe9953443169ef2bd6eb3f2"} 11:33:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:07 INFO - Contents: 11:33:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfa9dc20c033b2d9338cc4d40d0aa5670b8dd1233f9b13168692945b31165001b495cd1e32302c6cc31bfcced6fbc69b2a0d2ba587ba25d580814e90bf255b6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a677cb1f9208c614c6afce2e44f2d7af1e58596acac6267753c022bc4b9494d3dfb29fa6f1e788d06a4ec9cccd83ce4276864897fbe9953443169ef2bd6eb3f2"} 11:33:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:07 INFO - Copying logs to upload dir... 11:33:07 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.891241 ========= master_lag: 8.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-05-23 11:33:16.040919) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:33:16.046881) ========= 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=db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfa9dc20c033b2d9338cc4d40d0aa5670b8dd1233f9b13168692945b31165001b495cd1e32302c6cc31bfcced6fbc69b2a0d2ba587ba25d580814e90bf255b6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a677cb1f9208c614c6afce2e44f2d7af1e58596acac6267753c022bc4b9494d3dfb29fa6f1e788d06a4ec9cccd83ce4276864897fbe9953443169ef2bd6eb3f2"} 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.011497 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bfa9dc20c033b2d9338cc4d40d0aa5670b8dd1233f9b13168692945b31165001b495cd1e32302c6cc31bfcced6fbc69b2a0d2ba587ba25d580814e90bf255b6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a677cb1f9208c614c6afce2e44f2d7af1e58596acac6267753c022bc4b9494d3dfb29fa6f1e788d06a4ec9cccd83ce4276864897fbe9953443169ef2bd6eb3f2"}' ========= master_lag: 0.22 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 11:33:16.273595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:33:16.274062) ========= 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=db0483c52d987ecb441a263b000001ad-1464026117.985952-607043590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 1.71 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-05-23 11:33:17.987236) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:33:17.987636) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 11:33:18.062884) ========= ========= Total master_lag: 10.94 =========