builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1470075854.55 results: success (0) buildid: 20160801070053 builduid: eaf10adbc6074edb9e3b1e3d32dab73b revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.547568) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.548183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.548667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.767640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.767899) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 11:24:15-- 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% 60.2M=0s 2016-08-01 11:24:16 (60.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.335483 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.130044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.130355) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019581 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.179775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.183267) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 --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 bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 --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=56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 11:24:16,254 truncating revision to first 12 chars 2016-08-01 11:24:16,254 Setting DEBUG logging. 2016-08-01 11:24:16,254 attempt 1/10 2016-08-01 11:24:16,254 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bad9d4f5bf7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 11:24:16,608 unpacking tar archive at: mozilla-beta-bad9d4f5bf7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.887266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.887557) ========= script_repo_revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.887972) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.888250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.897330) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-01 11:24:15.897596) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:17 INFO - MultiFileLogger online at 20160801 11:24:17 in /builds/slave/test 11:24:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:24:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:17 INFO - {'append_to_log': False, 11:24:17 INFO - 'base_work_dir': '/builds/slave/test', 11:24:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:24:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:17 INFO - 'branch': 'Mozilla-Beta', 11:24:17 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:17 INFO - 'config_files': ('talos/linux_config.py',), 11:24:17 INFO - 'default_actions': ('clobber', 11:24:17 INFO - 'read-buildbot-config', 11:24:17 INFO - 'download-and-extract', 11:24:17 INFO - 'populate-webroot', 11:24:17 INFO - 'create-virtualenv', 11:24:17 INFO - 'install', 11:24:17 INFO - 'run-tests'), 11:24:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:17 INFO - 'download_minidump_stackwalk': True, 11:24:17 INFO - 'download_symbols': 'ondemand', 11:24:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:17 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:17 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:17 INFO - 'installer_path': 'installer.exe', 11:24:17 INFO - 'log_level': 'info', 11:24:17 INFO - 'log_name': 'talos', 11:24:17 INFO - 'log_to_console': True, 11:24:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:17 INFO - 'opt_config_files': (), 11:24:17 INFO - 'pip_index': False, 11:24:17 INFO - 'sps_profile': False, 11:24:17 INFO - 'sps_profile_interval': 0, 11:24:17 INFO - 'suite': 'dromaeojs', 11:24:17 INFO - 'system_bits': '32', 11:24:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:17 INFO - 'title': 'talos-linux64-ix-037', 11:24:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:17 INFO - 'use_talos_json': True, 11:24:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:17 INFO - 'work_dir': 'build'} 11:24:17 INFO - ##### 11:24:17 INFO - ##### Running clobber step. 11:24:17 INFO - ##### 11:24:17 INFO - Running pre-action listener: _resource_record_pre_action 11:24:17 INFO - Running main action method: clobber 11:24:17 INFO - rmtree: /builds/slave/test/build 11:24:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:17 INFO - Running post-action listener: _resource_record_post_action 11:24:17 INFO - ##### 11:24:17 INFO - ##### Finished clobber step (success) 11:24:17 INFO - ##### 11:24:17 INFO - ##### 11:24:17 INFO - ##### Running read-buildbot-config step. 11:24:17 INFO - ##### 11:24:17 INFO - Running pre-action listener: _resource_record_pre_action 11:24:17 INFO - Running main action method: read_buildbot_config 11:24:17 INFO - Using buildbot properties: 11:24:17 INFO - { 11:24:17 INFO - "project": "", 11:24:17 INFO - "product": "firefox", 11:24:17 INFO - "script_repo_revision": "production", 11:24:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:24:17 INFO - "repository": "", 11:24:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:24:17 INFO - "buildid": "20160801070053", 11:24:17 INFO - "pgo_build": "True", 11:24:17 INFO - "basedir": "/builds/slave/test", 11:24:17 INFO - "buildnumber": 182, 11:24:17 INFO - "slavename": "talos-linux64-ix-037", 11:24:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:24:17 INFO - "platform": "ubuntu64_hw", 11:24:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:24:17 INFO - "branch": "mozilla-beta", 11:24:17 INFO - "repo_path": "releases/mozilla-beta", 11:24:17 INFO - "revision": "bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2", 11:24:17 INFO - "stage_platform": "linux64-pgo", 11:24:17 INFO - "builduid": "eaf10adbc6074edb9e3b1e3d32dab73b", 11:24:17 INFO - "slavebuilddir": "test" 11:24:17 INFO - } 11:24:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 11:24:17 INFO - Running post-action listener: _resource_record_post_action 11:24:17 INFO - ##### 11:24:17 INFO - ##### Finished read-buildbot-config step (success) 11:24:17 INFO - ##### 11:24:17 INFO - ##### 11:24:17 INFO - ##### Running download-and-extract step. 11:24:17 INFO - ##### 11:24:17 INFO - Running pre-action listener: _resource_record_pre_action 11:24:17 INFO - Running main action method: download_and_extract 11:24:17 INFO - mkdir: /builds/slave/test/build/tests 11:24: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')]} 11:24:17 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:24:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:24:18 INFO - Downloaded 1327 bytes. 11:24:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:18 INFO - Using the following test package requirements: 11:24:18 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:18 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:24:18 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 11:24:18 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'jsshell-linux-x86_64.zip'], 11:24:18 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:24:18 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:18 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 11:24:18 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 11:24:18 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:24:18 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:24:18 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:18 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:20 INFO - Downloaded 21968684 bytes. 11:24:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:21 INFO - Return code: 0 11:24:21 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:21 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:26 INFO - Downloaded 21968684 bytes. 11:24:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:28 INFO - Return code: 0 11:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:28 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:24:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:24:29 INFO - Downloaded 10833369 bytes. 11:24:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:24:29 INFO - Return code: 0 11:24: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')]} 11:24:29 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:24:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:24:30 INFO - Downloaded 55264299 bytes. 11:24:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:30 INFO - mkdir: /builds/slave/test/properties 11:24:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:30 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:30 INFO - Contents: 11:24:30 INFO - build_url:https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:31 INFO - Running post-action listener: _resource_record_post_action 11:24:31 INFO - Running post-action listener: set_extra_try_arguments 11:24:31 INFO - ##### 11:24:31 INFO - ##### Finished download-and-extract step (success) 11:24:31 INFO - ##### 11:24:31 INFO - ##### 11:24:31 INFO - ##### Running populate-webroot step. 11:24:31 INFO - ##### 11:24:31 INFO - Running pre-action listener: _resource_record_pre_action 11:24:31 INFO - Running main action method: populate_webroot 11:24:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:31 INFO - '--tppagecycles', 11:24:31 INFO - '7'], 11:24:31 INFO - 'tests': ['tsvgm']}}, 11:24:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['damp', 'tps']}, 11:24:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'tests': ['damp', 'tps']}, 11:24:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['dromaeo_dom']}, 11:24:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['tsvgx', 11:24:31 INFO - 'tsvgr_opacity', 11:24:31 INFO - 'tart', 11:24:31 INFO - 'tscrollx', 11:24:31 INFO - 'cart']}, 11:24:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:31 INFO - 'tsvgr_opacity', 11:24:31 INFO - 'tart', 11:24:31 INFO - 'tscrollx', 11:24:31 INFO - 'cart']}, 11:24:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['tp5o']}, 11:24:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'tests': ['tp5o']}, 11:24:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'talos_options': ['--disable-e10s', 11:24:31 INFO - '--xperf_path', 11:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:31 INFO - 'tests': ['tp5n']}, 11:24:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'talos_options': ['--xperf_path', 11:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:31 INFO - 'tests': ['tp5n']}}, 11:24:31 INFO - 'talos.zip': {'path': '', 11:24:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:31 INFO - Running post-action listener: _resource_record_post_action 11:24:31 INFO - ##### 11:24:31 INFO - ##### Finished populate-webroot step (success) 11:24:31 INFO - ##### 11:24:31 INFO - ##### 11:24:31 INFO - ##### Running create-virtualenv step. 11:24:31 INFO - ##### 11:24:31 INFO - Running pre-action listener: _resource_record_pre_action 11:24:31 INFO - Running main action method: create_virtualenv 11:24:31 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:24:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:31 INFO - Using real prefix '/usr' 11:24:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:32 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:34 INFO - Installing pip.................done. 11:24:34 INFO - Return code: 0 11:24:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:34 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 0x7fda8c4f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:24:34 INFO - Using env: {'DISPLAY': ':0', 11:24:34 INFO - 'HOME': '/home/cltbld', 11:24:34 INFO - 'LANG': 'en_US.UTF-8', 11:24:34 INFO - 'LANGUAGE': 'en_US:en', 11:24:34 INFO - 'LOGNAME': 'cltbld', 11:24:34 INFO - 'MAIL': '/var/mail/cltbld', 11:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:34 INFO - 'MOZ_NO_REMOTE': '1', 11:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:34 INFO - 'NO_EM_RESTART': '1', 11:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:34 INFO - 'PWD': '/builds/slave/test', 11:24:34 INFO - 'SHELL': '/bin/bash', 11:24:34 INFO - 'SHLVL': '1', 11:24:34 INFO - 'TERM': 'linux', 11:24:34 INFO - 'TMOUT': '86400', 11:24:34 INFO - 'USER': 'cltbld', 11:24:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:34 INFO - '_': '/tools/buildbot/bin/python'} 11:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:24:34 INFO - Cleaning up... 11:24:34 INFO - Return code: 0 11:24:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:34 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda8c4f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:34 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>=3.1.1'] in /builds/slave/test/build 11:24:34 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>=3.1.1 11:24:34 INFO - Using env: {'DISPLAY': ':0', 11:24:34 INFO - 'HOME': '/home/cltbld', 11:24:34 INFO - 'LANG': 'en_US.UTF-8', 11:24:34 INFO - 'LANGUAGE': 'en_US:en', 11:24:34 INFO - 'LOGNAME': 'cltbld', 11:24:34 INFO - 'MAIL': '/var/mail/cltbld', 11:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:34 INFO - 'MOZ_NO_REMOTE': '1', 11:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:34 INFO - 'NO_EM_RESTART': '1', 11:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:34 INFO - 'PWD': '/builds/slave/test', 11:24:34 INFO - 'SHELL': '/bin/bash', 11:24:34 INFO - 'SHLVL': '1', 11:24:34 INFO - 'TERM': 'linux', 11:24:34 INFO - 'TMOUT': '86400', 11:24:34 INFO - 'USER': 'cltbld', 11:24:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:34 INFO - '_': '/tools/buildbot/bin/python'} 11:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:34 INFO - Downloading/unpacking psutil>=3.1.1 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:36 INFO - Installing collected packages: psutil 11:24:36 INFO - Running setup.py install for psutil 11:24:36 INFO - building 'psutil._psutil_linux' extension 11:24:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:24:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:24:36 INFO - building 'psutil._psutil_posix' extension 11:24:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:24:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:24:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:37 INFO - Successfully installed psutil 11:24:37 INFO - Cleaning up... 11:24:37 INFO - Return code: 0 11:24:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda8c4f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:37 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.3'] in /builds/slave/test/build 11:24:37 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.3 11:24:37 INFO - Using env: {'DISPLAY': ':0', 11:24:37 INFO - 'HOME': '/home/cltbld', 11:24:37 INFO - 'LANG': 'en_US.UTF-8', 11:24:37 INFO - 'LANGUAGE': 'en_US:en', 11:24:37 INFO - 'LOGNAME': 'cltbld', 11:24:37 INFO - 'MAIL': '/var/mail/cltbld', 11:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:37 INFO - 'MOZ_NO_REMOTE': '1', 11:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:37 INFO - 'NO_EM_RESTART': '1', 11:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:37 INFO - 'PWD': '/builds/slave/test', 11:24:37 INFO - 'SHELL': '/bin/bash', 11:24:37 INFO - 'SHLVL': '1', 11:24:37 INFO - 'TERM': 'linux', 11:24:37 INFO - 'TMOUT': '86400', 11:24:37 INFO - 'USER': 'cltbld', 11:24:37 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:37 INFO - '_': '/tools/buildbot/bin/python'} 11:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:39 INFO - Installing collected packages: mozsystemmonitor 11:24:39 INFO - Running setup.py install for mozsystemmonitor 11:24:39 INFO - Successfully installed mozsystemmonitor 11:24:39 INFO - Cleaning up... 11:24:39 INFO - Return code: 0 11:24:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:39 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda8c4f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:39 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==2.5.1'] in /builds/slave/test/build 11:24:39 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==2.5.1 11:24:39 INFO - Using env: {'DISPLAY': ':0', 11:24:39 INFO - 'HOME': '/home/cltbld', 11:24:39 INFO - 'LANG': 'en_US.UTF-8', 11:24:39 INFO - 'LANGUAGE': 'en_US:en', 11:24:39 INFO - 'LOGNAME': 'cltbld', 11:24:39 INFO - 'MAIL': '/var/mail/cltbld', 11:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:39 INFO - 'MOZ_NO_REMOTE': '1', 11:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:39 INFO - 'NO_EM_RESTART': '1', 11:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:39 INFO - 'PWD': '/builds/slave/test', 11:24:39 INFO - 'SHELL': '/bin/bash', 11:24:39 INFO - 'SHLVL': '1', 11:24:39 INFO - 'TERM': 'linux', 11:24:39 INFO - 'TMOUT': '86400', 11:24:39 INFO - 'USER': 'cltbld', 11:24:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:39 INFO - '_': '/tools/buildbot/bin/python'} 11:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:39 INFO - Downloading/unpacking jsonschema==2.5.1 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:41 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:41 INFO - warning: no files found matching '*.txt' 11:24:41 INFO - no previously-included directories found matching 'build' 11:24:41 INFO - no previously-included directories found matching 'dist' 11:24:41 INFO - no previously-included directories found matching '.git*' 11:24:41 INFO - Installing collected packages: jsonschema, functools32 11:24:41 INFO - Running setup.py install for functools32 11:24:42 INFO - warning: no files found matching '*.txt' 11:24:42 INFO - no previously-included directories found matching 'build' 11:24:42 INFO - no previously-included directories found matching 'dist' 11:24:42 INFO - no previously-included directories found matching '.git*' 11:24:42 INFO - Successfully installed jsonschema functools32 11:24:42 INFO - Cleaning up... 11:24:42 INFO - Return code: 0 11:24:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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', '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 0x7fda8c4f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:24: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 blobuploader==1.2.4 11:24:42 INFO - Using env: {'DISPLAY': ':0', 11:24:42 INFO - 'HOME': '/home/cltbld', 11:24:42 INFO - 'LANG': 'en_US.UTF-8', 11:24:42 INFO - 'LANGUAGE': 'en_US:en', 11:24:42 INFO - 'LOGNAME': 'cltbld', 11:24:42 INFO - 'MAIL': '/var/mail/cltbld', 11:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:42 INFO - 'MOZ_NO_REMOTE': '1', 11:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:42 INFO - 'NO_EM_RESTART': '1', 11:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:42 INFO - 'PWD': '/builds/slave/test', 11:24:42 INFO - 'SHELL': '/bin/bash', 11:24:42 INFO - 'SHLVL': '1', 11:24:42 INFO - 'TERM': 'linux', 11:24:42 INFO - 'TMOUT': '86400', 11:24:42 INFO - 'USER': 'cltbld', 11:24:42 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:42 INFO - '_': '/tools/buildbot/bin/python'} 11:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:44 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:44 INFO - Downloading docopt-0.6.1.tar.gz 11:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:44 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:44 INFO - Running setup.py install for blobuploader 11:24:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:45 INFO - Running setup.py install for requests 11:24:45 INFO - Running setup.py install for docopt 11:24:45 INFO - Successfully installed blobuploader requests docopt 11:24:45 INFO - Cleaning up... 11:24:45 INFO - Return code: 0 11:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:45 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 0x7fda8c4f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:45 INFO - Using env: {'DISPLAY': ':0', 11:24:45 INFO - 'HOME': '/home/cltbld', 11:24:45 INFO - 'LANG': 'en_US.UTF-8', 11:24:45 INFO - 'LANGUAGE': 'en_US:en', 11:24:45 INFO - 'LOGNAME': 'cltbld', 11:24:45 INFO - 'MAIL': '/var/mail/cltbld', 11:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:45 INFO - 'MOZ_NO_REMOTE': '1', 11:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:45 INFO - 'NO_EM_RESTART': '1', 11:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:45 INFO - 'PWD': '/builds/slave/test', 11:24:45 INFO - 'SHELL': '/bin/bash', 11:24:45 INFO - 'SHLVL': '1', 11:24:45 INFO - 'TERM': 'linux', 11:24:45 INFO - 'TMOUT': '86400', 11:24:45 INFO - 'USER': 'cltbld', 11:24:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:45 INFO - '_': '/tools/buildbot/bin/python'} 11:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:45 INFO - Running setup.py (path:/tmp/pip-NZrcbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:45 INFO - Running setup.py (path:/tmp/pip-C_sTvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:45 INFO - Running setup.py (path:/tmp/pip-vl5Rrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:46 INFO - Running setup.py (path:/tmp/pip-Ujtamz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:46 INFO - Running setup.py (path:/tmp/pip-bwS8Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:46 INFO - Running setup.py (path:/tmp/pip-Gsj52j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:46 INFO - Running setup.py (path:/tmp/pip-Nr8nFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:46 INFO - Running setup.py (path:/tmp/pip-Tqb8T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:46 INFO - Running setup.py (path:/tmp/pip-KKp2H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:46 INFO - Running setup.py (path:/tmp/pip-rdlY4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:46 INFO - Running setup.py (path:/tmp/pip-w3c6Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:46 INFO - Running setup.py (path:/tmp/pip-7P27i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:46 INFO - Running setup.py (path:/tmp/pip-6MfhDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:46 INFO - Running setup.py (path:/tmp/pip-oJvxaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:46 INFO - Running setup.py (path:/tmp/pip-M9oCgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:46 INFO - Running setup.py (path:/tmp/pip-bJ8MbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:46 INFO - Running setup.py (path:/tmp/pip-baJ_8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:47 INFO - Running setup.py install for manifestparser 11:24:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for mozcrash 11:24:47 INFO - Running setup.py install for mozdebug 11:24:47 INFO - Running setup.py install for mozdevice 11:24:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for mozfile 11:24:47 INFO - Running setup.py install for mozhttpd 11:24:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for mozinfo 11:24:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for mozInstall 11:24:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for mozleak 11:24:47 INFO - Running setup.py install for mozlog 11:24:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Running setup.py install for moznetwork 11:24:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Running setup.py install for mozprocess 11:24:48 INFO - Running setup.py install for mozprofile 11:24:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Running setup.py install for mozrunner 11:24:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Running setup.py install for mozscreenshot 11:24:48 INFO - Running setup.py install for moztest 11:24:48 INFO - Running setup.py install for mozversion 11:24:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:48 INFO - Cleaning up... 11:24:48 INFO - Return code: 0 11:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:48 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 0x7fda8c4f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:48 INFO - Using env: {'DISPLAY': ':0', 11:24:48 INFO - 'HOME': '/home/cltbld', 11:24:48 INFO - 'LANG': 'en_US.UTF-8', 11:24:48 INFO - 'LANGUAGE': 'en_US:en', 11:24:48 INFO - 'LOGNAME': 'cltbld', 11:24:48 INFO - 'MAIL': '/var/mail/cltbld', 11:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:48 INFO - 'MOZ_NO_REMOTE': '1', 11:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:48 INFO - 'NO_EM_RESTART': '1', 11:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:48 INFO - 'PWD': '/builds/slave/test', 11:24:48 INFO - 'SHELL': '/bin/bash', 11:24:48 INFO - 'SHLVL': '1', 11:24:48 INFO - 'TERM': 'linux', 11:24:48 INFO - 'TMOUT': '86400', 11:24:48 INFO - 'USER': 'cltbld', 11:24:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:48 INFO - '_': '/tools/buildbot/bin/python'} 11:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:49 INFO - Running setup.py (path:/tmp/pip-tHubxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:49 INFO - Running setup.py (path:/tmp/pip-W4SozH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:49 INFO - Running setup.py (path:/tmp/pip-m5sllu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:49 INFO - Running setup.py (path:/tmp/pip-8O0l8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:49 INFO - Running setup.py (path:/tmp/pip-R6ItRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:49 INFO - Running setup.py (path:/tmp/pip-kkbVj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:49 INFO - Running setup.py (path:/tmp/pip-ceW2bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:49 INFO - Running setup.py (path:/tmp/pip-tba9bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:49 INFO - Running setup.py (path:/tmp/pip-J8y0Of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:49 INFO - Running setup.py (path:/tmp/pip-ZOgjgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:49 INFO - Running setup.py (path:/tmp/pip-YVK0Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:49 INFO - Running setup.py (path:/tmp/pip-talA4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:49 INFO - Running setup.py (path:/tmp/pip-vgjdOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:50 INFO - Running setup.py (path:/tmp/pip-qSwBIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:50 INFO - Running setup.py (path:/tmp/pip-agqh43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:50 INFO - Running setup.py (path:/tmp/pip-a0t3kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:50 INFO - Running setup.py (path:/tmp/pip-_nt6Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:24:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:52 INFO - Downloading blessings-1.6.tar.gz 11:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:52 INFO - Installing collected packages: blessings 11:24:52 INFO - Running setup.py install for blessings 11:24:52 INFO - Successfully installed blessings 11:24:52 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 11:24:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:52 INFO - Reading from file tmpfile_stdout 11:24:52 INFO - Current package versions: 11:24:52 INFO - argparse == 1.2.1 11:24:52 INFO - blessings == 1.6 11:24:52 INFO - blobuploader == 1.2.4 11:24:52 INFO - docopt == 0.6.1 11:24:52 INFO - functools32 == 3.2.3-2 11:24:52 INFO - jsonschema == 2.5.1 11:24:52 INFO - manifestparser == 1.1 11:24:52 INFO - mozInstall == 1.12 11:24:52 INFO - mozcrash == 0.17 11:24:52 INFO - mozdebug == 0.1 11:24:52 INFO - mozdevice == 0.48 11:24:52 INFO - mozfile == 1.2 11:24:52 INFO - mozhttpd == 0.7 11:24:52 INFO - mozinfo == 0.9 11:24:52 INFO - mozleak == 0.1 11:24:52 INFO - mozlog == 3.2 11:24:52 INFO - moznetwork == 0.27 11:24:52 INFO - mozprocess == 0.23 11:24:52 INFO - mozprofile == 0.28 11:24:52 INFO - mozrunner == 6.12 11:24:52 INFO - mozscreenshot == 0.1 11:24:52 INFO - mozsystemmonitor == 0.3 11:24:52 INFO - moztest == 0.7 11:24:52 INFO - mozversion == 1.4 11:24:52 INFO - psutil == 3.1.1 11:24:52 INFO - requests == 1.2.3 11:24:52 INFO - wsgiref == 0.1.2 11:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:52 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 0x7fda8c4f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:52 INFO - Using env: {'DISPLAY': ':0', 11:24:52 INFO - 'HOME': '/home/cltbld', 11:24:52 INFO - 'LANG': 'en_US.UTF-8', 11:24:52 INFO - 'LANGUAGE': 'en_US:en', 11:24:52 INFO - 'LOGNAME': 'cltbld', 11:24:52 INFO - 'MAIL': '/var/mail/cltbld', 11:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:52 INFO - 'MOZ_NO_REMOTE': '1', 11:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:52 INFO - 'NO_EM_RESTART': '1', 11:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:52 INFO - 'PWD': '/builds/slave/test', 11:24:52 INFO - 'SHELL': '/bin/bash', 11:24:52 INFO - 'SHLVL': '1', 11:24:52 INFO - 'TERM': 'linux', 11:24:52 INFO - 'TMOUT': '86400', 11:24:52 INFO - 'USER': 'cltbld', 11:24:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:52 INFO - '_': '/tools/buildbot/bin/python'} 11:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:24:52 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 11:24:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:52 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 0x7fda8c4f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:24:52 INFO - Using env: {'DISPLAY': ':0', 11:24:52 INFO - 'HOME': '/home/cltbld', 11:24:52 INFO - 'LANG': 'en_US.UTF-8', 11:24:52 INFO - 'LANGUAGE': 'en_US:en', 11:24:52 INFO - 'LOGNAME': 'cltbld', 11:24:52 INFO - 'MAIL': '/var/mail/cltbld', 11:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:52 INFO - 'MOZ_NO_REMOTE': '1', 11:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:52 INFO - 'NO_EM_RESTART': '1', 11:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:52 INFO - 'PWD': '/builds/slave/test', 11:24:52 INFO - 'SHELL': '/bin/bash', 11:24:52 INFO - 'SHLVL': '1', 11:24:52 INFO - 'TERM': 'linux', 11:24:52 INFO - 'TMOUT': '86400', 11:24:52 INFO - 'USER': 'cltbld', 11:24:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:52 INFO - '_': '/tools/buildbot/bin/python'} 11:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:53 INFO - Cleaning up... 11:24:53 INFO - Return code: 0 11:24:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:53 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 0x7fda8c4f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168e3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:24:53 INFO - Using env: {'DISPLAY': ':0', 11:24:53 INFO - 'HOME': '/home/cltbld', 11:24:53 INFO - 'LANG': 'en_US.UTF-8', 11:24:53 INFO - 'LANGUAGE': 'en_US:en', 11:24:53 INFO - 'LOGNAME': 'cltbld', 11:24:53 INFO - 'MAIL': '/var/mail/cltbld', 11:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:53 INFO - 'MOZ_NO_REMOTE': '1', 11:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:53 INFO - 'NO_EM_RESTART': '1', 11:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:53 INFO - 'PWD': '/builds/slave/test', 11:24:53 INFO - 'SHELL': '/bin/bash', 11:24:53 INFO - 'SHLVL': '1', 11:24:53 INFO - 'TERM': 'linux', 11:24:53 INFO - 'TMOUT': '86400', 11:24:53 INFO - 'USER': 'cltbld', 11:24:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:53 INFO - '_': '/tools/buildbot/bin/python'} 11:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:53 INFO - Downloading/unpacking flake8 11:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:24:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:24:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:24:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:55 INFO - no previously-included directories found matching 'docs/_build' 11:24:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:24:55 INFO - Running setup.py install for pep8 11:24:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:56 INFO - no previously-included directories found matching 'docs/_build' 11:24:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:24:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:24:56 INFO - Cleaning up... 11:24:56 INFO - Return code: 0 11:24:56 INFO - Running post-action listener: _resource_record_post_action 11:24:56 INFO - Running post-action listener: _start_resource_monitoring 11:24:56 INFO - Starting resource monitoring. 11:24:56 INFO - ##### 11:24:56 INFO - ##### Finished create-virtualenv step (success) 11:24:56 INFO - ##### 11:24:56 INFO - ##### 11:24:56 INFO - ##### Running install step. 11:24:56 INFO - ##### 11:24:56 INFO - Running pre-action listener: _resource_record_pre_action 11:24:56 INFO - Running main action method: install 11:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:56 INFO - Reading from file tmpfile_stdout 11:24:56 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:56 INFO - Reading from file tmpfile_stdout 11:24:56 INFO - Output received: 11:24:56 INFO - Usage: mozinstall [options] installer 11:24:56 INFO - Options: 11:24:56 INFO - -h, --help show this help message and exit 11:24:56 INFO - -d DEST, --destination=DEST 11:24:56 INFO - Directory to install application into. [default: 11:24:56 INFO - "/builds/slave/test"] 11:24:56 INFO - --app=APP Application being installed. [default: firefox] 11:24:56 INFO - mkdir: /builds/slave/test/build/application 11:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:25:09 INFO - Reading from file tmpfile_stdout 11:25:09 INFO - Output received: 11:25:09 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:09 INFO - Running post-action listener: _resource_record_post_action 11:25:09 INFO - ##### 11:25:09 INFO - ##### Finished install step (success) 11:25:09 INFO - ##### 11:25:09 INFO - ##### 11:25:09 INFO - ##### Running run-tests step. 11:25:09 INFO - ##### 11:25:09 INFO - Running pre-action listener: _resource_record_pre_action 11:25:09 INFO - Running main action method: run_tests 11:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:09 INFO - Python 2.7.3 11:25:09 INFO - Return code: 0 11:25:09 INFO - grabbing minidump binary from tooltool 11:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:09 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720990>, '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 0x168c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:25:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:25:09 INFO - Calling ['/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'] with output_timeout 600 11:25:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:09 INFO - Return code: 0 11:25:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:25:10 INFO - Return code: 0 11:25:10 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/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:25:10 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/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:25:10 INFO - Using env: {'DISPLAY': ':0', 11:25:10 INFO - 'HOME': '/home/cltbld', 11:25:10 INFO - 'LANG': 'en_US.UTF-8', 11:25:10 INFO - 'LANGUAGE': 'en_US:en', 11:25:10 INFO - 'LOGNAME': 'cltbld', 11:25:10 INFO - 'MAIL': '/var/mail/cltbld', 11:25:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:10 INFO - 'MOZ_NO_REMOTE': '1', 11:25:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:10 INFO - 'NO_EM_RESTART': '1', 11:25:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:10 INFO - 'PWD': '/builds/slave/test', 11:25:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:10 INFO - 'SHELL': '/bin/bash', 11:25:10 INFO - 'SHLVL': '1', 11:25:10 INFO - 'TERM': 'linux', 11:25:10 INFO - 'TMOUT': '86400', 11:25:10 INFO - 'USER': 'cltbld', 11:25:10 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547', 11:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:10 INFO - '_': '/tools/buildbot/bin/python'} 11:25:10 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/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:25:10 INFO - mozversion application_buildid: 20160801070053 11:25:10 INFO - mozversion application_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:10 INFO - mozversion application_display_name: Firefox 11:25:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:10 INFO - mozversion application_name: Firefox 11:25:10 INFO - mozversion application_remotingname: firefox 11:25:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:10 INFO - mozversion application_vendor: Mozilla 11:25:10 INFO - mozversion application_version: 49.0 11:25:10 INFO - mozversion platform_buildid: 20160801070053 11:25:10 INFO - mozversion platform_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:10 INFO - mozversion platform_version: 49.0 11:25:10 INFO - using testdate: 1470075910 11:25:10 INFO - actual date: 1470075910 11:25:10 INFO - starting webserver on 'localhost:48686' 11:25:10 INFO - SUITE-START | Running 2 tests 11:25:10 INFO - TEST-START | dromaeo_css 11:25:10 INFO - operating with platform_type : linux_ 11:25:10 INFO - Initialising browser for dromaeo_css test... 11:25:10 INFO - TEST-INFO | started process 14128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuJqSQb/profile http://localhost:48686/getInfo.html) 11:25:14 INFO - PROCESS | 14128 | __metrics Screen width/height:1600/1200 11:25:14 INFO - PROCESS | 14128 | colorDepth:24 11:25:14 INFO - PROCESS | 14128 | Browser inner width/height: 1024/697 11:25:14 INFO - PROCESS | 14128 | __metrics 11:25:15 INFO - PROCESS | 14128 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:25:15 ERROR - PROCESS | 14128 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:25:16 INFO - TEST-INFO | 14128: exit 0 11:25:16 INFO - Browser initialized. 11:25:16 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:16 INFO - TEST-INFO | started process 14218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuJqSQb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:28 INFO - PROCESS | 14218 | RSS: Main: 141029376 11:25:28 INFO - PROCESS | 14218 | 11:26:19 INFO - PROCESS | 14218 | 1470075979420 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:28:27 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48686/tests/dromaeo/cssquery-ext.html) 11:28:28 INFO - PROCESS | 14218 | RSS: Main: 256102400 11:28:28 INFO - PROCESS | 14218 | 11:31:30 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-ext.html (next: http://localhost:48686/tests/dromaeo/cssquery-jquery.html) 11:31:31 INFO - PROCESS | 14218 | RSS: Main: 235474944 11:31:31 INFO - PROCESS | 14218 | 11:34:33 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48686/tests/dromaeo/cssquery-mootools.html) 11:34:33 INFO - PROCESS | 14218 | RSS: Main: 228147200 11:34:33 INFO - PROCESS | 14218 | 11:37:35 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48686/tests/dromaeo/cssquery-prototype.html) 11:37:36 INFO - PROCESS | 14218 | RSS: Main: 218673152 11:37:36 INFO - PROCESS | 14218 | 11:40:38 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48686/tests/dromaeo/cssquery-yui.html) 11:40:39 INFO - PROCESS | 14218 | RSS: Main: 216535040 11:40:39 INFO - PROCESS | 14218 | 11:43:42 INFO - PROCESS | 14218 | Cycle 1(1): loaded http://localhost:48686/tests/dromaeo/cssquery-yui.html (next: http://localhost:48686/tests/dromaeo/cssquery-dojo.html) 11:43:42 INFO - PROCESS | 14218 | RSS: Main: 259207168 11:43:42 INFO - PROCESS | 14218 | 11:43:42 INFO - PROCESS | 14218 | __start_tp_report 11:43:42 INFO - PROCESS | 14218 | _x_x_mozilla_page_load 11:43:42 INFO - PROCESS | 14218 | _x_x_mozilla_page_load_details 11:43:42 INFO - PROCESS | 14218 | |i|pagename|runs| 11:43:42 INFO - PROCESS | 14218 | |0;dojo.html;3455.084402633302;3456.170519075421;3462.5498685170933;3484.7386446016553;3497.877574284899;5692.715364231793;5736.942630573693;5740.167675687023;5753.309602847654;5779.21980532628;5730.713464326788;5788.82633520994;5792.942070579293;5795.710214489269;5801.129830525413;5087.7710503027265;5141.999999999991;5209.895802083956;5293;5293.788248470076;5146.253793199984;5258.526732594066;5316.840494785162;5320.574354051667;5322.04203243416;5190.7664155112925;5234.528892399683;5235.319408476912;5262.947370526284;5267.499587539197;5309.654872433318;5318;5327.840164795062;5334.493223143814;5354.41101478837;5127.615428842814;5130.333056702642;5168.5606723428555;5256.474352564751;5272.103742363769;5630.887382252373;5650.7174641267775;5651.06757385031;5653.745581448845;5684.516816070639;6204.720787564525;6208.472279856218;6210.1616281801835;6218.968905155445;6220.564560480768;6126.846828829315;6130.122981477949;6160;6231.158793562857;6244.656543890084;5825.621334613279;5839.620424672383;5853.619514731571;5855.238818953594;5867.941320586782;6128.142060111588;6351.428371446592;6364.872702546016;6371.267304259976;6373.139626150503;6021.2774467063355;6062.302835173923;6092.99465588173;6128.724207410677;6131.467133216695;6174.845628859314;6192.535559833031;6194.690265486708;6195.907061394083;6199.535034872402;5954.55340849438;6083.11794789753;6142.477889379453;6144.109104179958;6148.1392605035335;6109.712033285858;6173.660448675366;6185.938140618537;6191.226096737908;6193.6903154842075;4647;4656.185167595657;4692.601128904082;4698.788554515055;4727.267273572602;4143.627073563393;4155.439015732837;4190.790460476964;4193.811278492414;4210.978945105316;5995.61028533144;5996.310424301261;5998.790042348584;6005.759769609254;6018.187544681499;6281.309056003836;6298.244210694746;6301.464375528039;6304.3695630437505;6308.432241098231;5760.395158508296;5776.913346299809;5798.8550286242335;5802.274715660543;5964.761409543569;5257.421683614799;5258.158694608845;5259.658122222043;5265.262863199156;5267.762950667229;6384.457321127757;6394.616323020634;6395.840103997344;6396.200474940632;6399.072134540465;6078.422549857756;6125.662799505776;6151.0773383992755;6180.783672571439;6253.343398943045;6472.255690595453;6484.643344616092;6492.383223593751;6495.675216239264;6503.902441463477;5943.881122377442;6111.5110791137495;6148.815535533941;6153.230846144232;6165.229346331708;6073.149759033827;6093.421124993119;6123.601965872204;6143.120362531818;6177.81466556004;5975.193348898017;5976.252968378953;5979.3123790762875;5984.31180414258;6015.909761353496;5916.378780228014;5950;6006;6007.849803754941;6013.218281623361;5862.853428664147;5925.40745925404;5958.374370691015;5963.254593175853;5985.730642121028;6058.4244496772735;6076.058210977306;6080.606166346836;6114.510839132948;6122.938770612237;5844.795432159854;5847.298324201123;5871.530277577698;5940.405959404025;5959.821205363846 11:43:42 INFO - PROCESS | 14218 | |1;ext.html;555.8054680861699;585.8359659295397;612.3539665652736;673.7103045690358;680.2211467869292;34054.82972585137;44466.555334446646;45152.774236128775;45159;45192.77403612986;47966.52033479664;48436.2734558981;48444.51555484444;48533.27200092001;48561.51438485614;8384.622691978875;9131.406458580188;9261.351705380626;9264.21254193391;10534.683959481228;10608.151347892188;10970.451477426137;10975.396353200571;10978.505967231495;10982.560697572088;10985.231033827635;11033.503492342823;11042.668719938414;11055.72360690985;11058.612948546803;10942.890571094347;10946.671599852018;11010.229283950086;11027.558897644165;11032.338059716363;11000.394978276192;11073.446327683665;11075.335479871153;11084.279521831055;11088.722781930517;43744.03151858174;43988.78005609984;44091;44119.33820992688;44137.77931110324;3832.3485007548506;3914.2171565686976;3991.2017596480528;4120.464339635828;4305;33680.49479257813;34438.139046523786;34724.305513889834;34807.651923480946;35249.1187720309;4703.052710566469;4730.645201609858;4741.857744267678;4910.7299098549565;4917.803287868481;384258;384845;385498;386104;387316.9999999972;38744.418833717515;39884.601153988086;62552.68723656353;62724.372756272765;63058.684706576176;40788.38817417741;40871.38692919609;40939.1812163755;41025.1794964099;41035.38446923299;16111.758323625156;16159.67680646404;16168.514944551447;16172.433964811175;16199;12198.817017744741;13992.370343334574;14383.640408989859;14386.712265754835;14611.78082328766;9328.300377471716;9342.392744471588;9366.063393660716;9402.95298523503;9417.952910235404;3503.404421248394;3531.1878267998504;3570.91072723184;3574.5531808523933;3637.399829028234;1087.7008822573698;1095.1348434736628;1125.7410795517078;1160.2864238493266;1161.2103769436865;33949.32101357959;34100.76042775932;34547.65452345495;34736.131596709776;34745.30509389798;1131.9434028298717;1164.4468877283223;1177.1465687376583;1260.5021016698354;1260.8540501962693;17192;17569.297228110732;17806.46580602584;17809.46571602854;17905.820941790676;584824;590418;590986;592007;593318;64727;65092.34907650958;65238.673806630664;65301.34698652953;65499.34500655028;1355.7762969110183;1413.1803553938691;1455.9636009099856;1461.6857375664283;1482.8591283828018;34229.48655770116;34529.30941381108;34899.062546501074;35181.82409087938;35482.46776298306;54644.18033729418;55223.72388138194;55246.723766380914;55277.72361138168;55325.44674553203;417795;420214;421412.78587214963;422215;422595;30210.395792084473;31403.371932561677;31438.842805785825;31488;31515.842420788667;52010.73994630154;52740.47259527355;53093;53143.93712125658;54129.18806217831;44519.27933995602;44992.77503612461;45369.77315113403;45490.31764523469;46738.29892551546;43836.780816096994;43863.34204986991;44216.77891610521;44505;45581.77209113933;43963.56036439595;44204.557954420045;45073.32390014218;45126.54873451223;45255.54744452513;39147.41278880876;39858.60141398549;40163.79918100391;40174.397384038675;40216.79891600523;29688.851555742083;29854.064076237773;29980.700192997792;30019.54970675398;30138.84930575333 11:43:42 INFO - PROCESS | 14218 | |2;jquery.html;413.25820152825673;416.48979999500614;427.94436723225976;429.15884865663315;434.7695721267728;18884;19851.60296794063;20449.591008179847;21037.36887893362;21185.788142118574;19698.32564232042;20390.388288351372;20425.591488170227;20776;20821;5559.638623489471;5779.711014449261;5855.590108692393;5856.238688970428;5857.502112320458;4170.124273902484;4555.954440455603;5673.6879471629045;5757.539396848263;6383;6369.554131210817;6430.421262086411;6478.449331806779;6490.123833282493;6516.380943810354;6304.432601065926;6393.552451328409;6445.387688169616;6474.255460622042;6475.417212450879;5680.3467601225975;5707.229524014247;5716.857078573069;5724.112762521816;5724.685142317171;21640.350789476342;23043.884780576158;24387;24467.265982020566;24563.263102106965;2334.498082912165;2660.401409682825;2777.2084955787504;2782.833030018185;2859.9857000714865;10458.163346932228;10639.627613033585;10659.093977011964;10993.285436446606;11101.611443599435;2104.305579158874;2125.87244765313;2168.967465488019;2187.059564387329;2289.187338494827;80088;84088.57955710244;84127.5793621028;84978.57510712407;85166.14833851645;11815.11386646005;11818.822717659243;11839.28964262147;11949.522019119138;12078.577249796215;16857.83142168587;16924.238409271613;16947.152642367833;16961.575960601083;16965;8545.102764209669;8614.39699221061;8657.740267791976;8714.694985675598;8818.95590522056;8171;8301.045379781282;8304.294134998472;8403;8428.4942903426;5030.748462576857;5071.568916642127;5104.9744751276;5138.768755406016;5143.305653736773;1764.5170101931749;1968.6062787442568;2003.719479272903;2049.610573990937;2150.4408853697837;489.75757000285085;501.0330062978414;960.2893858544627;1062.4528367890543;1095.5617752898745;11873.525058997544;18975.62048759017;21553.892230538746;21736.239231626816;21755.67366489504;1039.6828967165088;1081.91344692426;1096.7696783675517;1115.2416356877238;1115.5649296774266;11107.333559986426;11242.66272011841;11261.718457038476;11272.985431311057;11309.038731707897;499547;515345;515866;515871;545800;64522.35477645163;91261.54369228112;99555.50222248843;100247;102319.48840255752;1105.2649987758211;1115.5426275227119;1125.3866642679595;1129.8870112988636;1136.5453818472677;17776.555586109935;17942.820571794637;18402.815971840646;18510.16704248339;18612.25550978;41983.790081049396;42520.78739606282;43146.13707725765;43981.56018439775;44159;57021.714891425276;59908.400915990285;61352.69323653353;62076;62234.688826555575;8729.956350218208;9190.862137067816;9218.170364667212;9272.536373181449;9382.343235973689;13374;13590.388432520362;13713.520026799015;13857.237851918242;13937.233452160228;11909.76180476403;12046.036317094786;12149.939250303692;12185.51257949672;12231.449584768885;11854.881451185378;11883.881161188277;12113.515459381879;12396.938015309866;12420.565280215149;12130.33283169434;12348.197367171106;12403.75192496163;12483.500659973499;12501.124921255425;8896.510691912006;8942.86585701228;9105.544722763703;9107.225885799517;9180.6786762463;10626.36241825493;11945.16383853122;11948.641540753792;12364.44360003784;12442 11:43:42 INFO - PROCESS | 14218 | |3;mootools.html;1439.1437094928526;1581.320032386074;1631.6084139806446;1668.1325710630472;1720.9139543022854;9274.072592740722;9634.566444509996;9667.22662187026;9982.85025724613;9985.101340879319;9583.712488625335;9788.510574471265;9790.216782657388;9793.314467987244;9793.461359625218;2474.6659201007906;2494.1270555305587;2504.273760609421;2517.509085728284;2517.6601158843505;2430.307362401716;2529.3676580854785;2536.3025168078834;2538.4542323400465;2542.8601426921514;2472.3695457658364;2473.4558397152687;2518.584433568459;2527.241827451757;2528;2381.9642705359433;2413.1674572272536;2424.5878200705924;2437.0982736387473;2437.7805997460314;2363.988180059106;2376.322748016807;2384.523095380931;2385.0817435287368;2431.878406079689;9620.086091821266;9730.270229732727;9765.316427850054;9769.706908792748;9873.753156171082;5911.438413350725;6051.213342265477;6052.243469566304;6053.545984051214;6057.212562366908;3653.3971894637352;3738.420544815558;3744.236486452948;3765.1151979284846;3802.9619703802887;1152.4180288954108;1156.242661057009;1188.5245901639414;1202.9458674359676;1212.933288669123;14350.569482915529;14403.567892963229;14447.133172009608;14455.927720361437;14462.855371446256;5028.622853285945;5063.797448102108;5162.6128040397125;5167.61242906776;5172.508611681884;11023.83464248037;11060.115190784878;11072.39101849406;11083.944580277208;11090.722731931604;5882.941170588325;5883.02930016551;5885.5585831062845;5888.9705551472825;5894.086416605433;4807.567318941312;5297.629165958346;5327.920081198785;5431.565474762009;5459.099248624012;4129.359949207817;4164.416981622575;4176.164767046603;4178.895527611834;4189.811458484375;1187.3350923482876;1195.874433184503;1204.590439250659;1205.3370646144585;1209.0992210803008;926.6432423516994;994.9452780097164;1034.3018462537757;1120.0591503137405;1134.5802053240188;6588.176477940257;6761.560498567577;6772.55978361405;6793.354631310018;6869.126896503518;505.79515296305055;506.2937202602349;508.15392371700705;508.8956763863399;520.8828013696888;4553.203189441834;4592.586667199968;4637.234856248681;4704.741239231875;4713.10451014313;12458.81311780324;12838.935805320914;12860.485580576673;12920.22478651284;12929.418176182095;11881.762364752656;12287.508499660093;12297.44661490235;12430;12634.178778379375;9113.316501262432;9281.350305478687;9290.070992900792;9292.070792920655;9304.8604270936;6699.564528305645;6902.413294869993;6916.619585922823;6924.896126558005;7059.5764254144915;11327.207095503236;11366.261193022427;11526;11894.583689570823;11915.582954596548;11651.12616553745;11880.584179553674;11890;11993.280403175837;12006.159568830448;8049.637766300648;8603.827923441371;8617.181367770303;8797.472151670665;8820.382573219813;9802.607895684092;9829;9838.114569688476;9869.555869986012;9889.357191782512;8545.316374689886;8593.097724738813;8628.956855215683;8853.867191991996;8984.82030359376;8214.05538363096;8299.6680132794;8319.958400207961;8324.458910170819;8423.747287581382;7896.32881205104;7956.283934445928;8012.639431225492;8013.6794528218215;8018.879716804136;5737.454941780524;5753.367129615655;5806.216160818235;5867.765289388547;5929.703514824155;5668.971655141698;5782.190493331022;5825.563082768894;5852.3269823969085;5940.257467816523 11:43:42 INFO - PROCESS | 14218 | |4;prototype.html;348.1661420896952;351.9630438803925;357.1161375595401;363.6091201957896;363.7944561322854;5662.292213473316;5680.437879583112;5728.255326807509;5749.540036797057;5817.796377126801;5325.733713314328;5455.563554915607;5473.534749546284;5480.561555075595;5642.489092353904;4225.387318838767;4322.416473776031;4358.869233922987;4391.297392417214;4393;4328.2209202343565;4331.7184383015165;4349.630281426083;4354.455693038371;4361.738295702252;4118.238125946709;4297.720648157875;4333.328334108218;4346.413234213388;4369.798305465991;4293.463317085364;4327.956720432819;4330.437043184397;4348;4352.020795321059;3829.2915810574855;3829.8276577554075;3838.4626152338697;3877.263319969197;3879.4180872869297;5285.365756109291;5414.187871819219;5421.620486565942;5477.863053423656;5527.309086364205;4973.751312434364;5031.138478762845;5035.647504674675;5035.949640503622;5049.772760225798;5945.524358051345;5958;5964.761409543613;5970.701464926779;6026.728797204137;4045.271851066807;4178.704601573522;4234.30134027885;4252.468441444819;4263.552327005651;6143.232095988002;6151.354107818659;6152.692365381713;6156.6921653917125;6185.195924529782;4367.45406824147;4375.693701440869;4377.277749171351;4378.277584198571;4385.386045953569;4116.794160291974;4302.9569704303185;4313.762743049162;4320.243957307459;4437.667174961891;4899.779509922062;4923.892124272082;4929.802807887716;4946.233333833262;4965.8013679452415;5903.76384944606;5905.494099004726;5917.733701983421;5927.769365695706;5955.493783028491;1420.3466405453607;1445.5302026841318;1455.9199244041467;1461.1087236785552;1521.2773932382252;906.9455832650062;998.8152191844532;1021.8313978193515;1037.1547189041057;1041.6666666666595;5698.857528561819;5715.914261286084;5735.770569177186;5769.336526299529;5799.217105690678;5881.588288819741;6011.27864656244;6038.879222415615;6081.726322315506;6084.30030546484;5634.183043458757;5646.520045796071;5661.782716715926;5674.829755107271;5681;3079.353335799507;3172.349668317989;3203.727683146912;3222.5166225066428;3223.274763178313;6187.566870319124;6190;6245.344238854855;6247.12586224131;6257.374262573706;6096.268447786205;6097.176881120992;6099;6128.846778830476;6177.536684748662;5914.556408269397;6217.937820621826;6254;6266.154069200599;6303.212098487781;5886.941130588811;5967.134765458897;6022.819315420545;6033.577649564489;6061.72722227492;5659.943400565941;5911.733971971185;5913.102579735984;5922.496587790086;5958.165856779968;6101.328853825987;6170.969145154246;6179.907301390573;6206.565540412128;6226.59527130735;4260.890859024803;4272.10285839977;4322.178786030644;4342.3703562982555;4351.695381323404;5884.382139875252;5996.609444833787;5999.520038397005;6004.279486461653;6051;5808.51882769891;5815.476607105381;5823.330317013429;5859.472647461749;5872.765089396376;5495.835124946258;5802.216700745515;5859.296884373732;5871.588988770916;5896.17453556511;5732.541396688338;5819.70901454934;5825.825225243249;5842.7078646066675;5854.912176317273;5929.258842644669;5932.970335148297;5944;5970.373110823301;5980.312264089685;5605.383407825218;5796.565257605781;5840.240768700211;5844.1525978732;5853.765849365977 11:43:42 INFO - PROCESS | 14218 | |5;yui.html;786.2805532937363;794.3565711773467;854.8589482735349;923.8198551282499;931.9534023298836;15826.604334891634;16879.746803797938;17012.574685632866;17200.225989830455;17532.64934701305;16239.756403653924;16321.428749993753;16377.181140942965;16424.589385265375;16464.259108340124;735.2059775442509;868.9913100869005;890.1365675294953;903.2999425445266;906.4515967839461;900.2303030908577;900.5002223765807;904.2720609909021;904.9185573298402;905.1310741687987;948.0993056596227;948.3124734567452;949.0699114867434;950.2303134461108;950.5722424908785;776.1501156233915;907.7276816954887;938.2728385501291;941.0824446165003;947.824652439301;696.7352406085706;696.9303069693041;697.159922293635;697.7418355208555;697.7453229571221;16327.51017469466;16328.183590820412;16333.91833040839;16364.427245046367;16383.508494745176;14633.122012679274;14784.556463306011;14937.775933361008;15071.397144114222;15087;13727.313634318343;14002.229877356742;14083.155010699391;14109.929450352785;14658.926705366404;4662.277347011219;4751.881202969919;4788.832390866338;4836.903261934777;4938.925916111261;77415.22584774137;77466;77467;80582.59708701419;81379.18620813717;10565.313254638424;10617.84073238902;10670.573177072985;11816.46825892837;12573.308468034164;22360.217392391187;22629.094836206696;22665.773342266697;22720.545589088124;22764.772352276264;8531.146885311544;8633.568321583896;8685.652573896974;8762.430442021248;8807.647694092293;4516.88707782308;4744.810207591727;4763.45220299663;4818.253170758538;4899.118158731462;3782.583915769263;3823.4073718573663;3892;3937.645611894943;3943.38877473992;659.9803303895493;660.9074729537869;671.4024518178825;673.9696713647897;676.5703778100843;688.8932215506604;689.4622194688151;690.5062880040795;696.4010950582496;710.9395701365338;9896.307258491837;10092.44491552957;10157.94921025405;10165.44090075053;10260.230482713678;636.7739452494391;657.4477438951304;724.5688815154974;725.8004048886493;737.306931484403;4584.564466375689;5075.365579302587;5126.92309615356;5241.842744717665;5270.446603106695;80734.19265807267;81022.59488702519;81202.59398702969;125846.3707681474;126078.36960815138;69976.6501167491;73497.89753153706;107345;108182;108323;92750.53624731969;93214.53392732993;96391.51804241074;96719;98030;10018.699439016842;10075.798484030425;10361.171106311627;10367.118794902517;10405.427701476492;54204.915901682536;54975;54993.1751023727;55420.44579554153;56088.43911560995;80656.59671701604;82236.58881705553;85077.57461212654;85264.1473585281;85882.57058714666;12537.373131343214;12839.165454245818;12841.422136003715;13087.934560327138;13197;11567.248128871597;14414.42342306338;14488;14515.709685806014;14670.413183472541;12183.147179697336;12542.623721288375;12562.120651554304;12684.682882928;13064.673383165496;12462.937685311515;12901.225926444444;12913.612591622266;13247.138935969131;13399.598012059654;12934.353282335658;13049.412776424893;13149.671258218621;13219;13261.801072984106;10392.324498907547;10454.372737635766;10641.201909856636;10877.945610271898;11108.666739997812;11015.559377624806;11169.776604468028;11346.262492937933;11374.146938979775;11452.713682158013 11:43:42 INFO - PROCESS | 14218 | __end_tp_report 11:43:42 INFO - PROCESS | 14218 | __start_cc_report 11:43:42 INFO - PROCESS | 14218 | _x_x_mozilla_cycle_collect,907 11:43:42 INFO - PROCESS | 14218 | __end_cc_report 11:43:42 INFO - PROCESS | 14218 | __startTimestamp1470077022251__endTimestamp 11:43:42 INFO - PROCESS | 14218 | 11:43:42 INFO - PROCESS | 14218 | ------- Summary: start ------- 11:43:42 INFO - PROCESS | 14218 | Number of tests: 6 11:43:42 INFO - PROCESS | 14218 | 11:43:42 INFO - PROCESS | 14218 | [#0] dojo.html Cycles:165 Average:5739.05 Median:5964.76 stddev:647.65 (10.9%) stddev-sans-first:624.36 11:43:42 INFO - PROCESS | 14218 | Values: 3455.1 3456.2 3462.5 3484.7 3497.9 5692.7 5736.9 5740.2 5753.3 5779.2 5730.7 5788.8 5792.9 5795.7 5801.1 5087.8 5142.0 5209.9 5293.0 5293.8 5146.3 5258.5 5316.8 5320.6 5322.0 5190.8 5234.5 5235.3 5262.9 5267.5 5309.7 5318.0 5327.8 5334.5 5354.4 5127.6 5130.3 5168.6 5256.5 5272.1 5630.9 5650.7 5651.1 5653.7 5684.5 6204.7 6208.5 6210.2 6219.0 6220.6 6126.8 6130.1 6160.0 6231.2 6244.7 5825.6 5839.6 5853.6 5855.2 5867.9 6128.1 6351.4 6364.9 6371.3 6373.1 6021.3 6062.3 6093.0 6128.7 6131.5 6174.8 6192.5 6194.7 6195.9 6199.5 5954.6 6083.1 6142.5 6144.1 6148.1 6109.7 6173.7 6185.9 6191.2 6193.7 4647.0 4656.2 4692.6 4698.8 4727.3 4143.6 4155.4 4190.8 4193.8 4211.0 5995.6 5996.3 5998.8 6005.8 6018.2 6281.3 6298.2 6301.5 6304.4 6308.4 5760.4 5776.9 5798.9 5802.3 5964.8 5257.4 5258.2 5259.7 5265.3 5267.8 6384.5 6394.6 6395.8 6396.2 6399.1 6078.4 6125.7 6151.1 6180.8 6253.3 6472.3 6484.6 6492.4 6495.7 6503.9 5943.9 6111.5 6148.8 6153.2 6165.2 6073.1 6093.4 6123.6 6143.1 6177.8 5975.2 5976.3 5979.3 5984.3 6015.9 5916.4 5950.0 6006.0 6007.8 6013.2 5862.9 5925.4 5958.4 5963.3 5985.7 6058.4 6076.1 6080.6 6114.5 6122.9 5844.8 5847.3 5871.5 5940.4 5959.8 11:43:42 INFO - PROCESS | 14218 | 11:43:42 INFO - PROCESS | 14218 | [#1] ext.html Cycles:180 Average:62952.63 Median:39503.01 stddev:125858.11 (318.6%) stddev-sans-first:126123.99 11:43:42 INFO - PROCESS | 14218 | Values: 555.8 585.8 612.4 673.7 680.2 34054.8 44466.6 45152.8 45159.0 45192.8 47966.5 48436.3 48444.5 48533.3 48561.5 8384.6 9131.4 9261.4 9264.2 10534.7 10608.2 10970.5 10975.4 10978.5 10982.6 10985.2 11033.5 11042.7 11055.7 11058.6 10942.9 10946.7 11010.2 11027.6 11032.3 11000.4 11073.4 11075.3 11084.3 11088.7 43744.0 43988.8 44091.0 44119.3 44137.8 3832.3 3914.2 3991.2 4120.5 4305.0 33680.5 34438.1 34724.3 34807.7 35249.1 4703.1 4730.6 4741.9 4910.7 4917.8 384258.0 384845.0 385498.0 386104.0 387317.0 38744.4 39884.6 62552.7 62724.4 63058.7 40788.4 40871.4 40939.2 41025.2 41035.4 16111.8 16159.7 16168.5 16172.4 16199.0 12198.8 13992.4 14383.6 14386.7 14611.8 9328.3 9342.4 9366.1 9403.0 9418.0 3503.4 3531.2 3570.9 3574.6 3637.4 1087.7 1095.1 1125.7 1160.3 1161.2 33949.3 34100.8 34547.7 34736.1 34745.3 1131.9 1164.4 1177.1 1260.5 1260.9 17192.0 17569.3 17806.5 17809.5 17905.8 584824.0 590418.0 590986.0 592007.0 593318.0 64727.0 65092.3 65238.7 65301.3 65499.3 1355.8 1413.2 1456.0 1461.7 1482.9 34229.5 34529.3 34899.1 35181.8 35482.5 54644.2 55223.7 55246.7 55277.7 55325.4 417795.0 420214.0 421412.8 422215.0 422595.0 30210.4 31403.4 31438.8 31488.0 31515.8 52010.7 52740.5 53093.0 53143.9 54129.2 44519.3 44992.8 45369.8 45490.3 46738.3 43836.8 43863.3 44216.8 44505.0 45581.8 43963.6 44204.6 45073.3 45126.5 45255.5 39147.4 39858.6 40163.8 40174.4 40216.8 29688.9 29854.1 29980.7 30019.5 30138.8 11:43:42 INFO - PROCESS | 14218 | 11:43:42 INFO - PROCESS | 14218 | [#2] jquery.html Cycles:180 Average:30346.47 Median:12689.19 stddev:85401.69 (673.0%) stddev-sans-first:85611.69 11:43:42 INFO - PROCESS | 14218 | Values: 413.3 416.5 427.9 429.2 434.8 18884.0 19851.6 20449.6 21037.4 21185.8 19698.3 20390.4 20425.6 20776.0 20821.0 5559.6 5779.7 5855.6 5856.2 5857.5 4170.1 4556.0 5673.7 5757.5 6383.0 6369.6 6430.4 6478.4 6490.1 6516.4 6304.4 6393.6 6445.4 6474.3 6475.4 5680.3 5707.2 5716.9 5724.1 5724.7 21640.4 23043.9 24387.0 24467.3 24563.3 2334.5 2660.4 2777.2 2782.8 2860.0 10458.2 10639.6 10659.1 10993.3 11101.6 2104.3 2125.9 2169.0 2187.1 2289.2 80088.0 84088.6 84127.6 84978.6 85166.1 11815.1 11818.8 11839.3 11949.5 12078.6 16857.8 16924.2 16947.2 16961.6 16965.0 8545.1 8614.4 8657.7 8714.7 8819.0 8171.0 8301.0 8304.3 8403.0 8428.5 5030.7 5071.6 5105.0 5138.8 5143.3 1764.5 1968.6 2003.7 2049.6 2150.4 489.8 501.0 960.3 1062.5 1095.6 11873.5 18975.6 21553.9 21736.2 21755.7 1039.7 1081.9 1096.8 1115.2 1115.6 11107.3 11242.7 11261.7 11273.0 11309.0 499547.0 515345.0 515866.0 515871.0 545800.0 64522.4 91261.5 99555.5 100247.0 102319.5 1105.3 1115.5 1125.4 1129.9 1136.5 17776.6 17942.8 18402.8 18510.2 18612.3 41983.8 42520.8 43146.1 43981.6 44159.0 57021.7 59908.4 61352.7 62076.0 62234.7 8730.0 9190.9 9218.2 9272.5 9382.3 13374.0 13590.4 13713.5 13857.2 13937.2 11909.8 12046.0 12149.9 12185.5 12231.4 11854.9 11883.9 12113.5 12396.9 12420.6 12130.3 12348.2 12403.8 12483.5 12501.1 8896.5 8942.9 9105.5 9107.2 9180.7 10626.4 11945.2 11948.6 12364.4 12442.0 11:43:42 INFO - PROCESS | 14218 | 11:43:42 INFO - PROCESS | 14218 | [#3] mootools.html Cycles:180 Average:6500.06 Median:506.04 stddev:3835.45 (757.9%) stddev-sans-first:3827.35 11:43:42 INFO - PROCESS | 14218 | Values: 1439.1 1581.3 1631.6 1668.1 1720.9 9274.1 9634.6 9667.2 9982.9 9985.1 9583.7 9788.5 9790.2 9793.3 9793.5 2474.7 2494.1 2504.3 2517.5 2517.7 2430.3 2529.4 2536.3 2538.5 2542.9 2472.4 2473.5 2518.6 2527.2 2528.0 2382.0 2413.2 2424.6 2437.1 2437.8 2364.0 2376.3 2384.5 2385.1 2431.9 9620.1 9730.3 9765.3 9769.7 9873.8 5911.4 6051.2 6052.2 6053.5 6057.2 3653.4 3738.4 3744.2 3765.1 3803.0 1152.4 1156.2 1188.5 1202.9 1212.9 14350.6 14403.6 14447.1 14455.9 14462.9 5028.6 5063.8 5162.6 5167.6 5172.5 11023.8 11060.1 11072.4 11083.9 11090.7 5882.9 5883.0 5885.6 5889.0 5894.1 4807.6 5297.6 5327.9 5431.6 5459.1 4129.4 4164.4 4176.2 4178.9 4189.8 1187.3 1195.9 1204.6 1205.3 1209.1 926.6 994.9 1034.3 1120.1 1134.6 6588.2 6761.6 6772.6 6793.4 6869.1 505.8 506.3 508.2 508.9 520.9 4553.2 4592.6 4637.2 4704.7 4713.1 12458.8 12838.9 12860.5 12920.2 12929.4 11881.8 12287.5 12297.4 12430.0 12634.2 9113.3 9281.4 9290.1 9292.1 9304.9 6699.6 6902.4 6916.6 6924.9 7059.6 11327.2 11366.3 11526.0 11894.6 11915.6 11651.1 11880.6 11890.0 11993.3 12006.2 8049.6 8603.8 8617.2 8797.5 8820.4 9802.6 9829.0 9838.1 9869.6 9889.4 8545.3 8593.1 8629.0 8853.9 8984.8 8214.1 8299.7 8320.0 8324.5 8423.7 7896.3 7956.3 8012.6 8013.7 8018.9 5737.5 5753.4 5806.2 5867.8 5929.7 5669.0 5782.2 5825.6 5852.3 5940.3 11:43:42 INFO - PROCESS | 14218 | 11:43:42 INFO - PROCESS | 14218 | [#4] prototype.html Cycles:180 Average:4948.43 Median:5677.63 stddev:1461.53 (25.7%) stddev-sans-first:1424.26 11:43:42 INFO - PROCESS | 14218 | Values: 348.2 352.0 357.1 363.6 363.8 5662.3 5680.4 5728.3 5749.5 5817.8 5325.7 5455.6 5473.5 5480.6 5642.5 4225.4 4322.4 4358.9 4391.3 4393.0 4328.2 4331.7 4349.6 4354.5 4361.7 4118.2 4297.7 4333.3 4346.4 4369.8 4293.5 4328.0 4330.4 4348.0 4352.0 3829.3 3829.8 3838.5 3877.3 3879.4 5285.4 5414.2 5421.6 5477.9 5527.3 4973.8 5031.1 5035.6 5035.9 5049.8 5945.5 5958.0 5964.8 5970.7 6026.7 4045.3 4178.7 4234.3 4252.5 4263.6 6143.2 6151.4 6152.7 6156.7 6185.2 4367.5 4375.7 4377.3 4378.3 4385.4 4116.8 4303.0 4313.8 4320.2 4437.7 4899.8 4923.9 4929.8 4946.2 4965.8 5903.8 5905.5 5917.7 5927.8 5955.5 1420.3 1445.5 1455.9 1461.1 1521.3 906.9 998.8 1021.8 1037.2 1041.7 5698.9 5715.9 5735.8 5769.3 5799.2 5881.6 6011.3 6038.9 6081.7 6084.3 5634.2 5646.5 5661.8 5674.8 5681.0 3079.4 3172.3 3203.7 3222.5 3223.3 6187.6 6190.0 6245.3 6247.1 6257.4 6096.3 6097.2 6099.0 6128.8 6177.5 5914.6 6217.9 6254.0 6266.2 6303.2 5886.9 5967.1 6022.8 6033.6 6061.7 5659.9 5911.7 5913.1 5922.5 5958.2 6101.3 6171.0 6179.9 6206.6 6226.6 4260.9 4272.1 4322.2 4342.4 4351.7 5884.4 5996.6 5999.5 6004.3 6051.0 5808.5 5815.5 5823.3 5859.5 5872.8 5495.8 5802.2 5859.3 5871.6 5896.2 5732.5 5819.7 5825.8 5842.7 5854.9 5929.3 5933.0 5944.0 5970.4 5980.3 5605.4 5796.6 5840.2 5844.2 5853.8 11:43:42 INFO - PROCESS | 14218 | 11:43:42 INFO - PROCESS | 14218 | [#5] yui.html Cycles:180 Average:21123.68 Median:4623.42 stddev:29912.60 (647.0%) stddev-sans-first:29957.53 11:43:42 INFO - PROCESS | 14218 | Values: 786.3 794.4 854.9 923.8 932.0 15826.6 16879.7 17012.6 17200.2 17532.6 16239.8 16321.4 16377.2 16424.6 16464.3 735.2 869.0 890.1 903.3 906.5 900.2 900.5 904.3 904.9 905.1 948.1 948.3 949.1 950.2 950.6 776.2 907.7 938.3 941.1 947.8 696.7 696.9 697.2 697.7 697.7 16327.5 16328.2 16333.9 16364.4 16383.5 14633.1 14784.6 14937.8 15071.4 15087.0 13727.3 14002.2 14083.2 14109.9 14658.9 4662.3 4751.9 4788.8 4836.9 4938.9 77415.2 77466.0 77467.0 80582.6 81379.2 10565.3 10617.8 10670.6 11816.5 12573.3 22360.2 22629.1 22665.8 22720.5 22764.8 8531.1 8633.6 8685.7 8762.4 8807.6 4516.9 4744.8 4763.5 4818.3 4899.1 3782.6 3823.4 3892.0 3937.6 3943.4 660.0 660.9 671.4 674.0 676.6 688.9 689.5 690.5 696.4 710.9 9896.3 10092.4 10157.9 10165.4 10260.2 636.8 657.4 724.6 725.8 737.3 4584.6 5075.4 5126.9 5241.8 5270.4 80734.2 81022.6 81202.6 125846.4 126078.4 69976.7 73497.9 107345.0 108182.0 108323.0 92750.5 93214.5 96391.5 96719.0 98030.0 10018.7 10075.8 10361.2 10367.1 10405.4 54204.9 54975.0 54993.2 55420.4 56088.4 80656.6 82236.6 85077.6 85264.1 85882.6 12537.4 12839.2 12841.4 13087.9 13197.0 11567.2 14414.4 14488.0 14515.7 14670.4 12183.1 12542.6 12562.1 12684.7 13064.7 12462.9 12901.2 12913.6 13247.1 13399.6 12934.4 13049.4 13149.7 13219.0 13261.8 10392.3 10454.4 10641.2 10877.9 11108.7 11015.6 11169.8 11346.3 11374.1 11452.7 11:43:42 INFO - PROCESS | 14218 | -------- Summary: end -------- 11:43:42 INFO - PROCESS | 14218 | 11:43:42 INFO - TEST-INFO | 14218: exit 0 11:43:43 INFO - TEST-OK | dromaeo_css | took 1112212ms 11:43:43 INFO - TEST-START | kraken 11:43:43 INFO - operating with platform_type : linux_ 11:43:43 INFO - Initialising browser for kraken test... 11:43:43 INFO - TEST-INFO | started process 14409 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ0GaO1/profile http://localhost:48686/getInfo.html) 11:43:46 INFO - PROCESS | 14409 | __metrics Screen width/height:1600/1200 11:43:46 INFO - PROCESS | 14409 | colorDepth:24 11:43:46 INFO - PROCESS | 14409 | Browser inner width/height: 1024/697 11:43:46 INFO - PROCESS | 14409 | __metrics 11:43:47 INFO - PROCESS | 14409 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:43:47 ERROR - PROCESS | 14409 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:43:48 INFO - TEST-INFO | 14409: exit 0 11:43:48 INFO - Browser initialized. 11:43:48 INFO - Running cycle 1/1 for kraken test... 11:43:48 INFO - TEST-INFO | started process 14499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ0GaO1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:00 INFO - PROCESS | 14499 | RSS: Main: 140312576 11:44:00 INFO - PROCESS | 14499 | 11:44:02 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48686/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:03 INFO - PROCESS | 14499 | RSS: Main: 191782912 11:44:03 INFO - PROCESS | 14499 | 11:44:06 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48686/tests/kraken/driver.html?testName=audio-dft) 11:44:06 INFO - PROCESS | 14499 | RSS: Main: 190476288 11:44:06 INFO - PROCESS | 14499 | 11:44:09 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48686/tests/kraken/driver.html?testName=audio-fft) 11:44:10 INFO - PROCESS | 14499 | RSS: Main: 277487616 11:44:10 INFO - PROCESS | 14499 | 11:44:12 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48686/tests/kraken/driver.html?testName=audio-oscillator) 11:44:12 INFO - PROCESS | 14499 | RSS: Main: 185872384 11:44:12 INFO - PROCESS | 14499 | 11:44:15 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48686/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:15 INFO - PROCESS | 14499 | RSS: Main: 186015744 11:44:15 INFO - PROCESS | 14499 | 11:44:18 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48686/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:19 INFO - PROCESS | 14499 | RSS: Main: 221495296 11:44:19 INFO - PROCESS | 14499 | 11:44:22 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48686/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:23 INFO - PROCESS | 14499 | RSS: Main: 220733440 11:44:23 INFO - PROCESS | 14499 | 11:44:25 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48686/tests/kraken/driver.html?testName=json-parse-financial) 11:44:26 INFO - PROCESS | 14499 | RSS: Main: 220737536 11:44:26 INFO - PROCESS | 14499 | 11:44:28 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48686/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:28 INFO - PROCESS | 14499 | RSS: Main: 198578176 11:44:28 INFO - PROCESS | 14499 | 11:44:30 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:31 INFO - PROCESS | 14499 | RSS: Main: 200871936 11:44:31 INFO - PROCESS | 14499 | 11:44:33 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:33 INFO - PROCESS | 14499 | RSS: Main: 207990784 11:44:33 INFO - PROCESS | 14499 | 11:44:36 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:36 INFO - PROCESS | 14499 | RSS: Main: 211873792 11:44:36 INFO - PROCESS | 14499 | 11:44:39 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:40 INFO - PROCESS | 14499 | RSS: Main: 211439616 11:44:40 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:48686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48686/tests/kraken/driver.html?testName=ai-astar) 11:44:41 INFO - PROCESS | 14499 | RSS: Main: 253665280 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | __start_tp_report 11:44:41 INFO - PROCESS | 14499 | _x_x_mozilla_page_load 11:44:41 INFO - PROCESS | 14499 | _x_x_mozilla_page_load_details 11:44:41 INFO - PROCESS | 14499 | |i|pagename|runs| 11:44:41 INFO - PROCESS | 14499 | |0;ai-astar;111;104;111;111;109;110;110;110;111;109 11:44:41 INFO - PROCESS | 14499 | |1;audio-beat-detection;154;123;130;181;124;132;154;130;161;123 11:44:41 INFO - PROCESS | 14499 | |2;audio-dft;160;162;161;159;159;160;159;161;160;161 11:44:41 INFO - PROCESS | 14499 | |3;audio-fft;75;74;75;107;75;75;75;75;103;75 11:44:41 INFO - PROCESS | 14499 | |4;audio-oscillator;85;83;117;84;84;84;122;84;84;121 11:44:41 INFO - PROCESS | 14499 | |5;imaging-gaussian-blur;117;116;116;117;117;116;116;117;116;116 11:44:41 INFO - PROCESS | 14499 | |6;imaging-darkroom;146;146;145;146;146;146;146;146;146;146 11:44:41 INFO - PROCESS | 14499 | |7;imaging-desaturate;95;95;94;94;94;95;94;95;94;94 11:44:41 INFO - PROCESS | 14499 | |8;json-parse-financial;53;52;50;51;51;52;54;50;51;56 11:44:41 INFO - PROCESS | 14499 | |9;json-stringify-tinderbox;60;59;60;59;60;59;59;59;60;61 11:44:41 INFO - PROCESS | 14499 | |10;stanford-crypto-aes;77;77;76;76;77;78;77;77;111;77 11:44:41 INFO - PROCESS | 14499 | |11;stanford-crypto-ccm;121;128;131;116;120;116;123;119;122;122 11:44:41 INFO - PROCESS | 14499 | |12;stanford-crypto-pbkdf2;160;161;154;161;154;154;153;152;152;159 11:44:41 INFO - PROCESS | 14499 | |13;stanford-crypto-sha256-iterative;66;65;62;61;62;62;62;68;60;60 11:44:41 INFO - PROCESS | 14499 | __end_tp_report 11:44:41 INFO - PROCESS | 14499 | __start_cc_report 11:44:41 INFO - PROCESS | 14499 | _x_x_mozilla_cycle_collect,1548 11:44:41 INFO - PROCESS | 14499 | __end_cc_report 11:44:41 INFO - PROCESS | 14499 | __startTimestamp1470077081916__endTimestamp 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | ------- Summary: start ------- 11:44:41 INFO - PROCESS | 14499 | Number of tests: 14 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.12 (1.9%) stddev-sans-first:2.19 11:44:41 INFO - PROCESS | 14499 | Values: 111.0 104.0 111.0 111.0 109.0 110.0 110.0 110.0 111.0 109.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:143.00 stddev:19.99 (14.0%) stddev-sans-first:20.66 11:44:41 INFO - PROCESS | 14499 | Values: 154.0 123.0 130.0 181.0 124.0 132.0 154.0 130.0 161.0 123.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.03 (0.6%) stddev-sans-first:1.09 11:44:41 INFO - PROCESS | 14499 | Values: 160.0 162.0 161.0 159.0 159.0 160.0 159.0 161.0 160.0 161.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.74 (17.0%) stddev-sans-first:13.33 11:44:41 INFO - PROCESS | 14499 | Values: 75.0 74.0 75.0 107.0 75.0 75.0 75.0 75.0 103.0 75.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.00 stddev:17.44 (20.8%) stddev-sans-first:18.13 11:44:41 INFO - PROCESS | 14499 | Values: 85.0 83.0 117.0 84.0 84.0 84.0 122.0 84.0 84.0 121.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:44:41 INFO - PROCESS | 14499 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 11:44:41 INFO - PROCESS | 14499 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:44:41 INFO - PROCESS | 14499 | Values: 95.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:1.89 (3.6%) stddev-sans-first:1.96 11:44:41 INFO - PROCESS | 14499 | Values: 53.0 52.0 50.0 51.0 51.0 52.0 54.0 50.0 51.0 56.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 11:44:41 INFO - PROCESS | 14499 | Values: 60.0 59.0 60.0 59.0 60.0 59.0 59.0 59.0 60.0 61.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:77.00 stddev:10.80 (14.0%) stddev-sans-first:11.39 11:44:41 INFO - PROCESS | 14499 | Values: 77.0 77.0 76.0 76.0 77.0 78.0 77.0 77.0 111.0 77.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.00 stddev:4.76 (3.9%) stddev-sans-first:5.04 11:44:41 INFO - PROCESS | 14499 | Values: 121.0 128.0 131.0 116.0 120.0 116.0 123.0 119.0 122.0 122.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:156.50 stddev:3.77 (2.4%) stddev-sans-first:3.71 11:44:41 INFO - PROCESS | 14499 | Values: 160.0 161.0 154.0 161.0 154.0 154.0 153.0 152.0 152.0 159.0 11:44:41 INFO - PROCESS | 14499 | 11:44:41 INFO - PROCESS | 14499 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.00 stddev:2.66 (4.3%) stddev-sans-first:2.55 11:44:41 INFO - PROCESS | 14499 | Values: 66.0 65.0 62.0 61.0 62.0 62.0 62.0 68.0 60.0 60.0 11:44:41 INFO - PROCESS | 14499 | -------- Summary: end -------- 11:44:41 INFO - PROCESS | 14499 | 11:44:42 INFO - TEST-INFO | 14499: exit 0 11:44:42 INFO - TEST-OK | kraken | took 59829ms 11:44:42 INFO - SUITE-END | took 1172s 11:44:43 INFO - Completed test suite (00:19:32) 11:44:43 INFO - javascript benchmark 11:44:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3455.084402633302, 3456.170519075421, 3462.5498685170933, 3484.7386446016553, 3497.877574284899, 5692.715364231793, 5736.942630573693, 5740.167675687023, 5753.309602847654, 5779.21980532628, 5730.713464326788, 5788.82633520994, 5792.942070579293, 5795.710214489269, 5801.129830525413, 5087.7710503027265, 5141.999999999991, 5209.895802083956, 5293.0, 5293.788248470076, 5146.253793199984, 5258.526732594066, 5316.840494785162, 5320.574354051667, 5322.04203243416, 5190.7664155112925, 5234.528892399683, 5235.319408476912, 5262.947370526284, 5267.499587539197, 5309.654872433318, 5318.0, 5327.840164795062, 5334.493223143814, 5354.41101478837, 5127.615428842814, 5130.333056702642, 5168.5606723428555, 5256.474352564751, 5272.103742363769, 5630.887382252373, 5650.7174641267775, 5651.06757385031, 5653.745581448845, 5684.516816070639, 6204.720787564525, 6208.472279856218, 6210.1616281801835, 6218.968905155445, 6220.564560480768, 6126.846828829315, 6130.122981477949, 6160.0, 6231.158793562857, 6244.656543890084, 5825.621334613279, 5839.620424672383, 5853.619514731571, 5855.238818953594, 5867.941320586782, 6128.142060111588, 6351.428371446592, 6364.872702546016, 6371.267304259976, 6373.139626150503, 6021.2774467063355, 6062.302835173923, 6092.99465588173, 6128.724207410677, 6131.467133216695, 6174.845628859314, 6192.535559833031, 6194.690265486708, 6195.907061394083, 6199.535034872402, 5954.55340849438, 6083.11794789753, 6142.477889379453, 6144.109104179958, 6148.1392605035335, 6109.712033285858, 6173.660448675366, 6185.938140618537, 6191.226096737908, 6193.6903154842075, 4647.0, 4656.185167595657, 4692.601128904082, 4698.788554515055, 4727.267273572602, 4143.627073563393, 4155.439015732837, 4190.790460476964, 4193.811278492414, 4210.978945105316, 5995.61028533144, 5996.310424301261, 5998.790042348584, 6005.759769609254, 6018.187544681499, 6281.309056003836, 6298.244210694746, 6301.464375528039, 6304.3695630437505, 6308.432241098231, 5760.395158508296, 5776.913346299809, 5798.8550286242335, 5802.274715660543, 5964.761409543569, 5257.421683614799, 5258.158694608845, 5259.658122222043, 5265.262863199156, 5267.762950667229, 6384.457321127757, 6394.616323020634, 6395.840103997344, 6396.200474940632, 6399.072134540465, 6078.422549857756, 6125.662799505776, 6151.0773383992755, 6180.783672571439, 6253.343398943045, 6472.255690595453, 6484.643344616092, 6492.383223593751, 6495.675216239264, 6503.902441463477, 5943.881122377442, 6111.5110791137495, 6148.815535533941, 6153.230846144232, 6165.229346331708, 6073.149759033827, 6093.421124993119, 6123.601965872204, 6143.120362531818, 6177.81466556004, 5975.193348898017, 5976.252968378953, 5979.3123790762875, 5984.31180414258, 6015.909761353496, 5916.378780228014, 5950.0, 6006.0, 6007.849803754941, 6013.218281623361, 5862.853428664147, 5925.40745925404, 5958.374370691015, 5963.254593175853, 5985.730642121028, 6058.4244496772735, 6076.058210977306, 6080.606166346836, 6114.510839132948, 6122.938770612237, 5844.795432159854, 5847.298324201123, 5871.530277577698, 5940.405959404025, 5959.821205363846], "value": 5696.315181530126, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.8054680861699, 585.8359659295397, 612.3539665652736, 673.7103045690358, 680.2211467869292, 34054.82972585137, 44466.555334446646, 45152.774236128775, 45159.0, 45192.77403612986, 47966.52033479664, 48436.2734558981, 48444.51555484444, 48533.27200092001, 48561.51438485614, 8384.622691978875, 9131.406458580188, 9261.351705380626, 9264.21254193391, 10534.683959481228, 10608.151347892188, 10970.451477426137, 10975.396353200571, 10978.505967231495, 10982.560697572088, 10985.231033827635, 11033.503492342823, 11042.668719938414, 11055.72360690985, 11058.612948546803, 10942.890571094347, 10946.671599852018, 11010.229283950086, 11027.558897644165, 11032.338059716363, 11000.394978276192, 11073.446327683665, 11075.335479871153, 11084.279521831055, 11088.722781930517, 43744.03151858174, 43988.78005609984, 44091.0, 44119.33820992688, 44137.77931110324, 3832.3485007548506, 3914.2171565686976, 3991.2017596480528, 4120.464339635828, 4305.0, 33680.49479257813, 34438.139046523786, 34724.305513889834, 34807.651923480946, 35249.1187720309, 4703.052710566469, 4730.645201609858, 4741.857744267678, 4910.7299098549565, 4917.803287868481, 384258.0, 384845.0, 385498.0, 386104.0, 387316.9999999972, 38744.418833717515, 39884.601153988086, 62552.68723656353, 62724.372756272765, 63058.684706576176, 40788.38817417741, 40871.38692919609, 40939.1812163755, 41025.1794964099, 41035.38446923299, 16111.758323625156, 16159.67680646404, 16168.514944551447, 16172.433964811175, 16199.0, 12198.817017744741, 13992.370343334574, 14383.640408989859, 14386.712265754835, 14611.78082328766, 9328.300377471716, 9342.392744471588, 9366.063393660716, 9402.95298523503, 9417.952910235404, 3503.404421248394, 3531.1878267998504, 3570.91072723184, 3574.5531808523933, 3637.399829028234, 1087.7008822573698, 1095.1348434736628, 1125.7410795517078, 1160.2864238493266, 1161.2103769436865, 33949.32101357959, 34100.76042775932, 34547.65452345495, 34736.131596709776, 34745.30509389798, 1131.9434028298717, 1164.4468877283223, 1177.1465687376583, 1260.5021016698354, 1260.8540501962693, 17192.0, 17569.297228110732, 17806.46580602584, 17809.46571602854, 17905.820941790676, 584824.0, 590418.0, 590986.0, 592007.0, 593318.0, 64727.0, 65092.34907650958, 65238.673806630664, 65301.34698652953, 65499.34500655028, 1355.7762969110183, 1413.1803553938691, 1455.9636009099856, 1461.6857375664283, 1482.8591283828018, 34229.48655770116, 34529.30941381108, 34899.062546501074, 35181.82409087938, 35482.46776298306, 54644.18033729418, 55223.72388138194, 55246.723766380914, 55277.72361138168, 55325.44674553203, 417795.0, 420214.0, 421412.78587214963, 422215.0, 422595.0, 30210.395792084473, 31403.371932561677, 31438.842805785825, 31488.0, 31515.842420788667, 52010.73994630154, 52740.47259527355, 53093.0, 53143.93712125658, 54129.18806217831, 44519.27933995602, 44992.77503612461, 45369.77315113403, 45490.31764523469, 46738.29892551546, 43836.780816096994, 43863.34204986991, 44216.77891610521, 44505.0, 45581.77209113933, 43963.56036439595, 44204.557954420045, 45073.32390014218, 45126.54873451223, 45255.54744452513, 39147.41278880876, 39858.60141398549, 40163.79918100391, 40174.397384038675, 40216.79891600523, 29688.851555742083, 29854.064076237773, 29980.700192997792, 30019.54970675398, 30138.84930575333], "value": 20642.900356443566, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.25820152825673, 416.48979999500614, 427.94436723225976, 429.15884865663315, 434.7695721267728, 18884.0, 19851.60296794063, 20449.591008179847, 21037.36887893362, 21185.788142118574, 19698.32564232042, 20390.388288351372, 20425.591488170227, 20776.0, 20821.0, 5559.638623489471, 5779.711014449261, 5855.590108692393, 5856.238688970428, 5857.502112320458, 4170.124273902484, 4555.954440455603, 5673.6879471629045, 5757.539396848263, 6383.0, 6369.554131210817, 6430.421262086411, 6478.449331806779, 6490.123833282493, 6516.380943810354, 6304.432601065926, 6393.552451328409, 6445.387688169616, 6474.255460622042, 6475.417212450879, 5680.3467601225975, 5707.229524014247, 5716.857078573069, 5724.112762521816, 5724.685142317171, 21640.350789476342, 23043.884780576158, 24387.0, 24467.265982020566, 24563.263102106965, 2334.498082912165, 2660.401409682825, 2777.2084955787504, 2782.833030018185, 2859.9857000714865, 10458.163346932228, 10639.627613033585, 10659.093977011964, 10993.285436446606, 11101.611443599435, 2104.305579158874, 2125.87244765313, 2168.967465488019, 2187.059564387329, 2289.187338494827, 80088.0, 84088.57955710244, 84127.5793621028, 84978.57510712407, 85166.14833851645, 11815.11386646005, 11818.822717659243, 11839.28964262147, 11949.522019119138, 12078.577249796215, 16857.83142168587, 16924.238409271613, 16947.152642367833, 16961.575960601083, 16965.0, 8545.102764209669, 8614.39699221061, 8657.740267791976, 8714.694985675598, 8818.95590522056, 8171.0, 8301.045379781282, 8304.294134998472, 8403.0, 8428.4942903426, 5030.748462576857, 5071.568916642127, 5104.9744751276, 5138.768755406016, 5143.305653736773, 1764.5170101931749, 1968.6062787442568, 2003.719479272903, 2049.610573990937, 2150.4408853697837, 489.75757000285085, 501.0330062978414, 960.2893858544627, 1062.4528367890543, 1095.5617752898745, 11873.525058997544, 18975.62048759017, 21553.892230538746, 21736.239231626816, 21755.67366489504, 1039.6828967165088, 1081.91344692426, 1096.7696783675517, 1115.2416356877238, 1115.5649296774266, 11107.333559986426, 11242.66272011841, 11261.718457038476, 11272.985431311057, 11309.038731707897, 499547.0, 515345.0, 515866.0, 515871.0, 545800.0, 64522.35477645163, 91261.54369228112, 99555.50222248843, 100247.0, 102319.48840255752, 1105.2649987758211, 1115.5426275227119, 1125.3866642679595, 1129.8870112988636, 1136.5453818472677, 17776.555586109935, 17942.820571794637, 18402.815971840646, 18510.16704248339, 18612.25550978, 41983.790081049396, 42520.78739606282, 43146.13707725765, 43981.56018439775, 44159.0, 57021.714891425276, 59908.400915990285, 61352.69323653353, 62076.0, 62234.688826555575, 8729.956350218208, 9190.862137067816, 9218.170364667212, 9272.536373181449, 9382.343235973689, 13374.0, 13590.388432520362, 13713.520026799015, 13857.237851918242, 13937.233452160228, 11909.76180476403, 12046.036317094786, 12149.939250303692, 12185.51257949672, 12231.449584768885, 11854.881451185378, 11883.881161188277, 12113.515459381879, 12396.938015309866, 12420.565280215149, 12130.33283169434, 12348.197367171106, 12403.75192496163, 12483.500659973499, 12501.124921255425, 8896.510691912006, 8942.86585701228, 9105.544722763703, 9107.225885799517, 9180.6786762463, 10626.36241825493, 11945.16383853122, 11948.641540753792, 12364.44360003784, 12442.0], "value": 9654.379798595031, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.1437094928526, 1581.320032386074, 1631.6084139806446, 1668.1325710630472, 1720.9139543022854, 9274.072592740722, 9634.566444509996, 9667.22662187026, 9982.85025724613, 9985.101340879319, 9583.712488625335, 9788.510574471265, 9790.216782657388, 9793.314467987244, 9793.461359625218, 2474.6659201007906, 2494.1270555305587, 2504.273760609421, 2517.509085728284, 2517.6601158843505, 2430.307362401716, 2529.3676580854785, 2536.3025168078834, 2538.4542323400465, 2542.8601426921514, 2472.3695457658364, 2473.4558397152687, 2518.584433568459, 2527.241827451757, 2528.0, 2381.9642705359433, 2413.1674572272536, 2424.5878200705924, 2437.0982736387473, 2437.7805997460314, 2363.988180059106, 2376.322748016807, 2384.523095380931, 2385.0817435287368, 2431.878406079689, 9620.086091821266, 9730.270229732727, 9765.316427850054, 9769.706908792748, 9873.753156171082, 5911.438413350725, 6051.213342265477, 6052.243469566304, 6053.545984051214, 6057.212562366908, 3653.3971894637352, 3738.420544815558, 3744.236486452948, 3765.1151979284846, 3802.9619703802887, 1152.4180288954108, 1156.242661057009, 1188.5245901639414, 1202.9458674359676, 1212.933288669123, 14350.569482915529, 14403.567892963229, 14447.133172009608, 14455.927720361437, 14462.855371446256, 5028.622853285945, 5063.797448102108, 5162.6128040397125, 5167.61242906776, 5172.508611681884, 11023.83464248037, 11060.115190784878, 11072.39101849406, 11083.944580277208, 11090.722731931604, 5882.941170588325, 5883.02930016551, 5885.5585831062845, 5888.9705551472825, 5894.086416605433, 4807.567318941312, 5297.629165958346, 5327.920081198785, 5431.565474762009, 5459.099248624012, 4129.359949207817, 4164.416981622575, 4176.164767046603, 4178.895527611834, 4189.811458484375, 1187.3350923482876, 1195.874433184503, 1204.590439250659, 1205.3370646144585, 1209.0992210803008, 926.6432423516994, 994.9452780097164, 1034.3018462537757, 1120.0591503137405, 1134.5802053240188, 6588.176477940257, 6761.560498567577, 6772.55978361405, 6793.354631310018, 6869.126896503518, 505.79515296305055, 506.2937202602349, 508.15392371700705, 508.8956763863399, 520.8828013696888, 4553.203189441834, 4592.586667199968, 4637.234856248681, 4704.741239231875, 4713.10451014313, 12458.81311780324, 12838.935805320914, 12860.485580576673, 12920.22478651284, 12929.418176182095, 11881.762364752656, 12287.508499660093, 12297.44661490235, 12430.0, 12634.178778379375, 9113.316501262432, 9281.350305478687, 9290.070992900792, 9292.070792920655, 9304.8604270936, 6699.564528305645, 6902.413294869993, 6916.619585922823, 6924.896126558005, 7059.5764254144915, 11327.207095503236, 11366.261193022427, 11526.0, 11894.583689570823, 11915.582954596548, 11651.12616553745, 11880.584179553674, 11890.0, 11993.280403175837, 12006.159568830448, 8049.637766300648, 8603.827923441371, 8617.181367770303, 8797.472151670665, 8820.382573219813, 9802.607895684092, 9829.0, 9838.114569688476, 9869.555869986012, 9889.357191782512, 8545.316374689886, 8593.097724738813, 8628.956855215683, 8853.867191991996, 8984.82030359376, 8214.05538363096, 8299.6680132794, 8319.958400207961, 8324.458910170819, 8423.747287581382, 7896.32881205104, 7956.283934445928, 8012.639431225492, 8013.6794528218215, 8018.879716804136, 5737.454941780524, 5753.367129615655, 5806.216160818235, 5867.765289388547, 5929.703514824155, 5668.971655141698, 5782.190493331022, 5825.563082768894, 5852.3269823969085, 5940.257467816523], "value": 5025.827323947489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.1661420896952, 351.9630438803925, 357.1161375595401, 363.6091201957896, 363.7944561322854, 5662.292213473316, 5680.437879583112, 5728.255326807509, 5749.540036797057, 5817.796377126801, 5325.733713314328, 5455.563554915607, 5473.534749546284, 5480.561555075595, 5642.489092353904, 4225.387318838767, 4322.416473776031, 4358.869233922987, 4391.297392417214, 4393.0, 4328.2209202343565, 4331.7184383015165, 4349.630281426083, 4354.455693038371, 4361.738295702252, 4118.238125946709, 4297.720648157875, 4333.328334108218, 4346.413234213388, 4369.798305465991, 4293.463317085364, 4327.956720432819, 4330.437043184397, 4348.0, 4352.020795321059, 3829.2915810574855, 3829.8276577554075, 3838.4626152338697, 3877.263319969197, 3879.4180872869297, 5285.365756109291, 5414.187871819219, 5421.620486565942, 5477.863053423656, 5527.309086364205, 4973.751312434364, 5031.138478762845, 5035.647504674675, 5035.949640503622, 5049.772760225798, 5945.524358051345, 5958.0, 5964.761409543613, 5970.701464926779, 6026.728797204137, 4045.271851066807, 4178.704601573522, 4234.30134027885, 4252.468441444819, 4263.552327005651, 6143.232095988002, 6151.354107818659, 6152.692365381713, 6156.6921653917125, 6185.195924529782, 4367.45406824147, 4375.693701440869, 4377.277749171351, 4378.277584198571, 4385.386045953569, 4116.794160291974, 4302.9569704303185, 4313.762743049162, 4320.243957307459, 4437.667174961891, 4899.779509922062, 4923.892124272082, 4929.802807887716, 4946.233333833262, 4965.8013679452415, 5903.76384944606, 5905.494099004726, 5917.733701983421, 5927.769365695706, 5955.493783028491, 1420.3466405453607, 1445.5302026841318, 1455.9199244041467, 1461.1087236785552, 1521.2773932382252, 906.9455832650062, 998.8152191844532, 1021.8313978193515, 1037.1547189041057, 1041.6666666666595, 5698.857528561819, 5715.914261286084, 5735.770569177186, 5769.336526299529, 5799.217105690678, 5881.588288819741, 6011.27864656244, 6038.879222415615, 6081.726322315506, 6084.30030546484, 5634.183043458757, 5646.520045796071, 5661.782716715926, 5674.829755107271, 5681.0, 3079.353335799507, 3172.349668317989, 3203.727683146912, 3222.5166225066428, 3223.274763178313, 6187.566870319124, 6190.0, 6245.344238854855, 6247.12586224131, 6257.374262573706, 6096.268447786205, 6097.176881120992, 6099.0, 6128.846778830476, 6177.536684748662, 5914.556408269397, 6217.937820621826, 6254.0, 6266.154069200599, 6303.212098487781, 5886.941130588811, 5967.134765458897, 6022.819315420545, 6033.577649564489, 6061.72722227492, 5659.943400565941, 5911.733971971185, 5913.102579735984, 5922.496587790086, 5958.165856779968, 6101.328853825987, 6170.969145154246, 6179.907301390573, 6206.565540412128, 6226.59527130735, 4260.890859024803, 4272.10285839977, 4322.178786030644, 4342.3703562982555, 4351.695381323404, 5884.382139875252, 5996.609444833787, 5999.520038397005, 6004.279486461653, 6051.0, 5808.51882769891, 5815.476607105381, 5823.330317013429, 5859.472647461749, 5872.765089396376, 5495.835124946258, 5802.216700745515, 5859.296884373732, 5871.588988770916, 5896.17453556511, 5732.541396688338, 5819.70901454934, 5825.825225243249, 5842.7078646066675, 5854.912176317273, 5929.258842644669, 5932.970335148297, 5944.0, 5970.373110823301, 5980.312264089685, 5605.383407825218, 5796.565257605781, 5840.240768700211, 5844.1525978732, 5853.765849365977], "value": 4482.699136757893, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.2805532937363, 794.3565711773467, 854.8589482735349, 923.8198551282499, 931.9534023298836, 15826.604334891634, 16879.746803797938, 17012.574685632866, 17200.225989830455, 17532.64934701305, 16239.756403653924, 16321.428749993753, 16377.181140942965, 16424.589385265375, 16464.259108340124, 735.2059775442509, 868.9913100869005, 890.1365675294953, 903.2999425445266, 906.4515967839461, 900.2303030908577, 900.5002223765807, 904.2720609909021, 904.9185573298402, 905.1310741687987, 948.0993056596227, 948.3124734567452, 949.0699114867434, 950.2303134461108, 950.5722424908785, 776.1501156233915, 907.7276816954887, 938.2728385501291, 941.0824446165003, 947.824652439301, 696.7352406085706, 696.9303069693041, 697.159922293635, 697.7418355208555, 697.7453229571221, 16327.51017469466, 16328.183590820412, 16333.91833040839, 16364.427245046367, 16383.508494745176, 14633.122012679274, 14784.556463306011, 14937.775933361008, 15071.397144114222, 15087.0, 13727.313634318343, 14002.229877356742, 14083.155010699391, 14109.929450352785, 14658.926705366404, 4662.277347011219, 4751.881202969919, 4788.832390866338, 4836.903261934777, 4938.925916111261, 77415.22584774137, 77466.0, 77467.0, 80582.59708701419, 81379.18620813717, 10565.313254638424, 10617.84073238902, 10670.573177072985, 11816.46825892837, 12573.308468034164, 22360.217392391187, 22629.094836206696, 22665.773342266697, 22720.545589088124, 22764.772352276264, 8531.146885311544, 8633.568321583896, 8685.652573896974, 8762.430442021248, 8807.647694092293, 4516.88707782308, 4744.810207591727, 4763.45220299663, 4818.253170758538, 4899.118158731462, 3782.583915769263, 3823.4073718573663, 3892.0, 3937.645611894943, 3943.38877473992, 659.9803303895493, 660.9074729537869, 671.4024518178825, 673.9696713647897, 676.5703778100843, 688.8932215506604, 689.4622194688151, 690.5062880040795, 696.4010950582496, 710.9395701365338, 9896.307258491837, 10092.44491552957, 10157.94921025405, 10165.44090075053, 10260.230482713678, 636.7739452494391, 657.4477438951304, 724.5688815154974, 725.8004048886493, 737.306931484403, 4584.564466375689, 5075.365579302587, 5126.92309615356, 5241.842744717665, 5270.446603106695, 80734.19265807267, 81022.59488702519, 81202.59398702969, 125846.3707681474, 126078.36960815138, 69976.6501167491, 73497.89753153706, 107345.0, 108182.0, 108323.0, 92750.53624731969, 93214.53392732993, 96391.51804241074, 96719.0, 98030.0, 10018.699439016842, 10075.798484030425, 10361.171106311627, 10367.118794902517, 10405.427701476492, 54204.915901682536, 54975.0, 54993.1751023727, 55420.44579554153, 56088.43911560995, 80656.59671701604, 82236.58881705553, 85077.57461212654, 85264.1473585281, 85882.57058714666, 12537.373131343214, 12839.165454245818, 12841.422136003715, 13087.934560327138, 13197.0, 11567.248128871597, 14414.42342306338, 14488.0, 14515.709685806014, 14670.413183472541, 12183.147179697336, 12542.623721288375, 12562.120651554304, 12684.682882928, 13064.673383165496, 12462.937685311515, 12901.225926444444, 12913.612591622266, 13247.138935969131, 13399.598012059654, 12934.353282335658, 13049.412776424893, 13149.671258218621, 13219.0, 13261.801072984106, 10392.324498907547, 10454.372737635766, 10641.201909856636, 10877.945610271898, 11108.666739997812, 11015.559377624806, 11169.776604468028, 11346.262492937933, 11374.146938979775, 11452.713682158013], "value": 7881.347466408937, "unit": "score"}], "name": "dromaeo_css", "value": 7657.367939998319, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 111.0, 109.0, 110.0, 110.0, 110.0, 111.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 130.0, 181.0, 124.0, 132.0, 154.0, 130.0, 161.0, 123.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 159.0, 159.0, 160.0, 159.0, 161.0, 160.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 107.0, 75.0, 75.0, 75.0, 75.0, 103.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 117.0, 84.0, 84.0, 84.0, 122.0, 84.0, 84.0, 121.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 50.0, 51.0, 51.0, 52.0, 54.0, 50.0, 51.0, 56.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 61.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 76.0, 77.0, 78.0, 77.0, 77.0, 111.0, 77.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 128.0, 131.0, 116.0, 120.0, 116.0, 123.0, 119.0, 122.0, 122.0], "value": 121.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 154.0, 161.0, 154.0, 154.0, 153.0, 152.0, 152.0, 159.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 62.0, 61.0, 62.0, 62.0, 62.0, 68.0, 60.0, 60.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1475.8999999999996, "alertThreshold": 2.0}]} 11:44:43 INFO - Return code: 0 11:44:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:43 ERROR - # TBPL SUCCESS # 11:44:43 INFO - Running post-action listener: _resource_record_post_action 11:44:43 INFO - ##### 11:44:43 INFO - ##### Finished run-tests step (success) 11:44:43 INFO - ##### 11:44:43 INFO - Running post-run listener: _resource_record_post_run 11:44:43 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 456916992; Read time: 208; Write time: 345040 11:44:43 INFO - TinderboxPrint: CPU usage
13.0% 11:44:43 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 208 11:44:43 INFO - TinderboxPrint: I/O write bytes / time
456,916,992 / 345,040 11:44:43 INFO - TinderboxPrint: CPU idle
8,233.1 (87.0%) 11:44:43 INFO - TinderboxPrint: CPU user
1,193.5 (12.6%) 11:44:43 INFO - TinderboxPrint: Swap in / out
0 / 0 11:44:43 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 4096; Write bytes: 235073536; Read time: 196; Write time: 219092 11:44:43 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221843456; Read time: 12; Write time: 125948 11:44:43 INFO - Running post-run listener: _upload_blobber_files 11:44:43 INFO - Blob upload gear active. 11:44:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:44 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:44 INFO - (blobuploader) - INFO - Done attempting. 11:44:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:45 INFO - (blobuploader) - WARNING - File uploaded to blobserver but failed uploading to Amazon S3. 11:44:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:45 INFO - (blobuploader) - INFO - Done attempting. 11:44:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:49 INFO - (blobuploader) - INFO - Done attempting. 11:44:49 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:49 INFO - Return code: 0 11:44:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47f5fd132d06597ecdf1c447f4b6a25cf718d938fa1dc209c0c80c6056c691974fee3d806097b4f6f37e4ad4ef45c7f9486eebbf88b7ad28921557252147382d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e1bf07f2801bd7d7d225b39e21c715b6e596cacfdc5d47de08f1c43dac973814a101ebd3a3681114ab0d302cb14258c07928964da8cb9e8b592d1f2228959cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1777298419aeafbbc1638e522d7930e165f8da4670745e434551e6652b025eda17244362e467c7e6fdec78ac38df537036d4217ad64193c103e3e3ce68eb8849"} 11:44:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:49 INFO - Contents: 11:44:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47f5fd132d06597ecdf1c447f4b6a25cf718d938fa1dc209c0c80c6056c691974fee3d806097b4f6f37e4ad4ef45c7f9486eebbf88b7ad28921557252147382d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e1bf07f2801bd7d7d225b39e21c715b6e596cacfdc5d47de08f1c43dac973814a101ebd3a3681114ab0d302cb14258c07928964da8cb9e8b592d1f2228959cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1777298419aeafbbc1638e522d7930e165f8da4670745e434551e6652b025eda17244362e467c7e6fdec78ac38df537036d4217ad64193c103e3e3ce68eb8849"} 11:44:49 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:49 INFO - Copying logs to upload dir... 11:44:49 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.598921 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-01 11:44:48.516323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:48.520364) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547 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/47f5fd132d06597ecdf1c447f4b6a25cf718d938fa1dc209c0c80c6056c691974fee3d806097b4f6f37e4ad4ef45c7f9486eebbf88b7ad28921557252147382d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e1bf07f2801bd7d7d225b39e21c715b6e596cacfdc5d47de08f1c43dac973814a101ebd3a3681114ab0d302cb14258c07928964da8cb9e8b592d1f2228959cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1777298419aeafbbc1638e522d7930e165f8da4670745e434551e6652b025eda17244362e467c7e6fdec78ac38df537036d4217ad64193c103e3e3ce68eb8849"} build_url:https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/47f5fd132d06597ecdf1c447f4b6a25cf718d938fa1dc209c0c80c6056c691974fee3d806097b4f6f37e4ad4ef45c7f9486eebbf88b7ad28921557252147382d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e1bf07f2801bd7d7d225b39e21c715b6e596cacfdc5d47de08f1c43dac973814a101ebd3a3681114ab0d302cb14258c07928964da8cb9e8b592d1f2228959cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1777298419aeafbbc1638e522d7930e165f8da4670745e434551e6652b025eda17244362e467c7e6fdec78ac38df537036d4217ad64193c103e3e3ce68eb8849"}' ========= master_lag: 0.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:48.650160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:48.650480) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1470075537.77222-117169547 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:48.702820) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:44:48.703140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:44:48.703409) ========= ========= Total master_lag: 0.26 =========