builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1465515125.72 results: success (0) buildid: 20160609133023 builduid: cd0e2202699c47d28f53e6416b0bf60d revision: 5e5914f1100056bd3144b0061a7c826bf73ef918 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.724246) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.724751) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.725031) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.739891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.740173) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 16:32:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-09 16:32:05 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.068164 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.822511) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.822852) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017140 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.872476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.872845) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5e5914f1100056bd3144b0061a7c826bf73ef918 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5e5914f1100056bd3144b0061a7c826bf73ef918 --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=97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 16:32:05,920 truncating revision to first 12 chars 2016-06-09 16:32:05,920 Setting DEBUG logging. 2016-06-09 16:32:05,920 attempt 1/10 2016-06-09 16:32:05,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5e5914f11000?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 16:32:06,222 unpacking tar archive at: mozilla-inbound-5e5914f11000/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:06.525159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:06.525496) ========= script_repo_revision: 5e5914f1100056bd3144b0061a7c826bf73ef918 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:06.525897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:06.526168) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:06.534450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-09 16:32:06.534754) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:32:06 INFO - MultiFileLogger online at 20160609 16:32:06 in /builds/slave/test 16:32:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:32:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:32:06 INFO - {'append_to_log': False, 16:32:06 INFO - 'base_work_dir': '/builds/slave/test', 16:32:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:32:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:32:06 INFO - 'branch': 'Mozilla-Inbound', 16:32:06 INFO - 'buildbot_json_path': 'buildprops.json', 16:32:06 INFO - 'config_files': ('talos/linux_config.py',), 16:32:06 INFO - 'default_actions': ('clobber', 16:32:06 INFO - 'read-buildbot-config', 16:32:06 INFO - 'download-and-extract', 16:32:06 INFO - 'populate-webroot', 16:32:06 INFO - 'create-virtualenv', 16:32:06 INFO - 'install', 16:32:06 INFO - 'run-tests'), 16:32:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:32:06 INFO - 'download_minidump_stackwalk': True, 16:32:06 INFO - 'download_symbols': 'ondemand', 16:32:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:32:06 INFO - 'tooltool.py': '/tools/tooltool.py', 16:32:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:32:06 INFO - '/tools/misc-python/virtualenv.py')}, 16:32:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:32:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:32:06 INFO - 'installer_path': 'installer.exe', 16:32:06 INFO - 'log_level': 'info', 16:32:06 INFO - 'log_name': 'talos', 16:32:06 INFO - 'log_to_console': True, 16:32:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:32:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:32:06 INFO - 'opt_config_files': (), 16:32:06 INFO - 'pip_index': False, 16:32:06 INFO - 'sps_profile': False, 16:32:06 INFO - 'sps_profile_interval': 0, 16:32:06 INFO - 'suite': 'dromaeojs', 16:32:06 INFO - 'system_bits': '32', 16:32:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:32:06 INFO - 'title': 'talos-linux64-ix-068', 16:32:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:32:06 INFO - 'use_talos_json': True, 16:32:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:32:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:32:06 INFO - 'work_dir': 'build'} 16:32:06 INFO - ##### 16:32:06 INFO - ##### Running clobber step. 16:32:06 INFO - ##### 16:32:06 INFO - Running pre-action listener: _resource_record_pre_action 16:32:06 INFO - Running main action method: clobber 16:32:06 INFO - rmtree: /builds/slave/test/build 16:32:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:32:07 INFO - Running post-action listener: _resource_record_post_action 16:32:07 INFO - ##### 16:32:07 INFO - ##### Finished clobber step (success) 16:32:07 INFO - ##### 16:32:07 INFO - ##### 16:32:07 INFO - ##### Running read-buildbot-config step. 16:32:07 INFO - ##### 16:32:07 INFO - Running pre-action listener: _resource_record_pre_action 16:32:07 INFO - Running main action method: read_buildbot_config 16:32:07 INFO - Using buildbot properties: 16:32:07 INFO - { 16:32:07 INFO - "project": "", 16:32:07 INFO - "product": "firefox", 16:32:07 INFO - "script_repo_revision": "production", 16:32:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:32:07 INFO - "repository": "", 16:32:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:32:07 INFO - "buildid": "20160609133023", 16:32:07 INFO - "pgo_build": "True", 16:32:07 INFO - "basedir": "/builds/slave/test", 16:32:07 INFO - "buildnumber": 1911, 16:32:07 INFO - "slavename": "talos-linux64-ix-068", 16:32:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:32:07 INFO - "platform": "ubuntu64_hw", 16:32:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:32:07 INFO - "branch": "mozilla-inbound", 16:32:07 INFO - "repo_path": "integration/mozilla-inbound", 16:32:07 INFO - "revision": "5e5914f1100056bd3144b0061a7c826bf73ef918", 16:32:07 INFO - "stage_platform": "linux64-pgo", 16:32:07 INFO - "builduid": "cd0e2202699c47d28f53e6416b0bf60d", 16:32:07 INFO - "slavebuilddir": "test" 16:32:07 INFO - } 16:32:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:32:07 INFO - Running post-action listener: _resource_record_post_action 16:32:07 INFO - ##### 16:32:07 INFO - ##### Finished read-buildbot-config step (success) 16:32:07 INFO - ##### 16:32:07 INFO - ##### 16:32:07 INFO - ##### Running download-and-extract step. 16:32:07 INFO - ##### 16:32:07 INFO - Running pre-action listener: _resource_record_pre_action 16:32:07 INFO - Running main action method: download_and_extract 16:32:07 INFO - mkdir: /builds/slave/test/build/tests 16:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:07 INFO - https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:32:09 INFO - Downloaded 1361 bytes. 16:32:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:32:09 INFO - Using the following test package requirements: 16:32:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:32:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:32:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:32:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:09 INFO - u'jsshell-linux-x86_64.zip'], 16:32:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:32:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:32:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:32:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:32:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:32:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:32:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:32: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')]} 16:32:09 INFO - https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:32:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:32:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:32:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:32:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:32:11 INFO - Downloaded 24463850 bytes. 16:32:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:32:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:32:12 INFO - Return code: 0 16:32:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:12 INFO - https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:32:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:32:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:32:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:32:13 INFO - Downloaded 24463850 bytes. 16:32:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:32:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:32:15 INFO - Return code: 0 16:32:15 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')]} 16:32:15 INFO - https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:32:16 INFO - Downloaded 10833377 bytes. 16:32:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:32:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:32:16 INFO - Return code: 0 16:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:16 INFO - https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:32:18 INFO - Downloaded 59345126 bytes. 16:32:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:32:18 INFO - mkdir: /builds/slave/test/properties 16:32:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:32:18 INFO - Writing to file /builds/slave/test/properties/build_url 16:32:18 INFO - Contents: 16:32:18 INFO - build_url:https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:32:18 INFO - Running post-action listener: _resource_record_post_action 16:32:18 INFO - Running post-action listener: set_extra_try_arguments 16:32:18 INFO - ##### 16:32:18 INFO - ##### Finished download-and-extract step (success) 16:32:18 INFO - ##### 16:32:18 INFO - ##### 16:32:18 INFO - ##### Running populate-webroot step. 16:32:18 INFO - ##### 16:32:18 INFO - Running pre-action listener: _resource_record_pre_action 16:32:18 INFO - Running main action method: populate_webroot 16:32:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:32:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:32:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:32:18 INFO - '--tppagecycles', 16:32:18 INFO - '7'], 16:32:18 INFO - 'tests': ['tsvgm']}}, 16:32:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:32:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:32:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:32:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:32:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['damp', 'tps']}, 16:32:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'tests': ['damp', 'tps']}, 16:32:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['dromaeo_dom']}, 16:32:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:32:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'other-e10s': {'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['tsvgx', 16:32:18 INFO - 'tsvgr_opacity', 16:32:18 INFO - 'tart', 16:32:18 INFO - 'tscrollx', 16:32:18 INFO - 'cart']}, 16:32:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:32:18 INFO - 'tsvgr_opacity', 16:32:18 INFO - 'tart', 16:32:18 INFO - 'tscrollx', 16:32:18 INFO - 'cart']}, 16:32:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['tp5o']}, 16:32:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'tests': ['tp5o']}, 16:32:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'talos_options': ['--disable-e10s', 16:32:18 INFO - '--xperf_path', 16:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:18 INFO - 'tests': ['tp5n']}, 16:32:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'talos_options': ['--xperf_path', 16:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:18 INFO - 'tests': ['tp5n']}}, 16:32:18 INFO - 'talos.zip': {'path': '', 16:32:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:32:18 INFO - Running post-action listener: _resource_record_post_action 16:32:18 INFO - ##### 16:32:18 INFO - ##### Finished populate-webroot step (success) 16:32:18 INFO - ##### 16:32:18 INFO - ##### 16:32:18 INFO - ##### Running create-virtualenv step. 16:32:18 INFO - ##### 16:32:18 INFO - Running pre-action listener: _resource_record_pre_action 16:32:18 INFO - Running main action method: create_virtualenv 16:32:18 INFO - Creating virtualenv /builds/slave/test/build/venv 16:32:18 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 16:32:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:32:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:32:19 INFO - Using real prefix '/usr' 16:32:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:32:19 INFO - Installing distribute.............................................................................................................................................................................................done. 16:32:21 INFO - Installing pip.................done. 16:32:21 INFO - Return code: 0 16:32:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:21 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 0x7fda12f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', '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 16:32:21 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 16:32:21 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 16:32:21 INFO - Using env: {'DISPLAY': ':0', 16:32:21 INFO - 'HOME': '/home/cltbld', 16:32:21 INFO - 'LANG': 'en_US.UTF-8', 16:32:21 INFO - 'LANGUAGE': 'en_US:en', 16:32:21 INFO - 'LOGNAME': 'cltbld', 16:32:21 INFO - 'MAIL': '/var/mail/cltbld', 16:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:21 INFO - 'MOZ_NO_REMOTE': '1', 16:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:21 INFO - 'NO_EM_RESTART': '1', 16:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:21 INFO - 'PWD': '/builds/slave/test', 16:32:21 INFO - 'SHELL': '/bin/bash', 16:32:21 INFO - 'SHLVL': '1', 16:32:21 INFO - 'TERM': 'linux', 16:32:21 INFO - 'TMOUT': '86400', 16:32:21 INFO - 'USER': 'cltbld', 16:32:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:21 INFO - '_': '/tools/buildbot/bin/python'} 16:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:21 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 16:32:21 INFO - Cleaning up... 16:32:21 INFO - Return code: 0 16:32:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:21 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 0x7fda12f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', '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 16:32:21 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 16:32:21 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 16:32:21 INFO - Using env: {'DISPLAY': ':0', 16:32:21 INFO - 'HOME': '/home/cltbld', 16:32:21 INFO - 'LANG': 'en_US.UTF-8', 16:32:21 INFO - 'LANGUAGE': 'en_US:en', 16:32:21 INFO - 'LOGNAME': 'cltbld', 16:32:21 INFO - 'MAIL': '/var/mail/cltbld', 16:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:21 INFO - 'MOZ_NO_REMOTE': '1', 16:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:21 INFO - 'NO_EM_RESTART': '1', 16:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:21 INFO - 'PWD': '/builds/slave/test', 16:32:21 INFO - 'SHELL': '/bin/bash', 16:32:21 INFO - 'SHLVL': '1', 16:32:21 INFO - 'TERM': 'linux', 16:32:21 INFO - 'TMOUT': '86400', 16:32:21 INFO - 'USER': 'cltbld', 16:32:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:21 INFO - '_': '/tools/buildbot/bin/python'} 16:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:21 INFO - Downloading/unpacking psutil>=3.1.1 16:32:21 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 16:32:21 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 16:32:21 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 16:32:21 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 16:32:21 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 16:32:21 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 16:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:23 INFO - Installing collected packages: psutil 16:32:23 INFO - Running setup.py install for psutil 16:32:23 INFO - building 'psutil._psutil_linux' extension 16:32:23 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 16:32:24 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 16:32:24 INFO - building 'psutil._psutil_posix' extension 16:32:24 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 16:32:24 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 16:32:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:24 INFO - Successfully installed psutil 16:32:24 INFO - Cleaning up... 16:32:24 INFO - Return code: 0 16:32:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda12f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', '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 16:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:32:24 INFO - Using env: {'DISPLAY': ':0', 16:32:24 INFO - 'HOME': '/home/cltbld', 16:32:24 INFO - 'LANG': 'en_US.UTF-8', 16:32:24 INFO - 'LANGUAGE': 'en_US:en', 16:32:24 INFO - 'LOGNAME': 'cltbld', 16:32:24 INFO - 'MAIL': '/var/mail/cltbld', 16:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:24 INFO - 'MOZ_NO_REMOTE': '1', 16:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:24 INFO - 'NO_EM_RESTART': '1', 16:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:24 INFO - 'PWD': '/builds/slave/test', 16:32:24 INFO - 'SHELL': '/bin/bash', 16:32:24 INFO - 'SHLVL': '1', 16:32:24 INFO - 'TERM': 'linux', 16:32:24 INFO - 'TMOUT': '86400', 16:32:24 INFO - 'USER': 'cltbld', 16:32:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:24 INFO - '_': '/tools/buildbot/bin/python'} 16:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:32:26 INFO - Installing collected packages: mozsystemmonitor 16:32:26 INFO - Running setup.py install for mozsystemmonitor 16:32:27 INFO - Successfully installed mozsystemmonitor 16:32:27 INFO - Cleaning up... 16:32:27 INFO - Return code: 0 16:32:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:32:27 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')]} 16:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:27 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')]} 16:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:27 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 0x7fda12f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', '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 16:32:27 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 16:32:27 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 16:32:27 INFO - Using env: {'DISPLAY': ':0', 16:32:27 INFO - 'HOME': '/home/cltbld', 16:32:27 INFO - 'LANG': 'en_US.UTF-8', 16:32:27 INFO - 'LANGUAGE': 'en_US:en', 16:32:27 INFO - 'LOGNAME': 'cltbld', 16:32:27 INFO - 'MAIL': '/var/mail/cltbld', 16:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:27 INFO - 'MOZ_NO_REMOTE': '1', 16:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:27 INFO - 'NO_EM_RESTART': '1', 16:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:27 INFO - 'PWD': '/builds/slave/test', 16:32:27 INFO - 'SHELL': '/bin/bash', 16:32:27 INFO - 'SHLVL': '1', 16:32:27 INFO - 'TERM': 'linux', 16:32:27 INFO - 'TMOUT': '86400', 16:32:27 INFO - 'USER': 'cltbld', 16:32:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:27 INFO - '_': '/tools/buildbot/bin/python'} 16:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:27 INFO - Downloading/unpacking jsonschema==2.5.1 16:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:32:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:29 INFO - Downloading functools32-3.2.3-2.tar.gz 16:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:32:29 INFO - warning: no files found matching '*.txt' 16:32:29 INFO - no previously-included directories found matching 'build' 16:32:29 INFO - no previously-included directories found matching 'dist' 16:32:29 INFO - no previously-included directories found matching '.git*' 16:32:29 INFO - Installing collected packages: jsonschema, functools32 16:32:29 INFO - Running setup.py install for functools32 16:32:29 INFO - warning: no files found matching '*.txt' 16:32:29 INFO - no previously-included directories found matching 'build' 16:32:29 INFO - no previously-included directories found matching 'dist' 16:32:29 INFO - no previously-included directories found matching '.git*' 16:32:29 INFO - Successfully installed jsonschema functools32 16:32:29 INFO - Cleaning up... 16:32:30 INFO - Return code: 0 16:32:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32:30 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')]} 16:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:30 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')]} 16:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:30 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 0x7fda12f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', '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 16:32:30 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 16:32:30 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 16:32:30 INFO - Using env: {'DISPLAY': ':0', 16:32:30 INFO - 'HOME': '/home/cltbld', 16:32:30 INFO - 'LANG': 'en_US.UTF-8', 16:32:30 INFO - 'LANGUAGE': 'en_US:en', 16:32:30 INFO - 'LOGNAME': 'cltbld', 16:32:30 INFO - 'MAIL': '/var/mail/cltbld', 16:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:30 INFO - 'MOZ_NO_REMOTE': '1', 16:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:30 INFO - 'NO_EM_RESTART': '1', 16:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:30 INFO - 'PWD': '/builds/slave/test', 16:32:30 INFO - 'SHELL': '/bin/bash', 16:32:30 INFO - 'SHLVL': '1', 16:32:30 INFO - 'TERM': 'linux', 16:32:30 INFO - 'TMOUT': '86400', 16:32:30 INFO - 'USER': 'cltbld', 16:32:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:30 INFO - '_': '/tools/buildbot/bin/python'} 16:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:30 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:30 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 16:32:30 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 16:32:30 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 16:32:30 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 16:32:30 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 16:32:30 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 16:32:32 INFO - Downloading blobuploader-1.2.4.tar.gz 16:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:32:32 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 16:32:32 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 16:32:32 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 16:32:32 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 16:32:32 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 16:32:32 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 16:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32:32 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 16:32:32 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 16:32:32 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 16:32:32 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 16:32:32 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 16:32:32 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 16:32:32 INFO - Downloading docopt-0.6.1.tar.gz 16:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:32 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:32 INFO - Running setup.py install for blobuploader 16:32:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:33 INFO - Running setup.py install for requests 16:32:33 INFO - Running setup.py install for docopt 16:32:33 INFO - Successfully installed blobuploader requests docopt 16:32:33 INFO - Cleaning up... 16:32:33 INFO - Return code: 0 16:32:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:33 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')]} 16:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:33 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')]} 16:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:33 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 0x7fda12f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', '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 16:32:33 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 16:32:33 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 16:32:33 INFO - Using env: {'DISPLAY': ':0', 16:32:33 INFO - 'HOME': '/home/cltbld', 16:32:33 INFO - 'LANG': 'en_US.UTF-8', 16:32:33 INFO - 'LANGUAGE': 'en_US:en', 16:32:33 INFO - 'LOGNAME': 'cltbld', 16:32:33 INFO - 'MAIL': '/var/mail/cltbld', 16:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:33 INFO - 'MOZ_NO_REMOTE': '1', 16:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:33 INFO - 'NO_EM_RESTART': '1', 16:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:33 INFO - 'PWD': '/builds/slave/test', 16:32:33 INFO - 'SHELL': '/bin/bash', 16:32:33 INFO - 'SHLVL': '1', 16:32:33 INFO - 'TERM': 'linux', 16:32:33 INFO - 'TMOUT': '86400', 16:32:33 INFO - 'USER': 'cltbld', 16:32:33 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:33 INFO - '_': '/tools/buildbot/bin/python'} 16:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:33 INFO - Running setup.py (path:/tmp/pip-cV4r2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:33 INFO - Running setup.py (path:/tmp/pip-5RFNeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:33 INFO - Running setup.py (path:/tmp/pip-ol76qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:33 INFO - Running setup.py (path:/tmp/pip-3Mhghb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:34 INFO - Running setup.py (path:/tmp/pip-_W9bid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:34 INFO - Running setup.py (path:/tmp/pip-6r_ulC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:34 INFO - Running setup.py (path:/tmp/pip-2IRJsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:34 INFO - Running setup.py (path:/tmp/pip-3ZpAEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:34 INFO - Running setup.py (path:/tmp/pip-ncnxzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:34 INFO - Running setup.py (path:/tmp/pip-vjK6B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:34 INFO - Running setup.py (path:/tmp/pip-im5OLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:34 INFO - Running setup.py (path:/tmp/pip-5oXWiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:34 INFO - Running setup.py (path:/tmp/pip-OlS0ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:34 INFO - Running setup.py (path:/tmp/pip-YBmr45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:34 INFO - Running setup.py (path:/tmp/pip-NMWSOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:34 INFO - Running setup.py (path:/tmp/pip-J846Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:34 INFO - Running setup.py (path:/tmp/pip-Orp2le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:34 INFO - Running setup.py install for manifestparser 16:32:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Running setup.py install for mozcrash 16:32:35 INFO - Running setup.py install for mozdebug 16:32:35 INFO - Running setup.py install for mozdevice 16:32:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Running setup.py install for mozfile 16:32:35 INFO - Running setup.py install for mozhttpd 16:32:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Running setup.py install for mozinfo 16:32:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Running setup.py install for mozInstall 16:32:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Running setup.py install for mozleak 16:32:35 INFO - Running setup.py install for mozlog 16:32:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Running setup.py install for moznetwork 16:32:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:36 INFO - Running setup.py install for mozprocess 16:32:36 INFO - Running setup.py install for mozprofile 16:32:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:36 INFO - Running setup.py install for mozrunner 16:32:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:36 INFO - Running setup.py install for mozscreenshot 16:32:36 INFO - Running setup.py install for moztest 16:32:36 INFO - Running setup.py install for mozversion 16:32:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:36 INFO - Cleaning up... 16:32:36 INFO - Return code: 0 16:32:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:36 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 0x7fda12f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', '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 16:32:36 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 16:32:36 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 16:32:36 INFO - Using env: {'DISPLAY': ':0', 16:32:36 INFO - 'HOME': '/home/cltbld', 16:32:36 INFO - 'LANG': 'en_US.UTF-8', 16:32:36 INFO - 'LANGUAGE': 'en_US:en', 16:32:36 INFO - 'LOGNAME': 'cltbld', 16:32:36 INFO - 'MAIL': '/var/mail/cltbld', 16:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:36 INFO - 'MOZ_NO_REMOTE': '1', 16:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:36 INFO - 'NO_EM_RESTART': '1', 16:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:36 INFO - 'PWD': '/builds/slave/test', 16:32:36 INFO - 'SHELL': '/bin/bash', 16:32:36 INFO - 'SHLVL': '1', 16:32:36 INFO - 'TERM': 'linux', 16:32:36 INFO - 'TMOUT': '86400', 16:32:36 INFO - 'USER': 'cltbld', 16:32:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:36 INFO - '_': '/tools/buildbot/bin/python'} 16:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:36 INFO - Running setup.py (path:/tmp/pip-rbS3U5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:37 INFO - Running setup.py (path:/tmp/pip-dE3t6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:37 INFO - Running setup.py (path:/tmp/pip-B0fCRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:37 INFO - Running setup.py (path:/tmp/pip-oymAsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:37 INFO - Running setup.py (path:/tmp/pip-LtxYhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:37 INFO - Running setup.py (path:/tmp/pip-Bg0tqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:37 INFO - Running setup.py (path:/tmp/pip-INRFMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:37 INFO - Running setup.py (path:/tmp/pip-U4JyWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:37 INFO - Running setup.py (path:/tmp/pip-tdrCXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:37 INFO - Running setup.py (path:/tmp/pip-7tpy6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:37 INFO - Running setup.py (path:/tmp/pip-eIkOrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:37 INFO - Running setup.py (path:/tmp/pip-xQQ2if-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:37 INFO - Running setup.py (path:/tmp/pip-xkaQhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:37 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)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:37 INFO - Running setup.py (path:/tmp/pip-Sn7s4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:37 INFO - Running setup.py (path:/tmp/pip-gou456-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:38 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)) 16:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:38 INFO - Running setup.py (path:/tmp/pip-3gbbuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:38 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)) 16:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:38 INFO - Running setup.py (path:/tmp/pip-7bjNJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:38 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)) 16:32:38 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)) 16:32:38 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)) 16:32:38 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)) 16:32:38 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)) 16:32:38 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)) 16:32:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:38 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 16:32:38 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 16:32:38 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 16:32:38 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 16:32:38 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 16:32:38 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 16:32:40 INFO - Downloading blessings-1.6.tar.gz 16:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:40 INFO - Installing collected packages: blessings 16:32:40 INFO - Running setup.py install for blessings 16:32:40 INFO - Successfully installed blessings 16:32:40 INFO - Cleaning up... 16:32:40 INFO - Return code: 0 16:32:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:40 INFO - Reading from file tmpfile_stdout 16:32:40 INFO - Current package versions: 16:32:40 INFO - argparse == 1.2.1 16:32:40 INFO - blessings == 1.6 16:32:40 INFO - blobuploader == 1.2.4 16:32:40 INFO - docopt == 0.6.1 16:32:40 INFO - functools32 == 3.2.3-2 16:32:40 INFO - jsonschema == 2.5.1 16:32:40 INFO - manifestparser == 1.1 16:32:40 INFO - mozInstall == 1.12 16:32:40 INFO - mozcrash == 0.17 16:32:40 INFO - mozdebug == 0.1 16:32:40 INFO - mozdevice == 0.48 16:32:40 INFO - mozfile == 1.2 16:32:40 INFO - mozhttpd == 0.7 16:32:40 INFO - mozinfo == 0.9 16:32:40 INFO - mozleak == 0.1 16:32:40 INFO - mozlog == 3.2 16:32:40 INFO - moznetwork == 0.27 16:32:40 INFO - mozprocess == 0.22 16:32:40 INFO - mozprofile == 0.28 16:32:40 INFO - mozrunner == 6.11 16:32:40 INFO - mozscreenshot == 0.1 16:32:40 INFO - mozsystemmonitor == 0.3 16:32:40 INFO - moztest == 0.7 16:32:40 INFO - mozversion == 1.4 16:32:40 INFO - psutil == 3.1.1 16:32:40 INFO - requests == 1.2.3 16:32:40 INFO - wsgiref == 0.1.2 16:32:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:40 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 0x7fda12f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', '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 16:32:40 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 16:32:40 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 16:32:40 INFO - Using env: {'DISPLAY': ':0', 16:32:40 INFO - 'HOME': '/home/cltbld', 16:32:40 INFO - 'LANG': 'en_US.UTF-8', 16:32:40 INFO - 'LANGUAGE': 'en_US:en', 16:32:40 INFO - 'LOGNAME': 'cltbld', 16:32:40 INFO - 'MAIL': '/var/mail/cltbld', 16:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:40 INFO - 'MOZ_NO_REMOTE': '1', 16:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:40 INFO - 'NO_EM_RESTART': '1', 16:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:40 INFO - 'PWD': '/builds/slave/test', 16:32:40 INFO - 'SHELL': '/bin/bash', 16:32:40 INFO - 'SHLVL': '1', 16:32:40 INFO - 'TERM': 'linux', 16:32:40 INFO - 'TMOUT': '86400', 16:32:40 INFO - 'USER': 'cltbld', 16:32:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:40 INFO - '_': '/tools/buildbot/bin/python'} 16:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:40 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)) 16:32:40 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)) 16:32:40 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)) 16:32:40 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)) 16:32:40 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)) 16:32:40 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)) 16:32:40 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)) 16:32:40 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)) 16:32:40 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)) 16:32:40 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)) 16:32:40 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)) 16:32:40 INFO - Cleaning up... 16:32:40 INFO - Return code: 0 16:32:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:40 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 0x7fda12f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', '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 16:32:40 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 16:32:40 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 16:32:40 INFO - Using env: {'DISPLAY': ':0', 16:32:40 INFO - 'HOME': '/home/cltbld', 16:32:40 INFO - 'LANG': 'en_US.UTF-8', 16:32:40 INFO - 'LANGUAGE': 'en_US:en', 16:32:40 INFO - 'LOGNAME': 'cltbld', 16:32:40 INFO - 'MAIL': '/var/mail/cltbld', 16:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:40 INFO - 'MOZ_NO_REMOTE': '1', 16:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:40 INFO - 'NO_EM_RESTART': '1', 16:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:40 INFO - 'PWD': '/builds/slave/test', 16:32:40 INFO - 'SHELL': '/bin/bash', 16:32:40 INFO - 'SHLVL': '1', 16:32:40 INFO - 'TERM': 'linux', 16:32:40 INFO - 'TMOUT': '86400', 16:32:40 INFO - 'USER': 'cltbld', 16:32:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:40 INFO - '_': '/tools/buildbot/bin/python'} 16:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:32:41 INFO - Cleaning up... 16:32:41 INFO - Return code: 0 16:32:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:32:41 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')]} 16:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:41 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')]} 16:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:41 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 0x7fda12f59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', '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 16:32:41 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 16:32:41 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 16:32:41 INFO - Using env: {'DISPLAY': ':0', 16:32:41 INFO - 'HOME': '/home/cltbld', 16:32:41 INFO - 'LANG': 'en_US.UTF-8', 16:32:41 INFO - 'LANGUAGE': 'en_US:en', 16:32:41 INFO - 'LOGNAME': 'cltbld', 16:32:41 INFO - 'MAIL': '/var/mail/cltbld', 16:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:41 INFO - 'MOZ_NO_REMOTE': '1', 16:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:41 INFO - 'NO_EM_RESTART': '1', 16:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:41 INFO - 'PWD': '/builds/slave/test', 16:32:41 INFO - 'SHELL': '/bin/bash', 16:32:41 INFO - 'SHLVL': '1', 16:32:41 INFO - 'TERM': 'linux', 16:32:41 INFO - 'TMOUT': '86400', 16:32:41 INFO - 'USER': 'cltbld', 16:32:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:41 INFO - '_': '/tools/buildbot/bin/python'} 16:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:41 INFO - Downloading/unpacking flake8 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32: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 16:32:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:32:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:32:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 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 16:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:32:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:32:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:32:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:32:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:32:44 INFO - no previously-included directories found matching 'docs/_build' 16:32:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:32:44 INFO - Running setup.py install for pep8 16:32:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:32:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:32:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:32:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:32:44 INFO - no previously-included directories found matching 'docs/_build' 16:32:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:32:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:32:44 INFO - Cleaning up... 16:32:44 INFO - Return code: 0 16:32:44 INFO - Running post-action listener: _resource_record_post_action 16:32:44 INFO - Running post-action listener: _start_resource_monitoring 16:32:44 INFO - Starting resource monitoring. 16:32:44 INFO - ##### 16:32:44 INFO - ##### Finished create-virtualenv step (success) 16:32:44 INFO - ##### 16:32:44 INFO - ##### 16:32:44 INFO - ##### Running install step. 16:32:44 INFO - ##### 16:32:44 INFO - Running pre-action listener: _resource_record_pre_action 16:32:44 INFO - Running main action method: install 16:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:44 INFO - Reading from file tmpfile_stdout 16:32:44 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:44 INFO - Reading from file tmpfile_stdout 16:32:44 INFO - Output received: 16:32:44 INFO - Usage: mozinstall [options] installer 16:32:44 INFO - Options: 16:32:44 INFO - -h, --help show this help message and exit 16:32:44 INFO - -d DEST, --destination=DEST 16:32:44 INFO - Directory to install application into. [default: 16:32:44 INFO - "/builds/slave/test"] 16:32:44 INFO - --app=APP Application being installed. [default: firefox] 16:32:44 INFO - mkdir: /builds/slave/test/build/application 16:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:33:01 INFO - Reading from file tmpfile_stdout 16:33:01 INFO - Output received: 16:33:01 INFO - /builds/slave/test/build/application/firefox/firefox 16:33:01 INFO - Running post-action listener: _resource_record_post_action 16:33:01 INFO - ##### 16:33:01 INFO - ##### Finished install step (success) 16:33:01 INFO - ##### 16:33:01 INFO - ##### 16:33:01 INFO - ##### Running run-tests step. 16:33:01 INFO - ##### 16:33:01 INFO - Running pre-action listener: _resource_record_pre_action 16:33:01 INFO - Running main action method: run_tests 16:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:33:01 INFO - Python 2.7.3 16:33:01 INFO - Return code: 0 16:33:01 INFO - grabbing minidump binary from tooltool 16:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:01 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f1c0>, '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 0x1a500c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a50550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:33:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:33:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:33:01 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 16:33:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:33:01 INFO - Return code: 0 16:33:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:33:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:33:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:33:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:33:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:33:02 INFO - Return code: 0 16:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 16:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 16:33:02 INFO - Using env: {'DISPLAY': ':0', 16:33:02 INFO - 'HOME': '/home/cltbld', 16:33:02 INFO - 'LANG': 'en_US.UTF-8', 16:33:02 INFO - 'LANGUAGE': 'en_US:en', 16:33:02 INFO - 'LOGNAME': 'cltbld', 16:33:02 INFO - 'MAIL': '/var/mail/cltbld', 16:33:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:33:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:02 INFO - 'MOZ_NO_REMOTE': '1', 16:33:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:02 INFO - 'NO_EM_RESTART': '1', 16:33:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:02 INFO - 'PWD': '/builds/slave/test', 16:33:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:33:02 INFO - 'SHELL': '/bin/bash', 16:33:02 INFO - 'SHLVL': '1', 16:33:02 INFO - 'TERM': 'linux', 16:33:02 INFO - 'TMOUT': '86400', 16:33:02 INFO - 'USER': 'cltbld', 16:33:02 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306', 16:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:02 INFO - '_': '/tools/buildbot/bin/python'} 16:33:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 16:33:02 INFO - mozversion application_buildid: 20160609133023 16:33:02 INFO - mozversion application_changeset: 5e5914f1100056bd3144b0061a7c826bf73ef918 16:33:02 INFO - mozversion application_display_name: Nightly 16:33:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:33:02 INFO - mozversion application_name: Firefox 16:33:02 INFO - mozversion application_remotingname: firefox 16:33:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:33:02 INFO - mozversion application_vendor: Mozilla 16:33:02 INFO - mozversion application_version: 50.0a1 16:33:02 INFO - mozversion platform_buildid: 20160609133023 16:33:02 INFO - mozversion platform_changeset: 5e5914f1100056bd3144b0061a7c826bf73ef918 16:33:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:33:02 INFO - mozversion platform_version: 50.0a1 16:33:02 INFO - using testdate: 1465515182 16:33:02 INFO - actual date: 1465515182 16:33:02 INFO - starting webserver on 'localhost:51414' 16:33:02 INFO - SUITE-START | Running 2 tests 16:33:02 INFO - TEST-START | dromaeo_css 16:33:02 INFO - operating with platform_type : linux_ 16:33:02 INFO - Initialising browser for dromaeo_css test... 16:33:02 INFO - TEST-INFO | started process 11112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe87kEH/profile http://localhost:51414/getInfo.html) 16:33:06 INFO - PROCESS | 11112 | __metrics Screen width/height:1600/1200 16:33:06 INFO - PROCESS | 11112 | colorDepth:24 16:33:06 INFO - PROCESS | 11112 | Browser inner width/height: 1024/697 16:33:06 INFO - PROCESS | 11112 | __metrics 16:33:08 ERROR - PROCESS | 11112 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:33:08 INFO - PROCESS | 11112 | console.error: PushService: 16:33:08 INFO - PROCESS | 11112 | stateChangeProcessEnqueue: Error transitioning state 16:33:08 INFO - PROCESS | 11112 | UnknownError 16:33:09 INFO - TEST-INFO | 11112: exit 0 16:33:09 INFO - Browser initialized. 16:33:09 INFO - Running cycle 1/1 for dromaeo_css test... 16:33:09 INFO - TEST-INFO | started process 11198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe87kEH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:21 INFO - PROCESS | 11198 | RSS: Main: 173748224 16:33:21 INFO - PROCESS | 11198 | 16:34:12 INFO - PROCESS | 11198 | 1465515252686 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] 16:36:21 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51414/tests/dromaeo/cssquery-ext.html) 16:36:22 INFO - PROCESS | 11198 | RSS: Main: 265498624 16:36:22 INFO - PROCESS | 11198 | 16:39:24 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-ext.html (next: http://localhost:51414/tests/dromaeo/cssquery-jquery.html) 16:39:25 INFO - PROCESS | 11198 | RSS: Main: 264617984 16:39:25 INFO - PROCESS | 11198 | 16:42:27 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51414/tests/dromaeo/cssquery-mootools.html) 16:42:27 INFO - PROCESS | 11198 | RSS: Main: 258469888 16:42:27 INFO - PROCESS | 11198 | 16:45:29 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51414/tests/dromaeo/cssquery-prototype.html) 16:45:30 INFO - PROCESS | 11198 | RSS: Main: 261345280 16:45:30 INFO - PROCESS | 11198 | 16:48:33 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51414/tests/dromaeo/cssquery-yui.html) 16:48:33 INFO - PROCESS | 11198 | RSS: Main: 243453952 16:48:33 INFO - PROCESS | 11198 | 16:51:36 INFO - PROCESS | 11198 | Cycle 1(1): loaded http://localhost:51414/tests/dromaeo/cssquery-yui.html (next: http://localhost:51414/tests/dromaeo/cssquery-dojo.html) 16:51:37 INFO - PROCESS | 11198 | RSS: Main: 297938944 16:51:37 INFO - PROCESS | 11198 | 16:51:37 INFO - PROCESS | 11198 | __start_tp_report 16:51:37 INFO - PROCESS | 11198 | _x_x_mozilla_page_load 16:51:37 INFO - PROCESS | 11198 | _x_x_mozilla_page_load_details 16:51:37 INFO - PROCESS | 11198 | |i|pagename|runs| 16:51:37 INFO - PROCESS | 11198 | |0;dojo.html;3031.287647402861;3049.771267154964;3080.7843450958426;3081.198888289047;3106.456370135226;5281.260623512711;5282.577393808496;5344.35867695877;5367.785288588457;5399.703016334095;5365.302510673617;5379.704116273603;5381.515663590276;5420.756065977031;5519.9448005519935;4826.300186472968;4890.315355850166;4917.262410638397;4920.852374428773;4935.777889994941;4990.65065445419;5009.924851127236;5032.672876263049;5062.215356619711;5062.417821950467;4847.07905497956;4890.462049174588;4905;4925.532074452921;4935.777889994959;4952.430470495903;4959.057779021974;4962.801487940478;4971.875703107451;4974.925376119361;4913.508649135058;4917.065757506062;4921.532454416824;4926.0394223126505;4927.408710954673;5224.895502089937;5247.344081989751;5264.15773476242;5338.252644629755;5409;5706.457886500776;5748.16651585522;5753.223314852483;5824.213731146283;5827.475527202572;5831.387704291031;5875.324337701177;5890.587658863881;5893.764249430018;5895.616784908967;5300.893982120375;5317.0163519748585;5340.572754179656;5375.3280839895015;5446.8910621787345;5878.764849405976;5899.734511946973;5900.232969713909;5905.409459054146;5921.526277897758;5479.506844383945;5664.603477756517;5701.971490142606;5708.429157084342;5713.628614140068;5740.42595740431;5790.334111577223;5797.623154494944;5810.680412577264;5816.505597024216;5797.36229014808;5800.419958004166;5805.577633479825;5812.680302583314;5815.476607105381;5597.076482380362;5654.6324488908085;5775.451332123442;5823.417658234142;5829.44620261083;4359.084592235603;4365.628921541705;4366.192254432876;4395.450568678915;4420.823167073346;3873.4189871519498;3880.9223815523533;3913.980430097888;3914.1388894443176;3940.9211815763524;5344.091504444254;5401.756920938567;5415;5441;5474.42518535556;5795.913061304083;5806.593538452352;5824;5827.4172582741385;5852.648841069549;5475.7262136893;5491.176323551419;5492.670439773627;5493.972530137324;5502;4868.391451068616;4914.533119353656;4939.728314942641;4974.427940786783;5040.521150490697;5945.316288626776;5952.345242023374;5953.166556682068;5961.552883533753;5992.610480318765;5773.393793651606;5778.653280803165;5785.103308987113;5785.161151633074;5786.392428794916;5847.06446968483;5923.763049477972;5933.643981361132;5952.76188952437;5980.910286345621;5640.492355687844;5691.686957217393;5700.372958974593;5715.599908006399;5722.284714410699;5729.656220626609;5738.426157384395;5800.6809625471005;5801.9709901451915;5808.419158084158;5511.035568775368;5528.668279903219;5568.387477377566;5571.8885622288135;5589.608727389043;5647.887042259214;5651.2935883014625;5653.632513886584;5653.717314134195;5669.801556945487;5472.863178420572;5566.554675625859;5568.610197286151;5569.248151499496;5573.804916827891;5654.236678048411;5689.544836412994;5703.058995265735;5777.942220577908;5784.334801497882;5626.38109807929;5627.549796016391;5628.986782379047;5633.63381380209;5635.380108188178 16:51:37 INFO - PROCESS | 11198 | |1;ext.html;609.9085137229415;610.1914962674457;613.7268915332679;613.7790395457635;632.7437387857916;31041.223969400748;43367.13265734683;44031.559684403146;44181.337279940824;47248;45825;46245.30632040522;46330.30504542434;46371;46485.8865524792;8926.2412694921;9064.456132632064;9071.95464022679;9079.409838360518;9085.273178145733;8897.866532002025;8983.685571005017;8987.415817971843;9000.504972226525;9004.324675649319;9055.592498337557;9073.228775554086;9081.909180908206;9094.363394562382;9094.818103637923;9039.728808135766;9069.909300907038;9091.227245684126;9091.909080909172;9092.499912504809;8914.375993680445;8956.014838367839;8996.235319997808;8998.460092394478;9014.36899417041;43644.563554364366;43662;44075.33886991665;44147.337789932855;44179;3362.5117413114363;3470.1498132957336;3495.5980062292906;3550.4851796489625;3553.378158822222;32832.50751238709;33269.83365083183;33359;33777.49333759971;34800;4361.127774445124;4375.934360984587;4416.381706561084;4435.667324950609;4444.688871778977;353118;353468.99999999744;353529;353867;353967;59421.405785941584;59556.70221648864;59921;59928.400715992284;59967.10049349263;54917.450825491236;55934.72032639811;59402;60020.19939401825;60477.09284360738;16954.830451695325;17033.48899533016;17228.569285767706;17231.56921076983;17232.310707571807;13223.272720000492;13265.137766045369;13332.600021999355;13336.066475346826;13336.399862006234;15427.922860385626;16751.6649667006;16952.491425257263;17384.913075434542;17568.209430575655;5989.431004054608;6030.155778191057;6040.2047696341615;6166.506679465632;6199.3490683478485;903.0698380667791;1001.7678255745328;1018.2312354172552;1061.2465149743614;1112.1325366214367;32740.672593274237;33292.50061249083;33453.83273083619;33624.831875840464;33738.49392259118;1083.8699356077163;1132.6262333429947;1141.9885801142048;1152.3143729480946;1153.9019183369508;16858.831411685725;17150.571235719206;17338.739918901225;17483.56291092733;17785.288588456577;555409;555884;559720;561201;564529;59667.70166149228;59681.403185968455;59856.70071649701;59864.10203846946;59880.70059649674;1254.1283807753707;1332.4670131947105;1339.04258455205;1347.797830325459;1350.7366063617696;31796.68203317937;31801;32626.347473050882;32677.509837352933;33179.50230746589;52866.73566632142;52907.206391904925;53018;53282;53410.732946336575;475753;478874;481254;481975;482846;25118.497630047663;25970;26045.609315860656;43204.56795432005;43440.4795832157;49210.50789492059;49664.73088666597;50589.49410505995;50642;51036.489635104655;41582;41601.37597936094;41892;42434.787826060674;43519;41661.58338416577;41951.79024104982;42049;42133.15733685248;42810.14379712326;40524;41361;42670.78664606657;42776;42835.78582107194;35041.824790875886;36477.45283820692;36900.81549592342;37296;37670;27940.483337219648;28124.92188632596;28468.171252905617;34980.47529287012;34983.475247870796 16:51:37 INFO - PROCESS | 11198 | |2;jquery.html;366.8862652577703;383.6987964447908;389.0992352703493;392.8291193330901;414.3639513347011;16511.256993435294;18384.632307353877;18445.72331415028;18486.445406637824;18599.256029758828;18206.453806385798;18518.44444666659;18520.814791852077;18813;19395.612087758236;5607.859803504904;5734.4265573442735;5844.561657875655;5895.705214739267;5900.085486749561;5657.830265092033;5725.083986562151;5731.914021289684;5755.510781583549;5777.797777077803;5638.40796716345;5688.061469857489;5727.971360143193;5739.196512488255;5789.913151302734;5607.663540187602;5634.492895639371;5687.630304030225;5789.218455508494;5790.855228619297;4889.559939605417;5013.423456302536;5055.266986286968;5213.165893457067;5216.765245563959;22540.549189016292;22731.431714207112;22977.77022229773;23122.190723324602;23161.189358372543;2439.81701372396;2475.628655701659;2556.130915488724;2841.2059451363743;3066.2794243352796;13943.302834858216;13977;14460;14954.62613434662;15003.1748253846;1782.875198736089;1892.101251905334;1925.3970944551288;1936.6320399124263;2044.2231951858348;52529;71984;72758.63620681915;80045;81171.5941420295;10088.848667269996;10435.269531132899;10756.408397538211;10861.728456788644;10929.398883061507;15168;15236.695266094615;15262.389504419922;15317.157556334285;15322.080675159526;7735.458517903805;8155.877661835078;8225.383096267804;8306.750797476085;8317.334613230927;7261.237570055174;7365.48441609093;7368.557886526825;7400.703971841173;8049.9597502013285;4588.449386073693;4618.399608050931;4677.158111539888;4691.554302341272;4766.189747742892;1825.4067428085925;1889.716542518633;1890.5462688954551;1910;1926.6435709393527;874.33113668044;937.7374335186158;972.3776782858976;990.4898977026837;1020.9489525523694;17706.20322085509;18745.7188142178;19022.90488547576;19053.80946190548;19167;944.9244060475146;975.331897650112;994.2096033653263;998.1914649134225;1013.1034034879185;10170.847437288447;10214.795704085876;10367.274290799722;10376.844347334796;10377.325473844176;180968;182119;314528;490474;510067;74739;95708;96328;98375;99562.5021874886;934.9859752103724;940.210223412337;969.9224062075017;974.1281553010016;974.7514383832078;16952.69510606604;17073.146342683063;17212.655746885244;17257.223424946158;17396.304147833944;39734.40398394084;39913.401298981116;39914.60085399109;40004.79997599994;41047.38428923509;56066.43933560612;57207.71396143159;58205.12692309534;58326;59102.40897590969;8255.380846436421;8309.6676132954;8346.207110324509;8369.204925532065;8593.484390936565;11344.943275283571;12861.742765144832;13098.672533186747;13109.803352949904;13197.736045279233;10772.084372828398;11153.219274650697;11222.887771122185;11507.84921507876;11523.423828808694;11025.393603351893;11241.213115081866;11581.82627260575;11585.536578536765;11784.292942423483;11198.160137989846;11402.657920262405;11530.250533715282;11762.3530705812;11813.940930295294;8237.299829514319;8353.415260931677;8363.623636936474;8413.200745929127;8523.701670441753;10754.73113172177;11286.66140015801;11298.322100673986;11890;11925.701857453287 16:51:37 INFO - PROCESS | 11198 | |3;mootools.html;1261.2306493039239;1416.8735854995277;1451.7169152015356;1530.8392618775028;1691.6362981958875;8200.876986845195;8550.871736923951;8578.356623253258;8759.781005474866;8816.735497935057;8569.65721371146;8725.694600688978;8727.912720872806;8737.912620873789;8745.344099192554;2020.6968954656772;2241.7309922809204;2295.586794377016;2323.3610757041865;2335.509542995973;2362.3149286706835;2375.7505461926507;2376.95246095078;2392.629142482909;2401.5917294059964;2313.363824948136;2358.882055897207;2382.5354055959097;2383.1778036577352;2383.8450500717486;1952.2386269354963;2187.7155969723995;2253.346529506441;2253.3690566641285;2261.513774538466;2255.2332207049517;2259.0850705464313;2275.9203427879943;2279.0200213908015;2279.8974046167964;8804.163604457566;8859.335549833724;8866;8868.822623547558;8881.511516866569;5074.619403544712;5248.291480650139;5255.1854462557985;5265.104932161542;5269.420363759983;3248.772585918987;3390.8982730518123;3436.604790449105;3449.275652113059;3460.740444466675;1093.4642025407572;1096.6929259807187;1110.1008183371496;1133.9489722962487;1140.321508702321;12415.689607759788;12440.315782631951;12454.128211025141;12474;12484.126111172221;4600.102979918951;4690.624750019991;4781.6891902026955;4790.281457781361;4807.086653535817;9846.556904939294;9856.112949834549;9862.309638325249;9869.457179855177;9884.406935583887;5184.870378240575;5233.476652334813;5235.60732945023;5236.973815130977;5237.816676416383;4191.601797829201;4677.695949763254;4781.497942716034;4822.348982887265;4889.193283108319;3872.0900588361715;3981.6615587675374;4014.658754005884;4026.214888096793;4092.3043082676018;1244.4337826289018;1258.7167887225485;1273.2042473454092;1273.3633183408297;1282.2498838179583;921.6267411698273;922.4096578189964;935.9625614975461;947.4410098042188;971.1890571372842;5594.482373138474;5832.358440571534;5850.619709718854;5948.9702551487835;5993.370696076936;450.5156956271955;452.12965042293456;463.54109431662414;470.17953670844594;472.2561964905288;4070.9592904070582;4116.958830411658;4125.834966601363;4141.730787498803;4172.08214192877;10347.948260258801;10882.183836212316;10882.29265097766;10915.617953371593;10936.671899843017;10714.892851071545;10746.462676866126;10757.9462102689;10771.56913723458;10793.892061079447;8016.278534931767;8080.191980801873;8145.266925976572;8156.551389673625;8172.918270817216;5668.7165641718575;5683.545316374597;5711.628744131618;5727.4845263926445;5906.232189815297;9839.557219924978;10204.336718113596;10249.33379330341;10270.229732770222;10294.897051029393;10146.289759716748;10255.07704306616;10258.281920265808;10265.076143147153;10286.125679317043;7105.609191494517;7419.740309089372;7608.2011388805595;7836.098848632252;7914.287714105758;8656.567171641267;8685.522296273766;8731.432456890281;8762.25520830711;8763.780905477413;7716.614169291625;7904.960475197588;7927.5243485391065;8000.119986801331;8004.319632831274;7406.851862962602;7739.845203096019;7764.262395072459;7869.213078692085;7948.403869709679;6779.220389655253;6985.441164706913;6995.265497122932;7008.5094043416475;7030.156381234285;4953.18272485036;5065.56942659878;5231.3199284092825;5232.816851410183;5274.472552744694;5129.102407078821;5166.948330516797;5202.869928251824;5228.895422091613;5254.159334506614 16:51:37 INFO - PROCESS | 11198 | |4;prototype.html;320.3544857112918;327.06296460640266;334.97320214382853;339.75028354159696;340.07499601085055;5154.608255770944;5183.50756678115;5272.365566674333;5323.281357016802;5355.7857685692625;5229.111051121309;5239.921401178985;5255.343082114736;5259.368875734907;5286.704757334458;4144.813483393239;4158.937615935756;4162.354835000579;4174.749515029092;4192.622663960243;4074.3073677474754;4142.730722503043;4167.979160104195;4179.1223842993;4179.3939878717565;4112;4129.380592911072;4149.107941792514;4155.210510003105;4160.523014329915;4116.991337122394;4120.835166593332;4146.834126634931;4150.481189851269;4164.12553363794;3684.44733290006;3695.297893400272;3707.4624179494094;3715.071232191952;3717.854592129756;4841.636877234221;5103.744812759347;5134.845954621367;5153;5172.6379153459275;4699.412573428322;4715.552022557851;4716.646251531149;4729.972817396869;4734.928976065362;5282.498162674578;5478.506934375925;5515.227868098469;5516.972415137939;5526;3977.7016723745546;3980.8208630611693;3984.2429938311916;3985.4021896715435;4023.0948036691802;5428.2671839301975;5480.780768769245;5736.168255602956;5757.165211044375;5797.188393624896;4119.176164766998;4159.708820382544;4190.874273771792;4194.224068547329;4195.895102622459;4227.091175397304;4261.850835220753;4263.552327005682;4264.125854199881;4265.317549192115;4483.229124495806;4507.301368287855;4638.6752927294765;4749.4775574686755;4770.642201834807;5293.470652934676;5566.4990150886615;5570.610057296031;5572.860678482989;5586.35756887955;1452.9200893950722;1461.2109460891;1462.3127130248765;1468.7943687883705;1472.6539263273123;930.0792215706537;953.2945620241111;958.520739630185;965.0891235354038;973.4500007495742;4746.7389293589185;4779.402574678165;4785.928211076836;4788.922492439243;4808.879778005507;4968.403791545038;4974.189582885658;4996.975015124901;5118.283440318359;5137.588992880561;4681.765911704401;4768.499307572724;4768.833090841804;4795.568398844121;4837.419509658864;2669.4794515069375;2694.420699549606;2710.1733971138992;2713.796465265113;2730.5904114383;5101.719405432663;5190.299309593157;5233;5233.921491177559;5236.6857988520815;4782.606574254312;5053.898922021539;5095.87260318495;5146.845594632092;5182.352205974254;5059.645824792229;5101.69389836611;5148.374329092115;5175.9741201293755;5186.455422180692;5009.874753131201;5023.773930173078;5027.2207807789855;5072.28987941681;5084.186530155157;4804.8798780030775;4946.554810067111;4974.253861920741;4999.900001999867;5034.974825125851;5125.282460455464;5221.955608878164;5506.2291279221745;5666.263385759825;5753.1945527627;4136.958630413657;4173.9582604173565;4194.182134483868;4214.852480163179;4228.731380585874;5664.716764161693;5666.886662266814;5675.545956323567;5680.403557626555;5699.2590963174525;5258.342707161605;5575;5665.518430933252;5675.602707810413;5699.857503562444;5456;5560.471755183251;5573.136163894603;5656;5690.83337915718;5176.7152806594495;5539;5551.8889622208135;5591.077472217039;5606.411326810626;5593.608447408642;5606.299212598426;5619.494245517923;5622.1566764983945;5633.774649013993;5513;5523.420040895809;5529.253550770594;5577.916331254954;5581.990483426044 16:51:37 INFO - PROCESS | 11198 | |5;yui.html;755.4787196834183;779.4193325972152;782.9843403131933;800.4996876951905;825.0759149752274;15554.533363999084;16248.918755406221;16500.42248521302;16512.66974660506;16527.83472165278;13991.650208744786;14043.578692639212;14117.858821411783;14160.787588186186;14340.282985850692;658.1969996604136;775.2634996753079;779.0845756236399;794.9761507154794;798.3533337996241;786.0488808541643;788.5544667263007;788.7121200761738;789.3054112381096;791.0586402181385;834.9081601023883;842.0821304777791;842.5787106446777;843.152631605239;843.5234092737614;697.9511434199608;839.2740279658052;840.4327079221532;840.5713086325957;841.3227351981683;605.5549171359047;613.1048668943304;614.6834380294152;620.5563022438978;620.5997131849977;15059.096454212782;15068.246587670683;15073.246337683073;15121.773173402407;15131.470398536108;13805.585832425044;14383.640408989859;14457.421703131862;14542.854571454256;14558.4904528341;12697.936510317482;12911.418986145645;13047.608571742863;13072;13640.522581709693;4445.599896009342;4510.639148868083;4557.544245575449;4581;4762.666613337068;67711.3228867715;68253;68845.31154688488;69376.0647147316;69620.6518967402;11339.546418143347;11423.828642570368;11491.195616306779;11547.422628868522;11574.247673901169;21554.56890862174;21609.243676471247;21617.78382216189;21625.24311649085;21626.891865540572;8757.781055473664;9015.639374424949;9023.548822558978;9280.350375473652;9293.210077143383;4771.5228477152;4816.325714399917;4819.975900120477;4879.097366987119;4934.235193545006;3379.121428428626;3498.632643572439;3516.4197907345515;3520.0847779576984;3523.2072783623994;589.3487696095838;606.4693393280879;609.5093449772976;659.4658326755343;701.3932947999944;704.1550139832221;725.5175308419841;770.7148355108534;771.8031901864988;799.6881216325638;10421.583136674448;10835.349281724997;11001.449927503592;11101.111911047097;11200;676.4960104722013;737.575893861032;761.7105499909999;771.155584634824;774.6823802241166;4921.557059864629;5060.722734156158;5115.590752739772;5128.615353848476;5171.560417364491;116952;122701;125199.37400313122;126569;126820;68467;84556.57721711475;108374.45812770886;108974.45512772385;110404;96221.51889240369;96994.51502742441;98170;98350;99367.50316248373;9203.309751768511;9331.393459425115;9461.101195386427;9492.620295188115;9510.191633711212;54472.45527544832;55420.44579554153;55570;56263.71868140633;56576.434235657114;48166;69226;81700.59149704213;82591;84573;12255;12415;12441.129120961808;12684.809727853904;12693;14026;14177.291135443393;14246.715065698421;14729.631759206106;14886.10683359002;12917.935410322889;12992.870071299543;13257.469701212229;13300.800487992494;13488.12327198729;12650;12737.745245095231;12902.419391127609;13253.66865828362;13411.731765364442;12471.5011399543;12668.619941401772;13147.408366623333;13168.80246796318;13630.93184534071;10421.53103110377;10534;10589.52347144365;10677.839832402675;10938.453077345941;11202.94398528002;11330.60342887995;11597.304161750322;11602.47788849487;11658.70853228676 16:51:37 INFO - PROCESS | 11198 | __end_tp_report 16:51:37 INFO - PROCESS | 11198 | __start_cc_report 16:51:37 INFO - PROCESS | 11198 | _x_x_mozilla_cycle_collect,949 16:51:37 INFO - PROCESS | 11198 | __end_cc_report 16:51:37 INFO - PROCESS | 11198 | __startTimestamp1465516297168__endTimestamp 16:51:37 INFO - PROCESS | 11198 | 16:51:37 INFO - PROCESS | 11198 | ------- Summary: start ------- 16:51:37 INFO - PROCESS | 11198 | Number of tests: 6 16:51:37 INFO - PROCESS | 11198 | 16:51:37 INFO - PROCESS | 11198 | [#0] dojo.html Cycles:165 Average:5361.75 Median:5569.25 stddev:617.80 (11.1%) stddev-sans-first:592.03 16:51:37 INFO - PROCESS | 11198 | Values: 3031.3 3049.8 3080.8 3081.2 3106.5 5281.3 5282.6 5344.4 5367.8 5399.7 5365.3 5379.7 5381.5 5420.8 5519.9 4826.3 4890.3 4917.3 4920.9 4935.8 4990.7 5009.9 5032.7 5062.2 5062.4 4847.1 4890.5 4905.0 4925.5 4935.8 4952.4 4959.1 4962.8 4971.9 4974.9 4913.5 4917.1 4921.5 4926.0 4927.4 5224.9 5247.3 5264.2 5338.3 5409.0 5706.5 5748.2 5753.2 5824.2 5827.5 5831.4 5875.3 5890.6 5893.8 5895.6 5300.9 5317.0 5340.6 5375.3 5446.9 5878.8 5899.7 5900.2 5905.4 5921.5 5479.5 5664.6 5702.0 5708.4 5713.6 5740.4 5790.3 5797.6 5810.7 5816.5 5797.4 5800.4 5805.6 5812.7 5815.5 5597.1 5654.6 5775.5 5823.4 5829.4 4359.1 4365.6 4366.2 4395.5 4420.8 3873.4 3880.9 3914.0 3914.1 3940.9 5344.1 5401.8 5415.0 5441.0 5474.4 5795.9 5806.6 5824.0 5827.4 5852.6 5475.7 5491.2 5492.7 5494.0 5502.0 4868.4 4914.5 4939.7 4974.4 5040.5 5945.3 5952.3 5953.2 5961.6 5992.6 5773.4 5778.7 5785.1 5785.2 5786.4 5847.1 5923.8 5933.6 5952.8 5980.9 5640.5 5691.7 5700.4 5715.6 5722.3 5729.7 5738.4 5800.7 5802.0 5808.4 5511.0 5528.7 5568.4 5571.9 5589.6 5647.9 5651.3 5653.6 5653.7 5669.8 5472.9 5566.6 5568.6 5569.2 5573.8 5654.2 5689.5 5703.1 5777.9 5784.3 5626.4 5627.5 5629.0 5633.6 5635.4 16:51:37 INFO - PROCESS | 11198 | 16:51:37 INFO - PROCESS | 11198 | [#1] ext.html Cycles:180 Average:62782.16 Median:23940.06 stddev:125282.28 (523.3%) stddev-sans-first:125546.76 16:51:37 INFO - PROCESS | 11198 | Values: 609.9 610.2 613.7 613.8 632.7 31041.2 43367.1 44031.6 44181.3 47248.0 45825.0 46245.3 46330.3 46371.0 46485.9 8926.2 9064.5 9072.0 9079.4 9085.3 8897.9 8983.7 8987.4 9000.5 9004.3 9055.6 9073.2 9081.9 9094.4 9094.8 9039.7 9069.9 9091.2 9091.9 9092.5 8914.4 8956.0 8996.2 8998.5 9014.4 43644.6 43662.0 44075.3 44147.3 44179.0 3362.5 3470.1 3495.6 3550.5 3553.4 32832.5 33269.8 33359.0 33777.5 34800.0 4361.1 4375.9 4416.4 4435.7 4444.7 353118.0 353469.0 353529.0 353867.0 353967.0 59421.4 59556.7 59921.0 59928.4 59967.1 54917.5 55934.7 59402.0 60020.2 60477.1 16954.8 17033.5 17228.6 17231.6 17232.3 13223.3 13265.1 13332.6 13336.1 13336.4 15427.9 16751.7 16952.5 17384.9 17568.2 5989.4 6030.2 6040.2 6166.5 6199.3 903.1 1001.8 1018.2 1061.2 1112.1 32740.7 33292.5 33453.8 33624.8 33738.5 1083.9 1132.6 1142.0 1152.3 1153.9 16858.8 17150.6 17338.7 17483.6 17785.3 555409.0 555884.0 559720.0 561201.0 564529.0 59667.7 59681.4 59856.7 59864.1 59880.7 1254.1 1332.5 1339.0 1347.8 1350.7 31796.7 31801.0 32626.3 32677.5 33179.5 52866.7 52907.2 53018.0 53282.0 53410.7 475753.0 478874.0 481254.0 481975.0 482846.0 25118.5 25970.0 26045.6 43204.6 43440.5 49210.5 49664.7 50589.5 50642.0 51036.5 41582.0 41601.4 41892.0 42434.8 43519.0 41661.6 41951.8 42049.0 42133.2 42810.1 40524.0 41361.0 42670.8 42776.0 42835.8 35041.8 36477.5 36900.8 37296.0 37670.0 27940.5 28124.9 28468.2 34980.5 34983.5 16:51:37 INFO - PROCESS | 11198 | 16:51:37 INFO - PROCESS | 11198 | [#2] jquery.html Cycles:180 Average:24379.16 Median:375.29 stddev:61246.73 (16319.7%) stddev-sans-first:61392.01 16:51:37 INFO - PROCESS | 11198 | Values: 366.9 383.7 389.1 392.8 414.4 16511.3 18384.6 18445.7 18486.4 18599.3 18206.5 18518.4 18520.8 18813.0 19395.6 5607.9 5734.4 5844.6 5895.7 5900.1 5657.8 5725.1 5731.9 5755.5 5777.8 5638.4 5688.1 5728.0 5739.2 5789.9 5607.7 5634.5 5687.6 5789.2 5790.9 4889.6 5013.4 5055.3 5213.2 5216.8 22540.5 22731.4 22977.8 23122.2 23161.2 2439.8 2475.6 2556.1 2841.2 3066.3 13943.3 13977.0 14460.0 14954.6 15003.2 1782.9 1892.1 1925.4 1936.6 2044.2 52529.0 71984.0 72758.6 80045.0 81171.6 10088.8 10435.3 10756.4 10861.7 10929.4 15168.0 15236.7 15262.4 15317.2 15322.1 7735.5 8155.9 8225.4 8306.8 8317.3 7261.2 7365.5 7368.6 7400.7 8050.0 4588.4 4618.4 4677.2 4691.6 4766.2 1825.4 1889.7 1890.5 1910.0 1926.6 874.3 937.7 972.4 990.5 1020.9 17706.2 18745.7 19022.9 19053.8 19167.0 944.9 975.3 994.2 998.2 1013.1 10170.8 10214.8 10367.3 10376.8 10377.3 180968.0 182119.0 314528.0 490474.0 510067.0 74739.0 95708.0 96328.0 98375.0 99562.5 935.0 940.2 969.9 974.1 974.8 16952.7 17073.1 17212.7 17257.2 17396.3 39734.4 39913.4 39914.6 40004.8 41047.4 56066.4 57207.7 58205.1 58326.0 59102.4 8255.4 8309.7 8346.2 8369.2 8593.5 11344.9 12861.7 13098.7 13109.8 13197.7 10772.1 11153.2 11222.9 11507.8 11523.4 11025.4 11241.2 11581.8 11585.5 11784.3 11198.2 11402.7 11530.3 11762.4 11813.9 8237.3 8353.4 8363.6 8413.2 8523.7 10754.7 11286.7 11298.3 11890.0 11925.7 16:51:37 INFO - PROCESS | 11198 | 16:51:37 INFO - PROCESS | 11198 | [#3] mootools.html Cycles:180 Average:5762.43 Median:4798.68 stddev:3310.73 (69.0%) stddev-sans-first:3302.74 16:51:37 INFO - PROCESS | 11198 | Values: 1261.2 1416.9 1451.7 1530.8 1691.6 8200.9 8550.9 8578.4 8759.8 8816.7 8569.7 8725.7 8727.9 8737.9 8745.3 2020.7 2241.7 2295.6 2323.4 2335.5 2362.3 2375.8 2377.0 2392.6 2401.6 2313.4 2358.9 2382.5 2383.2 2383.8 1952.2 2187.7 2253.3 2253.4 2261.5 2255.2 2259.1 2275.9 2279.0 2279.9 8804.2 8859.3 8866.0 8868.8 8881.5 5074.6 5248.3 5255.2 5265.1 5269.4 3248.8 3390.9 3436.6 3449.3 3460.7 1093.5 1096.7 1110.1 1133.9 1140.3 12415.7 12440.3 12454.1 12474.0 12484.1 4600.1 4690.6 4781.7 4790.3 4807.1 9846.6 9856.1 9862.3 9869.5 9884.4 5184.9 5233.5 5235.6 5237.0 5237.8 4191.6 4677.7 4781.5 4822.3 4889.2 3872.1 3981.7 4014.7 4026.2 4092.3 1244.4 1258.7 1273.2 1273.4 1282.2 921.6 922.4 936.0 947.4 971.2 5594.5 5832.4 5850.6 5949.0 5993.4 450.5 452.1 463.5 470.2 472.3 4071.0 4117.0 4125.8 4141.7 4172.1 10347.9 10882.2 10882.3 10915.6 10936.7 10714.9 10746.5 10757.9 10771.6 10793.9 8016.3 8080.2 8145.3 8156.6 8172.9 5668.7 5683.5 5711.6 5727.5 5906.2 9839.6 10204.3 10249.3 10270.2 10294.9 10146.3 10255.1 10258.3 10265.1 10286.1 7105.6 7419.7 7608.2 7836.1 7914.3 8656.6 8685.5 8731.4 8762.3 8763.8 7716.6 7905.0 7927.5 8000.1 8004.3 7406.9 7739.8 7764.3 7869.2 7948.4 6779.2 6985.4 6995.3 7008.5 7030.2 4953.2 5065.6 5231.3 5232.8 5274.5 5129.1 5166.9 5202.9 5228.9 5254.2 16:51:37 INFO - PROCESS | 11198 | 16:51:37 INFO - PROCESS | 11198 | [#4] prototype.html Cycles:180 Average:4523.58 Median:5025.50 stddev:1285.47 (25.6%) stddev-sans-first:1249.76 16:51:37 INFO - PROCESS | 11198 | Values: 320.4 327.1 335.0 339.8 340.1 5154.6 5183.5 5272.4 5323.3 5355.8 5229.1 5239.9 5255.3 5259.4 5286.7 4144.8 4158.9 4162.4 4174.7 4192.6 4074.3 4142.7 4168.0 4179.1 4179.4 4112.0 4129.4 4149.1 4155.2 4160.5 4117.0 4120.8 4146.8 4150.5 4164.1 3684.4 3695.3 3707.5 3715.1 3717.9 4841.6 5103.7 5134.8 5153.0 5172.6 4699.4 4715.6 4716.6 4730.0 4734.9 5282.5 5478.5 5515.2 5517.0 5526.0 3977.7 3980.8 3984.2 3985.4 4023.1 5428.3 5480.8 5736.2 5757.2 5797.2 4119.2 4159.7 4190.9 4194.2 4195.9 4227.1 4261.9 4263.6 4264.1 4265.3 4483.2 4507.3 4638.7 4749.5 4770.6 5293.5 5566.5 5570.6 5572.9 5586.4 1452.9 1461.2 1462.3 1468.8 1472.7 930.1 953.3 958.5 965.1 973.5 4746.7 4779.4 4785.9 4788.9 4808.9 4968.4 4974.2 4997.0 5118.3 5137.6 4681.8 4768.5 4768.8 4795.6 4837.4 2669.5 2694.4 2710.2 2713.8 2730.6 5101.7 5190.3 5233.0 5233.9 5236.7 4782.6 5053.9 5095.9 5146.8 5182.4 5059.6 5101.7 5148.4 5176.0 5186.5 5009.9 5023.8 5027.2 5072.3 5084.2 4804.9 4946.6 4974.3 4999.9 5035.0 5125.3 5222.0 5506.2 5666.3 5753.2 4137.0 4174.0 4194.2 4214.9 4228.7 5664.7 5666.9 5675.5 5680.4 5699.3 5258.3 5575.0 5665.5 5675.6 5699.9 5456.0 5560.5 5573.1 5656.0 5690.8 5176.7 5539.0 5551.9 5591.1 5606.4 5593.6 5606.3 5619.5 5622.2 5633.8 5513.0 5523.4 5529.3 5577.9 5582.0 16:51:37 INFO - PROCESS | 11198 | 16:51:37 INFO - PROCESS | 11198 | [#5] yui.html Cycles:180 Average:21211.73 Median:4569.27 stddev:31155.62 (681.9%) stddev-sans-first:31205.16 16:51:37 INFO - PROCESS | 11198 | Values: 755.5 779.4 783.0 800.5 825.1 15554.5 16248.9 16500.4 16512.7 16527.8 13991.7 14043.6 14117.9 14160.8 14340.3 658.2 775.3 779.1 795.0 798.4 786.0 788.6 788.7 789.3 791.1 834.9 842.1 842.6 843.2 843.5 698.0 839.3 840.4 840.6 841.3 605.6 613.1 614.7 620.6 620.6 15059.1 15068.2 15073.2 15121.8 15131.5 13805.6 14383.6 14457.4 14542.9 14558.5 12697.9 12911.4 13047.6 13072.0 13640.5 4445.6 4510.6 4557.5 4581.0 4762.7 67711.3 68253.0 68845.3 69376.1 69620.7 11339.5 11423.8 11491.2 11547.4 11574.2 21554.6 21609.2 21617.8 21625.2 21626.9 8757.8 9015.6 9023.5 9280.4 9293.2 4771.5 4816.3 4820.0 4879.1 4934.2 3379.1 3498.6 3516.4 3520.1 3523.2 589.3 606.5 609.5 659.5 701.4 704.2 725.5 770.7 771.8 799.7 10421.6 10835.3 11001.4 11101.1 11200.0 676.5 737.6 761.7 771.2 774.7 4921.6 5060.7 5115.6 5128.6 5171.6 116952.0 122701.0 125199.4 126569.0 126820.0 68467.0 84556.6 108374.5 108974.5 110404.0 96221.5 96994.5 98170.0 98350.0 99367.5 9203.3 9331.4 9461.1 9492.6 9510.2 54472.5 55420.4 55570.0 56263.7 56576.4 48166.0 69226.0 81700.6 82591.0 84573.0 12255.0 12415.0 12441.1 12684.8 12693.0 14026.0 14177.3 14246.7 14729.6 14886.1 12917.9 12992.9 13257.5 13300.8 13488.1 12650.0 12737.7 12902.4 13253.7 13411.7 12471.5 12668.6 13147.4 13168.8 13630.9 10421.5 10534.0 10589.5 10677.8 10938.5 11202.9 11330.6 11597.3 11602.5 11658.7 16:51:37 INFO - PROCESS | 11198 | -------- Summary: end -------- 16:51:37 INFO - PROCESS | 11198 | 16:51:37 INFO - TEST-INFO | 11198: exit 0 16:51:37 INFO - TEST-OK | dromaeo_css | took 1115202ms 16:51:37 INFO - TEST-START | kraken 16:51:37 INFO - operating with platform_type : linux_ 16:51:37 INFO - Initialising browser for kraken test... 16:51:37 INFO - TEST-INFO | started process 11379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNXwQuP/profile http://localhost:51414/getInfo.html) 16:51:41 INFO - PROCESS | 11379 | __metrics Screen width/height:1600/1200 16:51:41 INFO - PROCESS | 11379 | colorDepth:24 16:51:41 INFO - PROCESS | 11379 | Browser inner width/height: 1024/697 16:51:41 INFO - PROCESS | 11379 | __metrics 16:51:43 ERROR - PROCESS | 11379 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:51:43 INFO - PROCESS | 11379 | console.error: PushService: 16:51:43 INFO - PROCESS | 11379 | stateChangeProcessEnqueue: Error transitioning state 16:51:43 INFO - PROCESS | 11379 | UnknownError 16:51:43 INFO - TEST-INFO | 11379: exit 0 16:51:43 INFO - Browser initialized. 16:51:43 INFO - Running cycle 1/1 for kraken test... 16:51:43 INFO - TEST-INFO | started process 11460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNXwQuP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:55 INFO - PROCESS | 11460 | RSS: Main: 176799744 16:51:55 INFO - PROCESS | 11460 | 16:51:58 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51414/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:59 INFO - PROCESS | 11460 | RSS: Main: 234999808 16:51:59 INFO - PROCESS | 11460 | 16:52:01 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51414/tests/kraken/driver.html?testName=audio-dft) 16:52:02 INFO - PROCESS | 11460 | RSS: Main: 220758016 16:52:02 INFO - PROCESS | 11460 | 16:52:05 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51414/tests/kraken/driver.html?testName=audio-fft) 16:52:06 INFO - PROCESS | 11460 | RSS: Main: 289501184 16:52:06 INFO - PROCESS | 11460 | 16:52:08 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51414/tests/kraken/driver.html?testName=audio-oscillator) 16:52:08 INFO - PROCESS | 11460 | RSS: Main: 200761344 16:52:08 INFO - PROCESS | 11460 | 16:52:11 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51414/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:52:11 INFO - PROCESS | 11460 | RSS: Main: 204021760 16:52:11 INFO - PROCESS | 11460 | 16:52:14 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51414/tests/kraken/driver.html?testName=imaging-darkroom) 16:52:15 INFO - PROCESS | 11460 | RSS: Main: 239276032 16:52:15 INFO - PROCESS | 11460 | 16:52:18 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51414/tests/kraken/driver.html?testName=imaging-desaturate) 16:52:19 INFO - PROCESS | 11460 | RSS: Main: 241131520 16:52:19 INFO - PROCESS | 11460 | 16:52:22 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51414/tests/kraken/driver.html?testName=json-parse-financial) 16:52:22 INFO - PROCESS | 11460 | RSS: Main: 241577984 16:52:22 INFO - PROCESS | 11460 | 16:52:24 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51414/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:24 INFO - PROCESS | 11460 | RSS: Main: 225603584 16:52:24 INFO - PROCESS | 11460 | 16:52:26 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:27 INFO - PROCESS | 11460 | RSS: Main: 230567936 16:52:27 INFO - PROCESS | 11460 | 16:52:29 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:29 INFO - PROCESS | 11460 | RSS: Main: 235139072 16:52:29 INFO - PROCESS | 11460 | 16:52:32 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:33 INFO - PROCESS | 11460 | RSS: Main: 239779840 16:52:33 INFO - PROCESS | 11460 | 16:52:35 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:36 INFO - PROCESS | 11460 | RSS: Main: 241008640 16:52:36 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | Cycle 1(1): loaded http://localhost:51414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51414/tests/kraken/driver.html?testName=ai-astar) 16:52:38 INFO - PROCESS | 11460 | RSS: Main: 283246592 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | __start_tp_report 16:52:38 INFO - PROCESS | 11460 | _x_x_mozilla_page_load 16:52:38 INFO - PROCESS | 11460 | _x_x_mozilla_page_load_details 16:52:38 INFO - PROCESS | 11460 | |i|pagename|runs| 16:52:38 INFO - PROCESS | 11460 | |0;ai-astar;111;106;110;111;110;110;110;111;110;110 16:52:38 INFO - PROCESS | 11460 | |1;audio-beat-detection;152;127;126;177;125;127;151;133;173;124 16:52:38 INFO - PROCESS | 11460 | |2;audio-dft;161;161;159;161;161;160;161;161;162;162 16:52:38 INFO - PROCESS | 11460 | |3;audio-fft;75;75;76;108;75;75;74;75;98;76 16:52:38 INFO - PROCESS | 11460 | |4;audio-oscillator;85;85;116;86;85;85;113;84;84;128 16:52:38 INFO - PROCESS | 11460 | |5;imaging-gaussian-blur;116;117;117;117;116;116;116;117;117;116 16:52:38 INFO - PROCESS | 11460 | |6;imaging-darkroom;145;145;145;145;146;145;145;146;146;146 16:52:38 INFO - PROCESS | 11460 | |7;imaging-desaturate;95;95;94;95;95;95;96;95;96;95 16:52:38 INFO - PROCESS | 11460 | |8;json-parse-financial;55;53;53;53;53;53;53;55;53;54 16:52:38 INFO - PROCESS | 11460 | |9;json-stringify-tinderbox;60;60;60;61;61;60;61;60;60;59 16:52:38 INFO - PROCESS | 11460 | |10;stanford-crypto-aes;79;80;85;79;81;81;79;80;109;80 16:52:38 INFO - PROCESS | 11460 | |11;stanford-crypto-ccm;124;124;125;129;131;126;122;125;125;133 16:52:38 INFO - PROCESS | 11460 | |12;stanford-crypto-pbkdf2;165;167;170;166;163;165;160;161;164;160 16:52:38 INFO - PROCESS | 11460 | |13;stanford-crypto-sha256-iterative;65;64;66;63;65;67;64;64;67;63 16:52:38 INFO - PROCESS | 11460 | __end_tp_report 16:52:38 INFO - PROCESS | 11460 | __start_cc_report 16:52:38 INFO - PROCESS | 11460 | _x_x_mozilla_cycle_collect,1628 16:52:38 INFO - PROCESS | 11460 | __end_cc_report 16:52:38 INFO - PROCESS | 11460 | __startTimestamp1465516358282__endTimestamp 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | ------- Summary: start ------- 16:52:38 INFO - PROCESS | 11460 | Number of tests: 14 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.45 (1.3%) stddev-sans-first:1.48 16:52:38 INFO - PROCESS | 11460 | Values: 111.0 106.0 110.0 111.0 110.0 110.0 110.0 111.0 110.0 110.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:142.00 stddev:20.45 (14.4%) stddev-sans-first:21.34 16:52:38 INFO - PROCESS | 11460 | Values: 152.0 127.0 126.0 177.0 125.0 127.0 151.0 133.0 173.0 124.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 16:52:38 INFO - PROCESS | 11460 | Values: 161.0 161.0 159.0 161.0 161.0 160.0 161.0 161.0 162.0 162.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:12.00 (16.0%) stddev-sans-first:12.55 16:52:38 INFO - PROCESS | 11460 | Values: 75.0 75.0 76.0 108.0 75.0 75.0 74.0 75.0 98.0 76.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:85.00 stddev:16.92 (19.9%) stddev-sans-first:17.55 16:52:38 INFO - PROCESS | 11460 | Values: 85.0 85.0 116.0 86.0 85.0 85.0 113.0 84.0 84.0 128.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:52:38 INFO - PROCESS | 11460 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:52:38 INFO - PROCESS | 11460 | Values: 145.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:52:38 INFO - PROCESS | 11460 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:0.85 (1.6%) stddev-sans-first:0.71 16:52:38 INFO - PROCESS | 11460 | Values: 55.0 53.0 53.0 53.0 53.0 53.0 53.0 55.0 53.0 54.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 16:52:38 INFO - PROCESS | 11460 | Values: 60.0 60.0 60.0 61.0 61.0 60.0 61.0 60.0 60.0 59.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:80.00 stddev:9.20 (11.5%) stddev-sans-first:9.63 16:52:38 INFO - PROCESS | 11460 | Values: 79.0 80.0 85.0 79.0 81.0 81.0 79.0 80.0 109.0 80.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:125.50 stddev:3.47 (2.8%) stddev-sans-first:3.57 16:52:38 INFO - PROCESS | 11460 | Values: 124.0 124.0 125.0 129.0 131.0 126.0 122.0 125.0 125.0 133.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:165.00 stddev:3.21 (1.9%) stddev-sans-first:3.39 16:52:38 INFO - PROCESS | 11460 | Values: 165.0 167.0 170.0 166.0 163.0 165.0 160.0 161.0 164.0 160.0 16:52:38 INFO - PROCESS | 11460 | 16:52:38 INFO - PROCESS | 11460 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.48 (2.3%) stddev-sans-first:1.56 16:52:38 INFO - PROCESS | 11460 | Values: 65.0 64.0 66.0 63.0 65.0 67.0 64.0 64.0 67.0 63.0 16:52:38 INFO - PROCESS | 11460 | -------- Summary: end -------- 16:52:38 INFO - PROCESS | 11460 | 16:52:39 INFO - TEST-INFO | 11460: exit 0 16:52:39 INFO - TEST-OK | kraken | took 61453ms 16:52:39 INFO - SUITE-END | took 1176s 16:52:39 INFO - Completed test suite (00:19:36) 16:52:39 INFO - javascript benchmark 16:52:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3031.287647402861, 3049.771267154964, 3080.7843450958426, 3081.198888289047, 3106.456370135226, 5281.260623512711, 5282.577393808496, 5344.35867695877, 5367.785288588457, 5399.703016334095, 5365.302510673617, 5379.704116273603, 5381.515663590276, 5420.756065977031, 5519.9448005519935, 4826.300186472968, 4890.315355850166, 4917.262410638397, 4920.852374428773, 4935.777889994941, 4990.65065445419, 5009.924851127236, 5032.672876263049, 5062.215356619711, 5062.417821950467, 4847.07905497956, 4890.462049174588, 4905.0, 4925.532074452921, 4935.777889994959, 4952.430470495903, 4959.057779021974, 4962.801487940478, 4971.875703107451, 4974.925376119361, 4913.508649135058, 4917.065757506062, 4921.532454416824, 4926.0394223126505, 4927.408710954673, 5224.895502089937, 5247.344081989751, 5264.15773476242, 5338.252644629755, 5409.0, 5706.457886500776, 5748.16651585522, 5753.223314852483, 5824.213731146283, 5827.475527202572, 5831.387704291031, 5875.324337701177, 5890.587658863881, 5893.764249430018, 5895.616784908967, 5300.893982120375, 5317.0163519748585, 5340.572754179656, 5375.3280839895015, 5446.8910621787345, 5878.764849405976, 5899.734511946973, 5900.232969713909, 5905.409459054146, 5921.526277897758, 5479.506844383945, 5664.603477756517, 5701.971490142606, 5708.429157084342, 5713.628614140068, 5740.42595740431, 5790.334111577223, 5797.623154494944, 5810.680412577264, 5816.505597024216, 5797.36229014808, 5800.419958004166, 5805.577633479825, 5812.680302583314, 5815.476607105381, 5597.076482380362, 5654.6324488908085, 5775.451332123442, 5823.417658234142, 5829.44620261083, 4359.084592235603, 4365.628921541705, 4366.192254432876, 4395.450568678915, 4420.823167073346, 3873.4189871519498, 3880.9223815523533, 3913.980430097888, 3914.1388894443176, 3940.9211815763524, 5344.091504444254, 5401.756920938567, 5415.0, 5441.0, 5474.42518535556, 5795.913061304083, 5806.593538452352, 5824.0, 5827.4172582741385, 5852.648841069549, 5475.7262136893, 5491.176323551419, 5492.670439773627, 5493.972530137324, 5502.0, 4868.391451068616, 4914.533119353656, 4939.728314942641, 4974.427940786783, 5040.521150490697, 5945.316288626776, 5952.345242023374, 5953.166556682068, 5961.552883533753, 5992.610480318765, 5773.393793651606, 5778.653280803165, 5785.103308987113, 5785.161151633074, 5786.392428794916, 5847.06446968483, 5923.763049477972, 5933.643981361132, 5952.76188952437, 5980.910286345621, 5640.492355687844, 5691.686957217393, 5700.372958974593, 5715.599908006399, 5722.284714410699, 5729.656220626609, 5738.426157384395, 5800.6809625471005, 5801.9709901451915, 5808.419158084158, 5511.035568775368, 5528.668279903219, 5568.387477377566, 5571.8885622288135, 5589.608727389043, 5647.887042259214, 5651.2935883014625, 5653.632513886584, 5653.717314134195, 5669.801556945487, 5472.863178420572, 5566.554675625859, 5568.610197286151, 5569.248151499496, 5573.804916827891, 5654.236678048411, 5689.544836412994, 5703.058995265735, 5777.942220577908, 5784.334801497882, 5626.38109807929, 5627.549796016391, 5628.986782379047, 5633.63381380209, 5635.380108188178], "value": 5318.928047920705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.9085137229415, 610.1914962674457, 613.7268915332679, 613.7790395457635, 632.7437387857916, 31041.223969400748, 43367.13265734683, 44031.559684403146, 44181.337279940824, 47248.0, 45825.0, 46245.30632040522, 46330.30504542434, 46371.0, 46485.8865524792, 8926.2412694921, 9064.456132632064, 9071.95464022679, 9079.409838360518, 9085.273178145733, 8897.866532002025, 8983.685571005017, 8987.415817971843, 9000.504972226525, 9004.324675649319, 9055.592498337557, 9073.228775554086, 9081.909180908206, 9094.363394562382, 9094.818103637923, 9039.728808135766, 9069.909300907038, 9091.227245684126, 9091.909080909172, 9092.499912504809, 8914.375993680445, 8956.014838367839, 8996.235319997808, 8998.460092394478, 9014.36899417041, 43644.563554364366, 43662.0, 44075.33886991665, 44147.337789932855, 44179.0, 3362.5117413114363, 3470.1498132957336, 3495.5980062292906, 3550.4851796489625, 3553.378158822222, 32832.50751238709, 33269.83365083183, 33359.0, 33777.49333759971, 34800.0, 4361.127774445124, 4375.934360984587, 4416.381706561084, 4435.667324950609, 4444.688871778977, 353118.0, 353468.99999999744, 353529.0, 353867.0, 353967.0, 59421.405785941584, 59556.70221648864, 59921.0, 59928.400715992284, 59967.10049349263, 54917.450825491236, 55934.72032639811, 59402.0, 60020.19939401825, 60477.09284360738, 16954.830451695325, 17033.48899533016, 17228.569285767706, 17231.56921076983, 17232.310707571807, 13223.272720000492, 13265.137766045369, 13332.600021999355, 13336.066475346826, 13336.399862006234, 15427.922860385626, 16751.6649667006, 16952.491425257263, 17384.913075434542, 17568.209430575655, 5989.431004054608, 6030.155778191057, 6040.2047696341615, 6166.506679465632, 6199.3490683478485, 903.0698380667791, 1001.7678255745328, 1018.2312354172552, 1061.2465149743614, 1112.1325366214367, 32740.672593274237, 33292.50061249083, 33453.83273083619, 33624.831875840464, 33738.49392259118, 1083.8699356077163, 1132.6262333429947, 1141.9885801142048, 1152.3143729480946, 1153.9019183369508, 16858.831411685725, 17150.571235719206, 17338.739918901225, 17483.56291092733, 17785.288588456577, 555409.0, 555884.0, 559720.0, 561201.0, 564529.0, 59667.70166149228, 59681.403185968455, 59856.70071649701, 59864.10203846946, 59880.70059649674, 1254.1283807753707, 1332.4670131947105, 1339.04258455205, 1347.797830325459, 1350.7366063617696, 31796.68203317937, 31801.0, 32626.347473050882, 32677.509837352933, 33179.50230746589, 52866.73566632142, 52907.206391904925, 53018.0, 53282.0, 53410.732946336575, 475753.0, 478874.0, 481254.0, 481975.0, 482846.0, 25118.497630047663, 25970.0, 26045.609315860656, 43204.56795432005, 43440.4795832157, 49210.50789492059, 49664.73088666597, 50589.49410505995, 50642.0, 51036.489635104655, 41582.0, 41601.37597936094, 41892.0, 42434.787826060674, 43519.0, 41661.58338416577, 41951.79024104982, 42049.0, 42133.15733685248, 42810.14379712326, 40524.0, 41361.0, 42670.78664606657, 42776.0, 42835.78582107194, 35041.824790875886, 36477.45283820692, 36900.81549592342, 37296.0, 37670.0, 27940.483337219648, 28124.92188632596, 28468.171252905617, 34980.47529287012, 34983.475247870796], "value": 20474.180061624807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.8862652577703, 383.6987964447908, 389.0992352703493, 392.8291193330901, 414.3639513347011, 16511.256993435294, 18384.632307353877, 18445.72331415028, 18486.445406637824, 18599.256029758828, 18206.453806385798, 18518.44444666659, 18520.814791852077, 18813.0, 19395.612087758236, 5607.859803504904, 5734.4265573442735, 5844.561657875655, 5895.705214739267, 5900.085486749561, 5657.830265092033, 5725.083986562151, 5731.914021289684, 5755.510781583549, 5777.797777077803, 5638.40796716345, 5688.061469857489, 5727.971360143193, 5739.196512488255, 5789.913151302734, 5607.663540187602, 5634.492895639371, 5687.630304030225, 5789.218455508494, 5790.855228619297, 4889.559939605417, 5013.423456302536, 5055.266986286968, 5213.165893457067, 5216.765245563959, 22540.549189016292, 22731.431714207112, 22977.77022229773, 23122.190723324602, 23161.189358372543, 2439.81701372396, 2475.628655701659, 2556.130915488724, 2841.2059451363743, 3066.2794243352796, 13943.302834858216, 13977.0, 14460.0, 14954.62613434662, 15003.1748253846, 1782.875198736089, 1892.101251905334, 1925.3970944551288, 1936.6320399124263, 2044.2231951858348, 52529.0, 71984.0, 72758.63620681915, 80045.0, 81171.5941420295, 10088.848667269996, 10435.269531132899, 10756.408397538211, 10861.728456788644, 10929.398883061507, 15168.0, 15236.695266094615, 15262.389504419922, 15317.157556334285, 15322.080675159526, 7735.458517903805, 8155.877661835078, 8225.383096267804, 8306.750797476085, 8317.334613230927, 7261.237570055174, 7365.48441609093, 7368.557886526825, 7400.703971841173, 8049.9597502013285, 4588.449386073693, 4618.399608050931, 4677.158111539888, 4691.554302341272, 4766.189747742892, 1825.4067428085925, 1889.716542518633, 1890.5462688954551, 1910.0, 1926.6435709393527, 874.33113668044, 937.7374335186158, 972.3776782858976, 990.4898977026837, 1020.9489525523694, 17706.20322085509, 18745.7188142178, 19022.90488547576, 19053.80946190548, 19167.0, 944.9244060475146, 975.331897650112, 994.2096033653263, 998.1914649134225, 1013.1034034879185, 10170.847437288447, 10214.795704085876, 10367.274290799722, 10376.844347334796, 10377.325473844176, 180968.0, 182119.0, 314528.0, 490474.0, 510067.0, 74739.0, 95708.0, 96328.0, 98375.0, 99562.5021874886, 934.9859752103724, 940.210223412337, 969.9224062075017, 974.1281553010016, 974.7514383832078, 16952.69510606604, 17073.146342683063, 17212.655746885244, 17257.223424946158, 17396.304147833944, 39734.40398394084, 39913.401298981116, 39914.60085399109, 40004.79997599994, 41047.38428923509, 56066.43933560612, 57207.71396143159, 58205.12692309534, 58326.0, 59102.40897590969, 8255.380846436421, 8309.6676132954, 8346.207110324509, 8369.204925532065, 8593.484390936565, 11344.943275283571, 12861.742765144832, 13098.672533186747, 13109.803352949904, 13197.736045279233, 10772.084372828398, 11153.219274650697, 11222.887771122185, 11507.84921507876, 11523.423828808694, 11025.393603351893, 11241.213115081866, 11581.82627260575, 11585.536578536765, 11784.292942423483, 11198.160137989846, 11402.657920262405, 11530.250533715282, 11762.3530705812, 11813.940930295294, 8237.299829514319, 8353.415260931677, 8363.623636936474, 8413.200745929127, 8523.701670441753, 10754.73113172177, 11286.66140015801, 11298.322100673986, 11890.0, 11925.701857453287], "value": 9030.272744490592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1261.2306493039239, 1416.8735854995277, 1451.7169152015356, 1530.8392618775028, 1691.6362981958875, 8200.876986845195, 8550.871736923951, 8578.356623253258, 8759.781005474866, 8816.735497935057, 8569.65721371146, 8725.694600688978, 8727.912720872806, 8737.912620873789, 8745.344099192554, 2020.6968954656772, 2241.7309922809204, 2295.586794377016, 2323.3610757041865, 2335.509542995973, 2362.3149286706835, 2375.7505461926507, 2376.95246095078, 2392.629142482909, 2401.5917294059964, 2313.363824948136, 2358.882055897207, 2382.5354055959097, 2383.1778036577352, 2383.8450500717486, 1952.2386269354963, 2187.7155969723995, 2253.346529506441, 2253.3690566641285, 2261.513774538466, 2255.2332207049517, 2259.0850705464313, 2275.9203427879943, 2279.0200213908015, 2279.8974046167964, 8804.163604457566, 8859.335549833724, 8866.0, 8868.822623547558, 8881.511516866569, 5074.619403544712, 5248.291480650139, 5255.1854462557985, 5265.104932161542, 5269.420363759983, 3248.772585918987, 3390.8982730518123, 3436.604790449105, 3449.275652113059, 3460.740444466675, 1093.4642025407572, 1096.6929259807187, 1110.1008183371496, 1133.9489722962487, 1140.321508702321, 12415.689607759788, 12440.315782631951, 12454.128211025141, 12474.0, 12484.126111172221, 4600.102979918951, 4690.624750019991, 4781.6891902026955, 4790.281457781361, 4807.086653535817, 9846.556904939294, 9856.112949834549, 9862.309638325249, 9869.457179855177, 9884.406935583887, 5184.870378240575, 5233.476652334813, 5235.60732945023, 5236.973815130977, 5237.816676416383, 4191.601797829201, 4677.695949763254, 4781.497942716034, 4822.348982887265, 4889.193283108319, 3872.0900588361715, 3981.6615587675374, 4014.658754005884, 4026.214888096793, 4092.3043082676018, 1244.4337826289018, 1258.7167887225485, 1273.2042473454092, 1273.3633183408297, 1282.2498838179583, 921.6267411698273, 922.4096578189964, 935.9625614975461, 947.4410098042188, 971.1890571372842, 5594.482373138474, 5832.358440571534, 5850.619709718854, 5948.9702551487835, 5993.370696076936, 450.5156956271955, 452.12965042293456, 463.54109431662414, 470.17953670844594, 472.2561964905288, 4070.9592904070582, 4116.958830411658, 4125.834966601363, 4141.730787498803, 4172.08214192877, 10347.948260258801, 10882.183836212316, 10882.29265097766, 10915.617953371593, 10936.671899843017, 10714.892851071545, 10746.462676866126, 10757.9462102689, 10771.56913723458, 10793.892061079447, 8016.278534931767, 8080.191980801873, 8145.266925976572, 8156.551389673625, 8172.918270817216, 5668.7165641718575, 5683.545316374597, 5711.628744131618, 5727.4845263926445, 5906.232189815297, 9839.557219924978, 10204.336718113596, 10249.33379330341, 10270.229732770222, 10294.897051029393, 10146.289759716748, 10255.07704306616, 10258.281920265808, 10265.076143147153, 10286.125679317043, 7105.609191494517, 7419.740309089372, 7608.2011388805595, 7836.098848632252, 7914.287714105758, 8656.567171641267, 8685.522296273766, 8731.432456890281, 8762.25520830711, 8763.780905477413, 7716.614169291625, 7904.960475197588, 7927.5243485391065, 8000.119986801331, 8004.319632831274, 7406.851862962602, 7739.845203096019, 7764.262395072459, 7869.213078692085, 7948.403869709679, 6779.220389655253, 6985.441164706913, 6995.265497122932, 7008.5094043416475, 7030.156381234285, 4953.18272485036, 5065.56942659878, 5231.3199284092825, 5232.816851410183, 5274.472552744694, 5129.102407078821, 5166.948330516797, 5202.869928251824, 5228.895422091613, 5254.159334506614], "value": 4520.423648007503, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.3544857112918, 327.06296460640266, 334.97320214382853, 339.75028354159696, 340.07499601085055, 5154.608255770944, 5183.50756678115, 5272.365566674333, 5323.281357016802, 5355.7857685692625, 5229.111051121309, 5239.921401178985, 5255.343082114736, 5259.368875734907, 5286.704757334458, 4144.813483393239, 4158.937615935756, 4162.354835000579, 4174.749515029092, 4192.622663960243, 4074.3073677474754, 4142.730722503043, 4167.979160104195, 4179.1223842993, 4179.3939878717565, 4112.0, 4129.380592911072, 4149.107941792514, 4155.210510003105, 4160.523014329915, 4116.991337122394, 4120.835166593332, 4146.834126634931, 4150.481189851269, 4164.12553363794, 3684.44733290006, 3695.297893400272, 3707.4624179494094, 3715.071232191952, 3717.854592129756, 4841.636877234221, 5103.744812759347, 5134.845954621367, 5153.0, 5172.6379153459275, 4699.412573428322, 4715.552022557851, 4716.646251531149, 4729.972817396869, 4734.928976065362, 5282.498162674578, 5478.506934375925, 5515.227868098469, 5516.972415137939, 5526.0, 3977.7016723745546, 3980.8208630611693, 3984.2429938311916, 3985.4021896715435, 4023.0948036691802, 5428.2671839301975, 5480.780768769245, 5736.168255602956, 5757.165211044375, 5797.188393624896, 4119.176164766998, 4159.708820382544, 4190.874273771792, 4194.224068547329, 4195.895102622459, 4227.091175397304, 4261.850835220753, 4263.552327005682, 4264.125854199881, 4265.317549192115, 4483.229124495806, 4507.301368287855, 4638.6752927294765, 4749.4775574686755, 4770.642201834807, 5293.470652934676, 5566.4990150886615, 5570.610057296031, 5572.860678482989, 5586.35756887955, 1452.9200893950722, 1461.2109460891, 1462.3127130248765, 1468.7943687883705, 1472.6539263273123, 930.0792215706537, 953.2945620241111, 958.520739630185, 965.0891235354038, 973.4500007495742, 4746.7389293589185, 4779.402574678165, 4785.928211076836, 4788.922492439243, 4808.879778005507, 4968.403791545038, 4974.189582885658, 4996.975015124901, 5118.283440318359, 5137.588992880561, 4681.765911704401, 4768.499307572724, 4768.833090841804, 4795.568398844121, 4837.419509658864, 2669.4794515069375, 2694.420699549606, 2710.1733971138992, 2713.796465265113, 2730.5904114383, 5101.719405432663, 5190.299309593157, 5233.0, 5233.921491177559, 5236.6857988520815, 4782.606574254312, 5053.898922021539, 5095.87260318495, 5146.845594632092, 5182.352205974254, 5059.645824792229, 5101.69389836611, 5148.374329092115, 5175.9741201293755, 5186.455422180692, 5009.874753131201, 5023.773930173078, 5027.2207807789855, 5072.28987941681, 5084.186530155157, 4804.8798780030775, 4946.554810067111, 4974.253861920741, 4999.900001999867, 5034.974825125851, 5125.282460455464, 5221.955608878164, 5506.2291279221745, 5666.263385759825, 5753.1945527627, 4136.958630413657, 4173.9582604173565, 4194.182134483868, 4214.852480163179, 4228.731380585874, 5664.716764161693, 5666.886662266814, 5675.545956323567, 5680.403557626555, 5699.2590963174525, 5258.342707161605, 5575.0, 5665.518430933252, 5675.602707810413, 5699.857503562444, 5456.0, 5560.471755183251, 5573.136163894603, 5656.0, 5690.83337915718, 5176.7152806594495, 5539.0, 5551.8889622208135, 5591.077472217039, 5606.411326810626, 5593.608447408642, 5606.299212598426, 5619.494245517923, 5622.1566764983945, 5633.774649013993, 5513.0, 5523.420040895809, 5529.253550770594, 5577.916331254954, 5581.990483426044], "value": 4120.074022759735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.4787196834183, 779.4193325972152, 782.9843403131933, 800.4996876951905, 825.0759149752274, 15554.533363999084, 16248.918755406221, 16500.42248521302, 16512.66974660506, 16527.83472165278, 13991.650208744786, 14043.578692639212, 14117.858821411783, 14160.787588186186, 14340.282985850692, 658.1969996604136, 775.2634996753079, 779.0845756236399, 794.9761507154794, 798.3533337996241, 786.0488808541643, 788.5544667263007, 788.7121200761738, 789.3054112381096, 791.0586402181385, 834.9081601023883, 842.0821304777791, 842.5787106446777, 843.152631605239, 843.5234092737614, 697.9511434199608, 839.2740279658052, 840.4327079221532, 840.5713086325957, 841.3227351981683, 605.5549171359047, 613.1048668943304, 614.6834380294152, 620.5563022438978, 620.5997131849977, 15059.096454212782, 15068.246587670683, 15073.246337683073, 15121.773173402407, 15131.470398536108, 13805.585832425044, 14383.640408989859, 14457.421703131862, 14542.854571454256, 14558.4904528341, 12697.936510317482, 12911.418986145645, 13047.608571742863, 13072.0, 13640.522581709693, 4445.599896009342, 4510.639148868083, 4557.544245575449, 4581.0, 4762.666613337068, 67711.3228867715, 68253.0, 68845.31154688488, 69376.0647147316, 69620.6518967402, 11339.546418143347, 11423.828642570368, 11491.195616306779, 11547.422628868522, 11574.247673901169, 21554.56890862174, 21609.243676471247, 21617.78382216189, 21625.24311649085, 21626.891865540572, 8757.781055473664, 9015.639374424949, 9023.548822558978, 9280.350375473652, 9293.210077143383, 4771.5228477152, 4816.325714399917, 4819.975900120477, 4879.097366987119, 4934.235193545006, 3379.121428428626, 3498.632643572439, 3516.4197907345515, 3520.0847779576984, 3523.2072783623994, 589.3487696095838, 606.4693393280879, 609.5093449772976, 659.4658326755343, 701.3932947999944, 704.1550139832221, 725.5175308419841, 770.7148355108534, 771.8031901864988, 799.6881216325638, 10421.583136674448, 10835.349281724997, 11001.449927503592, 11101.111911047097, 11200.0, 676.4960104722013, 737.575893861032, 761.7105499909999, 771.155584634824, 774.6823802241166, 4921.557059864629, 5060.722734156158, 5115.590752739772, 5128.615353848476, 5171.560417364491, 116952.0, 122701.0, 125199.37400313122, 126569.0, 126820.0, 68467.0, 84556.57721711475, 108374.45812770886, 108974.45512772385, 110404.0, 96221.51889240369, 96994.51502742441, 98170.0, 98350.0, 99367.50316248373, 9203.309751768511, 9331.393459425115, 9461.101195386427, 9492.620295188115, 9510.191633711212, 54472.45527544832, 55420.44579554153, 55570.0, 56263.71868140633, 56576.434235657114, 48166.0, 69226.0, 81700.59149704213, 82591.0, 84573.0, 12255.0, 12415.0, 12441.129120961808, 12684.809727853904, 12693.0, 14026.0, 14177.291135443393, 14246.715065698421, 14729.631759206106, 14886.10683359002, 12917.935410322889, 12992.870071299543, 13257.469701212229, 13300.800487992494, 13488.12327198729, 12650.0, 12737.745245095231, 12902.419391127609, 13253.66865828362, 13411.731765364442, 12471.5011399543, 12668.619941401772, 13147.408366623333, 13168.80246796318, 13630.93184534071, 10421.53103110377, 10534.0, 10589.52347144365, 10677.839832402675, 10938.453077345941, 11202.94398528002, 11330.60342887995, 11597.304161750322, 11602.47788849487, 11658.70853228676], "value": 7657.856331365518, "unit": "score"}], "name": "dromaeo_css", "value": 7208.2263989646035, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 126.0, 177.0, 125.0, 127.0, 151.0, 133.0, 173.0, 124.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 108.0, 75.0, 75.0, 74.0, 75.0, 98.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 116.0, 86.0, 85.0, 85.0, 113.0, 84.0, 84.0, 128.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 55.0, 53.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 59.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 85.0, 79.0, 81.0, 81.0, 79.0, 80.0, 109.0, 80.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 125.0, 129.0, 131.0, 126.0, 122.0, 125.0, 125.0, 133.0], "value": 126.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 170.0, 166.0, 163.0, 165.0, 160.0, 161.0, 164.0, 160.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 63.0, 65.0, 67.0, 64.0, 64.0, 67.0, 63.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1497.3999999999999, "alertThreshold": 2.0}]} 16:52:39 INFO - Return code: 0 16:52:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:52:39 ERROR - # TBPL SUCCESS # 16:52:39 INFO - Running post-action listener: _resource_record_post_action 16:52:39 INFO - ##### 16:52:39 INFO - ##### Finished run-tests step (success) 16:52:39 INFO - ##### 16:52:39 INFO - Running post-run listener: _resource_record_post_run 16:52:39 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 299692032; Read time: 36; Write time: 304392 16:52:39 INFO - TinderboxPrint: CPU usage
13.2% 16:52:39 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 36 16:52:39 INFO - TinderboxPrint: I/O write bytes / time
299,692,032 / 304,392 16:52:39 INFO - TinderboxPrint: CPU idle
8,271.7 (86.7%) 16:52:39 INFO - TinderboxPrint: CPU user
1,214.9 (12.7%) 16:52:39 INFO - TinderboxPrint: Swap in / out
0 / 0 16:52:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 11714560; Read time: 0; Write time: 9504 16:52:39 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287977472; Read time: 36; Write time: 294888 16:52:40 INFO - Running post-run listener: _upload_blobber_files 16:52:40 INFO - Blob upload gear active. 16:52:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:40 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 16:52:40 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:52:40 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:52:40 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:52:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:44 INFO - (blobuploader) - INFO - Done attempting. 16:52:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:52:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:52:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:45 INFO - (blobuploader) - INFO - Done attempting. 16:52:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:52:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:46 INFO - (blobuploader) - INFO - Done attempting. 16:52:46 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:46 INFO - Return code: 0 16:52:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b5ce87d028a39f5ef82ce8e27e8cfc630b65e2167244111dde2710536b9933e8bbe2d30aaa84c20820cce072d3ac3a42cd3d5d4b9233dcafc039bbacac4042e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c1613f17959302e3b98ce4b2332df80778abb2a54e2612eadc607c8720cc395c6de392e66bee6b101b6301812ce132a7dec3b82047b37454193b8de96aba1ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1733be9f91f993be72edf4522b4eb78675871da42dc3b7893fe85210af6fa59f2d5acc0ed17b5d5e5b983ab76e0e77de2987545320c9eb0af690f8a366dc7b06"} 16:52:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:46 INFO - Contents: 16:52:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b5ce87d028a39f5ef82ce8e27e8cfc630b65e2167244111dde2710536b9933e8bbe2d30aaa84c20820cce072d3ac3a42cd3d5d4b9233dcafc039bbacac4042e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c1613f17959302e3b98ce4b2332df80778abb2a54e2612eadc607c8720cc395c6de392e66bee6b101b6301812ce132a7dec3b82047b37454193b8de96aba1ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1733be9f91f993be72edf4522b4eb78675871da42dc3b7893fe85210af6fa59f2d5acc0ed17b5d5e5b983ab76e0e77de2987545320c9eb0af690f8a366dc7b06"} 16:52:46 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:46 INFO - Copying logs to upload dir... 16:52:46 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.587918 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-09 16:52:46.118474) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:52:46.126058) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306 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-Inbound/sha512/7b5ce87d028a39f5ef82ce8e27e8cfc630b65e2167244111dde2710536b9933e8bbe2d30aaa84c20820cce072d3ac3a42cd3d5d4b9233dcafc039bbacac4042e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c1613f17959302e3b98ce4b2332df80778abb2a54e2612eadc607c8720cc395c6de392e66bee6b101b6301812ce132a7dec3b82047b37454193b8de96aba1ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1733be9f91f993be72edf4522b4eb78675871da42dc3b7893fe85210af6fa59f2d5acc0ed17b5d5e5b983ab76e0e77de2987545320c9eb0af690f8a366dc7b06"} build_url:https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7b5ce87d028a39f5ef82ce8e27e8cfc630b65e2167244111dde2710536b9933e8bbe2d30aaa84c20820cce072d3ac3a42cd3d5d4b9233dcafc039bbacac4042e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c1613f17959302e3b98ce4b2332df80778abb2a54e2612eadc607c8720cc395c6de392e66bee6b101b6301812ce132a7dec3b82047b37454193b8de96aba1ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1733be9f91f993be72edf4522b4eb78675871da42dc3b7893fe85210af6fa59f2d5acc0ed17b5d5e5b983ab76e0e77de2987545320c9eb0af690f8a366dc7b06"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:52:46.151394) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:52:46.151731) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1465515125.10885-1949302306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:52:46.237160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:52:46.239381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:52:46.239705) ========= ========= Total master_lag: 0.15 =========