builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1466642665.64 results: success (0) buildid: 20160622150924 builduid: afd162a89b93436cbed00d869a849370 revision: 364d6e860e97081c90de5f141d4a034ee4ddd073 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.642996) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.643470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.643804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.697422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.697731) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 17:44:25-- 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% 42.4M=0s 2016-06-22 17:44:25 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090915 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.806072) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.806401) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014738 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.860476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:25.860873) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 364d6e860e97081c90de5f141d4a034ee4ddd073 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 364d6e860e97081c90de5f141d4a034ee4ddd073 --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=9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 17:44:26,057 truncating revision to first 12 chars 2016-06-22 17:44:26,057 Setting DEBUG logging. 2016-06-22 17:44:26,057 attempt 1/10 2016-06-22 17:44:26,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/364d6e860e97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 17:44:26,397 unpacking tar archive at: mozilla-aurora-364d6e860e97/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690773 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:26.570018) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:26.570389) ========= script_repo_revision: 364d6e860e97081c90de5f141d4a034ee4ddd073 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:26.570913) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:26.571248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 17:44:26.598659) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-22 17:44:26.598979) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:44:26 INFO - MultiFileLogger online at 20160622 17:44:26 in /builds/slave/test 17:44:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:44:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:44:26 INFO - {'append_to_log': False, 17:44:26 INFO - 'base_work_dir': '/builds/slave/test', 17:44:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:44:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:44:26 INFO - 'branch': 'Mozilla-Aurora', 17:44:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:44:26 INFO - 'config_files': ('talos/linux_config.py',), 17:44:26 INFO - 'default_actions': ('clobber', 17:44:26 INFO - 'read-buildbot-config', 17:44:26 INFO - 'download-and-extract', 17:44:26 INFO - 'populate-webroot', 17:44:26 INFO - 'create-virtualenv', 17:44:26 INFO - 'install', 17:44:26 INFO - 'run-tests'), 17:44:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:44:26 INFO - 'download_minidump_stackwalk': True, 17:44:26 INFO - 'download_symbols': 'ondemand', 17:44:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:44:26 INFO - 'tooltool.py': '/tools/tooltool.py', 17:44:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:44:26 INFO - '/tools/misc-python/virtualenv.py')}, 17:44:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:44:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:44:26 INFO - 'installer_path': 'installer.exe', 17:44:26 INFO - 'log_level': 'info', 17:44:26 INFO - 'log_name': 'talos', 17:44:26 INFO - 'log_to_console': True, 17:44:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:44:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:44:26 INFO - 'opt_config_files': (), 17:44:26 INFO - 'pip_index': False, 17:44:26 INFO - 'sps_profile': False, 17:44:26 INFO - 'sps_profile_interval': 0, 17:44:26 INFO - 'suite': 'dromaeojs', 17:44:26 INFO - 'system_bits': '32', 17:44:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:44:26 INFO - 'title': 'talos-linux64-ix-022', 17:44:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:44:26 INFO - 'use_talos_json': True, 17:44:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:44:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:44:26 INFO - 'work_dir': 'build'} 17:44:26 INFO - ##### 17:44:26 INFO - ##### Running clobber step. 17:44:26 INFO - ##### 17:44:26 INFO - Running pre-action listener: _resource_record_pre_action 17:44:26 INFO - Running main action method: clobber 17:44:26 INFO - rmtree: /builds/slave/test/build 17:44:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:44:27 INFO - Running post-action listener: _resource_record_post_action 17:44:27 INFO - ##### 17:44:27 INFO - ##### Finished clobber step (success) 17:44:27 INFO - ##### 17:44:27 INFO - ##### 17:44:27 INFO - ##### Running read-buildbot-config step. 17:44:27 INFO - ##### 17:44:27 INFO - Running pre-action listener: _resource_record_pre_action 17:44:27 INFO - Running main action method: read_buildbot_config 17:44:27 INFO - Using buildbot properties: 17:44:27 INFO - { 17:44:27 INFO - "project": "", 17:44:27 INFO - "product": "firefox", 17:44:27 INFO - "script_repo_revision": "production", 17:44:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:44:27 INFO - "repository": "", 17:44:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:44:27 INFO - "buildid": "20160622150924", 17:44:27 INFO - "pgo_build": "True", 17:44:27 INFO - "basedir": "/builds/slave/test", 17:44:27 INFO - "buildnumber": 310, 17:44:27 INFO - "slavename": "talos-linux64-ix-022", 17:44:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:44:27 INFO - "platform": "ubuntu64_hw", 17:44:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:44:27 INFO - "branch": "mozilla-aurora", 17:44:27 INFO - "repo_path": "releases/mozilla-aurora", 17:44:27 INFO - "revision": "364d6e860e97081c90de5f141d4a034ee4ddd073", 17:44:27 INFO - "stage_platform": "linux64-pgo", 17:44:27 INFO - "builduid": "afd162a89b93436cbed00d869a849370", 17:44:27 INFO - "slavebuilddir": "test" 17:44:27 INFO - } 17:44:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 17:44:27 INFO - Running post-action listener: _resource_record_post_action 17:44:27 INFO - ##### 17:44:27 INFO - ##### Finished read-buildbot-config step (success) 17:44:27 INFO - ##### 17:44:27 INFO - ##### 17:44:27 INFO - ##### Running download-and-extract step. 17:44:27 INFO - ##### 17:44:27 INFO - Running pre-action listener: _resource_record_pre_action 17:44:27 INFO - Running main action method: download_and_extract 17:44:27 INFO - mkdir: /builds/slave/test/build/tests 17:44: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')]} 17:44:27 INFO - https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:44:38 INFO - Downloaded 1361 bytes. 17:44:38 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:44:38 INFO - Using the following test package requirements: 17:44:38 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:44:38 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:44:38 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:44:38 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:38 INFO - u'jsshell-linux-x86_64.zip'], 17:44:38 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:44:38 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:44:38 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:44:38 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:44:38 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:44:38 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:44:38 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:44:38 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:38 INFO - https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:44:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:44:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:44:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:44:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:44:40 INFO - Downloaded 24474376 bytes. 17:44:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:44:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:44:41 INFO - Return code: 0 17:44:41 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:44: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')]} 17:44:41 INFO - https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:44:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:44:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:44:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:44:49 INFO - Downloaded 24474376 bytes. 17:44:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:44:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:44:50 INFO - Return code: 0 17:44:50 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')]} 17:44:50 INFO - https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:44:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:44:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:44:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:44:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:44:52 INFO - Downloaded 10833369 bytes. 17:44:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:44:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:44:52 INFO - Return code: 0 17:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:52 INFO - https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:44:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:44:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:44:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:44:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:44:54 INFO - Downloaded 63604861 bytes. 17:44:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:44:54 INFO - mkdir: /builds/slave/test/properties 17:44:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:44:54 INFO - Writing to file /builds/slave/test/properties/build_url 17:44:54 INFO - Contents: 17:44:54 INFO - build_url:https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:44:55 INFO - Running post-action listener: _resource_record_post_action 17:44:55 INFO - Running post-action listener: set_extra_try_arguments 17:44:55 INFO - ##### 17:44:55 INFO - ##### Finished download-and-extract step (success) 17:44:55 INFO - ##### 17:44:55 INFO - ##### 17:44:55 INFO - ##### Running populate-webroot step. 17:44:55 INFO - ##### 17:44:55 INFO - Running pre-action listener: _resource_record_pre_action 17:44:55 INFO - Running main action method: populate_webroot 17:44:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:44:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:44:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:44:55 INFO - '--tppagecycles', 17:44:55 INFO - '7'], 17:44:55 INFO - 'tests': ['tsvgm']}}, 17:44:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:44:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:44:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:44:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:44:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:44:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:44:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:55 INFO - 'talos_options': ['--disable-e10s'], 17:44:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:55 INFO - 'talos_options': ['--disable-e10s'], 17:44:55 INFO - 'tests': ['damp', 'tps']}, 17:44:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:55 INFO - 'tests': ['damp', 'tps']}, 17:44:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:44:55 INFO - 'tests': ['dromaeo_dom']}, 17:44:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:44:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:44:55 INFO - 'tests': ['a11yr', 17:44:55 INFO - 'ts_paint', 17:44:55 INFO - 'tpaint', 17:44:55 INFO - 'sessionrestore', 17:44:55 INFO - 'sessionrestore_no_auto_restore', 17:44:55 INFO - 'tabpaint']}, 17:44:55 INFO - 'other-e10s': {'tests': ['a11yr', 17:44:55 INFO - 'ts_paint', 17:44:55 INFO - 'tpaint', 17:44:55 INFO - 'sessionrestore', 17:44:55 INFO - 'sessionrestore_no_auto_restore', 17:44:55 INFO - 'tabpaint']}, 17:44:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:44:55 INFO - 'ts_paint', 17:44:55 INFO - 'tpaint', 17:44:55 INFO - 'sessionrestore', 17:44:55 INFO - 'sessionrestore_no_auto_restore', 17:44:55 INFO - 'tabpaint']}, 17:44:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:44:55 INFO - 'ts_paint', 17:44:55 INFO - 'tpaint', 17:44:55 INFO - 'sessionrestore', 17:44:55 INFO - 'sessionrestore_no_auto_restore', 17:44:55 INFO - 'tabpaint']}, 17:44:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:44:55 INFO - 'tests': ['a11yr', 17:44:55 INFO - 'ts_paint', 17:44:55 INFO - 'tpaint', 17:44:55 INFO - 'sessionrestore', 17:44:55 INFO - 'sessionrestore_no_auto_restore', 17:44:55 INFO - 'tabpaint']}, 17:44:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:44:55 INFO - 'tests': ['a11yr', 17:44:55 INFO - 'ts_paint', 17:44:55 INFO - 'tpaint', 17:44:55 INFO - 'sessionrestore', 17:44:55 INFO - 'sessionrestore_no_auto_restore', 17:44:55 INFO - 'tabpaint']}, 17:44:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:44:55 INFO - 'tests': ['tsvgx', 17:44:55 INFO - 'tsvgr_opacity', 17:44:55 INFO - 'tart', 17:44:55 INFO - 'tscrollx', 17:44:55 INFO - 'cart']}, 17:44:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:44:55 INFO - 'tsvgr_opacity', 17:44:55 INFO - 'tart', 17:44:55 INFO - 'tscrollx', 17:44:55 INFO - 'cart']}, 17:44:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:55 INFO - 'talos_options': ['--disable-e10s'], 17:44:55 INFO - 'tests': ['tp5o']}, 17:44:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:55 INFO - 'tests': ['tp5o']}, 17:44:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:55 INFO - 'talos_options': ['--disable-e10s', 17:44:55 INFO - '--xperf_path', 17:44:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:55 INFO - 'tests': ['tp5n']}, 17:44:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:55 INFO - 'talos_options': ['--xperf_path', 17:44:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:55 INFO - 'tests': ['tp5n']}}, 17:44:55 INFO - 'talos.zip': {'path': '', 17:44:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:44:55 INFO - Running post-action listener: _resource_record_post_action 17:44:55 INFO - ##### 17:44:55 INFO - ##### Finished populate-webroot step (success) 17:44:55 INFO - ##### 17:44:55 INFO - ##### 17:44:55 INFO - ##### Running create-virtualenv step. 17:44:55 INFO - ##### 17:44:55 INFO - Running pre-action listener: _resource_record_pre_action 17:44:55 INFO - Running main action method: create_virtualenv 17:44:55 INFO - Creating virtualenv /builds/slave/test/build/venv 17:44:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:44:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:44:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:44:55 INFO - Using real prefix '/usr' 17:44:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:44:55 INFO - Installing distribute.............................................................................................................................................................................................done. 17:44:57 INFO - Installing pip.................done. 17:44:57 INFO - Return code: 0 17:44:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f392d108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', '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 17:44:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:44:57 INFO - Using env: {'DISPLAY': ':0', 17:44:57 INFO - 'HOME': '/home/cltbld', 17:44:57 INFO - 'LANG': 'en_US.UTF-8', 17:44:57 INFO - 'LANGUAGE': 'en_US:en', 17:44:57 INFO - 'LOGNAME': 'cltbld', 17:44:57 INFO - 'MAIL': '/var/mail/cltbld', 17:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:57 INFO - 'MOZ_NO_REMOTE': '1', 17:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:57 INFO - 'NO_EM_RESTART': '1', 17:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:57 INFO - 'PWD': '/builds/slave/test', 17:44:57 INFO - 'SHELL': '/bin/bash', 17:44:57 INFO - 'SHLVL': '1', 17:44:57 INFO - 'TERM': 'linux', 17:44:57 INFO - 'TMOUT': '86400', 17:44:57 INFO - 'USER': 'cltbld', 17:44:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:57 INFO - '_': '/tools/buildbot/bin/python'} 17:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:44:57 INFO - Cleaning up... 17:44:57 INFO - Return code: 0 17:44:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f392d108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', '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 17:44:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:44:57 INFO - Using env: {'DISPLAY': ':0', 17:44:57 INFO - 'HOME': '/home/cltbld', 17:44:57 INFO - 'LANG': 'en_US.UTF-8', 17:44:57 INFO - 'LANGUAGE': 'en_US:en', 17:44:57 INFO - 'LOGNAME': 'cltbld', 17:44:57 INFO - 'MAIL': '/var/mail/cltbld', 17:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:57 INFO - 'MOZ_NO_REMOTE': '1', 17:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:57 INFO - 'NO_EM_RESTART': '1', 17:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:57 INFO - 'PWD': '/builds/slave/test', 17:44:57 INFO - 'SHELL': '/bin/bash', 17:44:57 INFO - 'SHLVL': '1', 17:44:57 INFO - 'TERM': 'linux', 17:44:57 INFO - 'TMOUT': '86400', 17:44:57 INFO - 'USER': 'cltbld', 17:44:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:57 INFO - '_': '/tools/buildbot/bin/python'} 17:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:58 INFO - Downloading/unpacking psutil>=3.1.1 17:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:45:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:00 INFO - Installing collected packages: psutil 17:45:00 INFO - Running setup.py install for psutil 17:45:00 INFO - building 'psutil._psutil_linux' extension 17:45:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:45:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:45:00 INFO - building 'psutil._psutil_posix' extension 17:45:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:45:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:45:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:00 INFO - Successfully installed psutil 17:45:00 INFO - Cleaning up... 17:45:00 INFO - Return code: 0 17:45:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f392d108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', '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 17:45:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:45:00 INFO - Using env: {'DISPLAY': ':0', 17:45:00 INFO - 'HOME': '/home/cltbld', 17:45:00 INFO - 'LANG': 'en_US.UTF-8', 17:45:00 INFO - 'LANGUAGE': 'en_US:en', 17:45:00 INFO - 'LOGNAME': 'cltbld', 17:45:00 INFO - 'MAIL': '/var/mail/cltbld', 17:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:00 INFO - 'MOZ_NO_REMOTE': '1', 17:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:00 INFO - 'NO_EM_RESTART': '1', 17:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:00 INFO - 'PWD': '/builds/slave/test', 17:45:00 INFO - 'SHELL': '/bin/bash', 17:45:00 INFO - 'SHLVL': '1', 17:45:00 INFO - 'TERM': 'linux', 17:45:00 INFO - 'TMOUT': '86400', 17:45:00 INFO - 'USER': 'cltbld', 17:45:00 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:00 INFO - '_': '/tools/buildbot/bin/python'} 17:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:45:02 INFO - Installing collected packages: mozsystemmonitor 17:45:02 INFO - Running setup.py install for mozsystemmonitor 17:45:02 INFO - Successfully installed mozsystemmonitor 17:45:02 INFO - Cleaning up... 17:45:03 INFO - Return code: 0 17:45:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:45:03 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')]} 17:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:03 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')]} 17:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:03 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 0x7f392d108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', '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 17:45:03 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 17:45:03 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 17:45:03 INFO - Using env: {'DISPLAY': ':0', 17:45:03 INFO - 'HOME': '/home/cltbld', 17:45:03 INFO - 'LANG': 'en_US.UTF-8', 17:45:03 INFO - 'LANGUAGE': 'en_US:en', 17:45:03 INFO - 'LOGNAME': 'cltbld', 17:45:03 INFO - 'MAIL': '/var/mail/cltbld', 17:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:03 INFO - 'MOZ_NO_REMOTE': '1', 17:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:03 INFO - 'NO_EM_RESTART': '1', 17:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:03 INFO - 'PWD': '/builds/slave/test', 17:45:03 INFO - 'SHELL': '/bin/bash', 17:45:03 INFO - 'SHLVL': '1', 17:45:03 INFO - 'TERM': 'linux', 17:45:03 INFO - 'TMOUT': '86400', 17:45:03 INFO - 'USER': 'cltbld', 17:45:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:03 INFO - '_': '/tools/buildbot/bin/python'} 17:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:03 INFO - Downloading/unpacking jsonschema==2.5.1 17:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:45:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:05 INFO - Downloading functools32-3.2.3-2.tar.gz 17:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:45:05 INFO - warning: no files found matching '*.txt' 17:45:05 INFO - no previously-included directories found matching 'build' 17:45:05 INFO - no previously-included directories found matching 'dist' 17:45:05 INFO - no previously-included directories found matching '.git*' 17:45:05 INFO - Installing collected packages: jsonschema, functools32 17:45:05 INFO - Running setup.py install for functools32 17:45:05 INFO - warning: no files found matching '*.txt' 17:45:05 INFO - no previously-included directories found matching 'build' 17:45:05 INFO - no previously-included directories found matching 'dist' 17:45:05 INFO - no previously-included directories found matching '.git*' 17:45:05 INFO - Successfully installed jsonschema functools32 17:45:05 INFO - Cleaning up... 17:45:05 INFO - Return code: 0 17:45:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:45:05 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')]} 17:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:05 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')]} 17:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:05 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 0x7f392d108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', '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 17:45:05 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 17:45:05 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 17:45:05 INFO - Using env: {'DISPLAY': ':0', 17:45:05 INFO - 'HOME': '/home/cltbld', 17:45:05 INFO - 'LANG': 'en_US.UTF-8', 17:45:05 INFO - 'LANGUAGE': 'en_US:en', 17:45:05 INFO - 'LOGNAME': 'cltbld', 17:45:05 INFO - 'MAIL': '/var/mail/cltbld', 17:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:05 INFO - 'MOZ_NO_REMOTE': '1', 17:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:05 INFO - 'NO_EM_RESTART': '1', 17:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:05 INFO - 'PWD': '/builds/slave/test', 17:45:05 INFO - 'SHELL': '/bin/bash', 17:45:05 INFO - 'SHLVL': '1', 17:45:05 INFO - 'TERM': 'linux', 17:45:05 INFO - 'TMOUT': '86400', 17:45:05 INFO - 'USER': 'cltbld', 17:45:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:05 INFO - '_': '/tools/buildbot/bin/python'} 17:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:05 INFO - Downloading/unpacking blobuploader==1.2.4 17:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:07 INFO - Downloading blobuploader-1.2.4.tar.gz 17:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:45:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:45:08 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 17:45:08 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 17:45:08 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 17:45:08 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 17:45:08 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 17:45:08 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 17:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:45:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:45:08 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 17:45:08 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 17:45:08 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 17:45:08 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 17:45:08 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 17:45:08 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 17:45:08 INFO - Downloading docopt-0.6.1.tar.gz 17:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:45:08 INFO - Installing collected packages: blobuploader, requests, docopt 17:45:08 INFO - Running setup.py install for blobuploader 17:45:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:45:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:45:08 INFO - Running setup.py install for requests 17:45:09 INFO - Running setup.py install for docopt 17:45:09 INFO - Successfully installed blobuploader requests docopt 17:45:09 INFO - Cleaning up... 17:45:09 INFO - Return code: 0 17:45:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45: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')]} 17:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45: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')]} 17:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:09 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 0x7f392d108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', '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 17:45:09 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 17:45:09 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 17:45:09 INFO - Using env: {'DISPLAY': ':0', 17:45:09 INFO - 'HOME': '/home/cltbld', 17:45:09 INFO - 'LANG': 'en_US.UTF-8', 17:45:09 INFO - 'LANGUAGE': 'en_US:en', 17:45:09 INFO - 'LOGNAME': 'cltbld', 17:45:09 INFO - 'MAIL': '/var/mail/cltbld', 17:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:09 INFO - 'MOZ_NO_REMOTE': '1', 17:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:09 INFO - 'NO_EM_RESTART': '1', 17:45:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:09 INFO - 'PWD': '/builds/slave/test', 17:45:09 INFO - 'SHELL': '/bin/bash', 17:45:09 INFO - 'SHLVL': '1', 17:45:09 INFO - 'TERM': 'linux', 17:45:09 INFO - 'TMOUT': '86400', 17:45:09 INFO - 'USER': 'cltbld', 17:45:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:09 INFO - '_': '/tools/buildbot/bin/python'} 17:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:45:09 INFO - Running setup.py (path:/tmp/pip-RxU4ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:45:09 INFO - Running setup.py (path:/tmp/pip-NDr0Jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:45:09 INFO - Running setup.py (path:/tmp/pip-zuj0th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:45:09 INFO - Running setup.py (path:/tmp/pip-YMfPlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:45:09 INFO - Running setup.py (path:/tmp/pip-1SjHDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:45:09 INFO - Running setup.py (path:/tmp/pip-zn46hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:45:09 INFO - Running setup.py (path:/tmp/pip-s2z6PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:45:10 INFO - Running setup.py (path:/tmp/pip-yLKxxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:45:10 INFO - Running setup.py (path:/tmp/pip-_3gXoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:45:10 INFO - Running setup.py (path:/tmp/pip-KTA6zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:45:10 INFO - Running setup.py (path:/tmp/pip-0m2_bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:45:10 INFO - Running setup.py (path:/tmp/pip-BpYHKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:45:10 INFO - Running setup.py (path:/tmp/pip-uF07y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:45:10 INFO - Running setup.py (path:/tmp/pip-Pv5GEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:10 INFO - Running setup.py (path:/tmp/pip-jW8Oo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:45:10 INFO - Running setup.py (path:/tmp/pip-zX3HxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:45:10 INFO - Running setup.py (path:/tmp/pip-pJTPYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:45:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:45:10 INFO - Running setup.py install for manifestparser 17:45:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:45:10 INFO - Running setup.py install for mozcrash 17:45:11 INFO - Running setup.py install for mozdebug 17:45:11 INFO - Running setup.py install for mozdevice 17:45:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:45:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:45:11 INFO - Running setup.py install for mozfile 17:45:11 INFO - Running setup.py install for mozhttpd 17:45:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:45:11 INFO - Running setup.py install for mozinfo 17:45:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:45:11 INFO - Running setup.py install for mozInstall 17:45:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:45:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:45:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:45:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:45:11 INFO - Running setup.py install for mozleak 17:45:11 INFO - Running setup.py install for mozlog 17:45:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:45:11 INFO - Running setup.py install for moznetwork 17:45:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:45:11 INFO - Running setup.py install for mozprocess 17:45:12 INFO - Running setup.py install for mozprofile 17:45:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Running setup.py install for mozrunner 17:45:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Running setup.py install for mozscreenshot 17:45:12 INFO - Running setup.py install for moztest 17:45:12 INFO - Running setup.py install for mozversion 17:45:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:45:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:45:12 INFO - Cleaning up... 17:45:12 INFO - Return code: 0 17:45:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45: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')]} 17:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45: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')]} 17:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:12 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 0x7f392d108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', '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 17:45:12 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 17:45:12 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 17:45:12 INFO - Using env: {'DISPLAY': ':0', 17:45:12 INFO - 'HOME': '/home/cltbld', 17:45:12 INFO - 'LANG': 'en_US.UTF-8', 17:45:12 INFO - 'LANGUAGE': 'en_US:en', 17:45:12 INFO - 'LOGNAME': 'cltbld', 17:45:12 INFO - 'MAIL': '/var/mail/cltbld', 17:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:12 INFO - 'MOZ_NO_REMOTE': '1', 17:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:12 INFO - 'NO_EM_RESTART': '1', 17:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:12 INFO - 'PWD': '/builds/slave/test', 17:45:12 INFO - 'SHELL': '/bin/bash', 17:45:12 INFO - 'SHLVL': '1', 17:45:12 INFO - 'TERM': 'linux', 17:45:12 INFO - 'TMOUT': '86400', 17:45:12 INFO - 'USER': 'cltbld', 17:45:12 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:12 INFO - '_': '/tools/buildbot/bin/python'} 17:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:45:12 INFO - Running setup.py (path:/tmp/pip-GeVrzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:45:12 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)) 17:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:45:12 INFO - Running setup.py (path:/tmp/pip-4PM79w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:45:12 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)) 17:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:45:12 INFO - Running setup.py (path:/tmp/pip-rEKOHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:45:13 INFO - Running setup.py (path:/tmp/pip-2TIsJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:45:13 INFO - Running setup.py (path:/tmp/pip-6HUgpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:45:13 INFO - Running setup.py (path:/tmp/pip-HUeVZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:45:13 INFO - Running setup.py (path:/tmp/pip-w0A9gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:45:13 INFO - Running setup.py (path:/tmp/pip-KJTKlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:45:13 INFO - Running setup.py (path:/tmp/pip-jo6LZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:45:13 INFO - Running setup.py (path:/tmp/pip-cMQmIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:45:13 INFO - Running setup.py (path:/tmp/pip-8z54wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:45:13 INFO - Running setup.py (path:/tmp/pip-e6R153-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:45:13 INFO - Running setup.py (path:/tmp/pip-84QveS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:45:13 INFO - Running setup.py (path:/tmp/pip-cnVtbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:13 INFO - Running setup.py (path:/tmp/pip-hUekDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:45:13 INFO - Running setup.py (path:/tmp/pip-ofzRSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:45:13 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)) 17:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:45:13 INFO - Running setup.py (path:/tmp/pip-KHg6Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:45:14 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)) 17:45:14 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)) 17:45:14 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)) 17:45:14 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)) 17:45:14 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)) 17:45:14 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)) 17:45:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:45:14 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 17:45:14 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 17:45:14 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 17:45:14 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 17:45:14 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 17:45:14 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 17:45:15 INFO - Downloading blessings-1.6.tar.gz 17:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:45:16 INFO - Installing collected packages: blessings 17:45:16 INFO - Running setup.py install for blessings 17:45:16 INFO - Successfully installed blessings 17:45:16 INFO - Cleaning up... 17:45:16 INFO - Return code: 0 17:45:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:45:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:45:16 INFO - Reading from file tmpfile_stdout 17:45:16 INFO - Current package versions: 17:45:16 INFO - argparse == 1.2.1 17:45:16 INFO - blessings == 1.6 17:45:16 INFO - blobuploader == 1.2.4 17:45:16 INFO - docopt == 0.6.1 17:45:16 INFO - functools32 == 3.2.3-2 17:45:16 INFO - jsonschema == 2.5.1 17:45:16 INFO - manifestparser == 1.1 17:45:16 INFO - mozInstall == 1.12 17:45:16 INFO - mozcrash == 0.17 17:45:16 INFO - mozdebug == 0.1 17:45:16 INFO - mozdevice == 0.48 17:45:16 INFO - mozfile == 1.2 17:45:16 INFO - mozhttpd == 0.7 17:45:16 INFO - mozinfo == 0.9 17:45:16 INFO - mozleak == 0.1 17:45:16 INFO - mozlog == 3.2 17:45:16 INFO - moznetwork == 0.27 17:45:16 INFO - mozprocess == 0.22 17:45:16 INFO - mozprofile == 0.28 17:45:16 INFO - mozrunner == 6.11 17:45:16 INFO - mozscreenshot == 0.1 17:45:16 INFO - mozsystemmonitor == 0.3 17:45:16 INFO - moztest == 0.7 17:45:16 INFO - mozversion == 1.4 17:45:16 INFO - psutil == 3.1.1 17:45:16 INFO - requests == 1.2.3 17:45:16 INFO - wsgiref == 0.1.2 17:45:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45: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')]} 17:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45: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')]} 17:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:16 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 0x7f392d108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', '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 17:45:16 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 17:45:16 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 17:45:16 INFO - Using env: {'DISPLAY': ':0', 17:45:16 INFO - 'HOME': '/home/cltbld', 17:45:16 INFO - 'LANG': 'en_US.UTF-8', 17:45:16 INFO - 'LANGUAGE': 'en_US:en', 17:45:16 INFO - 'LOGNAME': 'cltbld', 17:45:16 INFO - 'MAIL': '/var/mail/cltbld', 17:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:16 INFO - 'MOZ_NO_REMOTE': '1', 17:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:16 INFO - 'NO_EM_RESTART': '1', 17:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:16 INFO - 'PWD': '/builds/slave/test', 17:45:16 INFO - 'SHELL': '/bin/bash', 17:45:16 INFO - 'SHLVL': '1', 17:45:16 INFO - 'TERM': 'linux', 17:45:16 INFO - 'TMOUT': '86400', 17:45:16 INFO - 'USER': 'cltbld', 17:45:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:16 INFO - '_': '/tools/buildbot/bin/python'} 17:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:16 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)) 17:45:16 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)) 17:45:16 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)) 17:45:16 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)) 17:45:16 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)) 17:45:16 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)) 17:45:16 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)) 17:45:16 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)) 17:45:16 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)) 17:45:16 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)) 17:45:16 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)) 17:45:16 INFO - Cleaning up... 17:45:16 INFO - Return code: 0 17:45:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:45: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')]} 17:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45: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')]} 17:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f392d108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', '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 17:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:45:16 INFO - Using env: {'DISPLAY': ':0', 17:45:16 INFO - 'HOME': '/home/cltbld', 17:45:16 INFO - 'LANG': 'en_US.UTF-8', 17:45:16 INFO - 'LANGUAGE': 'en_US:en', 17:45:16 INFO - 'LOGNAME': 'cltbld', 17:45:16 INFO - 'MAIL': '/var/mail/cltbld', 17:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:16 INFO - 'MOZ_NO_REMOTE': '1', 17:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:16 INFO - 'NO_EM_RESTART': '1', 17:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:16 INFO - 'PWD': '/builds/slave/test', 17:45:16 INFO - 'SHELL': '/bin/bash', 17:45:16 INFO - 'SHLVL': '1', 17:45:16 INFO - 'TERM': 'linux', 17:45:16 INFO - 'TMOUT': '86400', 17:45:16 INFO - 'USER': 'cltbld', 17:45:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:16 INFO - '_': '/tools/buildbot/bin/python'} 17:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:45:16 INFO - Cleaning up... 17:45:16 INFO - Return code: 0 17:45:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:45: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')]} 17:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45: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')]} 17:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:45:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f392d108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13df350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', '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 17:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:45:16 INFO - Using env: {'DISPLAY': ':0', 17:45:16 INFO - 'HOME': '/home/cltbld', 17:45:16 INFO - 'LANG': 'en_US.UTF-8', 17:45:16 INFO - 'LANGUAGE': 'en_US:en', 17:45:16 INFO - 'LOGNAME': 'cltbld', 17:45:16 INFO - 'MAIL': '/var/mail/cltbld', 17:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:16 INFO - 'MOZ_NO_REMOTE': '1', 17:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:16 INFO - 'NO_EM_RESTART': '1', 17:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:16 INFO - 'PWD': '/builds/slave/test', 17:45:16 INFO - 'SHELL': '/bin/bash', 17:45:16 INFO - 'SHLVL': '1', 17:45:16 INFO - 'TERM': 'linux', 17:45:16 INFO - 'TMOUT': '86400', 17:45:16 INFO - 'USER': 'cltbld', 17:45:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:16 INFO - '_': '/tools/buildbot/bin/python'} 17:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:17 INFO - Downloading/unpacking flake8 17:45:17 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 17:45:17 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 17:45:17 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 17:45:17 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 17:45:17 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 17:45:17 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 17:45:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:45:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:45:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:45:19 INFO - no previously-included directories found matching 'docs/_build' 17:45:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:45:19 INFO - Running setup.py install for pep8 17:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:45:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:45:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:45:19 INFO - no previously-included directories found matching 'docs/_build' 17:45:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:45:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:45:19 INFO - Cleaning up... 17:45:19 INFO - Return code: 0 17:45:19 INFO - Running post-action listener: _resource_record_post_action 17:45:19 INFO - Running post-action listener: _start_resource_monitoring 17:45:19 INFO - Starting resource monitoring. 17:45:19 INFO - ##### 17:45:19 INFO - ##### Finished create-virtualenv step (success) 17:45:19 INFO - ##### 17:45:19 INFO - ##### 17:45:19 INFO - ##### Running install step. 17:45:19 INFO - ##### 17:45:19 INFO - Running pre-action listener: _resource_record_pre_action 17:45:19 INFO - Running main action method: install 17:45:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:45:20 INFO - Reading from file tmpfile_stdout 17:45:20 INFO - Detecting whether we're running mozinstall >=1.0... 17:45:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:45:20 INFO - Reading from file tmpfile_stdout 17:45:20 INFO - Output received: 17:45:20 INFO - Usage: mozinstall [options] installer 17:45:20 INFO - Options: 17:45:20 INFO - -h, --help show this help message and exit 17:45:20 INFO - -d DEST, --destination=DEST 17:45:20 INFO - Directory to install application into. [default: 17:45:20 INFO - "/builds/slave/test"] 17:45:20 INFO - --app=APP Application being installed. [default: firefox] 17:45:20 INFO - mkdir: /builds/slave/test/build/application 17:45:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:45:36 INFO - Reading from file tmpfile_stdout 17:45:36 INFO - Output received: 17:45:36 INFO - /builds/slave/test/build/application/firefox/firefox 17:45:36 INFO - Running post-action listener: _resource_record_post_action 17:45:36 INFO - ##### 17:45:36 INFO - ##### Finished install step (success) 17:45:36 INFO - ##### 17:45:36 INFO - ##### 17:45:36 INFO - ##### Running run-tests step. 17:45:36 INFO - ##### 17:45:36 INFO - Running pre-action listener: _resource_record_pre_action 17:45:36 INFO - Running main action method: run_tests 17:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:45:36 INFO - Python 2.7.3 17:45:36 INFO - Return code: 0 17:45:36 INFO - grabbing minidump binary from tooltool 17:45: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')]} 17:45:36 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 0x146e1c0>, '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 0x146f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:45:36 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 17:45:36 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 17:45:36 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 17:45:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:45:36 INFO - Return code: 0 17:45:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:45:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:45:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:45:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:45:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:45:37 INFO - Return code: 0 17:45:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 17:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 17:45:37 INFO - Using env: {'DISPLAY': ':0', 17:45:37 INFO - 'HOME': '/home/cltbld', 17:45:37 INFO - 'LANG': 'en_US.UTF-8', 17:45:37 INFO - 'LANGUAGE': 'en_US:en', 17:45:37 INFO - 'LOGNAME': 'cltbld', 17:45:37 INFO - 'MAIL': '/var/mail/cltbld', 17:45:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:45:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:37 INFO - 'MOZ_NO_REMOTE': '1', 17:45:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:37 INFO - 'NO_EM_RESTART': '1', 17:45:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:37 INFO - 'PWD': '/builds/slave/test', 17:45:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:45:37 INFO - 'SHELL': '/bin/bash', 17:45:37 INFO - 'SHLVL': '1', 17:45:37 INFO - 'TERM': 'linux', 17:45:37 INFO - 'TMOUT': '86400', 17:45:37 INFO - 'USER': 'cltbld', 17:45:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673', 17:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:37 INFO - '_': '/tools/buildbot/bin/python'} 17:45:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 17:45:37 INFO - mozversion application_buildid: 20160622150924 17:45:37 INFO - mozversion application_changeset: 364d6e860e97081c90de5f141d4a034ee4ddd073 17:45:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:45:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:45:37 INFO - mozversion application_name: Firefox 17:45:37 INFO - mozversion application_remotingname: firefox-dev 17:45:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:45:37 INFO - mozversion application_vendor: Mozilla 17:45:37 INFO - mozversion application_version: 49.0a2 17:45:37 INFO - mozversion platform_buildid: 20160622150924 17:45:37 INFO - mozversion platform_changeset: 364d6e860e97081c90de5f141d4a034ee4ddd073 17:45:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:45:37 INFO - mozversion platform_version: 49.0a2 17:45:37 INFO - using testdate: 1466642737 17:45:37 INFO - actual date: 1466642737 17:45:37 INFO - starting webserver on 'localhost:40535' 17:45:37 INFO - SUITE-START | Running 2 tests 17:45:37 INFO - TEST-START | dromaeo_css 17:45:37 INFO - operating with platform_type : linux_ 17:45:37 INFO - Initialising browser for dromaeo_css test... 17:45:37 INFO - TEST-INFO | started process 10016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOykDY6/profile http://localhost:40535/getInfo.html) 17:45:41 INFO - PROCESS | 10016 | __metrics Screen width/height:1600/1200 17:45:41 INFO - PROCESS | 10016 | colorDepth:24 17:45:41 INFO - PROCESS | 10016 | Browser inner width/height: 1024/697 17:45:41 INFO - PROCESS | 10016 | __metrics 17:45:43 ERROR - PROCESS | 10016 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:45:43 INFO - PROCESS | 10016 | console.error: PushService: 17:45:43 INFO - PROCESS | 10016 | stateChangeProcessEnqueue: Error transitioning state 17:45:43 INFO - PROCESS | 10016 | UnknownError 17:45:43 INFO - TEST-INFO | 10016: exit 0 17:45:43 INFO - Browser initialized. 17:45:43 INFO - Running cycle 1/1 for dromaeo_css test... 17:45:43 INFO - TEST-INFO | started process 10107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOykDY6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:55 INFO - PROCESS | 10107 | RSS: Main: 145215488 17:45:55 INFO - PROCESS | 10107 | 17:46:46 INFO - PROCESS | 10107 | 1466642806381 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] 17:48:54 INFO - PROCESS | 10107 | Cycle 1(1): loaded http://localhost:40535/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40535/tests/dromaeo/cssquery-ext.html) 17:48:55 INFO - PROCESS | 10107 | RSS: Main: 248377344 17:48:55 INFO - PROCESS | 10107 | 17:51:58 INFO - PROCESS | 10107 | Cycle 1(1): loaded http://localhost:40535/tests/dromaeo/cssquery-ext.html (next: http://localhost:40535/tests/dromaeo/cssquery-jquery.html) 17:51:58 INFO - PROCESS | 10107 | RSS: Main: 229425152 17:51:58 INFO - PROCESS | 10107 | 17:55:00 INFO - PROCESS | 10107 | Cycle 1(1): loaded http://localhost:40535/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40535/tests/dromaeo/cssquery-mootools.html) 17:55:01 INFO - PROCESS | 10107 | RSS: Main: 229662720 17:55:01 INFO - PROCESS | 10107 | 17:58:03 INFO - PROCESS | 10107 | Cycle 1(1): loaded http://localhost:40535/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40535/tests/dromaeo/cssquery-prototype.html) 17:58:03 INFO - PROCESS | 10107 | RSS: Main: 222175232 17:58:03 INFO - PROCESS | 10107 | 18:01:06 INFO - PROCESS | 10107 | Cycle 1(1): loaded http://localhost:40535/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40535/tests/dromaeo/cssquery-yui.html) 18:01:07 INFO - PROCESS | 10107 | RSS: Main: 204378112 18:01:07 INFO - PROCESS | 10107 | 18:04:09 INFO - PROCESS | 10107 | Cycle 1(1): loaded http://localhost:40535/tests/dromaeo/cssquery-yui.html (next: http://localhost:40535/tests/dromaeo/cssquery-dojo.html) 18:04:09 INFO - PROCESS | 10107 | RSS: Main: 259960832 18:04:09 INFO - PROCESS | 10107 | 18:04:09 INFO - PROCESS | 10107 | __start_tp_report 18:04:09 INFO - PROCESS | 10107 | _x_x_mozilla_page_load 18:04:09 INFO - PROCESS | 10107 | _x_x_mozilla_page_load_details 18:04:09 INFO - PROCESS | 10107 | |i|pagename|runs| 18:04:09 INFO - PROCESS | 10107 | |0;dojo.html;3316.751243656726;3341.398548261313;3343.4316166251733;3379.83100844958;3388.983055084726;5439.18412238164;5504.532114770244;5560.721963901804;5567.137093750465;5573.637713548626;5514.172874068891;5592.748326325315;5600.943990560093;5601.159826026098;5645.830625081244;4885.7312847793355;4944.2089265717495;5011.649184557083;5028.472010438906;5071.137906555876;4898.657094003421;5009.273655319977;5014.423341315759;5030.11972904742;5123.871903202413;4995.700257984515;5008.39899212095;5041.873953151164;5091.261767043777;5108.923366149511;5058.974705126488;5103.5917126629965;5114.718690472023;5132.769025393866;5133.153029750106;4872.878178045542;4898.730569818658;4911.680740751875;4939.629527785394;5020.071286811952;5454.59090568205;5471.699056551888;5491.780328786844;5499.092649712793;5539.196816461631;5934.554908381845;5937.465628093492;5971.0744834550715;5972.014617588136;5978.432048955342;5752.654840709571;5885.8822823543715;5899.498542623882;5905.2323197984415;5932;5581.134924086814;5611;5612.130119831432;5612.186232996233;5619;5911.852203694942;6075.362086980892;6085.208922840091;6086.391360863967;6086.908696369558;5812.157237200582;5852.268466441695;5857.853553661107;5942.970285148633;5945.881082378328;5974.790882319098;5984.401559843981;5986.281646202484;6018.3680713524445;6030.758769649165;5767.192593036978;5859.1797148399255;5970.164177015221;5970.253718285215;5974.163617093611;5885.440883116097;5972.462478376967;5972.671503067286;6008.309044459856;6013.037913933749;4520;4538.29656403258;4554.3168524720895;4565.611922986517;4584.014436896084;3995.380715989026;4006.639402453793;4030.6170913763144;4067.3695577185586;4094.8566800161852;5590;5655.858603534944;5658.094704847287;5660.85847853807;5690.77236910519;5948.85127871798;5963.642181469039;5965.582409231312;5973.820785376359;6001.969990150109;5535.086710692691;5584.21820945068;5608.242887210256;5640.153976903415;5655.1517272409465;5122.92315615266;5133.563647089964;5137.383513978347;5160.48395160481;5164.2770012198325;6101.938980610226;6130.78542251028;6138.508919286446;6144.662043587557;6152.323244443108;5842.328132264844;5919.526437885045;5931.525477961839;5958.76164953397;5967.552433567413;6176.536759742948;6177.938220617736;6185.134081228722;6185.134081228722;6185.319614842454;5866.765329386947;5871.178035075008;5872.911906321494;5875.471207591338;5906.675132867734;5802.82591522255;5907.054871220584;5918.23063001807;5968.731407086779;5995.7901473449965;5856.297244330707;5858.414158584107;5861.120831875252;5864.384239654775;5874.089516125007;5788.218590490398;5844.298684157929;5846.123081537803;5857.824265272048;5858.912116318344;5610.747516361692;5693.800716974886;5722.0272553665145;5733.799317023884;5786.566007549366;5873.207117039145;5888.646681199141;5905.5570832186895;5911.704414779329;5912.290525137011;5546.500814926676;5751.3673495916255;5752.654840709571;5753.223314852608;5778.075507918881 18:04:09 INFO - PROCESS | 10107 | |1;ext.html;598.362743677983;651.8859199640065;652.8596351784365;663.4758540752804;668.1514476614697;33527;45411;46408;46457;46498.767506162505;48415.75792121043;48812.26781598279;48928.2660760088;49045;49067.263991040076;8341.66633334669;8546.52994085325;9159.908400915989;9322;10951.890481095166;10649.254552181312;11069.50187241576;11070.114390848754;11077.335359878432;11083.72290692735;11161.107111431107;11182.217244792868;11190.832137517904;11191.104711623051;11191.216614836965;8511.191436813462;8696.260817830493;10612.681619551426;10877.891221087766;11018.50416731249;10835.620753273677;10939.56241750329;10944.452777361179;10948.562057517689;10948.945255273753;44311.55688443106;44358.33462498065;44462.33306500405;44771.328430073576;44821.327680084825;3626.89119326418;3849.2301539691894;3922.666573341269;3934.1344904121047;4294.849680261176;34042.319153617034;34341.656583434095;34774.30451390983;35393.11517212065;35972.100697482514;4320.870373888788;4470.128324976631;4479.372887795711;4495.625514095572;4548.545145485458;358317;359033;359514;360458.1977090124;361055;34362.14094647654;60585.39414605797;61773;61873.38126618676;61909;37053.629463705554;38958.22083558313;39348.21303573912;39380.21239575192;39421.40867886984;16439.506814795575;16517.917410412872;16549.420770272984;16616.6676666466;16660.250288736792;12654;13440.395182216824;13779.862201378059;13824.654383640289;13997.30013499321;9111.316651251183;9112.635494580143;9138.725838224864;9175.58709858058;9189.724308270763;3461.913452163716;3482.460218666111;3486.8082255475683;3509.824508774551;3532.752707310515;915.555955361649;1030.8402197659375;1122.9831552526718;1142.9942850285695;1198.3522656347523;31364.686353136633;32594.83702581472;32770.344593108006;33243.50134747981;33628.663713362555;1178.834963105166;1213.2962881528692;1274.5156840400773;1292.6315999939973;1294.1458637299338;17846.643067138586;17850.26210851748;17887.642247154985;17969.460916172535;18005.369812056517;690430;902387;916316;917129;917539;61817.690911545156;62165;62292.68853655703;62298.68850655718;62313.376866230756;1368.8768010879069;1493.6713922936935;1494.1184701026446;1499.3777582303221;1503.4587548482757;31210;32195.51706724448;33939.321213575095;35198.472022919166;35437.64562354344;55580.94304813274;56511.869762603696;56512.43487565072;56575.71712141413;56585.434145658015;536025;542363;543168;544305;546004;46789.76605116953;48055.27917081316;48318.27522587094;48772.75613621909;49131.50868491412;52065.47934520606;53347;53666.195007074144;54211.18683219676;54269;43249.3512597305;43352;43463;44528.77735611431;44533.77733111314;44067.33898991453;44426.55573444224;45044.54955450403;45484.31773523334;46414.30378544257;44328.556714432445;44562.3315650259;44894.3265851019;45430.318545221184;45939.31091033704;38126.80936595299;38142;39925;40477;40689.59310406858;28059.71940280571;29947.251318717208;30120.926337615994;30217.244568885955;30861.537076944314 18:04:09 INFO - PROCESS | 10107 | |2;jquery.html;429.6069096776449;430.8879691280266;434.3723319802886;438.4891601284502;440.0407699243404;19408.417747467563;19624.13570710784;20144.899275503638;20687.793122068775;20688.586228275424;19640.50898727529;19864.70202946957;20199.798002019976;20249.898750506225;20396.898015509938;5725.112607545827;5976.701164941735;6024.698765061751;6035.064564992434;6036.547258955574;5628.859278518029;5845.444682755132;5889.352171261179;5906.291245050578;5928.49607783339;5832.037713777222;5834.679092649923;5841.328247251557;5847.26909136358;5857.179994800731;5625.296837895263;5894.145348924403;5894.17481552583;5897.823065308026;5898.557608179361;5205.037068142406;5317.494837990384;5335.439778823206;5339.932013597296;5340.732963351817;23839.880800595885;23944.640830387558;24060.39849003789;24308.63537046928;24385.756142438702;2432.7323994360604;2466.506698660275;2537.112010796225;2664.8001399895084;2696.137236084454;14810.925945370313;14856.702865942729;14944.40222391103;15180.924095379563;15434.638222786103;2013.1242909334487;2054.763702174254;2062.236972320236;2129.6592545192693;2212.4579478027986;73068.63465682637;74791;82644.58677706633;84777.15222847754;94260;17474.650506990045;18883.716744248846;19036.90481547611;19094.2362305509;19607.215711371384;29651.55522667162;32177.195570110933;33775.493367599505;33918.660813392045;35774.463383049275;10249.897501024894;10504.632337868137;10615.363078215332;10881.292715973437;11197.104231661448;8923.15230053144;9011.369204155777;9107.180353768194;9197.402168859002;9279.860802087975;9275.794146760878;9332.20676242527;9394.107559781809;9454.527273636291;9491.762705932408;3020.6828283030404;3586.336527742376;3692.726009526709;3695.870644527429;3824.8661296854475;984.7981163861391;995.581855620641;1065.2915810985608;1070.5503688450713;1110.0564520157964;19908.60182796336;19932.20271189136;20019.29932452357;20083.29708460226;20146.294879679142;1039.2257767962917;1045.9895401046044;1062.6918193723734;1077.1006209814736;1084.8643919510062;11124.61063862761;11323.660290191307;11327.037201837937;11361;11405.14461415397;520100;521555;524554;529825;548579;88566.55716721374;92162.53918730363;92887;92975;105722;1075.1613741281813;1091.230682368928;1115.726646971497;1122.405125283601;1122.966311010671;18633.161507731915;18793.154308056444;18869.811301887356;18953.023612786386;19023.809761902205;38943.026424339616;39160;39510.80244598759;43577.56422435735;44434.333484998395;55361;56761;60042;60605.69697151486;61696.38303616906;8394.664213431395;8441.704540341305;8506.191911768372;8530.872036919576;9119.908800911906;8566.057733649419;10002.799944001225;12883.742325153631;14069.577912662637;14161.86705063613;10193.694189174337;11885.28688278706;11993.220440671328;12344;12515.687107822378;12233.69415764613;12273.386330683252;12332.50669973191;12544.623661290176;12699.873001269869;12716.046296527613;12757.872421275668;12784.808227876403;12991.220526768424;13014.414351354022;9000.54997250148;9137.40606860552;9163;9196.12636799503;9339.626414943326;12259.448324825225;12406.937965310115;12447.439865205906;12589.370531473573;12611 18:04:09 INFO - PROCESS | 10107 | |3;mootools.html;1417.9574612761621;1558.5090696430623;1589.8887077904549;1623.7483190105538;1684.3745785317174;8921.910780892189;9303;9328.720138395858;9565.426074435522;9672.08115229052;9377.156055954963;9584.52077396129;9598.664046758366;9605.135537801596;9608.327417080789;2172.804447599716;2384.260879127476;2428.441458464554;2451.595486744685;2474;2387.8447900886385;2398.3764221302413;2399.448126930807;2400.2799160251943;2401.6397540369;2394.6527753475734;2410.276916924924;2441.060191826142;2444.9755502444928;2446.388402899275;2047.2118234479758;2226.666000099982;2286.1769762885347;2295.104909085458;2350.1304517328613;2438.926832195037;2454.5581795276844;2459.7417271186628;2461.90152393904;2463.1379017343966;9100.408473449204;9104.817903641957;9158.358914875962;9162.541872906328;9168.312376571785;5519.834404967857;5663.8584035399035;5680.005998950167;5685.914711279334;5686.232358631573;3229.919252018695;3311.4536101543217;3381.847816848248;3394.304167645627;3412.2322477442626;1097.6597254851022;1125.6060378867412;1126.3692332293942;1129.7006293332274;1133.2520536445907;13688.178709277476;13741;13741.931290343584;13746.862531374658;13746.93126534371;4772.7136371817105;4851.442084160296;4899.1426500362295;4915.188993816052;4942.827001054946;11353.205275630626;11355.318680879009;11398.487068081957;11400.714982125348;11404.315741055563;5596.27248457706;5667.744951477193;5676.205331253628;5681.289838770153;5683.204351390808;4523.615492683093;4967.428745694219;5045.394552653705;5085.186370180753;5161.896762064813;4237.258479766028;4285.97857010713;4350;4350.108227813354;4350.955770615093;1321.8215540901856;1364.5565191312862;1385.0373990077;1387.1469046536508;1397.4410235905516;908.4685459006555;984.945827979468;996.4071377530358;1023.9129673977646;1094.031781873048;6253.280872699698;6295.401936815995;6335.144755458046;6515.1333413298;6537.869242615121;1017.6489111256604;1029.3875144289136;1046.931949423285;1049.2130901823632;1069.775347177086;4200.726952748061;4313.633341166036;4390.143921935256;4415.116976604692;4475.283954567253;11604.245724027911;11715.472803723853;11820.881791181979;11847.940760296144;11892.940535297268;11604.477798499087;11630.592929247436;11633.941830290794;11723.4138293085;11783.057355411547;8720.520371379635;8748.650053997897;8891.64433422656;9145.725628231165;9153.496557689257;6540.117084193763;6651.368120028589;6715.630640314829;6752.5948443093575;6755.121834161528;10422.530986105492;10752.67741967711;10802.135829133493;10974.725631859268;11245.100391968786;10781;11110.888891110986;11121.944390277997;11128.777424451304;11138.55445782192;7449.329560339379;7881.211878812073;8101.351891848756;8117.675292988451;8251.33989280868;9395.812083758423;9422.905770942203;9439.19766819828;9495.24038076966;9504.95247523758;8337.874931875906;8578.78553036179;8641.56792160402;8689.391742577958;8748.212660860552;8057.556834374166;8134.511929284025;8269.875951860606;8294.668213271401;8428.325733941147;7744.49660772048;7989.041315042232;7990.280874721303;7995.12053674107;7997.7600671979935;5770.2498675171955;5770.826875193751;5884.146798714248;5892.852678682896;5927.555433342431;5738.598298119258;5767.509761670305;5816.476517113311;5828.446297601721;5855.063189889767 18:04:09 INFO - PROCESS | 10107 | |4;prototype.html;342.9725621950244;348.47728407388934;350.32737144682216;350.5355404089582;353.4360454986683;5544.279243698318;5606.6636001839815;5610.410906854782;5611.915821262684;5628.634138780982;5498.615096943216;5500.3949565547755;5557.944420555793;5561.581796641861;5569.192467092269;3990.563397177014;4111.794410279489;4133.483314585676;4303.698741088125;4314.1156063007165;4257.723247988871;4300.913981720364;4305.763183024932;4310.547392523787;4314.870553883373;4289.2922667759785;4295.248331541983;4297.312430011199;4298.484181898177;4308.827646894136;4082.326416141333;4167.604077612637;4275.508316543606;4316.892077698051;4320.1575692739925;3800.923981520354;3816.923661526754;3833.3291673956946;3843.7693738375788;3849.2493963677093;5365.624406291561;5371.167469042305;5372.7045012524295;5388.91916621247;5404.91892621611;4999;4999.600031997432;5020.623453241022;5026.8384594624295;5028.145215313369;5501.229827824108;5694.345150307726;5720.256366672306;5807.506361959238;5848.2689663792025;4042.7372220805846;4095.85664501744;4114.074333274989;4222;4241.257779888507;5869.266341707286;5971.552133589955;5977.7608895644125;6005.579609427298;6029.728662210167;4051.1290072633938;4244.554321796229;4252.766097864585;4254.787260637017;4309.698321117492;4284.807183676742;4299.9570004300185;4305.892352691145;4308.224519586442;4309.655227581786;4908.41099068107;4908.650121216694;4920.220075657242;4925.630577706686;4940.728259945666;5722.799702010493;5725.227094342294;5815.418458154235;5843.853903652443;5870.618409803435;1444.949426770058;1450.9564713058626;1461.4300422835104;1464.7110542722337;1474.8230212374583;929.1266209762802;937.9062093790703;960.8798900137483;962.4898803634085;962.8349696866869;5010.874728131753;5020.991603358686;5059.532735506736;5119.692818430906;5121.8463446096675;5246.868828279324;5259.894802103937;5264.947350526446;5307.973460132752;5314.893702125936;4928.802847886116;5022.59819214462;5111.086680592027;5246.245720996508;5778.104393818965;3167.334859679447;3186.203449137716;3199.7280231180143;3203.8878639247514;3212.3896459673056;6038.033914573647;6285.654289014056;6290.55966082379;6308.27454842699;6309.242890853127;6086.878262434727;6095.481884039907;6111.327753947062;6113.32753397126;6129.295131059896;5876.823695289148;6033.547483938634;6074.149619053336;6161.291451483047;6192.225971753531;5538.44615538459;5698.503982134635;5779.393163717749;5949.137375080676;5956.51087228193;5897.616654917417;5901.970490147522;5915.526757859447;5935.40645935403;5947.167396564571;5843.6201646894515;6169.2288463942;6196.938030619636;6197.659128747962;6200.9536852837555;4209.494860616745;4224.302990006738;4272.743635381763;4286.52848186693;4305.655547556251;6048.727807248596;6070.3929607038945;6074.726637301421;6086.6652334122045;6101.420365065312;5533.474319939599;5774.15227127332;5806.332271788799;5860.619059761102;5876.08920617305;5772.653640781398;5819.127130930225;5829.94170058294;5841.240638716939;5858.246624086672;5734.770609175586;5746.913796292975;5790.336445235071;5804.6807425592;5812.157237200667;5729.169270455677;5850.795222167204;5851.590388672752;5864.765409383747;5874.882502350015;5702.971485142548;5735.54115670737;5735.713214339183;5740.225069615549;5746.712664366682 18:04:09 INFO - PROCESS | 10107 | |5;yui.html;767.5471471831618;789.9526028438294;798.5448294472153;873.550121687331;904.1230006893313;16967.23647435865;17666.38167664132;17682;17692.734608980874;17772.822271777295;14955.626109347271;14979.101253924771;14979.625509362271;14991.850081499182;15071.321790519425;721.7293514931874;856.1524091149779;877.5480627476838;877.9868301975475;884.0849720539243;860.5955201055494;866.9869951950726;867.6876324523166;867.8047439326133;870.303756994402;919.3288899103659;920.5305294299922;921.7050543825978;921.8985911549725;922.7739203895055;758.1660173808822;894.6958034268348;918.42598376015;920.0845159066705;920.4477313611847;677.7763338098416;678.2302087131093;679.0730652659084;679.4530403025562;679.7756740275697;16083.11542865142;16116.919415402848;16143.112128832909;16155.273012714457;16164.27260773268;14518.637034074232;14822.258887055605;14895;15019.324130414157;15305.846941530554;12752.10735248533;12758.936205319007;12998.285094319808;13283.60149195516;13466.25935573543;4642.558956899089;4649.070185962787;4664.300354946785;4691.859244222679;4715.41057367829;75424.24575754227;76320.23679763186;76421;76529;76579;11424.485898134604;11616.419179041015;11696.532138714356;11991.340476273888;12229.449674764657;22246.55506889853;22518.887405562866;22570.548589028127;22717.772822271898;22784.20255291057;8491.065982741893;8591.183837535424;8642.799493827404;8663.306935445149;8674;4720.716756994591;4843.2735089736825;4929.507049295114;4953.2074868020945;4997.625178111656;3602.8018458985007;3681.6318368163506;3691.224842782992;3700.6299370063316;3701.3892707703467;618.2488276743778;626.417431788432;636.4049613611288;673.3670349871105;680.6052489556046;619.5291578400448;699.6012273004338;767.1293082351459;777.782220978127;806.052887856766;10525.157987361146;10869.782604347869;11023.779524409467;11036.448177591088;11222.887771122347;663.8904580744123;756.856197322518;764.361757932133;791.5923299500762;803.1245941923331;4968.950310496921;5082.161443361878;5123.7438128093445;5201.895962080737;5301.416844147141;78855.60572197102;123351.38324308321;130614;134756;134781;100008.4999575012;101317.49341253247;101443.4927825371;104342;108115;96321;97791;98237.50881245692;99953.50023249982;101251;9878.407295562289;9878.753031174278;9931.205503559553;9971.800563988534;9996.900030999597;57153;57502.42497575138;57697.423025770884;57866;58946;80510.59744701239;84520.15479845123;84645;86128.56935715281;86347.13652863391;12687.873121268669;12733.745325093632;12964.481420743065;13189.340532973121;13776.65558361049;14265.786013209603;14474.421023159377;14701.632459188606;14881.47914822976;15756.92121539385;12570.37148142571;12612.369381530703;12996.09027368113;13121.671958201121;14098.929505352407;12598.181118227287;12756;12762.42569084412;12980.8052879205;13307.534236301683;13327.333633318489;14136.15183089018;14283.571492855232;14380.35288412003;14526.491572794901;11155.55377784912;11481.598144064918;11649.1263155262;11660.358680272328;12128.818067728815;11460.770784584429;11615.76768464643;12531.310777906938;12749.553765618159;12822.358882056047 18:04:09 INFO - PROCESS | 10107 | __end_tp_report 18:04:09 INFO - PROCESS | 10107 | __start_cc_report 18:04:09 INFO - PROCESS | 10107 | _x_x_mozilla_cycle_collect,853 18:04:09 INFO - PROCESS | 10107 | __end_cc_report 18:04:09 INFO - PROCESS | 10107 | __startTimestamp1466643849900__endTimestamp 18:04:09 INFO - PROCESS | 10107 | 18:04:09 INFO - PROCESS | 10107 | ------- Summary: start ------- 18:04:09 INFO - PROCESS | 10107 | Number of tests: 6 18:04:09 INFO - PROCESS | 10107 | 18:04:09 INFO - PROCESS | 10107 | [#0] dojo.html Cycles:165 Average:5525.13 Median:5752.65 stddev:618.85 (10.8%) stddev-sans-first:596.01 18:04:09 INFO - PROCESS | 10107 | Values: 3316.8 3341.4 3343.4 3379.8 3389.0 5439.2 5504.5 5560.7 5567.1 5573.6 5514.2 5592.7 5600.9 5601.2 5645.8 4885.7 4944.2 5011.6 5028.5 5071.1 4898.7 5009.3 5014.4 5030.1 5123.9 4995.7 5008.4 5041.9 5091.3 5108.9 5059.0 5103.6 5114.7 5132.8 5133.2 4872.9 4898.7 4911.7 4939.6 5020.1 5454.6 5471.7 5491.8 5499.1 5539.2 5934.6 5937.5 5971.1 5972.0 5978.4 5752.7 5885.9 5899.5 5905.2 5932.0 5581.1 5611.0 5612.1 5612.2 5619.0 5911.9 6075.4 6085.2 6086.4 6086.9 5812.2 5852.3 5857.9 5943.0 5945.9 5974.8 5984.4 5986.3 6018.4 6030.8 5767.2 5859.2 5970.2 5970.3 5974.2 5885.4 5972.5 5972.7 6008.3 6013.0 4520.0 4538.3 4554.3 4565.6 4584.0 3995.4 4006.6 4030.6 4067.4 4094.9 5590.0 5655.9 5658.1 5660.9 5690.8 5948.9 5963.6 5965.6 5973.8 6002.0 5535.1 5584.2 5608.2 5640.2 5655.2 5122.9 5133.6 5137.4 5160.5 5164.3 6101.9 6130.8 6138.5 6144.7 6152.3 5842.3 5919.5 5931.5 5958.8 5967.6 6176.5 6177.9 6185.1 6185.1 6185.3 5866.8 5871.2 5872.9 5875.5 5906.7 5802.8 5907.1 5918.2 5968.7 5995.8 5856.3 5858.4 5861.1 5864.4 5874.1 5788.2 5844.3 5846.1 5857.8 5858.9 5610.7 5693.8 5722.0 5733.8 5786.6 5873.2 5888.6 5905.6 5911.7 5912.3 5546.5 5751.4 5752.7 5753.2 5778.1 18:04:09 INFO - PROCESS | 10107 | 18:04:09 INFO - PROCESS | 10107 | [#1] ext.html Cycles:180 Average:73703.55 Median:39673.20 stddev:169401.29 (427.0%) stddev-sans-first:169787.58 18:04:09 INFO - PROCESS | 10107 | Values: 598.4 651.9 652.9 663.5 668.2 33527.0 45411.0 46408.0 46457.0 46498.8 48415.8 48812.3 48928.3 49045.0 49067.3 8341.7 8546.5 9159.9 9322.0 10951.9 10649.3 11069.5 11070.1 11077.3 11083.7 11161.1 11182.2 11190.8 11191.1 11191.2 8511.2 8696.3 10612.7 10877.9 11018.5 10835.6 10939.6 10944.5 10948.6 10948.9 44311.6 44358.3 44462.3 44771.3 44821.3 3626.9 3849.2 3922.7 3934.1 4294.8 34042.3 34341.7 34774.3 35393.1 35972.1 4320.9 4470.1 4479.4 4495.6 4548.5 358317.0 359033.0 359514.0 360458.2 361055.0 34362.1 60585.4 61773.0 61873.4 61909.0 37053.6 38958.2 39348.2 39380.2 39421.4 16439.5 16517.9 16549.4 16616.7 16660.3 12654.0 13440.4 13779.9 13824.7 13997.3 9111.3 9112.6 9138.7 9175.6 9189.7 3461.9 3482.5 3486.8 3509.8 3532.8 915.6 1030.8 1123.0 1143.0 1198.4 31364.7 32594.8 32770.3 33243.5 33628.7 1178.8 1213.3 1274.5 1292.6 1294.1 17846.6 17850.3 17887.6 17969.5 18005.4 690430.0 902387.0 916316.0 917129.0 917539.0 61817.7 62165.0 62292.7 62298.7 62313.4 1368.9 1493.7 1494.1 1499.4 1503.5 31210.0 32195.5 33939.3 35198.5 35437.6 55580.9 56511.9 56512.4 56575.7 56585.4 536025.0 542363.0 543168.0 544305.0 546004.0 46789.8 48055.3 48318.3 48772.8 49131.5 52065.5 53347.0 53666.2 54211.2 54269.0 43249.4 43352.0 43463.0 44528.8 44533.8 44067.3 44426.6 45044.5 45484.3 46414.3 44328.6 44562.3 44894.3 45430.3 45939.3 38126.8 38142.0 39925.0 40477.0 40689.6 28059.7 29947.3 30120.9 30217.2 30861.5 18:04:09 INFO - PROCESS | 10107 | 18:04:09 INFO - PROCESS | 10107 | [#2] jquery.html Cycles:180 Average:31549.11 Median:2600.96 stddev:86889.15 (3340.7%) stddev-sans-first:87101.47 18:04:09 INFO - PROCESS | 10107 | Values: 429.6 430.9 434.4 438.5 440.0 19408.4 19624.1 20144.9 20687.8 20688.6 19640.5 19864.7 20199.8 20249.9 20396.9 5725.1 5976.7 6024.7 6035.1 6036.5 5628.9 5845.4 5889.4 5906.3 5928.5 5832.0 5834.7 5841.3 5847.3 5857.2 5625.3 5894.1 5894.2 5897.8 5898.6 5205.0 5317.5 5335.4 5339.9 5340.7 23839.9 23944.6 24060.4 24308.6 24385.8 2432.7 2466.5 2537.1 2664.8 2696.1 14810.9 14856.7 14944.4 15180.9 15434.6 2013.1 2054.8 2062.2 2129.7 2212.5 73068.6 74791.0 82644.6 84777.2 94260.0 17474.7 18883.7 19036.9 19094.2 19607.2 29651.6 32177.2 33775.5 33918.7 35774.5 10249.9 10504.6 10615.4 10881.3 11197.1 8923.2 9011.4 9107.2 9197.4 9279.9 9275.8 9332.2 9394.1 9454.5 9491.8 3020.7 3586.3 3692.7 3695.9 3824.9 984.8 995.6 1065.3 1070.6 1110.1 19908.6 19932.2 20019.3 20083.3 20146.3 1039.2 1046.0 1062.7 1077.1 1084.9 11124.6 11323.7 11327.0 11361.0 11405.1 520100.0 521555.0 524554.0 529825.0 548579.0 88566.6 92162.5 92887.0 92975.0 105722.0 1075.2 1091.2 1115.7 1122.4 1123.0 18633.2 18793.2 18869.8 18953.0 19023.8 38943.0 39160.0 39510.8 43577.6 44434.3 55361.0 56761.0 60042.0 60605.7 61696.4 8394.7 8441.7 8506.2 8530.9 9119.9 8566.1 10002.8 12883.7 14069.6 14161.9 10193.7 11885.3 11993.2 12344.0 12515.7 12233.7 12273.4 12332.5 12544.6 12699.9 12716.0 12757.9 12784.8 12991.2 13014.4 9000.5 9137.4 9163.0 9196.1 9339.6 12259.4 12406.9 12447.4 12589.4 12611.0 18:04:09 INFO - PROCESS | 10107 | 18:04:09 INFO - PROCESS | 10107 | [#3] mootools.html Cycles:180 Average:6264.88 Median:4445.20 stddev:3625.89 (81.6%) stddev-sans-first:3617.77 18:04:09 INFO - PROCESS | 10107 | Values: 1418.0 1558.5 1589.9 1623.7 1684.4 8921.9 9303.0 9328.7 9565.4 9672.1 9377.2 9584.5 9598.7 9605.1 9608.3 2172.8 2384.3 2428.4 2451.6 2474.0 2387.8 2398.4 2399.4 2400.3 2401.6 2394.7 2410.3 2441.1 2445.0 2446.4 2047.2 2226.7 2286.2 2295.1 2350.1 2438.9 2454.6 2459.7 2461.9 2463.1 9100.4 9104.8 9158.4 9162.5 9168.3 5519.8 5663.9 5680.0 5685.9 5686.2 3229.9 3311.5 3381.8 3394.3 3412.2 1097.7 1125.6 1126.4 1129.7 1133.3 13688.2 13741.0 13741.9 13746.9 13746.9 4772.7 4851.4 4899.1 4915.2 4942.8 11353.2 11355.3 11398.5 11400.7 11404.3 5596.3 5667.7 5676.2 5681.3 5683.2 4523.6 4967.4 5045.4 5085.2 5161.9 4237.3 4286.0 4350.0 4350.1 4351.0 1321.8 1364.6 1385.0 1387.1 1397.4 908.5 984.9 996.4 1023.9 1094.0 6253.3 6295.4 6335.1 6515.1 6537.9 1017.6 1029.4 1046.9 1049.2 1069.8 4200.7 4313.6 4390.1 4415.1 4475.3 11604.2 11715.5 11820.9 11847.9 11892.9 11604.5 11630.6 11633.9 11723.4 11783.1 8720.5 8748.7 8891.6 9145.7 9153.5 6540.1 6651.4 6715.6 6752.6 6755.1 10422.5 10752.7 10802.1 10974.7 11245.1 10781.0 11110.9 11121.9 11128.8 11138.6 7449.3 7881.2 8101.4 8117.7 8251.3 9395.8 9422.9 9439.2 9495.2 9505.0 8337.9 8578.8 8641.6 8689.4 8748.2 8057.6 8134.5 8269.9 8294.7 8428.3 7744.5 7989.0 7990.3 7995.1 7997.8 5770.2 5770.8 5884.1 5892.9 5927.6 5738.6 5767.5 5816.5 5828.4 5855.1 18:04:09 INFO - PROCESS | 10107 | 18:04:09 INFO - PROCESS | 10107 | [#4] prototype.html Cycles:180 Average:4846.33 Median:5500.81 stddev:1429.45 (26.0%) stddev-sans-first:1392.93 18:04:09 INFO - PROCESS | 10107 | Values: 343.0 348.5 350.3 350.5 353.4 5544.3 5606.7 5610.4 5611.9 5628.6 5498.6 5500.4 5557.9 5561.6 5569.2 3990.6 4111.8 4133.5 4303.7 4314.1 4257.7 4300.9 4305.8 4310.5 4314.9 4289.3 4295.2 4297.3 4298.5 4308.8 4082.3 4167.6 4275.5 4316.9 4320.2 3800.9 3816.9 3833.3 3843.8 3849.2 5365.6 5371.2 5372.7 5388.9 5404.9 4999.0 4999.6 5020.6 5026.8 5028.1 5501.2 5694.3 5720.3 5807.5 5848.3 4042.7 4095.9 4114.1 4222.0 4241.3 5869.3 5971.6 5977.8 6005.6 6029.7 4051.1 4244.6 4252.8 4254.8 4309.7 4284.8 4300.0 4305.9 4308.2 4309.7 4908.4 4908.7 4920.2 4925.6 4940.7 5722.8 5725.2 5815.4 5843.9 5870.6 1444.9 1451.0 1461.4 1464.7 1474.8 929.1 937.9 960.9 962.5 962.8 5010.9 5021.0 5059.5 5119.7 5121.8 5246.9 5259.9 5264.9 5308.0 5314.9 4928.8 5022.6 5111.1 5246.2 5778.1 3167.3 3186.2 3199.7 3203.9 3212.4 6038.0 6285.7 6290.6 6308.3 6309.2 6086.9 6095.5 6111.3 6113.3 6129.3 5876.8 6033.5 6074.1 6161.3 6192.2 5538.4 5698.5 5779.4 5949.1 5956.5 5897.6 5902.0 5915.5 5935.4 5947.2 5843.6 6169.2 6196.9 6197.7 6201.0 4209.5 4224.3 4272.7 4286.5 4305.7 6048.7 6070.4 6074.7 6086.7 6101.4 5533.5 5774.2 5806.3 5860.6 5876.1 5772.7 5819.1 5829.9 5841.2 5858.2 5734.8 5746.9 5790.3 5804.7 5812.2 5729.2 5850.8 5851.6 5864.8 5874.9 5703.0 5735.5 5735.7 5740.2 5746.7 18:04:09 INFO - PROCESS | 10107 | 18:04:09 INFO - PROCESS | 10107 | [#5] yui.html Cycles:180 Average:22183.08 Median:4645.81 stddev:32298.65 (695.2%) stddev-sans-first:32349.23 18:04:09 INFO - PROCESS | 10107 | Values: 767.5 790.0 798.5 873.6 904.1 16967.2 17666.4 17682.0 17692.7 17772.8 14955.6 14979.1 14979.6 14991.9 15071.3 721.7 856.2 877.5 878.0 884.1 860.6 867.0 867.7 867.8 870.3 919.3 920.5 921.7 921.9 922.8 758.2 894.7 918.4 920.1 920.4 677.8 678.2 679.1 679.5 679.8 16083.1 16116.9 16143.1 16155.3 16164.3 14518.6 14822.3 14895.0 15019.3 15305.8 12752.1 12758.9 12998.3 13283.6 13466.3 4642.6 4649.1 4664.3 4691.9 4715.4 75424.2 76320.2 76421.0 76529.0 76579.0 11424.5 11616.4 11696.5 11991.3 12229.4 22246.6 22518.9 22570.5 22717.8 22784.2 8491.1 8591.2 8642.8 8663.3 8674.0 4720.7 4843.3 4929.5 4953.2 4997.6 3602.8 3681.6 3691.2 3700.6 3701.4 618.2 626.4 636.4 673.4 680.6 619.5 699.6 767.1 777.8 806.1 10525.2 10869.8 11023.8 11036.4 11222.9 663.9 756.9 764.4 791.6 803.1 4969.0 5082.2 5123.7 5201.9 5301.4 78855.6 123351.4 130614.0 134756.0 134781.0 100008.5 101317.5 101443.5 104342.0 108115.0 96321.0 97791.0 98237.5 99953.5 101251.0 9878.4 9878.8 9931.2 9971.8 9996.9 57153.0 57502.4 57697.4 57866.0 58946.0 80510.6 84520.2 84645.0 86128.6 86347.1 12687.9 12733.7 12964.5 13189.3 13776.7 14265.8 14474.4 14701.6 14881.5 15756.9 12570.4 12612.4 12996.1 13121.7 14098.9 12598.2 12756.0 12762.4 12980.8 13307.5 13327.3 14136.2 14283.6 14380.4 14526.5 11155.6 11481.6 11649.1 11660.4 12128.8 11460.8 11615.8 12531.3 12749.6 12822.4 18:04:09 INFO - PROCESS | 10107 | -------- Summary: end -------- 18:04:09 INFO - PROCESS | 10107 | 18:04:10 INFO - TEST-INFO | 10107: exit 0 18:04:10 INFO - TEST-OK | dromaeo_css | took 1113380ms 18:04:10 INFO - TEST-START | kraken 18:04:10 INFO - operating with platform_type : linux_ 18:04:10 INFO - Initialising browser for kraken test... 18:04:10 INFO - TEST-INFO | started process 10295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3DJPKY/profile http://localhost:40535/getInfo.html) 18:04:14 INFO - PROCESS | 10295 | __metrics Screen width/height:1600/1200 18:04:14 INFO - PROCESS | 10295 | colorDepth:24 18:04:14 INFO - PROCESS | 10295 | Browser inner width/height: 1024/697 18:04:14 INFO - PROCESS | 10295 | __metrics 18:04:15 ERROR - PROCESS | 10295 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:04:16 INFO - PROCESS | 10295 | console.error: PushService: 18:04:16 INFO - PROCESS | 10295 | stateChangeProcessEnqueue: Error transitioning state 18:04:16 INFO - PROCESS | 10295 | UnknownError 18:04:16 INFO - TEST-INFO | 10295: exit 0 18:04:16 INFO - Browser initialized. 18:04:16 INFO - Running cycle 1/1 for kraken test... 18:04:16 INFO - TEST-INFO | started process 10387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3DJPKY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:04:28 INFO - PROCESS | 10387 | RSS: Main: 145731584 18:04:28 INFO - PROCESS | 10387 | 18:04:31 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40535/tests/kraken/driver.html?testName=audio-beat-detection) 18:04:31 INFO - PROCESS | 10387 | RSS: Main: 194269184 18:04:31 INFO - PROCESS | 10387 | 18:04:34 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40535/tests/kraken/driver.html?testName=audio-dft) 18:04:35 INFO - PROCESS | 10387 | RSS: Main: 192688128 18:04:35 INFO - PROCESS | 10387 | 18:04:37 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40535/tests/kraken/driver.html?testName=audio-fft) 18:04:38 INFO - PROCESS | 10387 | RSS: Main: 278204416 18:04:38 INFO - PROCESS | 10387 | 18:04:40 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40535/tests/kraken/driver.html?testName=audio-oscillator) 18:04:41 INFO - PROCESS | 10387 | RSS: Main: 187408384 18:04:41 INFO - PROCESS | 10387 | 18:04:43 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40535/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:04:43 INFO - PROCESS | 10387 | RSS: Main: 188616704 18:04:43 INFO - PROCESS | 10387 | 18:04:46 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40535/tests/kraken/driver.html?testName=imaging-darkroom) 18:04:47 INFO - PROCESS | 10387 | RSS: Main: 222720000 18:04:47 INFO - PROCESS | 10387 | 18:04:50 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40535/tests/kraken/driver.html?testName=imaging-desaturate) 18:04:51 INFO - PROCESS | 10387 | RSS: Main: 223473664 18:04:51 INFO - PROCESS | 10387 | 18:04:54 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40535/tests/kraken/driver.html?testName=json-parse-financial) 18:04:54 INFO - PROCESS | 10387 | RSS: Main: 223064064 18:04:54 INFO - PROCESS | 10387 | 18:04:56 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40535/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:04:57 INFO - PROCESS | 10387 | RSS: Main: 200744960 18:04:57 INFO - PROCESS | 10387 | 18:04:58 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40535/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:04:59 INFO - PROCESS | 10387 | RSS: Main: 201342976 18:04:59 INFO - PROCESS | 10387 | 18:05:01 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40535/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:05:02 INFO - PROCESS | 10387 | RSS: Main: 209956864 18:05:02 INFO - PROCESS | 10387 | 18:05:04 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40535/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:05:05 INFO - PROCESS | 10387 | RSS: Main: 213651456 18:05:05 INFO - PROCESS | 10387 | 18:05:07 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40535/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:05:08 INFO - PROCESS | 10387 | RSS: Main: 215535616 18:05:08 INFO - PROCESS | 10387 | 18:05:09 INFO - PROCESS | 10387 | Cycle 1(1): loaded http://localhost:40535/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40535/tests/kraken/driver.html?testName=ai-astar) 18:05:10 INFO - PROCESS | 10387 | RSS: Main: 257679360 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | __start_tp_report 18:05:10 INFO - PROCESS | 10387 | _x_x_mozilla_page_load 18:05:10 INFO - PROCESS | 10387 | _x_x_mozilla_page_load_details 18:05:10 INFO - PROCESS | 10387 | |i|pagename|runs| 18:05:10 INFO - PROCESS | 10387 | |0;ai-astar;111;106;110;109;110;111;111;111;109;110 18:05:10 INFO - PROCESS | 10387 | |1;audio-beat-detection;149;132;125;183;124;125;153;125;151;124 18:05:10 INFO - PROCESS | 10387 | |2;audio-dft;161;161;161;161;162;161;161;162;160;161 18:05:10 INFO - PROCESS | 10387 | |3;audio-fft;74;73;75;117;75;76;75;76;109;77 18:05:10 INFO - PROCESS | 10387 | |4;audio-oscillator;84;84;118;82;83;84;115;84;84;118 18:05:10 INFO - PROCESS | 10387 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;116;117;117 18:05:10 INFO - PROCESS | 10387 | |6;imaging-darkroom;145;145;146;145;145;145;147;145;145;144 18:05:10 INFO - PROCESS | 10387 | |7;imaging-desaturate;95;94;95;95;95;95;95;94;95;94 18:05:10 INFO - PROCESS | 10387 | |8;json-parse-financial;51;51;49;50;51;50;50;50;51;51 18:05:10 INFO - PROCESS | 10387 | |9;json-stringify-tinderbox;61;60;60;59;60;60;60;59;59;60 18:05:10 INFO - PROCESS | 10387 | |10;stanford-crypto-aes;76;75;82;83;86;78;78;77;110;79 18:05:10 INFO - PROCESS | 10387 | |11;stanford-crypto-ccm;129;118;118;116;115;115;124;125;131;123 18:05:10 INFO - PROCESS | 10387 | |12;stanford-crypto-pbkdf2;156;151;155;164;152;155;157;158;153;154 18:05:10 INFO - PROCESS | 10387 | |13;stanford-crypto-sha256-iterative;62;61;60;60;64;63;62;60;58;60 18:05:10 INFO - PROCESS | 10387 | __end_tp_report 18:05:10 INFO - PROCESS | 10387 | __start_cc_report 18:05:10 INFO - PROCESS | 10387 | _x_x_mozilla_cycle_collect,1593 18:05:10 INFO - PROCESS | 10387 | __end_cc_report 18:05:10 INFO - PROCESS | 10387 | __startTimestamp1466643910196__endTimestamp 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | ------- Summary: start ------- 18:05:10 INFO - PROCESS | 10387 | Number of tests: 14 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:1.55 (1.4%) stddev-sans-first:1.58 18:05:10 INFO - PROCESS | 10387 | Values: 111.0 106.0 110.0 109.0 110.0 111.0 111.0 111.0 109.0 110.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:140.50 stddev:19.62 (14.0%) stddev-sans-first:20.48 18:05:10 INFO - PROCESS | 10387 | Values: 149.0 132.0 125.0 183.0 124.0 125.0 153.0 125.0 151.0 124.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:05:10 INFO - PROCESS | 10387 | Values: 161.0 161.0 161.0 161.0 162.0 161.0 161.0 162.0 160.0 161.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.00 stddev:16.12 (21.5%) stddev-sans-first:16.79 18:05:10 INFO - PROCESS | 10387 | Values: 74.0 73.0 75.0 117.0 75.0 76.0 75.0 76.0 109.0 77.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:84.00 stddev:16.18 (19.3%) stddev-sans-first:16.79 18:05:10 INFO - PROCESS | 10387 | Values: 84.0 84.0 118.0 82.0 83.0 84.0 115.0 84.0 84.0 118.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 18:05:10 INFO - PROCESS | 10387 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 18:05:10 INFO - PROCESS | 10387 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 147.0 145.0 145.0 144.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 18:05:10 INFO - PROCESS | 10387 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.71 18:05:10 INFO - PROCESS | 10387 | Values: 51.0 51.0 49.0 50.0 51.0 50.0 50.0 50.0 51.0 51.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 18:05:10 INFO - PROCESS | 10387 | Values: 61.0 60.0 60.0 59.0 60.0 60.0 60.0 59.0 59.0 60.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:78.50 stddev:10.28 (13.1%) stddev-sans-first:10.64 18:05:10 INFO - PROCESS | 10387 | Values: 76.0 75.0 82.0 83.0 86.0 78.0 78.0 77.0 110.0 79.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:123.50 stddev:5.83 (4.7%) stddev-sans-first:5.50 18:05:10 INFO - PROCESS | 10387 | Values: 129.0 118.0 118.0 116.0 115.0 115.0 124.0 125.0 131.0 123.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:155.50 stddev:3.69 (2.4%) stddev-sans-first:3.91 18:05:10 INFO - PROCESS | 10387 | Values: 156.0 151.0 155.0 164.0 152.0 155.0 157.0 158.0 153.0 154.0 18:05:10 INFO - PROCESS | 10387 | 18:05:10 INFO - PROCESS | 10387 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:61.50 stddev:1.76 (2.9%) stddev-sans-first:1.83 18:05:10 INFO - PROCESS | 10387 | Values: 62.0 61.0 60.0 60.0 64.0 63.0 62.0 60.0 58.0 60.0 18:05:10 INFO - PROCESS | 10387 | -------- Summary: end -------- 18:05:10 INFO - PROCESS | 10387 | 18:05:11 INFO - TEST-INFO | 10387: exit 0 18:05:11 INFO - TEST-OK | kraken | took 60524ms 18:05:11 INFO - SUITE-END | took 1173s 18:05:11 INFO - Completed test suite (00:19:34) 18:05:11 INFO - javascript benchmark 18:05:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.751243656726, 3341.398548261313, 3343.4316166251733, 3379.83100844958, 3388.983055084726, 5439.18412238164, 5504.532114770244, 5560.721963901804, 5567.137093750465, 5573.637713548626, 5514.172874068891, 5592.748326325315, 5600.943990560093, 5601.159826026098, 5645.830625081244, 4885.7312847793355, 4944.2089265717495, 5011.649184557083, 5028.472010438906, 5071.137906555876, 4898.657094003421, 5009.273655319977, 5014.423341315759, 5030.11972904742, 5123.871903202413, 4995.700257984515, 5008.39899212095, 5041.873953151164, 5091.261767043777, 5108.923366149511, 5058.974705126488, 5103.5917126629965, 5114.718690472023, 5132.769025393866, 5133.153029750106, 4872.878178045542, 4898.730569818658, 4911.680740751875, 4939.629527785394, 5020.071286811952, 5454.59090568205, 5471.699056551888, 5491.780328786844, 5499.092649712793, 5539.196816461631, 5934.554908381845, 5937.465628093492, 5971.0744834550715, 5972.014617588136, 5978.432048955342, 5752.654840709571, 5885.8822823543715, 5899.498542623882, 5905.2323197984415, 5932.0, 5581.134924086814, 5611.0, 5612.130119831432, 5612.186232996233, 5619.0, 5911.852203694942, 6075.362086980892, 6085.208922840091, 6086.391360863967, 6086.908696369558, 5812.157237200582, 5852.268466441695, 5857.853553661107, 5942.970285148633, 5945.881082378328, 5974.790882319098, 5984.401559843981, 5986.281646202484, 6018.3680713524445, 6030.758769649165, 5767.192593036978, 5859.1797148399255, 5970.164177015221, 5970.253718285215, 5974.163617093611, 5885.440883116097, 5972.462478376967, 5972.671503067286, 6008.309044459856, 6013.037913933749, 4520.0, 4538.29656403258, 4554.3168524720895, 4565.611922986517, 4584.014436896084, 3995.380715989026, 4006.639402453793, 4030.6170913763144, 4067.3695577185586, 4094.8566800161852, 5590.0, 5655.858603534944, 5658.094704847287, 5660.85847853807, 5690.77236910519, 5948.85127871798, 5963.642181469039, 5965.582409231312, 5973.820785376359, 6001.969990150109, 5535.086710692691, 5584.21820945068, 5608.242887210256, 5640.153976903415, 5655.1517272409465, 5122.92315615266, 5133.563647089964, 5137.383513978347, 5160.48395160481, 5164.2770012198325, 6101.938980610226, 6130.78542251028, 6138.508919286446, 6144.662043587557, 6152.323244443108, 5842.328132264844, 5919.526437885045, 5931.525477961839, 5958.76164953397, 5967.552433567413, 6176.536759742948, 6177.938220617736, 6185.134081228722, 6185.134081228722, 6185.319614842454, 5866.765329386947, 5871.178035075008, 5872.911906321494, 5875.471207591338, 5906.675132867734, 5802.82591522255, 5907.054871220584, 5918.23063001807, 5968.731407086779, 5995.7901473449965, 5856.297244330707, 5858.414158584107, 5861.120831875252, 5864.384239654775, 5874.089516125007, 5788.218590490398, 5844.298684157929, 5846.123081537803, 5857.824265272048, 5858.912116318344, 5610.747516361692, 5693.800716974886, 5722.0272553665145, 5733.799317023884, 5786.566007549366, 5873.207117039145, 5888.646681199141, 5905.5570832186895, 5911.704414779329, 5912.290525137011, 5546.500814926676, 5751.3673495916255, 5752.654840709571, 5753.223314852608, 5778.075507918881], "value": 5484.646662427061, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.362743677983, 651.8859199640065, 652.8596351784365, 663.4758540752804, 668.1514476614697, 33527.0, 45411.0, 46408.0, 46457.0, 46498.767506162505, 48415.75792121043, 48812.26781598279, 48928.2660760088, 49045.0, 49067.263991040076, 8341.66633334669, 8546.52994085325, 9159.908400915989, 9322.0, 10951.890481095166, 10649.254552181312, 11069.50187241576, 11070.114390848754, 11077.335359878432, 11083.72290692735, 11161.107111431107, 11182.217244792868, 11190.832137517904, 11191.104711623051, 11191.216614836965, 8511.191436813462, 8696.260817830493, 10612.681619551426, 10877.891221087766, 11018.50416731249, 10835.620753273677, 10939.56241750329, 10944.452777361179, 10948.562057517689, 10948.945255273753, 44311.55688443106, 44358.33462498065, 44462.33306500405, 44771.328430073576, 44821.327680084825, 3626.89119326418, 3849.2301539691894, 3922.666573341269, 3934.1344904121047, 4294.849680261176, 34042.319153617034, 34341.656583434095, 34774.30451390983, 35393.11517212065, 35972.100697482514, 4320.870373888788, 4470.128324976631, 4479.372887795711, 4495.625514095572, 4548.545145485458, 358317.0, 359033.0, 359514.0, 360458.1977090124, 361055.0, 34362.14094647654, 60585.39414605797, 61773.0, 61873.38126618676, 61909.0, 37053.629463705554, 38958.22083558313, 39348.21303573912, 39380.21239575192, 39421.40867886984, 16439.506814795575, 16517.917410412872, 16549.420770272984, 16616.6676666466, 16660.250288736792, 12654.0, 13440.395182216824, 13779.862201378059, 13824.654383640289, 13997.30013499321, 9111.316651251183, 9112.635494580143, 9138.725838224864, 9175.58709858058, 9189.724308270763, 3461.913452163716, 3482.460218666111, 3486.8082255475683, 3509.824508774551, 3532.752707310515, 915.555955361649, 1030.8402197659375, 1122.9831552526718, 1142.9942850285695, 1198.3522656347523, 31364.686353136633, 32594.83702581472, 32770.344593108006, 33243.50134747981, 33628.663713362555, 1178.834963105166, 1213.2962881528692, 1274.5156840400773, 1292.6315999939973, 1294.1458637299338, 17846.643067138586, 17850.26210851748, 17887.642247154985, 17969.460916172535, 18005.369812056517, 690430.0, 902387.0, 916316.0, 917129.0, 917539.0, 61817.690911545156, 62165.0, 62292.68853655703, 62298.68850655718, 62313.376866230756, 1368.8768010879069, 1493.6713922936935, 1494.1184701026446, 1499.3777582303221, 1503.4587548482757, 31210.0, 32195.51706724448, 33939.321213575095, 35198.472022919166, 35437.64562354344, 55580.94304813274, 56511.869762603696, 56512.43487565072, 56575.71712141413, 56585.434145658015, 536025.0, 542363.0, 543168.0, 544305.0, 546004.0, 46789.76605116953, 48055.27917081316, 48318.27522587094, 48772.75613621909, 49131.50868491412, 52065.47934520606, 53347.0, 53666.195007074144, 54211.18683219676, 54269.0, 43249.3512597305, 43352.0, 43463.0, 44528.77735611431, 44533.77733111314, 44067.33898991453, 44426.55573444224, 45044.54955450403, 45484.31773523334, 46414.30378544257, 44328.556714432445, 44562.3315650259, 44894.3265851019, 45430.318545221184, 45939.31091033704, 38126.80936595299, 38142.0, 39925.0, 40477.0, 40689.59310406858, 28059.71940280571, 29947.251318717208, 30120.926337615994, 30217.244568885955, 30861.537076944314], "value": 21083.244655392155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.6069096776449, 430.8879691280266, 434.3723319802886, 438.4891601284502, 440.0407699243404, 19408.417747467563, 19624.13570710784, 20144.899275503638, 20687.793122068775, 20688.586228275424, 19640.50898727529, 19864.70202946957, 20199.798002019976, 20249.898750506225, 20396.898015509938, 5725.112607545827, 5976.701164941735, 6024.698765061751, 6035.064564992434, 6036.547258955574, 5628.859278518029, 5845.444682755132, 5889.352171261179, 5906.291245050578, 5928.49607783339, 5832.037713777222, 5834.679092649923, 5841.328247251557, 5847.26909136358, 5857.179994800731, 5625.296837895263, 5894.145348924403, 5894.17481552583, 5897.823065308026, 5898.557608179361, 5205.037068142406, 5317.494837990384, 5335.439778823206, 5339.932013597296, 5340.732963351817, 23839.880800595885, 23944.640830387558, 24060.39849003789, 24308.63537046928, 24385.756142438702, 2432.7323994360604, 2466.506698660275, 2537.112010796225, 2664.8001399895084, 2696.137236084454, 14810.925945370313, 14856.702865942729, 14944.40222391103, 15180.924095379563, 15434.638222786103, 2013.1242909334487, 2054.763702174254, 2062.236972320236, 2129.6592545192693, 2212.4579478027986, 73068.63465682637, 74791.0, 82644.58677706633, 84777.15222847754, 94260.0, 17474.650506990045, 18883.716744248846, 19036.90481547611, 19094.2362305509, 19607.215711371384, 29651.55522667162, 32177.195570110933, 33775.493367599505, 33918.660813392045, 35774.463383049275, 10249.897501024894, 10504.632337868137, 10615.363078215332, 10881.292715973437, 11197.104231661448, 8923.15230053144, 9011.369204155777, 9107.180353768194, 9197.402168859002, 9279.860802087975, 9275.794146760878, 9332.20676242527, 9394.107559781809, 9454.527273636291, 9491.762705932408, 3020.6828283030404, 3586.336527742376, 3692.726009526709, 3695.870644527429, 3824.8661296854475, 984.7981163861391, 995.581855620641, 1065.2915810985608, 1070.5503688450713, 1110.0564520157964, 19908.60182796336, 19932.20271189136, 20019.29932452357, 20083.29708460226, 20146.294879679142, 1039.2257767962917, 1045.9895401046044, 1062.6918193723734, 1077.1006209814736, 1084.8643919510062, 11124.61063862761, 11323.660290191307, 11327.037201837937, 11361.0, 11405.14461415397, 520100.0, 521555.0, 524554.0, 529825.0, 548579.0, 88566.55716721374, 92162.53918730363, 92887.0, 92975.0, 105722.0, 1075.1613741281813, 1091.230682368928, 1115.726646971497, 1122.405125283601, 1122.966311010671, 18633.161507731915, 18793.154308056444, 18869.811301887356, 18953.023612786386, 19023.809761902205, 38943.026424339616, 39160.0, 39510.80244598759, 43577.56422435735, 44434.333484998395, 55361.0, 56761.0, 60042.0, 60605.69697151486, 61696.38303616906, 8394.664213431395, 8441.704540341305, 8506.191911768372, 8530.872036919576, 9119.908800911906, 8566.057733649419, 10002.799944001225, 12883.742325153631, 14069.577912662637, 14161.86705063613, 10193.694189174337, 11885.28688278706, 11993.220440671328, 12344.0, 12515.687107822378, 12233.69415764613, 12273.386330683252, 12332.50669973191, 12544.623661290176, 12699.873001269869, 12716.046296527613, 12757.872421275668, 12784.808227876403, 12991.220526768424, 13014.414351354022, 9000.54997250148, 9137.40606860552, 9163.0, 9196.12636799503, 9339.626414943326, 12259.448324825225, 12406.937965310115, 12447.439865205906, 12589.370531473573, 12611.0], "value": 10458.163656530101, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.9574612761621, 1558.5090696430623, 1589.8887077904549, 1623.7483190105538, 1684.3745785317174, 8921.910780892189, 9303.0, 9328.720138395858, 9565.426074435522, 9672.08115229052, 9377.156055954963, 9584.52077396129, 9598.664046758366, 9605.135537801596, 9608.327417080789, 2172.804447599716, 2384.260879127476, 2428.441458464554, 2451.595486744685, 2474.0, 2387.8447900886385, 2398.3764221302413, 2399.448126930807, 2400.2799160251943, 2401.6397540369, 2394.6527753475734, 2410.276916924924, 2441.060191826142, 2444.9755502444928, 2446.388402899275, 2047.2118234479758, 2226.666000099982, 2286.1769762885347, 2295.104909085458, 2350.1304517328613, 2438.926832195037, 2454.5581795276844, 2459.7417271186628, 2461.90152393904, 2463.1379017343966, 9100.408473449204, 9104.817903641957, 9158.358914875962, 9162.541872906328, 9168.312376571785, 5519.834404967857, 5663.8584035399035, 5680.005998950167, 5685.914711279334, 5686.232358631573, 3229.919252018695, 3311.4536101543217, 3381.847816848248, 3394.304167645627, 3412.2322477442626, 1097.6597254851022, 1125.6060378867412, 1126.3692332293942, 1129.7006293332274, 1133.2520536445907, 13688.178709277476, 13741.0, 13741.931290343584, 13746.862531374658, 13746.93126534371, 4772.7136371817105, 4851.442084160296, 4899.1426500362295, 4915.188993816052, 4942.827001054946, 11353.205275630626, 11355.318680879009, 11398.487068081957, 11400.714982125348, 11404.315741055563, 5596.27248457706, 5667.744951477193, 5676.205331253628, 5681.289838770153, 5683.204351390808, 4523.615492683093, 4967.428745694219, 5045.394552653705, 5085.186370180753, 5161.896762064813, 4237.258479766028, 4285.97857010713, 4350.0, 4350.108227813354, 4350.955770615093, 1321.8215540901856, 1364.5565191312862, 1385.0373990077, 1387.1469046536508, 1397.4410235905516, 908.4685459006555, 984.945827979468, 996.4071377530358, 1023.9129673977646, 1094.031781873048, 6253.280872699698, 6295.401936815995, 6335.144755458046, 6515.1333413298, 6537.869242615121, 1017.6489111256604, 1029.3875144289136, 1046.931949423285, 1049.2130901823632, 1069.775347177086, 4200.726952748061, 4313.633341166036, 4390.143921935256, 4415.116976604692, 4475.283954567253, 11604.245724027911, 11715.472803723853, 11820.881791181979, 11847.940760296144, 11892.940535297268, 11604.477798499087, 11630.592929247436, 11633.941830290794, 11723.4138293085, 11783.057355411547, 8720.520371379635, 8748.650053997897, 8891.64433422656, 9145.725628231165, 9153.496557689257, 6540.117084193763, 6651.368120028589, 6715.630640314829, 6752.5948443093575, 6755.121834161528, 10422.530986105492, 10752.67741967711, 10802.135829133493, 10974.725631859268, 11245.100391968786, 10781.0, 11110.888891110986, 11121.944390277997, 11128.777424451304, 11138.55445782192, 7449.329560339379, 7881.211878812073, 8101.351891848756, 8117.675292988451, 8251.33989280868, 9395.812083758423, 9422.905770942203, 9439.19766819828, 9495.24038076966, 9504.95247523758, 8337.874931875906, 8578.78553036179, 8641.56792160402, 8689.391742577958, 8748.212660860552, 8057.556834374166, 8134.511929284025, 8269.875951860606, 8294.668213271401, 8428.325733941147, 7744.49660772048, 7989.041315042232, 7990.280874721303, 7995.12053674107, 7997.7600671979935, 5770.2498675171955, 5770.826875193751, 5884.146798714248, 5892.852678682896, 5927.555433342431, 5738.598298119258, 5767.509761670305, 5816.476517113311, 5828.446297601721, 5855.063189889767], "value": 4959.454536658143, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.9725621950244, 348.47728407388934, 350.32737144682216, 350.5355404089582, 353.4360454986683, 5544.279243698318, 5606.6636001839815, 5610.410906854782, 5611.915821262684, 5628.634138780982, 5498.615096943216, 5500.3949565547755, 5557.944420555793, 5561.581796641861, 5569.192467092269, 3990.563397177014, 4111.794410279489, 4133.483314585676, 4303.698741088125, 4314.1156063007165, 4257.723247988871, 4300.913981720364, 4305.763183024932, 4310.547392523787, 4314.870553883373, 4289.2922667759785, 4295.248331541983, 4297.312430011199, 4298.484181898177, 4308.827646894136, 4082.326416141333, 4167.604077612637, 4275.508316543606, 4316.892077698051, 4320.1575692739925, 3800.923981520354, 3816.923661526754, 3833.3291673956946, 3843.7693738375788, 3849.2493963677093, 5365.624406291561, 5371.167469042305, 5372.7045012524295, 5388.91916621247, 5404.91892621611, 4999.0, 4999.600031997432, 5020.623453241022, 5026.8384594624295, 5028.145215313369, 5501.229827824108, 5694.345150307726, 5720.256366672306, 5807.506361959238, 5848.2689663792025, 4042.7372220805846, 4095.85664501744, 4114.074333274989, 4222.0, 4241.257779888507, 5869.266341707286, 5971.552133589955, 5977.7608895644125, 6005.579609427298, 6029.728662210167, 4051.1290072633938, 4244.554321796229, 4252.766097864585, 4254.787260637017, 4309.698321117492, 4284.807183676742, 4299.9570004300185, 4305.892352691145, 4308.224519586442, 4309.655227581786, 4908.41099068107, 4908.650121216694, 4920.220075657242, 4925.630577706686, 4940.728259945666, 5722.799702010493, 5725.227094342294, 5815.418458154235, 5843.853903652443, 5870.618409803435, 1444.949426770058, 1450.9564713058626, 1461.4300422835104, 1464.7110542722337, 1474.8230212374583, 929.1266209762802, 937.9062093790703, 960.8798900137483, 962.4898803634085, 962.8349696866869, 5010.874728131753, 5020.991603358686, 5059.532735506736, 5119.692818430906, 5121.8463446096675, 5246.868828279324, 5259.894802103937, 5264.947350526446, 5307.973460132752, 5314.893702125936, 4928.802847886116, 5022.59819214462, 5111.086680592027, 5246.245720996508, 5778.104393818965, 3167.334859679447, 3186.203449137716, 3199.7280231180143, 3203.8878639247514, 3212.3896459673056, 6038.033914573647, 6285.654289014056, 6290.55966082379, 6308.27454842699, 6309.242890853127, 6086.878262434727, 6095.481884039907, 6111.327753947062, 6113.32753397126, 6129.295131059896, 5876.823695289148, 6033.547483938634, 6074.149619053336, 6161.291451483047, 6192.225971753531, 5538.44615538459, 5698.503982134635, 5779.393163717749, 5949.137375080676, 5956.51087228193, 5897.616654917417, 5901.970490147522, 5915.526757859447, 5935.40645935403, 5947.167396564571, 5843.6201646894515, 6169.2288463942, 6196.938030619636, 6197.659128747962, 6200.9536852837555, 4209.494860616745, 4224.302990006738, 4272.743635381763, 4286.52848186693, 4305.655547556251, 6048.727807248596, 6070.3929607038945, 6074.726637301421, 6086.6652334122045, 6101.420365065312, 5533.474319939599, 5774.15227127332, 5806.332271788799, 5860.619059761102, 5876.08920617305, 5772.653640781398, 5819.127130930225, 5829.94170058294, 5841.240638716939, 5858.246624086672, 5734.770609175586, 5746.913796292975, 5790.336445235071, 5804.6807425592, 5812.157237200667, 5729.169270455677, 5850.795222167204, 5851.590388672752, 5864.765409383747, 5874.882502350015, 5702.971485142548, 5735.54115670737, 5735.713214339183, 5740.225069615549, 5746.712664366682], "value": 4390.5336912766315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.5471471831618, 789.9526028438294, 798.5448294472153, 873.550121687331, 904.1230006893313, 16967.23647435865, 17666.38167664132, 17682.0, 17692.734608980874, 17772.822271777295, 14955.626109347271, 14979.101253924771, 14979.625509362271, 14991.850081499182, 15071.321790519425, 721.7293514931874, 856.1524091149779, 877.5480627476838, 877.9868301975475, 884.0849720539243, 860.5955201055494, 866.9869951950726, 867.6876324523166, 867.8047439326133, 870.303756994402, 919.3288899103659, 920.5305294299922, 921.7050543825978, 921.8985911549725, 922.7739203895055, 758.1660173808822, 894.6958034268348, 918.42598376015, 920.0845159066705, 920.4477313611847, 677.7763338098416, 678.2302087131093, 679.0730652659084, 679.4530403025562, 679.7756740275697, 16083.11542865142, 16116.919415402848, 16143.112128832909, 16155.273012714457, 16164.27260773268, 14518.637034074232, 14822.258887055605, 14895.0, 15019.324130414157, 15305.846941530554, 12752.10735248533, 12758.936205319007, 12998.285094319808, 13283.60149195516, 13466.25935573543, 4642.558956899089, 4649.070185962787, 4664.300354946785, 4691.859244222679, 4715.41057367829, 75424.24575754227, 76320.23679763186, 76421.0, 76529.0, 76579.0, 11424.485898134604, 11616.419179041015, 11696.532138714356, 11991.340476273888, 12229.449674764657, 22246.55506889853, 22518.887405562866, 22570.548589028127, 22717.772822271898, 22784.20255291057, 8491.065982741893, 8591.183837535424, 8642.799493827404, 8663.306935445149, 8674.0, 4720.716756994591, 4843.2735089736825, 4929.507049295114, 4953.2074868020945, 4997.625178111656, 3602.8018458985007, 3681.6318368163506, 3691.224842782992, 3700.6299370063316, 3701.3892707703467, 618.2488276743778, 626.417431788432, 636.4049613611288, 673.3670349871105, 680.6052489556046, 619.5291578400448, 699.6012273004338, 767.1293082351459, 777.782220978127, 806.052887856766, 10525.157987361146, 10869.782604347869, 11023.779524409467, 11036.448177591088, 11222.887771122347, 663.8904580744123, 756.856197322518, 764.361757932133, 791.5923299500762, 803.1245941923331, 4968.950310496921, 5082.161443361878, 5123.7438128093445, 5201.895962080737, 5301.416844147141, 78855.60572197102, 123351.38324308321, 130614.0, 134756.0, 134781.0, 100008.4999575012, 101317.49341253247, 101443.4927825371, 104342.0, 108115.0, 96321.0, 97791.0, 98237.50881245692, 99953.50023249982, 101251.0, 9878.407295562289, 9878.753031174278, 9931.205503559553, 9971.800563988534, 9996.900030999597, 57153.0, 57502.42497575138, 57697.423025770884, 57866.0, 58946.0, 80510.59744701239, 84520.15479845123, 84645.0, 86128.56935715281, 86347.13652863391, 12687.873121268669, 12733.745325093632, 12964.481420743065, 13189.340532973121, 13776.65558361049, 14265.786013209603, 14474.421023159377, 14701.632459188606, 14881.47914822976, 15756.92121539385, 12570.37148142571, 12612.369381530703, 12996.09027368113, 13121.671958201121, 14098.929505352407, 12598.181118227287, 12756.0, 12762.42569084412, 12980.8052879205, 13307.534236301683, 13327.333633318489, 14136.15183089018, 14283.571492855232, 14380.35288412003, 14526.491572794901, 11155.55377784912, 11481.598144064918, 11649.1263155262, 11660.358680272328, 12128.818067728815, 11460.770784584429, 11615.76768464643, 12531.310777906938, 12749.553765618159, 12822.358882056047], "value": 7997.2669359310485, "unit": "score"}], "name": "dromaeo_css", "value": 7713.4103634546145, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 109.0, 110.0, 111.0, 111.0, 111.0, 109.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 125.0, 183.0, 124.0, 125.0, 153.0, 125.0, 151.0, 124.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 117.0, 75.0, 76.0, 75.0, 76.0, 109.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 82.0, 83.0, 84.0, 115.0, 84.0, 84.0, 118.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 144.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 49.0, 50.0, 51.0, 50.0, 50.0, 50.0, 51.0, 51.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 82.0, 83.0, 86.0, 78.0, 78.0, 77.0, 110.0, 79.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 118.0, 118.0, 116.0, 115.0, 115.0, 124.0, 125.0, 131.0, 123.0], "value": 121.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 151.0, 155.0, 164.0, 152.0, 155.0, 157.0, 158.0, 153.0, 154.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 60.0, 64.0, 63.0, 62.0, 60.0, 58.0, 60.0], "value": 61.0, "unit": "score"}], "name": "kraken", "value": 1473.3000000000002, "alertThreshold": 2.0}]} 18:05:11 INFO - Return code: 0 18:05:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:05:11 ERROR - # TBPL SUCCESS # 18:05:11 INFO - Running post-action listener: _resource_record_post_action 18:05:11 INFO - ##### 18:05:11 INFO - ##### Finished run-tests step (success) 18:05:11 INFO - ##### 18:05:11 INFO - Running post-run listener: _resource_record_post_run 18:05:11 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504274944; Read time: 16; Write time: 411960 18:05:11 INFO - TinderboxPrint: CPU usage
13.1% 18:05:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:05:11 INFO - TinderboxPrint: I/O write bytes / time
504,274,944 / 411,960 18:05:11 INFO - TinderboxPrint: CPU idle
8,260.1 (86.9%) 18:05:11 INFO - TinderboxPrint: CPU user
1,198.0 (12.6%) 18:05:11 INFO - TinderboxPrint: Swap in / out
0 / 0 18:05:11 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 229810176; Read time: 0; Write time: 253836 18:05:11 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251412480; Read time: 16; Write time: 154148 18:05:12 INFO - Running post-run listener: _upload_blobber_files 18:05:12 INFO - Blob upload gear active. 18:05:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:05:12 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 18:05:12 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:05:12 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:05:12 INFO - (blobuploader) - INFO - Open directory for files ... 18:05:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:05:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:05:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:13 INFO - (blobuploader) - INFO - Done attempting. 18:05:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:05:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:05:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:16 INFO - (blobuploader) - INFO - Done attempting. 18:05:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:05:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:05:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:17 INFO - (blobuploader) - INFO - Done attempting. 18:05:17 INFO - (blobuploader) - INFO - Iteration through files over. 18:05:17 INFO - Return code: 0 18:05:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:05:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:05:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18b0dfc7a5046ff4f5409d1692fa5674ee9d1bcaa3274c6678f53609245a657e16fe46c987b4346d21d6e5802235a4c84ea6f4f77c610e27eb1af863b40f0e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a19ce70bf3ea87b6bf7b75a5df37cb446e750bf0ac2403cc7f89e64248f0afa6c3d130eb8b224bec72fae2b6757ef1bc0edff18c32d012f9800d6a3bb8cfe7b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63ece98eb1c347a58a5a6ce63693850f50b1d67a46e0a8378499b0b504d0d8d76b9df60d0829ad0c8bedf6fc6881167243f59925caee17aeff492d075b206996"} 18:05:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:05:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:05:17 INFO - Contents: 18:05:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18b0dfc7a5046ff4f5409d1692fa5674ee9d1bcaa3274c6678f53609245a657e16fe46c987b4346d21d6e5802235a4c84ea6f4f77c610e27eb1af863b40f0e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a19ce70bf3ea87b6bf7b75a5df37cb446e750bf0ac2403cc7f89e64248f0afa6c3d130eb8b224bec72fae2b6757ef1bc0edff18c32d012f9800d6a3bb8cfe7b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63ece98eb1c347a58a5a6ce63693850f50b1d67a46e0a8378499b0b504d0d8d76b9df60d0829ad0c8bedf6fc6881167243f59925caee17aeff492d075b206996"} 18:05:17 INFO - Running post-run listener: copy_logs_to_upload_dir 18:05:17 INFO - Copying logs to upload dir... 18:05:17 INFO - mkdir: /builds/slave/test/build/upload/logs 18:05:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.985648 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-22 18:05:17.607972) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 18:05:17.612915) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673 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-Aurora/sha512/f18b0dfc7a5046ff4f5409d1692fa5674ee9d1bcaa3274c6678f53609245a657e16fe46c987b4346d21d6e5802235a4c84ea6f4f77c610e27eb1af863b40f0e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a19ce70bf3ea87b6bf7b75a5df37cb446e750bf0ac2403cc7f89e64248f0afa6c3d130eb8b224bec72fae2b6757ef1bc0edff18c32d012f9800d6a3bb8cfe7b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63ece98eb1c347a58a5a6ce63693850f50b1d67a46e0a8378499b0b504d0d8d76b9df60d0829ad0c8bedf6fc6881167243f59925caee17aeff492d075b206996"} build_url:https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011449 build_url: 'https://queue.taskcluster.net/v1/task/b5b8tYbkT4iAtIOjdt770g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f18b0dfc7a5046ff4f5409d1692fa5674ee9d1bcaa3274c6678f53609245a657e16fe46c987b4346d21d6e5802235a4c84ea6f4f77c610e27eb1af863b40f0e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a19ce70bf3ea87b6bf7b75a5df37cb446e750bf0ac2403cc7f89e64248f0afa6c3d130eb8b224bec72fae2b6757ef1bc0edff18c32d012f9800d6a3bb8cfe7b4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/63ece98eb1c347a58a5a6ce63693850f50b1d67a46e0a8378499b0b504d0d8d76b9df60d0829ad0c8bedf6fc6881167243f59925caee17aeff492d075b206996"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 18:05:17.638168) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 18:05:17.638478) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466641166.766207-365872673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 18:05:17.722376) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 18:05:17.722696) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 18:05:17.722978) ========= ========= Total master_lag: 0.19 =========