builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1467034869.88 results: success (0) buildid: 20160627033728 builduid: bbebe8b318bb492daf3521276efec601 revision: e2f8b2e421f954c7f3b74f9f7bd7a982aed94d05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:09.882089) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:09.882571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:09.882880) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:09.898309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:09.898592) ========= 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=41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 06:41:10-- 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% 70.9M=0s 2016-06-27 06:41:10 (70.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085216 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:09.998224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:09.998561) ========= 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=41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022742 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:10.048240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:10.048606) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e2f8b2e421f954c7f3b74f9f7bd7a982aed94d05 --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 e2f8b2e421f954c7f3b74f9f7bd7a982aed94d05 --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=41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 06:41:10,194 truncating revision to first 12 chars 2016-06-27 06:41:10,194 Setting DEBUG logging. 2016-06-27 06:41:10,194 attempt 1/10 2016-06-27 06:41:10,194 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e2f8b2e421f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 06:41:10,506 unpacking tar archive at: mozilla-beta-e2f8b2e421f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655128 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:10.717319) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:10.717657) ========= script_repo_revision: e2f8b2e421f954c7f3b74f9f7bd7a982aed94d05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:10.718076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:10.718373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 06:41:10.728697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-27 06:41:10.728975) ========= /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=41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:41:10 INFO - MultiFileLogger online at 20160627 06:41:10 in /builds/slave/test 06:41:10 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 06:41:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:41:10 INFO - {'append_to_log': False, 06:41:10 INFO - 'base_work_dir': '/builds/slave/test', 06:41:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:41:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:41:10 INFO - 'branch': 'Mozilla-Beta', 06:41:10 INFO - 'buildbot_json_path': 'buildprops.json', 06:41:10 INFO - 'config_files': ('talos/linux_config.py',), 06:41:10 INFO - 'default_actions': ('clobber', 06:41:10 INFO - 'read-buildbot-config', 06:41:10 INFO - 'download-and-extract', 06:41:10 INFO - 'populate-webroot', 06:41:10 INFO - 'create-virtualenv', 06:41:10 INFO - 'install', 06:41:10 INFO - 'run-tests'), 06:41:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:41:10 INFO - 'download_minidump_stackwalk': True, 06:41:10 INFO - 'download_symbols': 'ondemand', 06:41:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:41:10 INFO - 'tooltool.py': '/tools/tooltool.py', 06:41:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:41:10 INFO - '/tools/misc-python/virtualenv.py')}, 06:41:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:41:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:41:10 INFO - 'installer_path': 'installer.exe', 06:41:10 INFO - 'log_level': 'info', 06:41:10 INFO - 'log_name': 'talos', 06:41:10 INFO - 'log_to_console': True, 06:41:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:41:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:41:10 INFO - 'opt_config_files': (), 06:41:10 INFO - 'pip_index': False, 06:41:10 INFO - 'sps_profile': False, 06:41:10 INFO - 'sps_profile_interval': 0, 06:41:10 INFO - 'suite': 'dromaeojs', 06:41:10 INFO - 'system_bits': '32', 06:41:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:41:10 INFO - 'title': 'talos-linux64-ix-026', 06:41:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:41:10 INFO - 'use_talos_json': True, 06:41:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:41:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:41:10 INFO - 'work_dir': 'build'} 06:41:10 INFO - ##### 06:41:10 INFO - ##### Running clobber step. 06:41:10 INFO - ##### 06:41:10 INFO - Running pre-action listener: _resource_record_pre_action 06:41:10 INFO - Running main action method: clobber 06:41:10 INFO - rmtree: /builds/slave/test/build 06:41:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:41:11 INFO - Running post-action listener: _resource_record_post_action 06:41:11 INFO - ##### 06:41:11 INFO - ##### Running read-buildbot-config step. 06:41:11 INFO - ##### 06:41:11 INFO - Running pre-action listener: _resource_record_pre_action 06:41:11 INFO - Running main action method: read_buildbot_config 06:41:11 INFO - Using buildbot properties: 06:41:11 INFO - { 06:41:11 INFO - "project": "", 06:41:11 INFO - "product": "firefox", 06:41:11 INFO - "script_repo_revision": "production", 06:41:11 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:41:11 INFO - "repository": "", 06:41:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:41:11 INFO - "buildid": "20160627033728", 06:41:11 INFO - "pgo_build": "True", 06:41:11 INFO - "basedir": "/builds/slave/test", 06:41:11 INFO - "buildnumber": 134, 06:41:11 INFO - "slavename": "talos-linux64-ix-026", 06:41:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:41:11 INFO - "platform": "ubuntu64_hw", 06:41:11 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:41:11 INFO - "branch": "mozilla-beta", 06:41:11 INFO - "repo_path": "releases/mozilla-beta", 06:41:11 INFO - "revision": "e2f8b2e421f954c7f3b74f9f7bd7a982aed94d05", 06:41:11 INFO - "stage_platform": "linux64-pgo", 06:41:11 INFO - "builduid": "bbebe8b318bb492daf3521276efec601", 06:41:11 INFO - "slavebuilddir": "test" 06:41:11 INFO - } 06:41:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 06:41:11 INFO - Running post-action listener: _resource_record_post_action 06:41:11 INFO - ##### 06:41:11 INFO - ##### Running download-and-extract step. 06:41:11 INFO - ##### 06:41:11 INFO - Running pre-action listener: _resource_record_pre_action 06:41:11 INFO - Running main action method: download_and_extract 06:41:11 INFO - mkdir: /builds/slave/test/build/tests 06:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:11 INFO - https://queue.taskcluster.net/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:41:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:41:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:41:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:41:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:41:12 INFO - Downloaded 1327 bytes. 06:41:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:41:12 INFO - Using the following test package requirements: 06:41:12 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:41:12 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:41:12 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:41:12 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:41:12 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:41:12 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:41:12 INFO - u'jsshell-linux-x86_64.zip'], 06:41:12 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:41:12 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:41:12 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:41:12 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:41:12 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:41:12 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:41:12 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:41:12 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:41:12 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:41:12 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:41:12 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:41:12 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:41:12 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')]} 06:41:12 INFO - https://queue.taskcluster.net/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:41:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:41:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:41:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:41:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:41:13 INFO - Downloaded 24229873 bytes. 06:41:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:41:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:41:14 INFO - Return code: 0 06:41:14 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:14 INFO - https://queue.taskcluster.net/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:41:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:41:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:41:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:41:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:41:15 INFO - Downloaded 24229873 bytes. 06:41:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:41:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:41:17 INFO - Return code: 0 06:41:17 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')]} 06:41:17 INFO - https://queue.taskcluster.net/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:41:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:41:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:41:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:41:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:41:18 INFO - Downloaded 10840145 bytes. 06:41:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:41:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:41:18 INFO - Return code: 0 06:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:18 INFO - https://queue.taskcluster.net/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:41:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:41:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:41:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:41:21 INFO - Downloaded 56017585 bytes. 06:41:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:41:21 INFO - mkdir: /builds/slave/test/properties 06:41:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:41:21 INFO - Writing to file /builds/slave/test/properties/build_url 06:41:21 INFO - Contents: 06:41:21 INFO - build_url:https://queue.taskcluster.net/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:41:22 INFO - Running post-action listener: _resource_record_post_action 06:41:22 INFO - Running post-action listener: set_extra_try_arguments 06:41:22 INFO - ##### 06:41:22 INFO - ##### Running populate-webroot step. 06:41:22 INFO - ##### 06:41:22 INFO - Running pre-action listener: _resource_record_pre_action 06:41:22 INFO - Running main action method: populate_webroot 06:41:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:41:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:41:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:41:22 INFO - '--tppagecycles', 06:41:22 INFO - '7'], 06:41:22 INFO - 'tests': ['tsvgm']}}, 06:41:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:41:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:41:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:41:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:41:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:41:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:41:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:22 INFO - 'talos_options': ['--disable-e10s'], 06:41:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:22 INFO - 'talos_options': ['--disable-e10s'], 06:41:22 INFO - 'tests': ['damp', 'tps']}, 06:41:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:22 INFO - 'tests': ['damp', 'tps']}, 06:41:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:41:22 INFO - 'tests': ['dromaeo_dom']}, 06:41:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:41:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:41:22 INFO - 'tests': ['a11yr', 06:41:22 INFO - 'ts_paint', 06:41:22 INFO - 'tpaint', 06:41:22 INFO - 'sessionrestore', 06:41:22 INFO - 'sessionrestore_no_auto_restore', 06:41:22 INFO - 'tabpaint']}, 06:41:22 INFO - 'other-e10s': {'tests': ['a11yr', 06:41:22 INFO - 'ts_paint', 06:41:22 INFO - 'tpaint', 06:41:22 INFO - 'sessionrestore', 06:41:22 INFO - 'sessionrestore_no_auto_restore', 06:41:22 INFO - 'tabpaint']}, 06:41:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:41:22 INFO - 'ts_paint', 06:41:22 INFO - 'tpaint', 06:41:22 INFO - 'sessionrestore', 06:41:22 INFO - 'sessionrestore_no_auto_restore', 06:41:22 INFO - 'tabpaint']}, 06:41:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:41:22 INFO - 'ts_paint', 06:41:22 INFO - 'tpaint', 06:41:22 INFO - 'sessionrestore', 06:41:22 INFO - 'sessionrestore_no_auto_restore', 06:41:22 INFO - 'tabpaint']}, 06:41:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:41:22 INFO - 'tests': ['a11yr', 06:41:22 INFO - 'ts_paint', 06:41:22 INFO - 'tpaint', 06:41:22 INFO - 'sessionrestore', 06:41:22 INFO - 'sessionrestore_no_auto_restore', 06:41:22 INFO - 'tabpaint']}, 06:41:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:41:22 INFO - 'tests': ['a11yr', 06:41:22 INFO - 'ts_paint', 06:41:22 INFO - 'tpaint', 06:41:22 INFO - 'sessionrestore', 06:41:22 INFO - 'sessionrestore_no_auto_restore', 06:41:22 INFO - 'tabpaint']}, 06:41:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:41:22 INFO - 'tests': ['tsvgx', 06:41:22 INFO - 'tsvgr_opacity', 06:41:22 INFO - 'tart', 06:41:22 INFO - 'tscrollx', 06:41:22 INFO - 'cart']}, 06:41:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:41:22 INFO - 'tsvgr_opacity', 06:41:22 INFO - 'tart', 06:41:22 INFO - 'tscrollx', 06:41:22 INFO - 'cart']}, 06:41:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:22 INFO - 'talos_options': ['--disable-e10s'], 06:41:22 INFO - 'tests': ['tp5o']}, 06:41:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:22 INFO - 'tests': ['tp5o']}, 06:41:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:22 INFO - 'talos_options': ['--disable-e10s', 06:41:22 INFO - '--xperf_path', 06:41:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:22 INFO - 'tests': ['tp5n']}, 06:41:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:41:22 INFO - 'talos_options': ['--xperf_path', 06:41:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:22 INFO - 'tests': ['tp5n']}}, 06:41:22 INFO - 'talos.zip': {'path': '', 06:41:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:41:22 INFO - Running post-action listener: _resource_record_post_action 06:41:22 INFO - ##### 06:41:22 INFO - ##### Running create-virtualenv step. 06:41:22 INFO - ##### 06:41:22 INFO - Running pre-action listener: _resource_record_pre_action 06:41:22 INFO - Running main action method: create_virtualenv 06:41:22 INFO - Creating virtualenv /builds/slave/test/build/venv 06:41:22 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 06:41:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:41:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:41:22 INFO - Using real prefix '/usr' 06:41:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:41:23 INFO - Installing distribute.............................................................................................................................................................................................done. 06:41:25 INFO - Installing pip.................done. 06:41:25 INFO - Return code: 0 06:41:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:41:25 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')]} 06:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:25 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')]} 06:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:25 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 0x7fbb50f8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', '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 06:41:25 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 06:41:25 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 06:41:25 INFO - Using env: {'DISPLAY': ':0', 06:41:25 INFO - 'HOME': '/home/cltbld', 06:41:25 INFO - 'LANG': 'en_US.UTF-8', 06:41:25 INFO - 'LANGUAGE': 'en_US:en', 06:41:25 INFO - 'LOGNAME': 'cltbld', 06:41:25 INFO - 'MAIL': '/var/mail/cltbld', 06:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:25 INFO - 'MOZ_NO_REMOTE': '1', 06:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:25 INFO - 'NO_EM_RESTART': '1', 06:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:25 INFO - 'PWD': '/builds/slave/test', 06:41:25 INFO - 'SHELL': '/bin/bash', 06:41:25 INFO - 'SHLVL': '1', 06:41:25 INFO - 'TERM': 'linux', 06:41:25 INFO - 'TMOUT': '86400', 06:41:25 INFO - 'USER': 'cltbld', 06:41:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', 06:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:25 INFO - '_': '/tools/buildbot/bin/python'} 06:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:25 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 06:41:25 INFO - Cleaning up... 06:41:25 INFO - Return code: 0 06:41:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:41:25 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')]} 06:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:25 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')]} 06:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:25 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 0x7fbb50f8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', '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 06:41:25 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 06:41:25 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 06:41:25 INFO - Using env: {'DISPLAY': ':0', 06:41:25 INFO - 'HOME': '/home/cltbld', 06:41:25 INFO - 'LANG': 'en_US.UTF-8', 06:41:25 INFO - 'LANGUAGE': 'en_US:en', 06:41:25 INFO - 'LOGNAME': 'cltbld', 06:41:25 INFO - 'MAIL': '/var/mail/cltbld', 06:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:25 INFO - 'MOZ_NO_REMOTE': '1', 06:41:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:25 INFO - 'NO_EM_RESTART': '1', 06:41:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:25 INFO - 'PWD': '/builds/slave/test', 06:41:25 INFO - 'SHELL': '/bin/bash', 06:41:25 INFO - 'SHLVL': '1', 06:41:25 INFO - 'TERM': 'linux', 06:41:25 INFO - 'TMOUT': '86400', 06:41:25 INFO - 'USER': 'cltbld', 06:41:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', 06:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:25 INFO - '_': '/tools/buildbot/bin/python'} 06:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:25 INFO - Downloading/unpacking psutil>=0.7.1 06:41:25 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 06:41:25 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 06:41:25 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 06:41:25 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 06:41:25 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 06:41:25 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 06:41:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:41:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:28 INFO - Installing collected packages: psutil 06:41:28 INFO - Running setup.py install for psutil 06:41:28 INFO - building 'psutil._psutil_linux' extension 06:41:28 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 06:41:28 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 06:41:29 INFO - building 'psutil._psutil_posix' extension 06:41:29 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 06:41:29 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 06:41:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:41:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:41:29 INFO - Successfully installed psutil 06:41:29 INFO - Cleaning up... 06:41:29 INFO - Return code: 0 06:41:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:29 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 0x7fbb50f8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', '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 06:41:29 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 06:41:29 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 06:41:29 INFO - Using env: {'DISPLAY': ':0', 06:41:29 INFO - 'HOME': '/home/cltbld', 06:41:29 INFO - 'LANG': 'en_US.UTF-8', 06:41:29 INFO - 'LANGUAGE': 'en_US:en', 06:41:29 INFO - 'LOGNAME': 'cltbld', 06:41:29 INFO - 'MAIL': '/var/mail/cltbld', 06:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:29 INFO - 'MOZ_NO_REMOTE': '1', 06:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:29 INFO - 'NO_EM_RESTART': '1', 06:41:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:29 INFO - 'PWD': '/builds/slave/test', 06:41:29 INFO - 'SHELL': '/bin/bash', 06:41:29 INFO - 'SHLVL': '1', 06:41:29 INFO - 'TERM': 'linux', 06:41:29 INFO - 'TMOUT': '86400', 06:41:29 INFO - 'USER': 'cltbld', 06:41:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', 06:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:29 INFO - '_': '/tools/buildbot/bin/python'} 06:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:41:29 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 06:41:29 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 06:41:29 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 06:41:29 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 06:41:29 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 06:41:29 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 06:41:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:41:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:41:31 INFO - Installing collected packages: mozsystemmonitor 06:41:31 INFO - Running setup.py install for mozsystemmonitor 06:41:31 INFO - Successfully installed mozsystemmonitor 06:41:31 INFO - Cleaning up... 06:41:31 INFO - Return code: 0 06:41:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:31 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 0x7fbb50f8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', '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 06:41:31 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 06:41:31 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 06:41:31 INFO - Using env: {'DISPLAY': ':0', 06:41:31 INFO - 'HOME': '/home/cltbld', 06:41:31 INFO - 'LANG': 'en_US.UTF-8', 06:41:31 INFO - 'LANGUAGE': 'en_US:en', 06:41:31 INFO - 'LOGNAME': 'cltbld', 06:41:31 INFO - 'MAIL': '/var/mail/cltbld', 06:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:31 INFO - 'MOZ_NO_REMOTE': '1', 06:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:31 INFO - 'NO_EM_RESTART': '1', 06:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:31 INFO - 'PWD': '/builds/slave/test', 06:41:31 INFO - 'SHELL': '/bin/bash', 06:41:31 INFO - 'SHLVL': '1', 06:41:31 INFO - 'TERM': 'linux', 06:41:31 INFO - 'TMOUT': '86400', 06:41:31 INFO - 'USER': 'cltbld', 06:41:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', 06:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:31 INFO - '_': '/tools/buildbot/bin/python'} 06:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:31 INFO - Downloading/unpacking blobuploader==1.2.4 06:41:31 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 06:41:31 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 06:41:31 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 06:41:31 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 06:41:31 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 06:41:31 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 06:41:33 INFO - Downloading blobuploader-1.2.4.tar.gz 06:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:41:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:41:33 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 06:41:33 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 06:41:33 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 06:41:33 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 06:41:33 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 06:41:33 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 06:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:41:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:41:34 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 06:41:34 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 06:41:34 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 06:41:34 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 06:41:34 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 06:41:34 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 06:41:34 INFO - Downloading docopt-0.6.1.tar.gz 06:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:41:34 INFO - Installing collected packages: blobuploader, requests, docopt 06:41:34 INFO - Running setup.py install for blobuploader 06:41:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:41:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:41:34 INFO - Running setup.py install for requests 06:41:34 INFO - Running setup.py install for docopt 06:41:34 INFO - Successfully installed blobuploader requests docopt 06:41:34 INFO - Cleaning up... 06:41:35 INFO - Return code: 0 06:41:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41: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')]} 06:41:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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')]} 06:41:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:35 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 0x7fbb50f8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', '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 06:41:35 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 06:41:35 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 06:41:35 INFO - Using env: {'DISPLAY': ':0', 06:41:35 INFO - 'HOME': '/home/cltbld', 06:41:35 INFO - 'LANG': 'en_US.UTF-8', 06:41:35 INFO - 'LANGUAGE': 'en_US:en', 06:41:35 INFO - 'LOGNAME': 'cltbld', 06:41:35 INFO - 'MAIL': '/var/mail/cltbld', 06:41:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:35 INFO - 'MOZ_NO_REMOTE': '1', 06:41:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:35 INFO - 'NO_EM_RESTART': '1', 06:41:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:35 INFO - 'PWD': '/builds/slave/test', 06:41:35 INFO - 'SHELL': '/bin/bash', 06:41:35 INFO - 'SHLVL': '1', 06:41:35 INFO - 'TERM': 'linux', 06:41:35 INFO - 'TMOUT': '86400', 06:41:35 INFO - 'USER': 'cltbld', 06:41:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', 06:41:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:35 INFO - '_': '/tools/buildbot/bin/python'} 06:41:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:35 INFO - Running setup.py (path:/tmp/pip-ZqFizK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:35 INFO - Running setup.py (path:/tmp/pip-IWzjsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:35 INFO - Running setup.py (path:/tmp/pip-WImEM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:35 INFO - Running setup.py (path:/tmp/pip-nskF5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:35 INFO - Running setup.py (path:/tmp/pip-ikts7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:35 INFO - Running setup.py (path:/tmp/pip-Mb0i91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:35 INFO - Running setup.py (path:/tmp/pip-hr1rNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:35 INFO - Running setup.py (path:/tmp/pip-H4yqKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:35 INFO - Running setup.py (path:/tmp/pip-816jKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:35 INFO - Running setup.py (path:/tmp/pip-Is9Wap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:35 INFO - Running setup.py (path:/tmp/pip-Gel6se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:36 INFO - Running setup.py (path:/tmp/pip-dYZMyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:36 INFO - Running setup.py (path:/tmp/pip-gQ7AHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:36 INFO - Running setup.py (path:/tmp/pip-OC8hvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:36 INFO - Running setup.py (path:/tmp/pip-0B2zTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:36 INFO - Running setup.py (path:/tmp/pip-nXQzIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:36 INFO - Running setup.py (path:/tmp/pip-_RgUPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:41:36 INFO - Running setup.py install for manifestparser 06:41:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:41:36 INFO - Running setup.py install for mozcrash 06:41:36 INFO - Running setup.py install for mozdebug 06:41:36 INFO - Running setup.py install for mozdevice 06:41:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:41:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:41:36 INFO - Running setup.py install for mozfile 06:41:36 INFO - Running setup.py install for mozhttpd 06:41:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Running setup.py install for mozinfo 06:41:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Running setup.py install for mozInstall 06:41:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Running setup.py install for mozleak 06:41:37 INFO - Running setup.py install for mozlog 06:41:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Running setup.py install for moznetwork 06:41:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Running setup.py install for mozprocess 06:41:37 INFO - Running setup.py install for mozprofile 06:41:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Running setup.py install for mozrunner 06:41:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:41:37 INFO - Running setup.py install for mozscreenshot 06:41:38 INFO - Running setup.py install for moztest 06:41:38 INFO - Running setup.py install for mozversion 06:41:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:41:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:41:38 INFO - Cleaning up... 06:41:38 INFO - Return code: 0 06:41:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41: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')]} 06:41:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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')]} 06:41:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:38 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 0x7fbb50f8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', '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 06:41:38 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 06:41:38 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 06:41:38 INFO - Using env: {'DISPLAY': ':0', 06:41:38 INFO - 'HOME': '/home/cltbld', 06:41:38 INFO - 'LANG': 'en_US.UTF-8', 06:41:38 INFO - 'LANGUAGE': 'en_US:en', 06:41:38 INFO - 'LOGNAME': 'cltbld', 06:41:38 INFO - 'MAIL': '/var/mail/cltbld', 06:41:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:38 INFO - 'MOZ_NO_REMOTE': '1', 06:41:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:38 INFO - 'NO_EM_RESTART': '1', 06:41:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:38 INFO - 'PWD': '/builds/slave/test', 06:41:38 INFO - 'SHELL': '/bin/bash', 06:41:38 INFO - 'SHLVL': '1', 06:41:38 INFO - 'TERM': 'linux', 06:41:38 INFO - 'TMOUT': '86400', 06:41:38 INFO - 'USER': 'cltbld', 06:41:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', 06:41:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:38 INFO - '_': '/tools/buildbot/bin/python'} 06:41:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:41:38 INFO - Running setup.py (path:/tmp/pip-uK1R94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:41:38 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)) 06:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:41:38 INFO - Running setup.py (path:/tmp/pip-f03dXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:41:38 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)) 06:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:41:38 INFO - Running setup.py (path:/tmp/pip-8w9tdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:41:38 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)) 06:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:41:38 INFO - Running setup.py (path:/tmp/pip-rXKcsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:41:38 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)) 06:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:41:38 INFO - Running setup.py (path:/tmp/pip-40OVQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:41:38 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)) 06:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:41:38 INFO - Running setup.py (path:/tmp/pip-QMmwno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:41:38 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)) 06:41:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:41:38 INFO - Running setup.py (path:/tmp/pip-o_2VmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:41:39 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)) 06:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:41:39 INFO - Running setup.py (path:/tmp/pip-hdchVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:41:39 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)) 06:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:41:39 INFO - Running setup.py (path:/tmp/pip-tSNSPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:41:39 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)) 06:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:41:39 INFO - Running setup.py (path:/tmp/pip-uMJFbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:41:39 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)) 06:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:41:39 INFO - Running setup.py (path:/tmp/pip-o9i_we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:41:39 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)) 06:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:41:39 INFO - Running setup.py (path:/tmp/pip-Odb5k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:41:39 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)) 06:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:41:39 INFO - Running setup.py (path:/tmp/pip-gfg0Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:41:39 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)) 06:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:41:39 INFO - Running setup.py (path:/tmp/pip-8985jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:41:39 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)) 06:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:39 INFO - Running setup.py (path:/tmp/pip-QbgVHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:41:39 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)) 06:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:41:39 INFO - Running setup.py (path:/tmp/pip-fR6Fri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:41:39 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)) 06:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:41:39 INFO - Running setup.py (path:/tmp/pip-4S3n4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:41:39 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)) 06:41:39 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)) 06:41:39 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)) 06:41:39 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)) 06:41:39 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)) 06:41:39 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)) 06:41:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:41:39 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 06:41:39 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 06:41:39 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 06:41:39 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 06:41:39 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 06:41:39 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 06:41:41 INFO - Downloading blessings-1.6.tar.gz 06:41:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:41:41 INFO - Installing collected packages: blessings 06:41:41 INFO - Running setup.py install for blessings 06:41:41 INFO - Successfully installed blessings 06:41:41 INFO - Cleaning up... 06:41:41 INFO - Return code: 0 06:41:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:41:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:42 INFO - Reading from file tmpfile_stdout 06:41:42 INFO - Current package versions: 06:41:42 INFO - argparse == 1.2.1 06:41:42 INFO - blessings == 1.6 06:41:42 INFO - blobuploader == 1.2.4 06:41:42 INFO - docopt == 0.6.1 06:41:42 INFO - manifestparser == 1.1 06:41:42 INFO - mozInstall == 1.12 06:41:42 INFO - mozcrash == 0.17 06:41:42 INFO - mozdebug == 0.1 06:41:42 INFO - mozdevice == 0.48 06:41:42 INFO - mozfile == 1.2 06:41:42 INFO - mozhttpd == 0.7 06:41:42 INFO - mozinfo == 0.9 06:41:42 INFO - mozleak == 0.1 06:41:42 INFO - mozlog == 3.1 06:41:42 INFO - moznetwork == 0.27 06:41:42 INFO - mozprocess == 0.22 06:41:42 INFO - mozprofile == 0.28 06:41:42 INFO - mozrunner == 6.11 06:41:42 INFO - mozscreenshot == 0.1 06:41:42 INFO - mozsystemmonitor == 0.0 06:41:42 INFO - moztest == 0.7 06:41:42 INFO - mozversion == 1.4 06:41:42 INFO - psutil == 3.1.1 06:41:42 INFO - requests == 1.2.3 06:41:42 INFO - wsgiref == 0.1.2 06:41:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:42 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 0x7fbb50f8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', '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 06:41:42 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 06:41:42 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 06:41:42 INFO - Using env: {'DISPLAY': ':0', 06:41:42 INFO - 'HOME': '/home/cltbld', 06:41:42 INFO - 'LANG': 'en_US.UTF-8', 06:41:42 INFO - 'LANGUAGE': 'en_US:en', 06:41:42 INFO - 'LOGNAME': 'cltbld', 06:41:42 INFO - 'MAIL': '/var/mail/cltbld', 06:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:42 INFO - 'MOZ_NO_REMOTE': '1', 06:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:42 INFO - 'NO_EM_RESTART': '1', 06:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:42 INFO - 'PWD': '/builds/slave/test', 06:41:42 INFO - 'SHELL': '/bin/bash', 06:41:42 INFO - 'SHLVL': '1', 06:41:42 INFO - 'TERM': 'linux', 06:41:42 INFO - 'TMOUT': '86400', 06:41:42 INFO - 'USER': 'cltbld', 06:41:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', 06:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:42 INFO - '_': '/tools/buildbot/bin/python'} 06:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:42 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)) 06:41:42 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)) 06:41:42 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)) 06:41:42 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)) 06:41:42 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)) 06:41:42 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)) 06:41:42 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)) 06:41:42 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)) 06:41:42 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)) 06:41:42 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)) 06:41:42 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)) 06:41:42 INFO - Cleaning up... 06:41:42 INFO - Return code: 0 06:41:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:41:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:42 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 0x7fbb50f8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', '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 06:41:42 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 06:41:42 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 06:41:42 INFO - Using env: {'DISPLAY': ':0', 06:41:42 INFO - 'HOME': '/home/cltbld', 06:41:42 INFO - 'LANG': 'en_US.UTF-8', 06:41:42 INFO - 'LANGUAGE': 'en_US:en', 06:41:42 INFO - 'LOGNAME': 'cltbld', 06:41:42 INFO - 'MAIL': '/var/mail/cltbld', 06:41:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:42 INFO - 'MOZ_NO_REMOTE': '1', 06:41:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:42 INFO - 'NO_EM_RESTART': '1', 06:41:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:42 INFO - 'PWD': '/builds/slave/test', 06:41:42 INFO - 'SHELL': '/bin/bash', 06:41:42 INFO - 'SHLVL': '1', 06:41:42 INFO - 'TERM': 'linux', 06:41:42 INFO - 'TMOUT': '86400', 06:41:42 INFO - 'USER': 'cltbld', 06:41:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', 06:41:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:42 INFO - '_': '/tools/buildbot/bin/python'} 06:41:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:42 INFO - Downloading/unpacking jsonschema 06:41:42 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 06:41:42 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 06:41:42 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 06:41:42 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 06:41:42 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 06:41:42 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 06:41:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:41:44 INFO - Downloading/unpacking functools32 (from jsonschema) 06:41:44 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 06:41:44 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 06:41:44 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 06:41:44 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 06:41:44 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 06:41:44 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 06:41:44 INFO - Downloading functools32-3.2.3-2.tar.gz 06:41:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:41:44 INFO - warning: no files found matching '*.txt' 06:41:44 INFO - no previously-included directories found matching 'build' 06:41:44 INFO - no previously-included directories found matching 'dist' 06:41:44 INFO - no previously-included directories found matching '.git*' 06:41:44 INFO - Installing collected packages: jsonschema, functools32 06:41:44 INFO - Running setup.py install for functools32 06:41:44 INFO - warning: no files found matching '*.txt' 06:41:44 INFO - no previously-included directories found matching 'build' 06:41:44 INFO - no previously-included directories found matching 'dist' 06:41:44 INFO - no previously-included directories found matching '.git*' 06:41:44 INFO - Successfully installed jsonschema functools32 06:41:44 INFO - Cleaning up... 06:41:44 INFO - Return code: 0 06:41:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:41:44 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')]} 06:41:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:44 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')]} 06:41:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41:44 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 0x7fbb50f8df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f6b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20365a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, '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': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', '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 06:41:44 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 06:41:44 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 06:41:44 INFO - Using env: {'DISPLAY': ':0', 06:41:44 INFO - 'HOME': '/home/cltbld', 06:41:44 INFO - 'LANG': 'en_US.UTF-8', 06:41:44 INFO - 'LANGUAGE': 'en_US:en', 06:41:44 INFO - 'LOGNAME': 'cltbld', 06:41:44 INFO - 'MAIL': '/var/mail/cltbld', 06:41:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:44 INFO - 'MOZ_NO_REMOTE': '1', 06:41:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:41:44 INFO - 'NO_EM_RESTART': '1', 06:41:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:41:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:44 INFO - 'PWD': '/builds/slave/test', 06:41:44 INFO - 'SHELL': '/bin/bash', 06:41:44 INFO - 'SHLVL': '1', 06:41:44 INFO - 'TERM': 'linux', 06:41:44 INFO - 'TMOUT': '86400', 06:41:44 INFO - 'USER': 'cltbld', 06:41:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', 06:41:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:44 INFO - '_': '/tools/buildbot/bin/python'} 06:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:45 INFO - Downloading/unpacking flake8 06:41:45 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 06:41:45 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 06:41:45 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 06:41:45 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 06:41:45 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 06:41:45 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 06:41:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:41:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:41:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 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 06:41:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:41:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:41:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:41:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:41:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:41:47 INFO - no previously-included directories found matching 'docs/_build' 06:41:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:41:47 INFO - Running setup.py install for pep8 06:41:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:41:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:41:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:41:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:41:47 INFO - no previously-included directories found matching 'docs/_build' 06:41:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:41:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:41:47 INFO - Cleaning up... 06:41:47 INFO - Return code: 0 06:41:47 INFO - Running post-action listener: _resource_record_post_action 06:41:47 INFO - Running post-action listener: _start_resource_monitoring 06:41:47 INFO - Starting resource monitoring. 06:41:47 INFO - ##### 06:41:47 INFO - ##### Running install step. 06:41:47 INFO - ##### 06:41:47 INFO - Running pre-action listener: _resource_record_pre_action 06:41:47 INFO - Running main action method: install 06:41:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:41:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:41:48 INFO - Reading from file tmpfile_stdout 06:41:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:41:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:41:48 INFO - Reading from file tmpfile_stdout 06:41:48 INFO - Output received: 06:41:48 INFO - Usage: mozinstall [options] installer 06:41:48 INFO - Options: 06:41:48 INFO - -h, --help show this help message and exit 06:41:48 INFO - -d DEST, --destination=DEST 06:41:48 INFO - Directory to install application into. [default: 06:41:48 INFO - "/builds/slave/test"] 06:41:48 INFO - --app=APP Application being installed. [default: firefox] 06:41:48 INFO - mkdir: /builds/slave/test/build/application 06:41:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:42:01 INFO - Reading from file tmpfile_stdout 06:42:01 INFO - Output received: 06:42:01 INFO - /builds/slave/test/build/application/firefox/firefox 06:42:01 INFO - Running post-action listener: _resource_record_post_action 06:42:01 INFO - ##### 06:42:01 INFO - ##### Running run-tests step. 06:42:01 INFO - ##### 06:42:01 INFO - Running pre-action listener: _resource_record_pre_action 06:42:01 INFO - Running main action method: run_tests 06:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:42:01 INFO - Python 2.7.3 06:42:01 INFO - Return code: 0 06:42:01 INFO - grabbing minidump binary from tooltool 06:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:42:01 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 0x20c5410>, '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 0x20c6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:42:01 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 06:42:01 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 06:42:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:42:01 INFO - Return code: 0 06:42:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:42:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:42:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:42:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:42:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:42:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:42:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:42:02 INFO - Return code: 0 06:42:02 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/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 06:42:02 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/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 06:42:02 INFO - Using env: {'DISPLAY': ':0', 06:42:02 INFO - 'HOME': '/home/cltbld', 06:42:02 INFO - 'LANG': 'en_US.UTF-8', 06:42:02 INFO - 'LANGUAGE': 'en_US:en', 06:42:02 INFO - 'LOGNAME': 'cltbld', 06:42:02 INFO - 'MAIL': '/var/mail/cltbld', 06:42:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:42:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:02 INFO - 'MOZ_NO_REMOTE': '1', 06:42:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:02 INFO - 'NO_EM_RESTART': '1', 06:42:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:02 INFO - 'PWD': '/builds/slave/test', 06:42:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:42:02 INFO - 'SHELL': '/bin/bash', 06:42:02 INFO - 'SHLVL': '1', 06:42:02 INFO - 'TERM': 'linux', 06:42:02 INFO - 'TMOUT': '86400', 06:42:02 INFO - 'USER': 'cltbld', 06:42:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031', 06:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:02 INFO - '_': '/tools/buildbot/bin/python'} 06:42:02 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/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 06:42:02 INFO - mozversion application_buildid: 20160627033728 06:42:02 INFO - mozversion application_changeset: e2f8b2e421f954c7f3b74f9f7bd7a982aed94d05 06:42:02 INFO - mozversion application_display_name: Firefox 06:42:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:42:02 INFO - mozversion application_name: Firefox 06:42:02 INFO - mozversion application_remotingname: firefox 06:42:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:42:02 INFO - mozversion application_vendor: Mozilla 06:42:02 INFO - mozversion application_version: 48.0 06:42:02 INFO - mozversion platform_buildid: 20160627033728 06:42:02 INFO - mozversion platform_changeset: e2f8b2e421f954c7f3b74f9f7bd7a982aed94d05 06:42:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:42:02 INFO - mozversion platform_version: 48.0 06:42:02 INFO - using testdate: 1467034922 06:42:02 INFO - actual date: 1467034922 06:42:02 INFO - starting webserver on 'localhost:52165' 06:42:02 INFO - SUITE-START | Running 2 tests 06:42:02 INFO - TEST-START | dromaeo_css 06:42:02 INFO - operating with platform_type : linux_ 06:42:02 INFO - Initialising browser for dromaeo_css test... 06:42:02 INFO - TEST-INFO | started process 29697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMRp4yA/profile http://localhost:52165/getInfo.html) 06:42:06 INFO - PROCESS | 29697 | __metrics Screen width/height:1600/1200 06:42:06 INFO - PROCESS | 29697 | colorDepth:24 06:42:06 INFO - PROCESS | 29697 | Browser inner width/height: 1024/697 06:42:06 INFO - PROCESS | 29697 | __metrics 06:42:07 ERROR - PROCESS | 29697 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:42:08 INFO - TEST-INFO | 29697: exit 0 06:42:08 INFO - Browser initialized. 06:42:08 INFO - Running cycle 1/1 for dromaeo_css test... 06:42:08 INFO - TEST-INFO | started process 29787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMRp4yA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:19 INFO - PROCESS | 29787 | RSS: Main: 139542528 06:42:19 INFO - PROCESS | 29787 | 06:43:10 INFO - PROCESS | 29787 | 1467034990900 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] 06:45:18 INFO - PROCESS | 29787 | Cycle 1(1): loaded http://localhost:52165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52165/tests/dromaeo/cssquery-ext.html) 06:45:19 INFO - PROCESS | 29787 | RSS: Main: 247697408 06:45:19 INFO - PROCESS | 29787 | 06:48:21 INFO - PROCESS | 29787 | Cycle 1(1): loaded http://localhost:52165/tests/dromaeo/cssquery-ext.html (next: http://localhost:52165/tests/dromaeo/cssquery-jquery.html) 06:48:22 INFO - PROCESS | 29787 | RSS: Main: 221769728 06:48:22 INFO - PROCESS | 29787 | 06:51:24 INFO - PROCESS | 29787 | Cycle 1(1): loaded http://localhost:52165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52165/tests/dromaeo/cssquery-mootools.html) 06:51:24 INFO - PROCESS | 29787 | RSS: Main: 222908416 06:51:24 INFO - PROCESS | 29787 | 06:54:26 INFO - PROCESS | 29787 | Cycle 1(1): loaded http://localhost:52165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52165/tests/dromaeo/cssquery-prototype.html) 06:54:26 INFO - PROCESS | 29787 | RSS: Main: 217518080 06:54:26 INFO - PROCESS | 29787 | 06:57:29 INFO - PROCESS | 29787 | Cycle 1(1): loaded http://localhost:52165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52165/tests/dromaeo/cssquery-yui.html) 06:57:30 INFO - PROCESS | 29787 | RSS: Main: 213966848 06:57:30 INFO - PROCESS | 29787 | 07:00:32 INFO - PROCESS | 29787 | Cycle 1(1): loaded http://localhost:52165/tests/dromaeo/cssquery-yui.html (next: http://localhost:52165/tests/dromaeo/cssquery-dojo.html) 07:00:32 INFO - PROCESS | 29787 | RSS: Main: 244486144 07:00:32 INFO - PROCESS | 29787 | 07:00:32 INFO - PROCESS | 29787 | __start_tp_report 07:00:32 INFO - PROCESS | 29787 | _x_x_mozilla_page_load 07:00:32 INFO - PROCESS | 29787 | _x_x_mozilla_page_load_details 07:00:32 INFO - PROCESS | 29787 | |i|pagename|runs| 07:00:32 INFO - PROCESS | 29787 | |0;dojo.html;3258.299465614892;3353.3628610564006;3369.0903456066853;3389.2374215801465;3411.3518431498014;5483.588730845183;5519.089350257203;5526.557875369971;5535.335759708835;5539.501444869961;5466.480684334992;5508.7521061552225;5518.558515318775;5521.171824226368;5542.528885044766;4850.054239423313;4862.756862156895;4940.802367905279;5059.949400505985;5106.4382917879;4858.441279252878;4929.408470983487;4936;4939.53074457926;4948.233023881304;4873.731944743037;4920.630952678545;4942.579880710144;4947.703137811724;4970.950290497103;5031.899362012739;5052.115879721053;5062.544371006608;5063.594912406998;5079.923801142986;4811.49479304675;4930.235813448921;4974.751262436864;4978.77595508203;5015.4733752956145;5267.578593712532;5286.973565132188;5287.656302340336;5299.761510731988;5312.707801070939;5849.502792262663;5881.2942446906645;5891.23413956183;5893.469587737081;5896.262967129109;5779.971100144472;5850.6489610623075;5876.706164691748;5898.646081235097;5914;5501.614886957915;5508;5524.558035357162;5547.417521160261;5548.944510554924;5784.652920824764;6052.12244224585;6054.122152287893;6061.151438798572;6064.06007068905;5724.599278050579;5772.538196944234;5786;5791.333996590446;5800.8259752207505;5859.062549991981;5873.794417195378;5874.353821079678;5879.52963762898;5883.764649413975;5606.915896261559;5754.856128596735;5809.68046757424;5821.912671309934;5827.446392592697;5856.795012174553;5859.589828711949;5861.238039054895;5880.235569375954;5906.114082887515;4509.368688383629;4521.773911304422;4521.932171017437;4521.932171017437;4554.7039442436135;3958.960410395859;3964.32606456903;4040.8585699500377;4052.756834589934;4092.304308267542;5622.465865742748;5645.266115404971;5648.378678345379;5650.152477128464;5660.943390566042;5901.793437229677;5906.202662640574;5909.054551271776;5910;5913.881722365614;5339.786408543692;5530.668159910419;5593.804216852391;5612.915806262909;5618.719064046782;5065.822696205689;5100.1074811907765;5101.846944591668;5104.668196567285;5107.897842043139;6177.96911015442;6179.660118693515;6191.938080619136;6193.597416167935;6194.0708893665405;5676.744546495335;5807.7967271147;5893.2044174035955;5895.823125306248;5905.35041145465;6121;6127.3566275540425;6128.479079278133;6131.172291740736;6135.570510064431;5757.827265182052;5758.1362795581;5760.8271751847515;5764.337101233412;5765;5689.2319536862;5873.73568189424;5925.9407405925385;5936.406359364029;5948.613340132878;5671.262735844479;5693.743781529758;5702.087665973424;5710.65736055838;5727.140928860705;5484.232207491034;5663.122216056518;5702.6863522506665;5715.628484148517;5732.971335143297;5569.081101618188;5643.604947653625;5649.237352957298;5651;5678.716064196691;5755.3381361144;5763.625364351304;5776.797812076726;5777.335606405317;5782.739776709974;5452.127659574449;5627.634203776742;5639.718014099197;5643.32280126371;5666.603337766482 07:00:32 INFO - PROCESS | 29787 | |1;ext.html;613.6992873491987;653.4119292636627;669.9129113215281;673.2594146438918;773.3001633521665;31989;41134.38298425522;41572;41577.79211103944;41578.16843663133;42338.57661423385;42611.36082958758;42651.57348426515;42686;42745.35881961773;7841.333486653642;8866.246369058637;9150.49672268025;9152.4966126863;10226.488675566228;10621.097206737399;10797.892021079768;10800.243982921198;10802.72993175169;10805.945970270177;10798.298110622824;10865.891341086606;10883.782324353508;10890.509927053301;10894.782104357948;10739.946300268488;10756.139508839353;10793.190510711727;10801.621943231949;10822.67531974042;10621.681349559525;10697.732556686067;10720.410377429238;10721.463926803706;10746.194035447295;42775.572244277784;43036.354454683205;43051.784741076095;43060;43316.56683433157;3754.7559408638626;3813.3707938190164;3904.39481880309;3950;4108.794560272005;33583.49624755631;33900;34169;34211;34550.48174277363;4533.297338912474;4557.840475583372;4568.794404251817;4602.401687780601;4732.1482133216;311189;311552;312223;312547;312842;62453.687731561055;62520.687396562724;62960.37039629637;63058.684706576176;63067.6846615764;67064.32935670679;68299.65850170718;68453.3154668447;68454.65772671204;68531.3146868535;17292.827071729374;17674.91162544179;17691.557711057325;17695.55761105957;17697.203625836868;12152.635420937386;13216.074874758675;13331.466741330432;13337.599872003855;13353.732925341634;19536.979676665283;20336;20433.795662043485;20489.2828750993;20525.79474205239;7484.43866709988;7486.513376630502;7594.696212151563;7659.119201291811;7664.386849052063;1025.2720568396373;1166.830809532613;1183.6153250193722;1201.7656556971306;1211.8364020857248;30597.69402305993;30872.84563577168;31042.534361984588;31413.214669633442;31753.682463175533;1175.3535555444641;1220.6206986105644;1279.366713476835;1334.1328136711022;1347.0637906654977;16640.417585384454;16759.2458339375;16776.664466710597;16786.664266714597;16937.645875351292;447830;452719;452739;453907;454402;60364;61576.69211653913;61656.69171654113;61663.6916815422;61724;1397.4200706706604;1404.192589261179;1407.5917983784793;1486.695227478386;1588.9989306736682;29455.11634650964;35122.64877351296;36026.378812954004;36286.45570316395;36928.26143477062;56201;57087.42912570821;57213.42786572081;57300;57305.71347143404;405830;406554;408074;408427;408856;30227.244318892204;45577;45923;46413.3038004437;47037.76481117572;44949;45103.7744811287;45354.54645453503;45992.080158397315;46284;37977.62022379741;38647.22705545817;38863.611363886;38925.41611875881;39220.80389598034;36955.6304436963;37175.62824371722;37737.43393849149;38200.426993595676;38458.42312365261;41267.38098928458;41964.3705344414;42033.78983105065;42366;42513.149737005704;36138.4579231317;36497.27005459929;37226.627733722315;37378.8131059343;37577.4363384544;28347.133026377258;28929.56605650959;30542;30849.537256940715;31142.37715245637 07:00:32 INFO - PROCESS | 29787 | |2;jquery.html;424.8130822438127;438.97327923964247;440.8085461260474;444.4599811229357;459.10245470105923;18845.434636960897;18932.99999999998;19415.611687766253;20913.686294705592;20946;19640.508987275327;19713.605727885435;19935.202591896308;19942.102605382755;19951.201951921943;5481.862953426156;5972.0444728843395;5976.193213916109;5977.432143946318;5982.581219314649;4300.462442194726;5748.655080695172;5875.559333050017;6268.341824108471;6573.605583664971;6537.836554086139;6547.836304092388;6560.2455717592375;6564;6569.7700580479695;6433.131527243809;6504.902426463606;6633.86732265352;6643.734250629969;6645.966770166118;3942.8028598570245;5573.303337082864;5816.040353341694;5902.704864756745;5937.317208521033;23303.18438854632;23521.882390588107;23576.76423235763;23648.172313968927;23795.40511487227;2531.556977528925;2570.4088059746177;2675.4247836715003;3034.544818277276;3190.489521676544;14257.429702811874;15003;15243.847561524353;15474.303656335493;15589.688206235925;2138.454694053022;2166.523364859728;2219.323106452531;2262.728472583284;2323.035940084863;89643.10356896413;95214;96687;98808.50595746975;99649.5017524915;18141;18470.261189552268;18577.814221857607;18633.13668633153;18902.81097189038;33244.1688957778;33283.83358083194;33577.496337554956;33773.66226337754;33787.66212337894;9799.11807937289;10310.484475776182;10329.12202462799;10343.327683700536;10370.896291037145;8436.156384361515;8463.66145354179;8483.533405662625;8603.870941935877;8632.827343453097;9456.90543094574;9465.195458386115;9575.329726919048;9716.659916902874;9764.218862490983;3012;3635.5273814404486;3671.430928206132;3775.9433608495897;3802.8098595070137;1004.2719028704277;1046.7133201746522;1088.7441451259106;1111.916606254518;1120.445379537118;18406.723899141525;18811.623767524572;18870.81129188718;19163.75435596682;19319.90340048319;1093.2565855218527;1096.5394534295615;1099.8075336816025;1173.049829637996;1180.7697498987786;10674.946625266824;10795.244332896622;10894.945525272324;10942.56229750817;11003.284786488852;472854;495074;508242;509533;512711;88658.55670721734;95236.19055237851;95458.52270738741;96002.51998740101;96038;1043.4782608695652;1051.2693677893944;1061.8778840433295;1112.6161474291357;1166.690826930881;16557.503274901774;16652.750208746635;16782.66434671324;16920.830791691926;16966.23651935641;36984;37094.44358334681;37715;37953.81023094867;38711.2257754849;51851.48148518467;54666.72666636641;59502.10746838714;60891.086633701416;61167.08249376352;8932.86600701003;8953.641854325753;9084.40951338161;9204.355695101278;9218.032106628707;11790.94104529472;13121.606351809462;13140.540081097115;13164.934175329063;13425.798613021008;11617.361045142261;11774.411279436164;11902;11974.281543107441;12069.456874440495;11247.831282530933;11359.602413915803;11369.31784092957;11514.481848316678;11627.825582616098;11669.335568226561;12001.63995080149;12005.39973001329;12177.33024683651;12425.62723118308;8772.824543508967;8940.955295223483;8957.485841908025;8980.955095224743;8999.730008099768;8966.237869781142;11251.15616328795;11601.651950441501;11876.940615296868;11881.5841445549 07:00:32 INFO - PROCESS | 29787 | |3;mootools.html;1385.224274406333;1539.23807715181;1567.8588926996572;1799.4075243409586;1917.8945158016313;7477.551346919182;8053.355731541477;8183.304419124382;8207.384446166547;8208.09710931797;8009.39929505288;8260.421770476069;8268.751937441872;8273.710420135296;8286.502809831414;2330.790228879405;2370.502194539149;2371.1463873005705;2372.2764556810166;2372.92881213563;2362.9763702363016;2378.8334816562847;2424.769646883552;2427.5023620157826;2452.1294940296207;2394.0782798622567;2424.018272599591;2429.331933718233;2445.6209287560455;2455.815813813962;2366.0299277296313;2367.768760244663;2371.2886134159858;2373.620220764678;2425.199684104259;2281.9201327953606;2335.7547457516885;2339.251439539348;2341.9297421077395;2342.2504798464497;7135.357817796424;7894.80262993424;8426.031006434216;8492.490450572985;8500.362472814564;5199.376074871002;5334.706591137486;5335.493128152819;5339.813106541291;5342.118550439173;3452.9482057769155;3473.3053389321985;3474.4614584739406;3513.2622149348667;3576.195356044895;1203.4825025239143;1228.7173949991463;1234.0991076514194;1243.819646151303;1269.041873385588;11269.66191014271;11634.476448559835;11639.06887449002;11678.708032299175;11686.76626467466;4613.169629466728;4702.741349225826;4704.600108990774;4749.572538471554;4754.358161648202;10060.849087263698;10064.094231519199;10121.544530496145;10121.645742399129;10151.086402223687;5167.6641018333685;5206.687598744087;5210.114280572312;5211.400688920823;5211.452797456288;4727.834525791581;4775.6657034007285;4793.1372352976105;4796.37647105874;4799.736014519235;3827.158025234444;4056.6957478189256;4061.6547593454297;4089.6932730045364;4091.2635725569685;1330.155351351879;1331.1148086522549;1335.6660834791303;1336.9197848129143;1342.838859336886;1045.911097556701;1047.6856942917095;1048.5124417146064;1048.7430579507916;1050.5377633841085;5865.973454645506;5931.555133364928;5979.611325263844;6036.8793763905915;6184.690765461709;477.32696897374535;480.24601375840297;481.814501416957;484.66800241834454;499.62528103922057;4166.854160104382;4180.874573762792;4198.097409057067;4210.115875666083;4232.619064284229;10008.349457285252;10151.7462063449;10424.218183636258;10440.216983726252;10449.477526123663;10266.281360304856;10276.743081423025;10278.33190842593;10280.897191028143;10294.17646588271;7872.17342179063;8039.517628942165;8144.226298501751;8147.063087744985;8148.470349427268;5726.942730572641;5810.273715785527;5909.113632955091;5938.732757025858;5990.31111422192;8970.192682658591;9091.863622045543;9100.544972751468;9278.304127190353;9284.210842078499;9125.22435592982;9253.444793312423;9348.065193480597;9382.906170938477;9387.483688397204;7031.6835742390695;7201.603911784902;7245.5652660840515;7253.455990800817;7256.528325658815;7983.281504664608;7996.920030799618;8144.348452123934;8144.796380090308;8202.38482113832;7168.390686791681;7412.96293518529;7434.131409205109;7588;7610.657520411705;7616.466847320635;7621.12357078943;7625.237476252552;7723.884141737766;7733.188015258317;6972.337627925339;7010.334018268256;7051;7061.399781018466;7066.258042905421;4888.608911287018;5092.185250359925;5095.898082038412;5096.413912400121;5096.668716533413;4907.60739140875;4927.630427717864;4930.9506904930495;4947.084789313988;5036.496350364934 07:00:32 INFO - PROCESS | 29787 | |4;prototype.html;371.9497867787848;372.515729551583;375.62249938811493;378.5230609432118;384.8729919126687;6103.786367477139;6105.5420843436805;6120.296165940918;6152.200213972183;6203.379662033794;6000.249968753906;6111.266648002234;6150.446459818615;6162.291336496293;6172.722227499762;4690.226112691402;4763.095011947719;4770.236762118062;4788.592969597588;4792.880177995543;4779.091972525209;4789.497102804207;4796.83211087612;4830.758462076899;4831.420229572456;4572.268437050073;4775.90448191036;4783.71297722136;4796.08874313881;4807.326974223612;4673.065386922629;4711.92932106017;4725.078609671098;4786.760661966888;4814.494478079821;4184.518780340239;4252.723572967747;4257.680673949435;4258.850110470186;4261.382099595541;6025.397460253984;6026.246719160105;6038.818835434944;6041.818745437644;6052.425019623129;5608.074667679828;5611.551075913917;5617.691026993513;5619.578531610146;5622.240997465331;6441.710123044474;6578.80263592093;6582.670866456658;6593.868122637568;6595.703193356262;4715.64632652549;4721;4728.527147285278;4730.266808644631;4731.33761273422;6875.690593923286;6884.896726549106;6918.5502942308585;6919;6933.0986971693865;4838.201696720002;4840.370751802243;4844.103840789465;4845;4848.75756212195;4908.730019848943;4915.705057696478;4915.729634870117;4916.262560615936;4919.237518184687;5582.413846546136;5592.664440133523;5595.21666966625;5595.664260144323;5603.131514615241;6461.8061458156335;6643.833904152435;6645.800625981228;6656.36764507371;6670.299618540081;1683.1163639089332;1712.289399899028;1715.519654496743;1717.0212978602076;1718.1666891557584;1146.541383446628;1161.814109742437;1171.9355435450962;1176.2589568571746;1183.219075410225;6266.686665666698;6327.367263273636;6338.461230795434;6381;6526.477881769447;6913.51605387618;6913.930860691429;6918.515703900779;6934.271901450376;6940.861182776316;6536.150300460909;6543.901841472381;6544.280129185786;6545.574537655038;6548.410643042149;3676.9080772980888;3714.4428335749853;3714.461403096536;3721.962780372216;3722.4230244312175;7030.3321184487395;7267.890981635174;7293.38006269473;7324.230955749569;7333.74331898381;7032.12098487689;7048.788536343918;7063.929360706327;7066.116735408074;7070.080889484437;7294.197638259893;7299.379552737971;7300.671469783872;7304.780856574312;7316.56100633953;6918.8616227676175;6919.37725604698;6921.7231310747;7002.159740831133;7008.194057683228;6671.8665626686225;6737.326267373223;6791.524593278621;6791.830204244933;6813.625250611264;7249.05762250904;7280.963595182202;7290.198078211286;7293.088363954505;7294.161171465349;4724.787384567771;4760.976195119002;4765.404324459442;4766.976165119152;4772.687510934521;6869.175698916162;6901.413379862768;6903.309669033258;6903.792886213421;6908.412784913137;6452.387023232785;6686.063951046955;6700.564463309869;6703;6708.060871477899;6651.301613330531;6690.732370705117;6700.028495867974;6702.262751097278;6705.430038446787;6579.17760279965;6579.2104947406615;6582.80251592453;6583.177102862142;6596.736130554724;6729.1252137221845;6730;6780.321967803377;6825.35159159879;6827.931720682928;6436.710348034256;6566.737330506726;6583.144191255297;6584.572002819801;6593.3736295051895 07:00:32 INFO - PROCESS | 29787 | |5;yui.html;877.0746862060525;879.9999999999999;895.2435192262536;902.2691619787977;924.8381533231683;14362.928185359071;14370.497032603835;14617.415303387852;14643.487477938274;14650.120992740443;14223.502177423792;14315.92842035791;14338.283085845693;14359.066660667075;14366;773.3619763694946;890.2655309369795;904.2088172848773;913.5249670171506;920.1994264989435;918.1002617434917;919.3380765848578;919.3702313914956;919.384012711485;921.6681994481982;958.9760255993586;963.388248462228;964.4840010594334;964.5177411294353;964.744342749172;793.8293266947605;948.2035090523958;948.9383190092622;951.2580187453797;951.4148798488949;696.6377483708494;697.6616341074575;697.7801992372387;702.115334678304;708.1714394158795;14158.221297828615;14342.64143396413;14358.066725662798;14374.928125359307;14375.78436323456;14944;15169.469068582657;15176.620584485367;15192.088474691443;15232.619184520365;12060.698482537919;12072.698182545419;12186.329751863645;12231;12346.691332716664;4528.75091869947;4577.793999270008;4616.584507394351;4646.117237724821;4699.107169637758;52951.735241323935;53018.46981530174;53073.734631326595;53337;53367.733161334334;11056.447177641086;11300.830487542693;11348.829767553494;11516.1362897783;11857.288562686266;20249.79750202479;20262.189512419634;20282.188712451338;20367.592648146954;20381;8668.956655216683;8670.696525621574;8752.51861147643;8779.385443018928;8941.284697224206;5162.716050617252;5271.868203294872;5280.313559237275;5299.284596579412;5393.649412788156;3677.2093999790172;3732.309522738302;3732.9440058399146;3735.8879233623034;3738.962610373916;636.2301615045753;636.2460484326089;659.1826135591832;667.3426674725391;668.2048362448768;802.8314054048599;827.5696637748457;840.8822764812932;856.9400141990001;870.2385412763832;10029.64896228643;10109;10128.392296462089;10130.189584833195;10158.13655839262;753.6118898767139;787.830616417473;810.6919370639238;815.1888870573817;841.3017195727532;4534.387857639243;4633.258678611406;4717.787699553528;4728;4799.232122860326;66674;67477.32522674711;67744.6612766933;68149.3185068153;68464.6576767113;55989.72005139948;56530.43469565334;57094.7145264271;57143.42856571381;58826.705866470395;52330;52527.212091818656;52768.208476872875;52912.91112039595;53425.46574534283;9299.67451139207;9352.438853668802;9376.390534615228;9440.433573985583;9455.19630831387;39213;39530.40704389494;40530;40533.1893362137;40912.59087409207;46623.76688116538;49873;51115;51578.48421515887;51638.483615163364;11417.657470275904;11747.353895535485;12024.218425802295;12055.15613907018;12476.625701228977;12720.300383478998;12736.872631273569;12782.23306601607;12874.67813304675;13019.567847536575;11791.882081179421;11867.525298987945;11946;11949;12081.637550873487;12185.086118541321;12401.317927514074;12589.118761686594;12617.186917791194;12771.552995645108;11948.342841143472;11957.521699132285;12035.75928481408;12185.939070304947;12320.691982700504;10198.898011019795;10351.689449316533;10426.68719938403;10508.789824203626;10572.735681608021;10459.581616735246;10589.647441620256;10634.468276586294;10656.57373705043;10693.358398496115 07:00:32 INFO - PROCESS | 29787 | __end_tp_report 07:00:32 INFO - PROCESS | 29787 | __start_cc_report 07:00:32 INFO - PROCESS | 29787 | _x_x_mozilla_cycle_collect,834 07:00:32 INFO - PROCESS | 29787 | __end_cc_report 07:00:32 INFO - PROCESS | 29787 | __startTimestamp1467036032533__endTimestamp 07:00:32 INFO - PROCESS | 29787 | 07:00:32 INFO - PROCESS | 29787 | ------- Summary: start ------- 07:00:32 INFO - PROCESS | 29787 | Number of tests: 6 07:00:32 INFO - PROCESS | 29787 | 07:00:32 INFO - PROCESS | 29787 | [#0] dojo.html Cycles:165 Average:5453.32 Median:5650.15 stddev:602.68 (10.7%) stddev-sans-first:579.40 07:00:32 INFO - PROCESS | 29787 | Values: 3258.3 3353.4 3369.1 3389.2 3411.4 5483.6 5519.1 5526.6 5535.3 5539.5 5466.5 5508.8 5518.6 5521.2 5542.5 4850.1 4862.8 4940.8 5059.9 5106.4 4858.4 4929.4 4936.0 4939.5 4948.2 4873.7 4920.6 4942.6 4947.7 4971.0 5031.9 5052.1 5062.5 5063.6 5079.9 4811.5 4930.2 4974.8 4978.8 5015.5 5267.6 5287.0 5287.7 5299.8 5312.7 5849.5 5881.3 5891.2 5893.5 5896.3 5780.0 5850.6 5876.7 5898.6 5914.0 5501.6 5508.0 5524.6 5547.4 5548.9 5784.7 6052.1 6054.1 6061.2 6064.1 5724.6 5772.5 5786.0 5791.3 5800.8 5859.1 5873.8 5874.4 5879.5 5883.8 5606.9 5754.9 5809.7 5821.9 5827.4 5856.8 5859.6 5861.2 5880.2 5906.1 4509.4 4521.8 4521.9 4521.9 4554.7 3959.0 3964.3 4040.9 4052.8 4092.3 5622.5 5645.3 5648.4 5650.2 5660.9 5901.8 5906.2 5909.1 5910.0 5913.9 5339.8 5530.7 5593.8 5612.9 5618.7 5065.8 5100.1 5101.8 5104.7 5107.9 6178.0 6179.7 6191.9 6193.6 6194.1 5676.7 5807.8 5893.2 5895.8 5905.4 6121.0 6127.4 6128.5 6131.2 6135.6 5757.8 5758.1 5760.8 5764.3 5765.0 5689.2 5873.7 5925.9 5936.4 5948.6 5671.3 5693.7 5702.1 5710.7 5727.1 5484.2 5663.1 5702.7 5715.6 5733.0 5569.1 5643.6 5649.2 5651.0 5678.7 5755.3 5763.6 5776.8 5777.3 5782.7 5452.1 5627.6 5639.7 5643.3 5666.6 07:00:32 INFO - PROCESS | 29787 | 07:00:32 INFO - PROCESS | 29787 | [#1] ext.html Cycles:180 Average:57251.10 Median:37657.44 stddev:103976.48 (276.1%) stddev-sans-first:104181.21 07:00:32 INFO - PROCESS | 29787 | Values: 613.7 653.4 669.9 673.3 773.3 31989.0 41134.4 41572.0 41577.8 41578.2 42338.6 42611.4 42651.6 42686.0 42745.4 7841.3 8866.2 9150.5 9152.5 10226.5 10621.1 10797.9 10800.2 10802.7 10805.9 10798.3 10865.9 10883.8 10890.5 10894.8 10739.9 10756.1 10793.2 10801.6 10822.7 10621.7 10697.7 10720.4 10721.5 10746.2 42775.6 43036.4 43051.8 43060.0 43316.6 3754.8 3813.4 3904.4 3950.0 4108.8 33583.5 33900.0 34169.0 34211.0 34550.5 4533.3 4557.8 4568.8 4602.4 4732.1 311189.0 311552.0 312223.0 312547.0 312842.0 62453.7 62520.7 62960.4 63058.7 63067.7 67064.3 68299.7 68453.3 68454.7 68531.3 17292.8 17674.9 17691.6 17695.6 17697.2 12152.6 13216.1 13331.5 13337.6 13353.7 19537.0 20336.0 20433.8 20489.3 20525.8 7484.4 7486.5 7594.7 7659.1 7664.4 1025.3 1166.8 1183.6 1201.8 1211.8 30597.7 30872.8 31042.5 31413.2 31753.7 1175.4 1220.6 1279.4 1334.1 1347.1 16640.4 16759.2 16776.7 16786.7 16937.6 447830.0 452719.0 452739.0 453907.0 454402.0 60364.0 61576.7 61656.7 61663.7 61724.0 1397.4 1404.2 1407.6 1486.7 1589.0 29455.1 35122.6 36026.4 36286.5 36928.3 56201.0 57087.4 57213.4 57300.0 57305.7 405830.0 406554.0 408074.0 408427.0 408856.0 30227.2 45577.0 45923.0 46413.3 47037.8 44949.0 45103.8 45354.5 45992.1 46284.0 37977.6 38647.2 38863.6 38925.4 39220.8 36955.6 37175.6 37737.4 38200.4 38458.4 41267.4 41964.4 42033.8 42366.0 42513.1 36138.5 36497.3 37226.6 37378.8 37577.4 28347.1 28929.6 30542.0 30849.5 31142.4 07:00:32 INFO - PROCESS | 29787 | 07:00:32 INFO - PROCESS | 29787 | [#2] jquery.html Cycles:180 Average:30847.48 Median:2843.71 stddev:82501.72 (2901.2%) stddev-sans-first:82701.53 07:00:32 INFO - PROCESS | 29787 | Values: 424.8 439.0 440.8 444.5 459.1 18845.4 18933.0 19415.6 20913.7 20946.0 19640.5 19713.6 19935.2 19942.1 19951.2 5481.9 5972.0 5976.2 5977.4 5982.6 4300.5 5748.7 5875.6 6268.3 6573.6 6537.8 6547.8 6560.2 6564.0 6569.8 6433.1 6504.9 6633.9 6643.7 6646.0 3942.8 5573.3 5816.0 5902.7 5937.3 23303.2 23521.9 23576.8 23648.2 23795.4 2531.6 2570.4 2675.4 3034.5 3190.5 14257.4 15003.0 15243.8 15474.3 15589.7 2138.5 2166.5 2219.3 2262.7 2323.0 89643.1 95214.0 96687.0 98808.5 99649.5 18141.0 18470.3 18577.8 18633.1 18902.8 33244.2 33283.8 33577.5 33773.7 33787.7 9799.1 10310.5 10329.1 10343.3 10370.9 8436.2 8463.7 8483.5 8603.9 8632.8 9456.9 9465.2 9575.3 9716.7 9764.2 3012.0 3635.5 3671.4 3775.9 3802.8 1004.3 1046.7 1088.7 1111.9 1120.4 18406.7 18811.6 18870.8 19163.8 19319.9 1093.3 1096.5 1099.8 1173.0 1180.8 10674.9 10795.2 10894.9 10942.6 11003.3 472854.0 495074.0 508242.0 509533.0 512711.0 88658.6 95236.2 95458.5 96002.5 96038.0 1043.5 1051.3 1061.9 1112.6 1166.7 16557.5 16652.8 16782.7 16920.8 16966.2 36984.0 37094.4 37715.0 37953.8 38711.2 51851.5 54666.7 59502.1 60891.1 61167.1 8932.9 8953.6 9084.4 9204.4 9218.0 11790.9 13121.6 13140.5 13164.9 13425.8 11617.4 11774.4 11902.0 11974.3 12069.5 11247.8 11359.6 11369.3 11514.5 11627.8 11669.3 12001.6 12005.4 12177.3 12425.6 8772.8 8941.0 8957.5 8981.0 8999.7 8966.2 11251.2 11601.7 11876.9 11881.6 07:00:32 INFO - PROCESS | 29787 | 07:00:32 INFO - PROCESS | 29787 | [#3] mootools.html Cycles:180 Average:5605.38 Median:2639.99 stddev:3052.06 (115.6%) stddev-sans-first:3044.14 07:00:32 INFO - PROCESS | 29787 | Values: 1385.2 1539.2 1567.9 1799.4 1917.9 7477.6 8053.4 8183.3 8207.4 8208.1 8009.4 8260.4 8268.8 8273.7 8286.5 2330.8 2370.5 2371.1 2372.3 2372.9 2363.0 2378.8 2424.8 2427.5 2452.1 2394.1 2424.0 2429.3 2445.6 2455.8 2366.0 2367.8 2371.3 2373.6 2425.2 2281.9 2335.8 2339.3 2341.9 2342.3 7135.4 7894.8 8426.0 8492.5 8500.4 5199.4 5334.7 5335.5 5339.8 5342.1 3452.9 3473.3 3474.5 3513.3 3576.2 1203.5 1228.7 1234.1 1243.8 1269.0 11269.7 11634.5 11639.1 11678.7 11686.8 4613.2 4702.7 4704.6 4749.6 4754.4 10060.8 10064.1 10121.5 10121.6 10151.1 5167.7 5206.7 5210.1 5211.4 5211.5 4727.8 4775.7 4793.1 4796.4 4799.7 3827.2 4056.7 4061.7 4089.7 4091.3 1330.2 1331.1 1335.7 1336.9 1342.8 1045.9 1047.7 1048.5 1048.7 1050.5 5866.0 5931.6 5979.6 6036.9 6184.7 477.3 480.2 481.8 484.7 499.6 4166.9 4180.9 4198.1 4210.1 4232.6 10008.3 10151.7 10424.2 10440.2 10449.5 10266.3 10276.7 10278.3 10280.9 10294.2 7872.2 8039.5 8144.2 8147.1 8148.5 5726.9 5810.3 5909.1 5938.7 5990.3 8970.2 9091.9 9100.5 9278.3 9284.2 9125.2 9253.4 9348.1 9382.9 9387.5 7031.7 7201.6 7245.6 7253.5 7256.5 7983.3 7996.9 8144.3 8144.8 8202.4 7168.4 7413.0 7434.1 7588.0 7610.7 7616.5 7621.1 7625.2 7723.9 7733.2 6972.3 7010.3 7051.0 7061.4 7066.3 4888.6 5092.2 5095.9 5096.4 5096.7 4907.6 4927.6 4931.0 4947.1 5036.5 07:00:32 INFO - PROCESS | 29787 | 07:00:32 INFO - PROCESS | 29787 | [#4] prototype.html Cycles:180 Average:5602.30 Median:6297.03 stddev:1683.75 (26.7%) stddev-sans-first:1642.07 07:00:32 INFO - PROCESS | 29787 | Values: 371.9 372.5 375.6 378.5 384.9 6103.8 6105.5 6120.3 6152.2 6203.4 6000.2 6111.3 6150.4 6162.3 6172.7 4690.2 4763.1 4770.2 4788.6 4792.9 4779.1 4789.5 4796.8 4830.8 4831.4 4572.3 4775.9 4783.7 4796.1 4807.3 4673.1 4711.9 4725.1 4786.8 4814.5 4184.5 4252.7 4257.7 4258.9 4261.4 6025.4 6026.2 6038.8 6041.8 6052.4 5608.1 5611.6 5617.7 5619.6 5622.2 6441.7 6578.8 6582.7 6593.9 6595.7 4715.6 4721.0 4728.5 4730.3 4731.3 6875.7 6884.9 6918.6 6919.0 6933.1 4838.2 4840.4 4844.1 4845.0 4848.8 4908.7 4915.7 4915.7 4916.3 4919.2 5582.4 5592.7 5595.2 5595.7 5603.1 6461.8 6643.8 6645.8 6656.4 6670.3 1683.1 1712.3 1715.5 1717.0 1718.2 1146.5 1161.8 1171.9 1176.3 1183.2 6266.7 6327.4 6338.5 6381.0 6526.5 6913.5 6913.9 6918.5 6934.3 6940.9 6536.2 6543.9 6544.3 6545.6 6548.4 3676.9 3714.4 3714.5 3722.0 3722.4 7030.3 7267.9 7293.4 7324.2 7333.7 7032.1 7048.8 7063.9 7066.1 7070.1 7294.2 7299.4 7300.7 7304.8 7316.6 6918.9 6919.4 6921.7 7002.2 7008.2 6671.9 6737.3 6791.5 6791.8 6813.6 7249.1 7281.0 7290.2 7293.1 7294.2 4724.8 4761.0 4765.4 4767.0 4772.7 6869.2 6901.4 6903.3 6903.8 6908.4 6452.4 6686.1 6700.6 6703.0 6708.1 6651.3 6690.7 6700.0 6702.3 6705.4 6579.2 6579.2 6582.8 6583.2 6596.7 6729.1 6730.0 6780.3 6825.4 6827.9 6436.7 6566.7 6583.1 6584.6 6593.4 07:00:32 INFO - PROCESS | 29787 | 07:00:32 INFO - PROCESS | 29787 | [#5] yui.html Cycles:180 Average:15548.37 Median:25634.94 stddev:18125.93 (70.7%) stddev-sans-first:18143.29 07:00:32 INFO - PROCESS | 29787 | Values: 877.1 880.0 895.2 902.3 924.8 14362.9 14370.5 14617.4 14643.5 14650.1 14223.5 14315.9 14338.3 14359.1 14366.0 773.4 890.3 904.2 913.5 920.2 918.1 919.3 919.4 919.4 921.7 959.0 963.4 964.5 964.5 964.7 793.8 948.2 948.9 951.3 951.4 696.6 697.7 697.8 702.1 708.2 14158.2 14342.6 14358.1 14374.9 14375.8 14944.0 15169.5 15176.6 15192.1 15232.6 12060.7 12072.7 12186.3 12231.0 12346.7 4528.8 4577.8 4616.6 4646.1 4699.1 52951.7 53018.5 53073.7 53337.0 53367.7 11056.4 11300.8 11348.8 11516.1 11857.3 20249.8 20262.2 20282.2 20367.6 20381.0 8669.0 8670.7 8752.5 8779.4 8941.3 5162.7 5271.9 5280.3 5299.3 5393.6 3677.2 3732.3 3732.9 3735.9 3739.0 636.2 636.2 659.2 667.3 668.2 802.8 827.6 840.9 856.9 870.2 10029.6 10109.0 10128.4 10130.2 10158.1 753.6 787.8 810.7 815.2 841.3 4534.4 4633.3 4717.8 4728.0 4799.2 66674.0 67477.3 67744.7 68149.3 68464.7 55989.7 56530.4 57094.7 57143.4 58826.7 52330.0 52527.2 52768.2 52912.9 53425.5 9299.7 9352.4 9376.4 9440.4 9455.2 39213.0 39530.4 40530.0 40533.2 40912.6 46623.8 49873.0 51115.0 51578.5 51638.5 11417.7 11747.4 12024.2 12055.2 12476.6 12720.3 12736.9 12782.2 12874.7 13019.6 11791.9 11867.5 11946.0 11949.0 12081.6 12185.1 12401.3 12589.1 12617.2 12771.6 11948.3 11957.5 12035.8 12185.9 12320.7 10198.9 10351.7 10426.7 10508.8 10572.7 10459.6 10589.6 10634.5 10656.6 10693.4 07:00:32 INFO - PROCESS | 29787 | -------- Summary: end -------- 07:00:32 INFO - PROCESS | 29787 | 07:00:33 INFO - TEST-INFO | 29787: exit 0 07:00:33 INFO - TEST-OK | dromaeo_css | took 1110521ms 07:00:33 INFO - TEST-START | kraken 07:00:33 INFO - operating with platform_type : linux_ 07:00:33 INFO - Initialising browser for kraken test... 07:00:33 INFO - TEST-INFO | started process 29980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyWATJq/profile http://localhost:52165/getInfo.html) 07:00:36 INFO - PROCESS | 29980 | __metrics Screen width/height:1600/1200 07:00:36 INFO - PROCESS | 29980 | colorDepth:24 07:00:36 INFO - PROCESS | 29980 | Browser inner width/height: 1024/697 07:00:36 INFO - PROCESS | 29980 | __metrics 07:00:37 ERROR - PROCESS | 29980 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:00:38 INFO - TEST-INFO | 29980: exit 0 07:00:38 INFO - Browser initialized. 07:00:38 INFO - Running cycle 1/1 for kraken test... 07:00:38 INFO - TEST-INFO | started process 30072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyWATJq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:50 INFO - PROCESS | 30072 | RSS: Main: 139501568 07:00:50 INFO - PROCESS | 30072 | 07:00:52 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52165/tests/kraken/driver.html?testName=audio-beat-detection) 07:00:53 INFO - PROCESS | 30072 | RSS: Main: 197459968 07:00:53 INFO - PROCESS | 30072 | 07:00:56 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52165/tests/kraken/driver.html?testName=audio-dft) 07:00:56 INFO - PROCESS | 30072 | RSS: Main: 185200640 07:00:56 INFO - PROCESS | 30072 | 07:00:59 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52165/tests/kraken/driver.html?testName=audio-fft) 07:01:00 INFO - PROCESS | 30072 | RSS: Main: 274677760 07:01:00 INFO - PROCESS | 30072 | 07:01:02 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52165/tests/kraken/driver.html?testName=audio-oscillator) 07:01:02 INFO - PROCESS | 30072 | RSS: Main: 180920320 07:01:02 INFO - PROCESS | 30072 | 07:01:05 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:01:05 INFO - PROCESS | 30072 | RSS: Main: 178876416 07:01:05 INFO - PROCESS | 30072 | 07:01:08 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52165/tests/kraken/driver.html?testName=imaging-darkroom) 07:01:09 INFO - PROCESS | 30072 | RSS: Main: 213782528 07:01:09 INFO - PROCESS | 30072 | 07:01:12 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52165/tests/kraken/driver.html?testName=imaging-desaturate) 07:01:13 INFO - PROCESS | 30072 | RSS: Main: 214155264 07:01:13 INFO - PROCESS | 30072 | 07:01:15 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52165/tests/kraken/driver.html?testName=json-parse-financial) 07:01:16 INFO - PROCESS | 30072 | RSS: Main: 212803584 07:01:16 INFO - PROCESS | 30072 | 07:01:18 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:01:18 INFO - PROCESS | 30072 | RSS: Main: 196149248 07:01:18 INFO - PROCESS | 30072 | 07:01:20 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52165/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:01:20 INFO - PROCESS | 30072 | RSS: Main: 198602752 07:01:20 INFO - PROCESS | 30072 | 07:01:22 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:01:23 INFO - PROCESS | 30072 | RSS: Main: 208510976 07:01:23 INFO - PROCESS | 30072 | 07:01:25 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:01:26 INFO - PROCESS | 30072 | RSS: Main: 216084480 07:01:26 INFO - PROCESS | 30072 | 07:01:29 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:01:29 INFO - PROCESS | 30072 | RSS: Main: 210751488 07:01:29 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | Cycle 1(1): loaded http://localhost:52165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52165/tests/kraken/driver.html?testName=ai-astar) 07:01:31 INFO - PROCESS | 30072 | RSS: Main: 270659584 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | __start_tp_report 07:01:31 INFO - PROCESS | 30072 | _x_x_mozilla_page_load 07:01:31 INFO - PROCESS | 30072 | _x_x_mozilla_page_load_details 07:01:31 INFO - PROCESS | 30072 | |i|pagename|runs| 07:01:31 INFO - PROCESS | 30072 | |0;ai-astar;111;111;111;112;110;112;106;109;109;111 07:01:31 INFO - PROCESS | 30072 | |1;audio-beat-detection;172;126;156;179;126;156;152;127;195;126 07:01:31 INFO - PROCESS | 30072 | |2;audio-dft;164;163;161;159;161;162;162;161;161;161 07:01:31 INFO - PROCESS | 30072 | |3;audio-fft;77;75;76;188;74;73;74;76;158;76 07:01:31 INFO - PROCESS | 30072 | |4;audio-oscillator;93;91;153;92;92;93;157;92;91;150 07:01:31 INFO - PROCESS | 30072 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;117;116 07:01:31 INFO - PROCESS | 30072 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;146;145 07:01:31 INFO - PROCESS | 30072 | |7;imaging-desaturate;95;94;95;94;94;94;95;94;95;94 07:01:31 INFO - PROCESS | 30072 | |8;json-parse-financial;56;58;56;57;58;58;58;81;56;56 07:01:31 INFO - PROCESS | 30072 | |9;json-stringify-tinderbox;58;58;58;57;58;58;57;59;58;58 07:01:31 INFO - PROCESS | 30072 | |10;stanford-crypto-aes;72;71;72;73;75;74;76;74;74;74 07:01:31 INFO - PROCESS | 30072 | |11;stanford-crypto-ccm;114;115;111;119;116;115;111;112;129;113 07:01:31 INFO - PROCESS | 30072 | |12;stanford-crypto-pbkdf2;159;159;159;160;160;163;162;160;162;158 07:01:31 INFO - PROCESS | 30072 | |13;stanford-crypto-sha256-iterative;67;65;69;67;65;68;67;66;66;65 07:01:31 INFO - PROCESS | 30072 | __end_tp_report 07:01:31 INFO - PROCESS | 30072 | __start_cc_report 07:01:31 INFO - PROCESS | 30072 | _x_x_mozilla_cycle_collect,1586 07:01:31 INFO - PROCESS | 30072 | __end_cc_report 07:01:31 INFO - PROCESS | 30072 | __startTimestamp1467036091719__endTimestamp 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | ------- Summary: start ------- 07:01:31 INFO - PROCESS | 30072 | Number of tests: 14 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.81 (1.6%) stddev-sans-first:1.90 07:01:31 INFO - PROCESS | 30072 | Values: 111.0 111.0 111.0 112.0 110.0 112.0 106.0 109.0 109.0 111.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:156.00 stddev:25.08 (16.1%) stddev-sans-first:25.48 07:01:31 INFO - PROCESS | 30072 | Values: 172.0 126.0 156.0 179.0 126.0 156.0 152.0 127.0 195.0 126.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.09 07:01:31 INFO - PROCESS | 30072 | Values: 164.0 163.0 161.0 159.0 161.0 162.0 162.0 161.0 161.0 161.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.50 stddev:41.89 (55.5%) stddev-sans-first:43.93 07:01:31 INFO - PROCESS | 30072 | Values: 77.0 75.0 76.0 188.0 74.0 73.0 74.0 76.0 158.0 76.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:92.00 stddev:29.68 (32.3%) stddev-sans-first:30.81 07:01:31 INFO - PROCESS | 30072 | Values: 93.0 91.0 153.0 92.0 92.0 93.0 157.0 92.0 91.0 150.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:01:31 INFO - PROCESS | 30072 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:01:31 INFO - PROCESS | 30072 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:01:31 INFO - PROCESS | 30072 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:58.00 stddev:7.65 (13.2%) stddev-sans-first:8.01 07:01:31 INFO - PROCESS | 30072 | Values: 56.0 58.0 56.0 57.0 58.0 58.0 58.0 81.0 56.0 56.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 07:01:31 INFO - PROCESS | 30072 | Values: 58.0 58.0 58.0 57.0 58.0 58.0 57.0 59.0 58.0 58.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:74.00 stddev:1.51 (2.0%) stddev-sans-first:1.50 07:01:31 INFO - PROCESS | 30072 | Values: 72.0 71.0 72.0 73.0 75.0 74.0 76.0 74.0 74.0 74.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:115.00 stddev:5.34 (4.6%) stddev-sans-first:5.63 07:01:31 INFO - PROCESS | 30072 | Values: 114.0 115.0 111.0 119.0 116.0 115.0 111.0 112.0 129.0 113.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.00 stddev:1.62 (1.0%) stddev-sans-first:1.66 07:01:31 INFO - PROCESS | 30072 | Values: 159.0 159.0 159.0 160.0 160.0 163.0 162.0 160.0 162.0 158.0 07:01:31 INFO - PROCESS | 30072 | 07:01:31 INFO - PROCESS | 30072 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 07:01:31 INFO - PROCESS | 30072 | Values: 67.0 65.0 69.0 67.0 65.0 68.0 67.0 66.0 66.0 65.0 07:01:31 INFO - PROCESS | 30072 | -------- Summary: end -------- 07:01:31 INFO - PROCESS | 30072 | 07:01:32 INFO - TEST-INFO | 30072: exit 0 07:01:32 INFO - TEST-OK | kraken | took 59432ms 07:01:32 INFO - SUITE-END | took 1169s 07:01:32 INFO - Completed test suite (00:19:30) 07:01:32 INFO - javascript benchmark 07:01:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3258.299465614892, 3353.3628610564006, 3369.0903456066853, 3389.2374215801465, 3411.3518431498014, 5483.588730845183, 5519.089350257203, 5526.557875369971, 5535.335759708835, 5539.501444869961, 5466.480684334992, 5508.7521061552225, 5518.558515318775, 5521.171824226368, 5542.528885044766, 4850.054239423313, 4862.756862156895, 4940.802367905279, 5059.949400505985, 5106.4382917879, 4858.441279252878, 4929.408470983487, 4936.0, 4939.53074457926, 4948.233023881304, 4873.731944743037, 4920.630952678545, 4942.579880710144, 4947.703137811724, 4970.950290497103, 5031.899362012739, 5052.115879721053, 5062.544371006608, 5063.594912406998, 5079.923801142986, 4811.49479304675, 4930.235813448921, 4974.751262436864, 4978.77595508203, 5015.4733752956145, 5267.578593712532, 5286.973565132188, 5287.656302340336, 5299.761510731988, 5312.707801070939, 5849.502792262663, 5881.2942446906645, 5891.23413956183, 5893.469587737081, 5896.262967129109, 5779.971100144472, 5850.6489610623075, 5876.706164691748, 5898.646081235097, 5914.0, 5501.614886957915, 5508.0, 5524.558035357162, 5547.417521160261, 5548.944510554924, 5784.652920824764, 6052.12244224585, 6054.122152287893, 6061.151438798572, 6064.06007068905, 5724.599278050579, 5772.538196944234, 5786.0, 5791.333996590446, 5800.8259752207505, 5859.062549991981, 5873.794417195378, 5874.353821079678, 5879.52963762898, 5883.764649413975, 5606.915896261559, 5754.856128596735, 5809.68046757424, 5821.912671309934, 5827.446392592697, 5856.795012174553, 5859.589828711949, 5861.238039054895, 5880.235569375954, 5906.114082887515, 4509.368688383629, 4521.773911304422, 4521.932171017437, 4521.932171017437, 4554.7039442436135, 3958.960410395859, 3964.32606456903, 4040.8585699500377, 4052.756834589934, 4092.304308267542, 5622.465865742748, 5645.266115404971, 5648.378678345379, 5650.152477128464, 5660.943390566042, 5901.793437229677, 5906.202662640574, 5909.054551271776, 5910.0, 5913.881722365614, 5339.786408543692, 5530.668159910419, 5593.804216852391, 5612.915806262909, 5618.719064046782, 5065.822696205689, 5100.1074811907765, 5101.846944591668, 5104.668196567285, 5107.897842043139, 6177.96911015442, 6179.660118693515, 6191.938080619136, 6193.597416167935, 6194.0708893665405, 5676.744546495335, 5807.7967271147, 5893.2044174035955, 5895.823125306248, 5905.35041145465, 6121.0, 6127.3566275540425, 6128.479079278133, 6131.172291740736, 6135.570510064431, 5757.827265182052, 5758.1362795581, 5760.8271751847515, 5764.337101233412, 5765.0, 5689.2319536862, 5873.73568189424, 5925.9407405925385, 5936.406359364029, 5948.613340132878, 5671.262735844479, 5693.743781529758, 5702.087665973424, 5710.65736055838, 5727.140928860705, 5484.232207491034, 5663.122216056518, 5702.6863522506665, 5715.628484148517, 5732.971335143297, 5569.081101618188, 5643.604947653625, 5649.237352957298, 5651.0, 5678.716064196691, 5755.3381361144, 5763.625364351304, 5776.797812076726, 5777.335606405317, 5782.739776709974, 5452.127659574449, 5627.634203776742, 5639.718014099197, 5643.32280126371, 5666.603337766482], "value": 5414.872343745396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.6992873491987, 653.4119292636627, 669.9129113215281, 673.2594146438918, 773.3001633521665, 31989.0, 41134.38298425522, 41572.0, 41577.79211103944, 41578.16843663133, 42338.57661423385, 42611.36082958758, 42651.57348426515, 42686.0, 42745.35881961773, 7841.333486653642, 8866.246369058637, 9150.49672268025, 9152.4966126863, 10226.488675566228, 10621.097206737399, 10797.892021079768, 10800.243982921198, 10802.72993175169, 10805.945970270177, 10798.298110622824, 10865.891341086606, 10883.782324353508, 10890.509927053301, 10894.782104357948, 10739.946300268488, 10756.139508839353, 10793.190510711727, 10801.621943231949, 10822.67531974042, 10621.681349559525, 10697.732556686067, 10720.410377429238, 10721.463926803706, 10746.194035447295, 42775.572244277784, 43036.354454683205, 43051.784741076095, 43060.0, 43316.56683433157, 3754.7559408638626, 3813.3707938190164, 3904.39481880309, 3950.0, 4108.794560272005, 33583.49624755631, 33900.0, 34169.0, 34211.0, 34550.48174277363, 4533.297338912474, 4557.840475583372, 4568.794404251817, 4602.401687780601, 4732.1482133216, 311189.0, 311552.0, 312223.0, 312547.0, 312842.0, 62453.687731561055, 62520.687396562724, 62960.37039629637, 63058.684706576176, 63067.6846615764, 67064.32935670679, 68299.65850170718, 68453.3154668447, 68454.65772671204, 68531.3146868535, 17292.827071729374, 17674.91162544179, 17691.557711057325, 17695.55761105957, 17697.203625836868, 12152.635420937386, 13216.074874758675, 13331.466741330432, 13337.599872003855, 13353.732925341634, 19536.979676665283, 20336.0, 20433.795662043485, 20489.2828750993, 20525.79474205239, 7484.43866709988, 7486.513376630502, 7594.696212151563, 7659.119201291811, 7664.386849052063, 1025.2720568396373, 1166.830809532613, 1183.6153250193722, 1201.7656556971306, 1211.8364020857248, 30597.69402305993, 30872.84563577168, 31042.534361984588, 31413.214669633442, 31753.682463175533, 1175.3535555444641, 1220.6206986105644, 1279.366713476835, 1334.1328136711022, 1347.0637906654977, 16640.417585384454, 16759.2458339375, 16776.664466710597, 16786.664266714597, 16937.645875351292, 447830.0, 452719.0, 452739.0, 453907.0, 454402.0, 60364.0, 61576.69211653913, 61656.69171654113, 61663.6916815422, 61724.0, 1397.4200706706604, 1404.192589261179, 1407.5917983784793, 1486.695227478386, 1588.9989306736682, 29455.11634650964, 35122.64877351296, 36026.378812954004, 36286.45570316395, 36928.26143477062, 56201.0, 57087.42912570821, 57213.42786572081, 57300.0, 57305.71347143404, 405830.0, 406554.0, 408074.0, 408427.0, 408856.0, 30227.244318892204, 45577.0, 45923.0, 46413.3038004437, 47037.76481117572, 44949.0, 45103.7744811287, 45354.54645453503, 45992.080158397315, 46284.0, 37977.62022379741, 38647.22705545817, 38863.611363886, 38925.41611875881, 39220.80389598034, 36955.6304436963, 37175.62824371722, 37737.43393849149, 38200.426993595676, 38458.42312365261, 41267.38098928458, 41964.3705344414, 42033.78983105065, 42366.0, 42513.149737005704, 36138.4579231317, 36497.27005459929, 37226.627733722315, 37378.8131059343, 37577.4363384544, 28347.133026377258, 28929.56605650959, 30542.0, 30849.537256940715, 31142.37715245637], "value": 21224.23643833093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.8130822438127, 438.97327923964247, 440.8085461260474, 444.4599811229357, 459.10245470105923, 18845.434636960897, 18932.99999999998, 19415.611687766253, 20913.686294705592, 20946.0, 19640.508987275327, 19713.605727885435, 19935.202591896308, 19942.102605382755, 19951.201951921943, 5481.862953426156, 5972.0444728843395, 5976.193213916109, 5977.432143946318, 5982.581219314649, 4300.462442194726, 5748.655080695172, 5875.559333050017, 6268.341824108471, 6573.605583664971, 6537.836554086139, 6547.836304092388, 6560.2455717592375, 6564.0, 6569.7700580479695, 6433.131527243809, 6504.902426463606, 6633.86732265352, 6643.734250629969, 6645.966770166118, 3942.8028598570245, 5573.303337082864, 5816.040353341694, 5902.704864756745, 5937.317208521033, 23303.18438854632, 23521.882390588107, 23576.76423235763, 23648.172313968927, 23795.40511487227, 2531.556977528925, 2570.4088059746177, 2675.4247836715003, 3034.544818277276, 3190.489521676544, 14257.429702811874, 15003.0, 15243.847561524353, 15474.303656335493, 15589.688206235925, 2138.454694053022, 2166.523364859728, 2219.323106452531, 2262.728472583284, 2323.035940084863, 89643.10356896413, 95214.0, 96687.0, 98808.50595746975, 99649.5017524915, 18141.0, 18470.261189552268, 18577.814221857607, 18633.13668633153, 18902.81097189038, 33244.1688957778, 33283.83358083194, 33577.496337554956, 33773.66226337754, 33787.66212337894, 9799.11807937289, 10310.484475776182, 10329.12202462799, 10343.327683700536, 10370.896291037145, 8436.156384361515, 8463.66145354179, 8483.533405662625, 8603.870941935877, 8632.827343453097, 9456.90543094574, 9465.195458386115, 9575.329726919048, 9716.659916902874, 9764.218862490983, 3012.0, 3635.5273814404486, 3671.430928206132, 3775.9433608495897, 3802.8098595070137, 1004.2719028704277, 1046.7133201746522, 1088.7441451259106, 1111.916606254518, 1120.445379537118, 18406.723899141525, 18811.623767524572, 18870.81129188718, 19163.75435596682, 19319.90340048319, 1093.2565855218527, 1096.5394534295615, 1099.8075336816025, 1173.049829637996, 1180.7697498987786, 10674.946625266824, 10795.244332896622, 10894.945525272324, 10942.56229750817, 11003.284786488852, 472854.0, 495074.0, 508242.0, 509533.0, 512711.0, 88658.55670721734, 95236.19055237851, 95458.52270738741, 96002.51998740101, 96038.0, 1043.4782608695652, 1051.2693677893944, 1061.8778840433295, 1112.6161474291357, 1166.690826930881, 16557.503274901774, 16652.750208746635, 16782.66434671324, 16920.830791691926, 16966.23651935641, 36984.0, 37094.44358334681, 37715.0, 37953.81023094867, 38711.2257754849, 51851.48148518467, 54666.72666636641, 59502.10746838714, 60891.086633701416, 61167.08249376352, 8932.86600701003, 8953.641854325753, 9084.40951338161, 9204.355695101278, 9218.032106628707, 11790.94104529472, 13121.606351809462, 13140.540081097115, 13164.934175329063, 13425.798613021008, 11617.361045142261, 11774.411279436164, 11902.0, 11974.281543107441, 12069.456874440495, 11247.831282530933, 11359.602413915803, 11369.31784092957, 11514.481848316678, 11627.825582616098, 11669.335568226561, 12001.63995080149, 12005.39973001329, 12177.33024683651, 12425.62723118308, 8772.824543508967, 8940.955295223483, 8957.485841908025, 8980.955095224743, 8999.730008099768, 8966.237869781142, 11251.15616328795, 11601.651950441501, 11876.940615296868, 11881.5841445549], "value": 10448.182017169698, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.224274406333, 1539.23807715181, 1567.8588926996572, 1799.4075243409586, 1917.8945158016313, 7477.551346919182, 8053.355731541477, 8183.304419124382, 8207.384446166547, 8208.09710931797, 8009.39929505288, 8260.421770476069, 8268.751937441872, 8273.710420135296, 8286.502809831414, 2330.790228879405, 2370.502194539149, 2371.1463873005705, 2372.2764556810166, 2372.92881213563, 2362.9763702363016, 2378.8334816562847, 2424.769646883552, 2427.5023620157826, 2452.1294940296207, 2394.0782798622567, 2424.018272599591, 2429.331933718233, 2445.6209287560455, 2455.815813813962, 2366.0299277296313, 2367.768760244663, 2371.2886134159858, 2373.620220764678, 2425.199684104259, 2281.9201327953606, 2335.7547457516885, 2339.251439539348, 2341.9297421077395, 2342.2504798464497, 7135.357817796424, 7894.80262993424, 8426.031006434216, 8492.490450572985, 8500.362472814564, 5199.376074871002, 5334.706591137486, 5335.493128152819, 5339.813106541291, 5342.118550439173, 3452.9482057769155, 3473.3053389321985, 3474.4614584739406, 3513.2622149348667, 3576.195356044895, 1203.4825025239143, 1228.7173949991463, 1234.0991076514194, 1243.819646151303, 1269.041873385588, 11269.66191014271, 11634.476448559835, 11639.06887449002, 11678.708032299175, 11686.76626467466, 4613.169629466728, 4702.741349225826, 4704.600108990774, 4749.572538471554, 4754.358161648202, 10060.849087263698, 10064.094231519199, 10121.544530496145, 10121.645742399129, 10151.086402223687, 5167.6641018333685, 5206.687598744087, 5210.114280572312, 5211.400688920823, 5211.452797456288, 4727.834525791581, 4775.6657034007285, 4793.1372352976105, 4796.37647105874, 4799.736014519235, 3827.158025234444, 4056.6957478189256, 4061.6547593454297, 4089.6932730045364, 4091.2635725569685, 1330.155351351879, 1331.1148086522549, 1335.6660834791303, 1336.9197848129143, 1342.838859336886, 1045.911097556701, 1047.6856942917095, 1048.5124417146064, 1048.7430579507916, 1050.5377633841085, 5865.973454645506, 5931.555133364928, 5979.611325263844, 6036.8793763905915, 6184.690765461709, 477.32696897374535, 480.24601375840297, 481.814501416957, 484.66800241834454, 499.62528103922057, 4166.854160104382, 4180.874573762792, 4198.097409057067, 4210.115875666083, 4232.619064284229, 10008.349457285252, 10151.7462063449, 10424.218183636258, 10440.216983726252, 10449.477526123663, 10266.281360304856, 10276.743081423025, 10278.33190842593, 10280.897191028143, 10294.17646588271, 7872.17342179063, 8039.517628942165, 8144.226298501751, 8147.063087744985, 8148.470349427268, 5726.942730572641, 5810.273715785527, 5909.113632955091, 5938.732757025858, 5990.31111422192, 8970.192682658591, 9091.863622045543, 9100.544972751468, 9278.304127190353, 9284.210842078499, 9125.22435592982, 9253.444793312423, 9348.065193480597, 9382.906170938477, 9387.483688397204, 7031.6835742390695, 7201.603911784902, 7245.5652660840515, 7253.455990800817, 7256.528325658815, 7983.281504664608, 7996.920030799618, 8144.348452123934, 8144.796380090308, 8202.38482113832, 7168.390686791681, 7412.96293518529, 7434.131409205109, 7588.0, 7610.657520411705, 7616.466847320635, 7621.12357078943, 7625.237476252552, 7723.884141737766, 7733.188015258317, 6972.337627925339, 7010.334018268256, 7051.0, 7061.399781018466, 7066.258042905421, 4888.608911287018, 5092.185250359925, 5095.898082038412, 5096.413912400121, 5096.668716533413, 4907.60739140875, 4927.630427717864, 4930.9506904930495, 4947.084789313988, 5036.496350364934], "value": 4512.937974158304, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.9497867787848, 372.515729551583, 375.62249938811493, 378.5230609432118, 384.8729919126687, 6103.786367477139, 6105.5420843436805, 6120.296165940918, 6152.200213972183, 6203.379662033794, 6000.249968753906, 6111.266648002234, 6150.446459818615, 6162.291336496293, 6172.722227499762, 4690.226112691402, 4763.095011947719, 4770.236762118062, 4788.592969597588, 4792.880177995543, 4779.091972525209, 4789.497102804207, 4796.83211087612, 4830.758462076899, 4831.420229572456, 4572.268437050073, 4775.90448191036, 4783.71297722136, 4796.08874313881, 4807.326974223612, 4673.065386922629, 4711.92932106017, 4725.078609671098, 4786.760661966888, 4814.494478079821, 4184.518780340239, 4252.723572967747, 4257.680673949435, 4258.850110470186, 4261.382099595541, 6025.397460253984, 6026.246719160105, 6038.818835434944, 6041.818745437644, 6052.425019623129, 5608.074667679828, 5611.551075913917, 5617.691026993513, 5619.578531610146, 5622.240997465331, 6441.710123044474, 6578.80263592093, 6582.670866456658, 6593.868122637568, 6595.703193356262, 4715.64632652549, 4721.0, 4728.527147285278, 4730.266808644631, 4731.33761273422, 6875.690593923286, 6884.896726549106, 6918.5502942308585, 6919.0, 6933.0986971693865, 4838.201696720002, 4840.370751802243, 4844.103840789465, 4845.0, 4848.75756212195, 4908.730019848943, 4915.705057696478, 4915.729634870117, 4916.262560615936, 4919.237518184687, 5582.413846546136, 5592.664440133523, 5595.21666966625, 5595.664260144323, 5603.131514615241, 6461.8061458156335, 6643.833904152435, 6645.800625981228, 6656.36764507371, 6670.299618540081, 1683.1163639089332, 1712.289399899028, 1715.519654496743, 1717.0212978602076, 1718.1666891557584, 1146.541383446628, 1161.814109742437, 1171.9355435450962, 1176.2589568571746, 1183.219075410225, 6266.686665666698, 6327.367263273636, 6338.461230795434, 6381.0, 6526.477881769447, 6913.51605387618, 6913.930860691429, 6918.515703900779, 6934.271901450376, 6940.861182776316, 6536.150300460909, 6543.901841472381, 6544.280129185786, 6545.574537655038, 6548.410643042149, 3676.9080772980888, 3714.4428335749853, 3714.461403096536, 3721.962780372216, 3722.4230244312175, 7030.3321184487395, 7267.890981635174, 7293.38006269473, 7324.230955749569, 7333.74331898381, 7032.12098487689, 7048.788536343918, 7063.929360706327, 7066.116735408074, 7070.080889484437, 7294.197638259893, 7299.379552737971, 7300.671469783872, 7304.780856574312, 7316.56100633953, 6918.8616227676175, 6919.37725604698, 6921.7231310747, 7002.159740831133, 7008.194057683228, 6671.8665626686225, 6737.326267373223, 6791.524593278621, 6791.830204244933, 6813.625250611264, 7249.05762250904, 7280.963595182202, 7290.198078211286, 7293.088363954505, 7294.161171465349, 4724.787384567771, 4760.976195119002, 4765.404324459442, 4766.976165119152, 4772.687510934521, 6869.175698916162, 6901.413379862768, 6903.309669033258, 6903.792886213421, 6908.412784913137, 6452.387023232785, 6686.063951046955, 6700.564463309869, 6703.0, 6708.060871477899, 6651.301613330531, 6690.732370705117, 6700.028495867974, 6702.262751097278, 6705.430038446787, 6579.17760279965, 6579.2104947406615, 6582.80251592453, 6583.177102862142, 6596.736130554724, 6729.1252137221845, 6730.0, 6780.321967803377, 6825.35159159879, 6827.931720682928, 6436.710348034256, 6566.737330506726, 6583.144191255297, 6584.572002819801, 6593.3736295051895], "value": 5064.765936303433, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.0746862060525, 879.9999999999999, 895.2435192262536, 902.2691619787977, 924.8381533231683, 14362.928185359071, 14370.497032603835, 14617.415303387852, 14643.487477938274, 14650.120992740443, 14223.502177423792, 14315.92842035791, 14338.283085845693, 14359.066660667075, 14366.0, 773.3619763694946, 890.2655309369795, 904.2088172848773, 913.5249670171506, 920.1994264989435, 918.1002617434917, 919.3380765848578, 919.3702313914956, 919.384012711485, 921.6681994481982, 958.9760255993586, 963.388248462228, 964.4840010594334, 964.5177411294353, 964.744342749172, 793.8293266947605, 948.2035090523958, 948.9383190092622, 951.2580187453797, 951.4148798488949, 696.6377483708494, 697.6616341074575, 697.7801992372387, 702.115334678304, 708.1714394158795, 14158.221297828615, 14342.64143396413, 14358.066725662798, 14374.928125359307, 14375.78436323456, 14944.0, 15169.469068582657, 15176.620584485367, 15192.088474691443, 15232.619184520365, 12060.698482537919, 12072.698182545419, 12186.329751863645, 12231.0, 12346.691332716664, 4528.75091869947, 4577.793999270008, 4616.584507394351, 4646.117237724821, 4699.107169637758, 52951.735241323935, 53018.46981530174, 53073.734631326595, 53337.0, 53367.733161334334, 11056.447177641086, 11300.830487542693, 11348.829767553494, 11516.1362897783, 11857.288562686266, 20249.79750202479, 20262.189512419634, 20282.188712451338, 20367.592648146954, 20381.0, 8668.956655216683, 8670.696525621574, 8752.51861147643, 8779.385443018928, 8941.284697224206, 5162.716050617252, 5271.868203294872, 5280.313559237275, 5299.284596579412, 5393.649412788156, 3677.2093999790172, 3732.309522738302, 3732.9440058399146, 3735.8879233623034, 3738.962610373916, 636.2301615045753, 636.2460484326089, 659.1826135591832, 667.3426674725391, 668.2048362448768, 802.8314054048599, 827.5696637748457, 840.8822764812932, 856.9400141990001, 870.2385412763832, 10029.64896228643, 10109.0, 10128.392296462089, 10130.189584833195, 10158.13655839262, 753.6118898767139, 787.830616417473, 810.6919370639238, 815.1888870573817, 841.3017195727532, 4534.387857639243, 4633.258678611406, 4717.787699553528, 4728.0, 4799.232122860326, 66674.0, 67477.32522674711, 67744.6612766933, 68149.3185068153, 68464.6576767113, 55989.72005139948, 56530.43469565334, 57094.7145264271, 57143.42856571381, 58826.705866470395, 52330.0, 52527.212091818656, 52768.208476872875, 52912.91112039595, 53425.46574534283, 9299.67451139207, 9352.438853668802, 9376.390534615228, 9440.433573985583, 9455.19630831387, 39213.0, 39530.40704389494, 40530.0, 40533.1893362137, 40912.59087409207, 46623.76688116538, 49873.0, 51115.0, 51578.48421515887, 51638.483615163364, 11417.657470275904, 11747.353895535485, 12024.218425802295, 12055.15613907018, 12476.625701228977, 12720.300383478998, 12736.872631273569, 12782.23306601607, 12874.67813304675, 13019.567847536575, 11791.882081179421, 11867.525298987945, 11946.0, 11949.0, 12081.637550873487, 12185.086118541321, 12401.317927514074, 12589.118761686594, 12617.186917791194, 12771.552995645108, 11948.342841143472, 11957.521699132285, 12035.75928481408, 12185.939070304947, 12320.691982700504, 10198.898011019795, 10351.689449316533, 10426.68719938403, 10508.789824203626, 10572.735681608021, 10459.581616735246, 10589.647441620256, 10634.468276586294, 10656.57373705043, 10693.358398496115], "value": 7160.14396415993, "unit": "score"}], "name": "dromaeo_css", "value": 7625.016259488798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 112.0, 110.0, 112.0, 106.0, 109.0, 109.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 126.0, 156.0, 179.0, 126.0, 156.0, 152.0, 127.0, 195.0, 126.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 159.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 188.0, 74.0, 73.0, 74.0, 76.0, 158.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 153.0, 92.0, 92.0, 93.0, 157.0, 92.0, 91.0, 150.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 57.0, 58.0, 58.0, 58.0, 81.0, 56.0, 56.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 57.0, 59.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 73.0, 75.0, 74.0, 76.0, 74.0, 74.0, 74.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 111.0, 119.0, 116.0, 115.0, 111.0, 112.0, 129.0, 113.0], "value": 115.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 159.0, 160.0, 160.0, 163.0, 162.0, 160.0, 162.0, 158.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 69.0, 67.0, 65.0, 68.0, 67.0, 66.0, 66.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1517.5000000000002, "alertThreshold": 2.0}]} 07:01:32 INFO - Return code: 0 07:01:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:01:33 ERROR - # TBPL SUCCESS # 07:01:33 INFO - Running post-action listener: _resource_record_post_action 07:01:33 INFO - Running post-run listener: _resource_record_post_run 07:01:34 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 453894144; Read time: 20; Write time: 373908 07:01:34 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 150720512; Read time: 0; Write time: 161152 07:01:34 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 205758464; Read time: 20; Write time: 151444 07:01:34 INFO - Running post-run listener: _upload_blobber_files 07:01:34 INFO - Blob upload gear active. 07:01:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:01:34 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 07:01:34 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'] 07:01:34 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 07:01:34 INFO - (blobuploader) - INFO - Open directory for files ... 07:01:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:01:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:01:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:35 INFO - (blobuploader) - INFO - Done attempting. 07:01:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:01:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:01:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:01:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:01:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:01:36 INFO - (blobuploader) - INFO - Done attempting. 07:01:36 INFO - (blobuploader) - INFO - Iteration through files over. 07:01:36 INFO - Return code: 0 07:01:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:01:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:01:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c471ba13b857ebf24861cc541ea1e56cbbe0d9378af9ca8ae755f21a4915e027cd6ad11771ca868e4c20835372e5a3bed8b24446af12ac6a8911af46b1d20a4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6e5b4b98cf8cc0f0c835b00d819c6dd970d102821f1850908751efeb97d2bbe6df0cc0fab460d013ba82d9147ddd99da582ce2b93b39255dad0fd85471b96cd"} 07:01:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:01:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:01:36 INFO - Contents: 07:01:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c471ba13b857ebf24861cc541ea1e56cbbe0d9378af9ca8ae755f21a4915e027cd6ad11771ca868e4c20835372e5a3bed8b24446af12ac6a8911af46b1d20a4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6e5b4b98cf8cc0f0c835b00d819c6dd970d102821f1850908751efeb97d2bbe6df0cc0fab460d013ba82d9147ddd99da582ce2b93b39255dad0fd85471b96cd"} 07:01:36 INFO - Running post-run listener: copy_logs_to_upload_dir 07:01:36 INFO - Copying logs to upload dir... 07:01:36 INFO - mkdir: /builds/slave/test/build/upload/logs 07:01:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.337677 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-06-27 07:01:36.084672) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 07:01:36.088652) ========= 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=41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031 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/c471ba13b857ebf24861cc541ea1e56cbbe0d9378af9ca8ae755f21a4915e027cd6ad11771ca868e4c20835372e5a3bed8b24446af12ac6a8911af46b1d20a4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6e5b4b98cf8cc0f0c835b00d819c6dd970d102821f1850908751efeb97d2bbe6df0cc0fab460d013ba82d9147ddd99da582ce2b93b39255dad0fd85471b96cd"} build_url:https://queue.taskcluster.net/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/GXMndyYoQF2EwKKLT803dg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c471ba13b857ebf24861cc541ea1e56cbbe0d9378af9ca8ae755f21a4915e027cd6ad11771ca868e4c20835372e5a3bed8b24446af12ac6a8911af46b1d20a4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6e5b4b98cf8cc0f0c835b00d819c6dd970d102821f1850908751efeb97d2bbe6df0cc0fab460d013ba82d9147ddd99da582ce2b93b39255dad0fd85471b96cd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 07:01:36.113230) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:01:36.113548) ========= 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=41bf3e9aed84707956354da8000001c5-1467034869.40037-1325603031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 07:01:36.197049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 07:01:36.197379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 07:01:36.197656) ========= ========= Total master_lag: 0.17 =========