builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1465513816.85 results: success (0) buildid: 20160609133009 builduid: 3af3af3b7a99412dbde1fb2824436ce6 revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:16.851609) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:16.852142) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:16.852465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:16.913691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:16.914394) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 16:10:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.5M=0.001s 2016-06-09 16:10:17 (20.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090493 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:17.021831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:17.022224) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018804 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:17.075657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:17.076469) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ccccf8e5036179a3178437cabc154b5e04b333d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3ccccf8e5036179a3178437cabc154b5e04b333d --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=82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 16:10:17,174 truncating revision to first 12 chars 2016-06-09 16:10:17,174 Setting DEBUG logging. 2016-06-09 16:10:17,174 attempt 1/10 2016-06-09 16:10:17,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ccccf8e5036?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 16:10:17,472 unpacking tar archive at: mozilla-central-3ccccf8e5036/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667905 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:17.761805) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:17.762366) ========= script_repo_revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:17.763204) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:17.763890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:10:17.776223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-09 16:10:17.776721) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:10:17 INFO - MultiFileLogger online at 20160609 16:10:17 in /builds/slave/test 16:10:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:10:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:10:17 INFO - {'append_to_log': False, 16:10:17 INFO - 'base_work_dir': '/builds/slave/test', 16:10:17 INFO - 'blob_upload_branch': 'Firefox', 16:10:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:10:17 INFO - 'branch': 'Firefox', 16:10:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:10:17 INFO - 'config_files': ('talos/linux_config.py',), 16:10:17 INFO - 'default_actions': ('clobber', 16:10:17 INFO - 'read-buildbot-config', 16:10:17 INFO - 'download-and-extract', 16:10:17 INFO - 'populate-webroot', 16:10:17 INFO - 'create-virtualenv', 16:10:17 INFO - 'install', 16:10:17 INFO - 'run-tests'), 16:10:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:10:17 INFO - 'download_minidump_stackwalk': True, 16:10:17 INFO - 'download_symbols': 'ondemand', 16:10:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:10:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:10:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:10:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:10:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:10:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:10:17 INFO - 'installer_path': 'installer.exe', 16:10:17 INFO - 'log_level': 'info', 16:10:17 INFO - 'log_name': 'talos', 16:10:17 INFO - 'log_to_console': True, 16:10:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:10:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:10:17 INFO - 'opt_config_files': (), 16:10:17 INFO - 'pip_index': False, 16:10:17 INFO - 'sps_profile': False, 16:10:17 INFO - 'sps_profile_interval': 0, 16:10:17 INFO - 'suite': 'dromaeojs', 16:10:17 INFO - 'system_bits': '32', 16:10:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:10:17 INFO - 'title': 'talos-linux64-ix-066', 16:10:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:10:17 INFO - 'use_talos_json': True, 16:10:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:10:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:10:17 INFO - 'work_dir': 'build'} 16:10:17 INFO - ##### 16:10:17 INFO - ##### Running clobber step. 16:10:17 INFO - ##### 16:10:17 INFO - Running pre-action listener: _resource_record_pre_action 16:10:17 INFO - Running main action method: clobber 16:10:17 INFO - rmtree: /builds/slave/test/build 16:10:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:10:18 INFO - Running post-action listener: _resource_record_post_action 16:10:18 INFO - ##### 16:10:18 INFO - ##### Finished clobber step (success) 16:10:18 INFO - ##### 16:10:18 INFO - ##### 16:10:18 INFO - ##### Running read-buildbot-config step. 16:10:18 INFO - ##### 16:10:18 INFO - Running pre-action listener: _resource_record_pre_action 16:10:18 INFO - Running main action method: read_buildbot_config 16:10:18 INFO - Using buildbot properties: 16:10:18 INFO - { 16:10:18 INFO - "project": "", 16:10:18 INFO - "product": "firefox", 16:10:18 INFO - "script_repo_revision": "production", 16:10:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:10:18 INFO - "repository": "", 16:10:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:10:18 INFO - "buildid": "20160609133009", 16:10:18 INFO - "pgo_build": "True", 16:10:18 INFO - "basedir": "/builds/slave/test", 16:10:18 INFO - "buildnumber": 334, 16:10:18 INFO - "slavename": "talos-linux64-ix-066", 16:10:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:10:18 INFO - "platform": "ubuntu64_hw", 16:10:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:10:18 INFO - "branch": "mozilla-central", 16:10:18 INFO - "repo_path": "mozilla-central", 16:10:18 INFO - "revision": "3ccccf8e5036179a3178437cabc154b5e04b333d", 16:10:18 INFO - "stage_platform": "linux64-pgo", 16:10:18 INFO - "builduid": "3af3af3b7a99412dbde1fb2824436ce6", 16:10:18 INFO - "slavebuilddir": "test" 16:10:18 INFO - } 16:10:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:10:18 INFO - Running post-action listener: _resource_record_post_action 16:10:18 INFO - ##### 16:10:18 INFO - ##### Finished read-buildbot-config step (success) 16:10:18 INFO - ##### 16:10:18 INFO - ##### 16:10:18 INFO - ##### Running download-and-extract step. 16:10:18 INFO - ##### 16:10:18 INFO - Running pre-action listener: _resource_record_pre_action 16:10:18 INFO - Running main action method: download_and_extract 16:10:18 INFO - mkdir: /builds/slave/test/build/tests 16:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:18 INFO - https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:10:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:10:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:10:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:10:19 INFO - Downloaded 1361 bytes. 16:10:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:10:19 INFO - Using the following test package requirements: 16:10:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:10:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:10:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:10:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:19 INFO - u'jsshell-linux-x86_64.zip'], 16:10:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:10:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:10:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:10:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:10:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:10:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:10:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:19 INFO - https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:10:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:10:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:10:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:10:20 INFO - Downloaded 24452789 bytes. 16:10:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:10:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:10:21 INFO - Return code: 0 16:10:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:22 INFO - https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:10:23 INFO - Downloaded 24452789 bytes. 16:10:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:10:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:10:24 INFO - Return code: 0 16:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:24 INFO - https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:10:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:10:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:10:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:10:26 INFO - Downloaded 10833377 bytes. 16:10:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:10:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:10:26 INFO - Return code: 0 16:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:26 INFO - https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:10:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:10:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:10:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:10:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:10:28 INFO - Downloaded 59328660 bytes. 16:10:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:10:28 INFO - mkdir: /builds/slave/test/properties 16:10:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:10:28 INFO - Writing to file /builds/slave/test/properties/build_url 16:10:28 INFO - Contents: 16:10:28 INFO - build_url:https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:10:29 INFO - Running post-action listener: _resource_record_post_action 16:10:29 INFO - Running post-action listener: set_extra_try_arguments 16:10:29 INFO - ##### 16:10:29 INFO - ##### Finished download-and-extract step (success) 16:10:29 INFO - ##### 16:10:29 INFO - ##### 16:10:29 INFO - ##### Running populate-webroot step. 16:10:29 INFO - ##### 16:10:29 INFO - Running pre-action listener: _resource_record_pre_action 16:10:29 INFO - Running main action method: populate_webroot 16:10:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:10:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:10:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:10:29 INFO - '--tppagecycles', 16:10:29 INFO - '7'], 16:10:29 INFO - 'tests': ['tsvgm']}}, 16:10:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:10:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:10:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:10:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:10:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:10:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:10:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:29 INFO - 'talos_options': ['--disable-e10s'], 16:10:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:29 INFO - 'talos_options': ['--disable-e10s'], 16:10:29 INFO - 'tests': ['damp', 'tps']}, 16:10:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:29 INFO - 'tests': ['damp', 'tps']}, 16:10:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:10:29 INFO - 'tests': ['dromaeo_dom']}, 16:10:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:10:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:10:29 INFO - 'tests': ['a11yr', 16:10:29 INFO - 'ts_paint', 16:10:29 INFO - 'tpaint', 16:10:29 INFO - 'sessionrestore', 16:10:29 INFO - 'sessionrestore_no_auto_restore', 16:10:29 INFO - 'tabpaint']}, 16:10:29 INFO - 'other-e10s': {'tests': ['a11yr', 16:10:29 INFO - 'ts_paint', 16:10:29 INFO - 'tpaint', 16:10:29 INFO - 'sessionrestore', 16:10:29 INFO - 'sessionrestore_no_auto_restore', 16:10:29 INFO - 'tabpaint']}, 16:10:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:10:29 INFO - 'ts_paint', 16:10:29 INFO - 'tpaint', 16:10:29 INFO - 'sessionrestore', 16:10:29 INFO - 'sessionrestore_no_auto_restore', 16:10:29 INFO - 'tabpaint']}, 16:10:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:10:29 INFO - 'ts_paint', 16:10:29 INFO - 'tpaint', 16:10:29 INFO - 'sessionrestore', 16:10:29 INFO - 'sessionrestore_no_auto_restore', 16:10:29 INFO - 'tabpaint']}, 16:10:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:10:29 INFO - 'tests': ['a11yr', 16:10:29 INFO - 'ts_paint', 16:10:29 INFO - 'tpaint', 16:10:29 INFO - 'sessionrestore', 16:10:29 INFO - 'sessionrestore_no_auto_restore', 16:10:29 INFO - 'tabpaint']}, 16:10:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:10:29 INFO - 'tests': ['a11yr', 16:10:29 INFO - 'ts_paint', 16:10:29 INFO - 'tpaint', 16:10:29 INFO - 'sessionrestore', 16:10:29 INFO - 'sessionrestore_no_auto_restore', 16:10:29 INFO - 'tabpaint']}, 16:10:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:10:29 INFO - 'tests': ['tsvgx', 16:10:29 INFO - 'tsvgr_opacity', 16:10:29 INFO - 'tart', 16:10:29 INFO - 'tscrollx', 16:10:29 INFO - 'cart']}, 16:10:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:10:29 INFO - 'tsvgr_opacity', 16:10:29 INFO - 'tart', 16:10:29 INFO - 'tscrollx', 16:10:29 INFO - 'cart']}, 16:10:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:29 INFO - 'talos_options': ['--disable-e10s'], 16:10:29 INFO - 'tests': ['tp5o']}, 16:10:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:29 INFO - 'tests': ['tp5o']}, 16:10:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:29 INFO - 'talos_options': ['--disable-e10s', 16:10:29 INFO - '--xperf_path', 16:10:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:29 INFO - 'tests': ['tp5n']}, 16:10:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:29 INFO - 'talos_options': ['--xperf_path', 16:10:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:29 INFO - 'tests': ['tp5n']}}, 16:10:29 INFO - 'talos.zip': {'path': '', 16:10:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:10:29 INFO - Running post-action listener: _resource_record_post_action 16:10:29 INFO - ##### 16:10:29 INFO - ##### Finished populate-webroot step (success) 16:10:29 INFO - ##### 16:10:29 INFO - ##### 16:10:29 INFO - ##### Running create-virtualenv step. 16:10:29 INFO - ##### 16:10:29 INFO - Running pre-action listener: _resource_record_pre_action 16:10:29 INFO - Running main action method: create_virtualenv 16:10:29 INFO - Creating virtualenv /builds/slave/test/build/venv 16:10:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:10:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:10:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:10:29 INFO - Using real prefix '/usr' 16:10:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:10:30 INFO - Installing distribute.............................................................................................................................................................................................done. 16:10:32 INFO - Installing pip.................done. 16:10:32 INFO - Return code: 0 16:10:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:32 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 0x7f687e540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:10:32 INFO - Using env: {'DISPLAY': ':0', 16:10:32 INFO - 'HOME': '/home/cltbld', 16:10:32 INFO - 'LANG': 'en_US.UTF-8', 16:10:32 INFO - 'LANGUAGE': 'en_US:en', 16:10:32 INFO - 'LOGNAME': 'cltbld', 16:10:32 INFO - 'MAIL': '/var/mail/cltbld', 16:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:32 INFO - 'MOZ_NO_REMOTE': '1', 16:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:32 INFO - 'NO_EM_RESTART': '1', 16:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:32 INFO - 'PWD': '/builds/slave/test', 16:10:32 INFO - 'SHELL': '/bin/bash', 16:10:32 INFO - 'SHLVL': '1', 16:10:32 INFO - 'TERM': 'linux', 16:10:32 INFO - 'TMOUT': '86400', 16:10:32 INFO - 'USER': 'cltbld', 16:10:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:32 INFO - '_': '/tools/buildbot/bin/python'} 16:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:10:32 INFO - Cleaning up... 16:10:32 INFO - Return code: 0 16:10:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:32 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 0x7f687e540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:10:32 INFO - Using env: {'DISPLAY': ':0', 16:10:32 INFO - 'HOME': '/home/cltbld', 16:10:32 INFO - 'LANG': 'en_US.UTF-8', 16:10:32 INFO - 'LANGUAGE': 'en_US:en', 16:10:32 INFO - 'LOGNAME': 'cltbld', 16:10:32 INFO - 'MAIL': '/var/mail/cltbld', 16:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:32 INFO - 'MOZ_NO_REMOTE': '1', 16:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:32 INFO - 'NO_EM_RESTART': '1', 16:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:32 INFO - 'PWD': '/builds/slave/test', 16:10:32 INFO - 'SHELL': '/bin/bash', 16:10:32 INFO - 'SHLVL': '1', 16:10:32 INFO - 'TERM': 'linux', 16:10:32 INFO - 'TMOUT': '86400', 16:10:32 INFO - 'USER': 'cltbld', 16:10:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:32 INFO - '_': '/tools/buildbot/bin/python'} 16:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:32 INFO - Downloading/unpacking psutil>=3.1.1 16:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:10:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:34 INFO - Installing collected packages: psutil 16:10:34 INFO - Running setup.py install for psutil 16:10:34 INFO - building 'psutil._psutil_linux' extension 16:10:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:10:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:10:34 INFO - building 'psutil._psutil_posix' extension 16:10:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:10:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:10:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:35 INFO - Successfully installed psutil 16:10:35 INFO - Cleaning up... 16:10:35 INFO - Return code: 0 16:10:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:35 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 0x7f687e540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:10:35 INFO - Using env: {'DISPLAY': ':0', 16:10:35 INFO - 'HOME': '/home/cltbld', 16:10:35 INFO - 'LANG': 'en_US.UTF-8', 16:10:35 INFO - 'LANGUAGE': 'en_US:en', 16:10:35 INFO - 'LOGNAME': 'cltbld', 16:10:35 INFO - 'MAIL': '/var/mail/cltbld', 16:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:35 INFO - 'MOZ_NO_REMOTE': '1', 16:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:35 INFO - 'NO_EM_RESTART': '1', 16:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:35 INFO - 'PWD': '/builds/slave/test', 16:10:35 INFO - 'SHELL': '/bin/bash', 16:10:35 INFO - 'SHLVL': '1', 16:10:35 INFO - 'TERM': 'linux', 16:10:35 INFO - 'TMOUT': '86400', 16:10:35 INFO - 'USER': 'cltbld', 16:10:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:35 INFO - '_': '/tools/buildbot/bin/python'} 16:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:10:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:10:37 INFO - Installing collected packages: mozsystemmonitor 16:10:37 INFO - Running setup.py install for mozsystemmonitor 16:10:37 INFO - Successfully installed mozsystemmonitor 16:10:37 INFO - Cleaning up... 16:10:37 INFO - Return code: 0 16:10:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f687e540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:10:37 INFO - Using env: {'DISPLAY': ':0', 16:10:37 INFO - 'HOME': '/home/cltbld', 16:10:37 INFO - 'LANG': 'en_US.UTF-8', 16:10:37 INFO - 'LANGUAGE': 'en_US:en', 16:10:37 INFO - 'LOGNAME': 'cltbld', 16:10:37 INFO - 'MAIL': '/var/mail/cltbld', 16:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:37 INFO - 'MOZ_NO_REMOTE': '1', 16:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:37 INFO - 'NO_EM_RESTART': '1', 16:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:37 INFO - 'PWD': '/builds/slave/test', 16:10:37 INFO - 'SHELL': '/bin/bash', 16:10:37 INFO - 'SHLVL': '1', 16:10:37 INFO - 'TERM': 'linux', 16:10:37 INFO - 'TMOUT': '86400', 16:10:37 INFO - 'USER': 'cltbld', 16:10:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:37 INFO - '_': '/tools/buildbot/bin/python'} 16:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:37 INFO - Downloading/unpacking jsonschema==2.5.1 16:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:10:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:39 INFO - Downloading functools32-3.2.3-2.tar.gz 16:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:10:39 INFO - warning: no files found matching '*.txt' 16:10:39 INFO - no previously-included directories found matching 'build' 16:10:39 INFO - no previously-included directories found matching 'dist' 16:10:39 INFO - no previously-included directories found matching '.git*' 16:10:39 INFO - Installing collected packages: jsonschema, functools32 16:10:39 INFO - Running setup.py install for functools32 16:10:39 INFO - warning: no files found matching '*.txt' 16:10:39 INFO - no previously-included directories found matching 'build' 16:10:39 INFO - no previously-included directories found matching 'dist' 16:10:39 INFO - no previously-included directories found matching '.git*' 16:10:39 INFO - Successfully installed jsonschema functools32 16:10:39 INFO - Cleaning up... 16:10:40 INFO - Return code: 0 16:10:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f687e540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:10:40 INFO - Using env: {'DISPLAY': ':0', 16:10:40 INFO - 'HOME': '/home/cltbld', 16:10:40 INFO - 'LANG': 'en_US.UTF-8', 16:10:40 INFO - 'LANGUAGE': 'en_US:en', 16:10:40 INFO - 'LOGNAME': 'cltbld', 16:10:40 INFO - 'MAIL': '/var/mail/cltbld', 16:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:40 INFO - 'MOZ_NO_REMOTE': '1', 16:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:40 INFO - 'NO_EM_RESTART': '1', 16:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:40 INFO - 'PWD': '/builds/slave/test', 16:10:40 INFO - 'SHELL': '/bin/bash', 16:10:40 INFO - 'SHLVL': '1', 16:10:40 INFO - 'TERM': 'linux', 16:10:40 INFO - 'TMOUT': '86400', 16:10:40 INFO - 'USER': 'cltbld', 16:10:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:40 INFO - '_': '/tools/buildbot/bin/python'} 16:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:40 INFO - Downloading/unpacking blobuploader==1.2.4 16:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:42 INFO - Downloading blobuploader-1.2.4.tar.gz 16:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:10:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:10:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:42 INFO - Downloading docopt-0.6.1.tar.gz 16:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:10:42 INFO - Installing collected packages: blobuploader, requests, docopt 16:10:42 INFO - Running setup.py install for blobuploader 16:10:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:10:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:10:43 INFO - Running setup.py install for requests 16:10:43 INFO - Running setup.py install for docopt 16:10:43 INFO - Successfully installed blobuploader requests docopt 16:10:43 INFO - Cleaning up... 16:10:43 INFO - Return code: 0 16:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:43 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 0x7f687e540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:10:43 INFO - Using env: {'DISPLAY': ':0', 16:10:43 INFO - 'HOME': '/home/cltbld', 16:10:43 INFO - 'LANG': 'en_US.UTF-8', 16:10:43 INFO - 'LANGUAGE': 'en_US:en', 16:10:43 INFO - 'LOGNAME': 'cltbld', 16:10:43 INFO - 'MAIL': '/var/mail/cltbld', 16:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:43 INFO - 'MOZ_NO_REMOTE': '1', 16:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:43 INFO - 'NO_EM_RESTART': '1', 16:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:43 INFO - 'PWD': '/builds/slave/test', 16:10:43 INFO - 'SHELL': '/bin/bash', 16:10:43 INFO - 'SHLVL': '1', 16:10:43 INFO - 'TERM': 'linux', 16:10:43 INFO - 'TMOUT': '86400', 16:10:43 INFO - 'USER': 'cltbld', 16:10:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:43 INFO - '_': '/tools/buildbot/bin/python'} 16:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:43 INFO - Running setup.py (path:/tmp/pip-hokbVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:43 INFO - Running setup.py (path:/tmp/pip-MyTsHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:43 INFO - Running setup.py (path:/tmp/pip-BIeKES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:43 INFO - Running setup.py (path:/tmp/pip-3PZ85I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:44 INFO - Running setup.py (path:/tmp/pip-PMTX_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:44 INFO - Running setup.py (path:/tmp/pip-yDfD7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:44 INFO - Running setup.py (path:/tmp/pip-txtZ3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:44 INFO - Running setup.py (path:/tmp/pip-wwsMXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:44 INFO - Running setup.py (path:/tmp/pip-MRI45A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:44 INFO - Running setup.py (path:/tmp/pip-XJoWn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:44 INFO - Running setup.py (path:/tmp/pip-n2qerJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:44 INFO - Running setup.py (path:/tmp/pip-Vlf34S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:44 INFO - Running setup.py (path:/tmp/pip-s5wXOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:44 INFO - Running setup.py (path:/tmp/pip-nIwa8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:44 INFO - Running setup.py (path:/tmp/pip-dqN3vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:44 INFO - Running setup.py (path:/tmp/pip-Zyrteg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:44 INFO - Running setup.py (path:/tmp/pip-tAM7A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:10:44 INFO - Running setup.py install for manifestparser 16:10:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:10:45 INFO - Running setup.py install for mozcrash 16:10:45 INFO - Running setup.py install for mozdebug 16:10:45 INFO - Running setup.py install for mozdevice 16:10:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:10:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:10:45 INFO - Running setup.py install for mozfile 16:10:45 INFO - Running setup.py install for mozhttpd 16:10:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:10:45 INFO - Running setup.py install for mozinfo 16:10:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:10:45 INFO - Running setup.py install for mozInstall 16:10:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:10:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:10:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:10:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:10:45 INFO - Running setup.py install for mozleak 16:10:45 INFO - Running setup.py install for mozlog 16:10:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:10:46 INFO - Running setup.py install for moznetwork 16:10:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:10:46 INFO - Running setup.py install for mozprocess 16:10:46 INFO - Running setup.py install for mozprofile 16:10:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:10:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:10:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:10:46 INFO - Running setup.py install for mozrunner 16:10:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:10:46 INFO - Running setup.py install for mozscreenshot 16:10:46 INFO - Running setup.py install for moztest 16:10:46 INFO - Running setup.py install for mozversion 16:10:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:10:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:10:46 INFO - Cleaning up... 16:10:46 INFO - Return code: 0 16:10:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:46 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 0x7f687e540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:10:46 INFO - Using env: {'DISPLAY': ':0', 16:10:46 INFO - 'HOME': '/home/cltbld', 16:10:46 INFO - 'LANG': 'en_US.UTF-8', 16:10:46 INFO - 'LANGUAGE': 'en_US:en', 16:10:46 INFO - 'LOGNAME': 'cltbld', 16:10:46 INFO - 'MAIL': '/var/mail/cltbld', 16:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:46 INFO - 'MOZ_NO_REMOTE': '1', 16:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:46 INFO - 'NO_EM_RESTART': '1', 16:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:46 INFO - 'PWD': '/builds/slave/test', 16:10:46 INFO - 'SHELL': '/bin/bash', 16:10:46 INFO - 'SHLVL': '1', 16:10:46 INFO - 'TERM': 'linux', 16:10:46 INFO - 'TMOUT': '86400', 16:10:46 INFO - 'USER': 'cltbld', 16:10:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:46 INFO - '_': '/tools/buildbot/bin/python'} 16:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:47 INFO - Running setup.py (path:/tmp/pip-yaBXSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:47 INFO - Running setup.py (path:/tmp/pip-nGgiNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:47 INFO - Running setup.py (path:/tmp/pip-PAqQIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:47 INFO - Running setup.py (path:/tmp/pip-EK2JAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:47 INFO - Running setup.py (path:/tmp/pip-CM2h4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:47 INFO - Running setup.py (path:/tmp/pip-XCN6RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:47 INFO - Running setup.py (path:/tmp/pip-MtldSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:47 INFO - Running setup.py (path:/tmp/pip-9Q0CFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:47 INFO - Running setup.py (path:/tmp/pip-obpA_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:47 INFO - Running setup.py (path:/tmp/pip-v8kXvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:47 INFO - Running setup.py (path:/tmp/pip-5RiNf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:47 INFO - Running setup.py (path:/tmp/pip-trIC1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:47 INFO - Running setup.py (path:/tmp/pip-bD90uC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:48 INFO - Running setup.py (path:/tmp/pip-LtS8dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:48 INFO - Running setup.py (path:/tmp/pip-oldFbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:48 INFO - Running setup.py (path:/tmp/pip-ntuqVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:48 INFO - Running setup.py (path:/tmp/pip-AF9P6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:10:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:50 INFO - Downloading blessings-1.6.tar.gz 16:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:10:50 INFO - Installing collected packages: blessings 16:10:50 INFO - Running setup.py install for blessings 16:10:50 INFO - Successfully installed blessings 16:10:50 INFO - Cleaning up... 16:10:50 INFO - Return code: 0 16:10:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:10:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:50 INFO - Reading from file tmpfile_stdout 16:10:50 INFO - Current package versions: 16:10:50 INFO - argparse == 1.2.1 16:10:50 INFO - blessings == 1.6 16:10:50 INFO - blobuploader == 1.2.4 16:10:50 INFO - docopt == 0.6.1 16:10:50 INFO - functools32 == 3.2.3-2 16:10:50 INFO - jsonschema == 2.5.1 16:10:50 INFO - manifestparser == 1.1 16:10:50 INFO - mozInstall == 1.12 16:10:50 INFO - mozcrash == 0.17 16:10:50 INFO - mozdebug == 0.1 16:10:50 INFO - mozdevice == 0.48 16:10:50 INFO - mozfile == 1.2 16:10:50 INFO - mozhttpd == 0.7 16:10:50 INFO - mozinfo == 0.9 16:10:50 INFO - mozleak == 0.1 16:10:50 INFO - mozlog == 3.2 16:10:50 INFO - moznetwork == 0.27 16:10:50 INFO - mozprocess == 0.22 16:10:50 INFO - mozprofile == 0.28 16:10:50 INFO - mozrunner == 6.11 16:10:50 INFO - mozscreenshot == 0.1 16:10:50 INFO - mozsystemmonitor == 0.3 16:10:50 INFO - moztest == 0.7 16:10:50 INFO - mozversion == 1.4 16:10:50 INFO - psutil == 3.1.1 16:10:50 INFO - requests == 1.2.3 16:10:50 INFO - wsgiref == 0.1.2 16:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:50 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 0x7f687e540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:10:50 INFO - Using env: {'DISPLAY': ':0', 16:10:50 INFO - 'HOME': '/home/cltbld', 16:10:50 INFO - 'LANG': 'en_US.UTF-8', 16:10:50 INFO - 'LANGUAGE': 'en_US:en', 16:10:50 INFO - 'LOGNAME': 'cltbld', 16:10:50 INFO - 'MAIL': '/var/mail/cltbld', 16:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:50 INFO - 'MOZ_NO_REMOTE': '1', 16:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:50 INFO - 'NO_EM_RESTART': '1', 16:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:50 INFO - 'PWD': '/builds/slave/test', 16:10:50 INFO - 'SHELL': '/bin/bash', 16:10:50 INFO - 'SHLVL': '1', 16:10:50 INFO - 'TERM': 'linux', 16:10:50 INFO - 'TMOUT': '86400', 16:10:50 INFO - 'USER': 'cltbld', 16:10:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:50 INFO - '_': '/tools/buildbot/bin/python'} 16:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:10:50 INFO - Cleaning up... 16:10:50 INFO - Return code: 0 16:10:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:50 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 0x7f687e540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:10:50 INFO - Using env: {'DISPLAY': ':0', 16:10:50 INFO - 'HOME': '/home/cltbld', 16:10:50 INFO - 'LANG': 'en_US.UTF-8', 16:10:50 INFO - 'LANGUAGE': 'en_US:en', 16:10:50 INFO - 'LOGNAME': 'cltbld', 16:10:50 INFO - 'MAIL': '/var/mail/cltbld', 16:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:50 INFO - 'MOZ_NO_REMOTE': '1', 16:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:50 INFO - 'NO_EM_RESTART': '1', 16:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:50 INFO - 'PWD': '/builds/slave/test', 16:10:50 INFO - 'SHELL': '/bin/bash', 16:10:50 INFO - 'SHLVL': '1', 16:10:50 INFO - 'TERM': 'linux', 16:10:50 INFO - 'TMOUT': '86400', 16:10:50 INFO - 'USER': 'cltbld', 16:10:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:50 INFO - '_': '/tools/buildbot/bin/python'} 16:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:10:51 INFO - Cleaning up... 16:10:51 INFO - Return code: 0 16:10:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:51 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 0x7f687e540f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ce350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:10:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:10:51 INFO - Using env: {'DISPLAY': ':0', 16:10:51 INFO - 'HOME': '/home/cltbld', 16:10:51 INFO - 'LANG': 'en_US.UTF-8', 16:10:51 INFO - 'LANGUAGE': 'en_US:en', 16:10:51 INFO - 'LOGNAME': 'cltbld', 16:10:51 INFO - 'MAIL': '/var/mail/cltbld', 16:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:51 INFO - 'MOZ_NO_REMOTE': '1', 16:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:51 INFO - 'NO_EM_RESTART': '1', 16:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:51 INFO - 'PWD': '/builds/slave/test', 16:10:51 INFO - 'SHELL': '/bin/bash', 16:10:51 INFO - 'SHLVL': '1', 16:10:51 INFO - 'TERM': 'linux', 16:10:51 INFO - 'TMOUT': '86400', 16:10:51 INFO - 'USER': 'cltbld', 16:10:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:51 INFO - '_': '/tools/buildbot/bin/python'} 16:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:51 INFO - Downloading/unpacking flake8 16:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:10:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:10:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:10:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:10:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:10:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:10:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:10:53 INFO - no previously-included directories found matching 'docs/_build' 16:10:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:10:53 INFO - Running setup.py install for pep8 16:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:10:54 INFO - no previously-included directories found matching 'docs/_build' 16:10:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:10:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:10:54 INFO - Cleaning up... 16:10:54 INFO - Return code: 0 16:10:54 INFO - Running post-action listener: _resource_record_post_action 16:10:54 INFO - Running post-action listener: _start_resource_monitoring 16:10:54 INFO - Starting resource monitoring. 16:10:54 INFO - ##### 16:10:54 INFO - ##### Finished create-virtualenv step (success) 16:10:54 INFO - ##### 16:10:54 INFO - ##### 16:10:54 INFO - ##### Running install step. 16:10:54 INFO - ##### 16:10:54 INFO - Running pre-action listener: _resource_record_pre_action 16:10:54 INFO - Running main action method: install 16:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:54 INFO - Reading from file tmpfile_stdout 16:10:54 INFO - Detecting whether we're running mozinstall >=1.0... 16:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:10:54 INFO - Reading from file tmpfile_stdout 16:10:54 INFO - Output received: 16:10:54 INFO - Usage: mozinstall [options] installer 16:10:54 INFO - Options: 16:10:54 INFO - -h, --help show this help message and exit 16:10:54 INFO - -d DEST, --destination=DEST 16:10:54 INFO - Directory to install application into. [default: 16:10:54 INFO - "/builds/slave/test"] 16:10:54 INFO - --app=APP Application being installed. [default: firefox] 16:10:54 INFO - mkdir: /builds/slave/test/build/application 16:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:11:11 INFO - Reading from file tmpfile_stdout 16:11:11 INFO - Output received: 16:11:11 INFO - /builds/slave/test/build/application/firefox/firefox 16:11:11 INFO - Running post-action listener: _resource_record_post_action 16:11:11 INFO - ##### 16:11:11 INFO - ##### Finished install step (success) 16:11:11 INFO - ##### 16:11:11 INFO - ##### 16:11:11 INFO - ##### Running run-tests step. 16:11:11 INFO - ##### 16:11:11 INFO - Running pre-action listener: _resource_record_pre_action 16:11:11 INFO - Running main action method: run_tests 16:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:11:11 INFO - Python 2.7.3 16:11:11 INFO - Return code: 0 16:11:11 INFO - grabbing minidump binary from tooltool 16:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:11 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 0x125d1c0>, '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 0x125e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:11:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:11:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:11:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:11:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:11:11 INFO - Return code: 0 16:11:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:11:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:11:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:11:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:11:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:11:12 INFO - Return code: 0 16:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:11:12 INFO - Using env: {'DISPLAY': ':0', 16:11:12 INFO - 'HOME': '/home/cltbld', 16:11:12 INFO - 'LANG': 'en_US.UTF-8', 16:11:12 INFO - 'LANGUAGE': 'en_US:en', 16:11:12 INFO - 'LOGNAME': 'cltbld', 16:11:12 INFO - 'MAIL': '/var/mail/cltbld', 16:11:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:11:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:12 INFO - 'MOZ_NO_REMOTE': '1', 16:11:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:12 INFO - 'NO_EM_RESTART': '1', 16:11:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:12 INFO - 'PWD': '/builds/slave/test', 16:11:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:11:12 INFO - 'SHELL': '/bin/bash', 16:11:12 INFO - 'SHLVL': '1', 16:11:12 INFO - 'TERM': 'linux', 16:11:12 INFO - 'TMOUT': '86400', 16:11:12 INFO - 'USER': 'cltbld', 16:11:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205', 16:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:12 INFO - '_': '/tools/buildbot/bin/python'} 16:11:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:11:12 INFO - mozversion application_buildid: 20160609133009 16:11:12 INFO - mozversion application_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 16:11:12 INFO - mozversion application_display_name: Nightly 16:11:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:11:12 INFO - mozversion application_name: Firefox 16:11:12 INFO - mozversion application_remotingname: firefox 16:11:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:11:12 INFO - mozversion application_vendor: Mozilla 16:11:12 INFO - mozversion application_version: 50.0a1 16:11:12 INFO - mozversion platform_buildid: 20160609133009 16:11:12 INFO - mozversion platform_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 16:11:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:11:12 INFO - mozversion platform_version: 50.0a1 16:11:12 INFO - using testdate: 1465513872 16:11:12 INFO - actual date: 1465513872 16:11:12 INFO - starting webserver on 'localhost:37816' 16:11:12 INFO - SUITE-START | Running 2 tests 16:11:12 INFO - TEST-START | dromaeo_css 16:11:12 INFO - operating with platform_type : linux_ 16:11:12 INFO - Initialising browser for dromaeo_css test... 16:11:12 INFO - TEST-INFO | started process 26073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH6tKxU/profile http://localhost:37816/getInfo.html) 16:11:16 INFO - PROCESS | 26073 | __metrics Screen width/height:1600/1200 16:11:16 INFO - PROCESS | 26073 | colorDepth:24 16:11:16 INFO - PROCESS | 26073 | Browser inner width/height: 1024/697 16:11:16 INFO - PROCESS | 26073 | __metrics 16:11:18 ERROR - PROCESS | 26073 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:11:18 INFO - PROCESS | 26073 | console.error: PushService: 16:11:18 INFO - PROCESS | 26073 | stateChangeProcessEnqueue: Error transitioning state 16:11:18 INFO - PROCESS | 26073 | UnknownError 16:11:19 INFO - TEST-INFO | 26073: exit 0 16:11:19 INFO - Browser initialized. 16:11:19 INFO - Running cycle 1/1 for dromaeo_css test... 16:11:19 INFO - TEST-INFO | started process 26156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH6tKxU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:31 INFO - PROCESS | 26156 | RSS: Main: 173342720 16:11:31 INFO - PROCESS | 26156 | 16:12:21 INFO - PROCESS | 26156 | 1465513941891 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:14:30 INFO - PROCESS | 26156 | Cycle 1(1): loaded http://localhost:37816/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37816/tests/dromaeo/cssquery-ext.html) 16:14:31 INFO - PROCESS | 26156 | RSS: Main: 275673088 16:14:31 INFO - PROCESS | 26156 | 16:17:34 INFO - PROCESS | 26156 | Cycle 1(1): loaded http://localhost:37816/tests/dromaeo/cssquery-ext.html (next: http://localhost:37816/tests/dromaeo/cssquery-jquery.html) 16:17:34 INFO - PROCESS | 26156 | RSS: Main: 254787584 16:17:34 INFO - PROCESS | 26156 | 16:20:36 INFO - PROCESS | 26156 | Cycle 1(1): loaded http://localhost:37816/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37816/tests/dromaeo/cssquery-mootools.html) 16:20:37 INFO - PROCESS | 26156 | RSS: Main: 267182080 16:20:37 INFO - PROCESS | 26156 | 16:23:39 INFO - PROCESS | 26156 | Cycle 1(1): loaded http://localhost:37816/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37816/tests/dromaeo/cssquery-prototype.html) 16:23:40 INFO - PROCESS | 26156 | RSS: Main: 247836672 16:23:40 INFO - PROCESS | 26156 | 16:26:42 INFO - PROCESS | 26156 | Cycle 1(1): loaded http://localhost:37816/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37816/tests/dromaeo/cssquery-yui.html) 16:26:43 INFO - PROCESS | 26156 | RSS: Main: 228548608 16:26:43 INFO - PROCESS | 26156 | 16:29:45 INFO - PROCESS | 26156 | Cycle 1(1): loaded http://localhost:37816/tests/dromaeo/cssquery-yui.html (next: http://localhost:37816/tests/dromaeo/cssquery-dojo.html) 16:29:46 INFO - PROCESS | 26156 | RSS: Main: 306638848 16:29:46 INFO - PROCESS | 26156 | 16:29:46 INFO - PROCESS | 26156 | __start_tp_report 16:29:46 INFO - PROCESS | 26156 | _x_x_mozilla_page_load 16:29:46 INFO - PROCESS | 26156 | _x_x_mozilla_page_load_details 16:29:46 INFO - PROCESS | 26156 | |i|pagename|runs| 16:29:46 INFO - PROCESS | 26156 | |0;dojo.html;3071.9232019199517;3091.4899041658123;3122.640896296925;3124.9218769530744;3135.561021456995;5279.736013199344;5386.084365657838;5410.323709536308;5459.754311056002;5486.8353949381535;5391.78432862686;5419.187121931712;5431.864203394917;5454.59090568208;5457.345118585766;4857.781399837007;4907.656464047518;4957.479464656213;4968.056069346812;5089.389273287192;4969.428515720702;4989.077020751154;5033.496650334955;5045.899082018357;5056.873578160538;4754.524547545252;4857.101436234308;4862.100511405366;4875.463698993108;4908.803647854082;4855.562999330042;4868.951310486886;4943.28322393251;4946.530079642428;5000.499950004971;4773.832915847928;4885.7312847793355;4897.6326775491625;4915.090708218991;4940.629452791055;5239.816606418795;5311.389190243133;5338.172583249602;5389.407165211824;5396.973015134939;5715.1713001614535;5758.193852860602;5789;5794.82615521535;5799.5650326225705;5570.080936645449;5756.251687280668;5794.536437085023;5797.159411885253;5854.648721076749;5394.271773310592;5476.342838859362;5483.287172667568;5483.369412517532;5488.204210389471;5985.910211346833;5997.550183736237;5999.820005399845;6002.129691194752;6004.309504406961;5492.80775172867;5565.6104072714525;5589.301337332833;5740.68426236561;5757.798477053283;5719.28508936383;5760.193572899798;5768.971155144198;5772.3650398456975;5799.594028418054;5614.354349249888;5648.039833228361;5649.830505084854;5655.066913959151;5665.12190610456;5579.8884022320135;5623.156526520973;5682.516986056149;5688.857778555486;5708.914366284509;4382.320740285261;4385.780710964439;4388.2320593896575;4389.231884420214;4442;3923.941140882889;3932.9016774580864;3945.368741001426;3975.284448799244;3984.880453586397;5280.419153893145;5381.327334083239;5437.619366644376;5452.781888724407;5505.3393592768325;5812.331581868055;5838.824835254949;5840.766369345179;5843.094320380348;5877.676727779927;5270.49930256625;5512.862178445491;5522.364928033247;5523.558115350762;5525.834224973257;4946.1344264753525;4988.7505624718615;4998.6750861193905;5020.623453241022;5026.396832380065;5971.611845230046;5976.372480889531;5977.731002104916;5980.043193088998;5985.970070149621;5625.746841392229;5661.603687741818;5795.130730390475;5809.738561764815;5811.157382179645;5832.795852145155;5893.793717219876;5899.6165249260375;5948.226730525004;5951.404859514014;5614.045612245846;5649.096144616841;5658.03813351723;5663.433656634304;5665.405132461032;5598.468145526169;5681.829545113653;5759.164921086335;5766.596338256281;5772.826815195551;5628.465295796893;5685.488306052475;5686.800961966312;5692.51613612831;5737.627054241461;5602.803901863415;5604.299462567179;5625.634333768292;5634.32388113429;5651.124075768263;5418.593605479526;5457.962987032452;5499.285092937893;5553.16702494629;5560.165975103605;5685.630434021776;5696.857578560403;5704.258446401941;5706.714664266687;5723.7996670116345;5502.504774570308;5543.833684989457;5546.195801608825;5559.610827242054;5585.134304182858 16:29:46 INFO - PROCESS | 26156 | |1;ext.html;602.0788194063082;611.5382885921128;617.9660118693472;652.2433976587159;652.8726898254839;31304.373912521736;34848.30303393931;41166.588334116685;42046.57953420465;42102.73715785527;42841.785791071;43049;43132;43193.13613727724;43250;8733.388662793592;8857.557122143899;8869.467831930073;8871.866921996143;8872.423292485968;8663.523506207157;8737.95631021844;8738.912610873906;8749.518776467292;8753.124687531259;8795.604197811113;8797;8807.559622018873;8812.118788121168;8841.38110332277;8741.737747867573;8789.077146899548;8794.296456283482;8806;8809.251213646783;8713.607887645008;8713.738587842376;8732.8690069649;8738.344624153215;8742;42354.57645423537;42720.145597088194;42724;42741.57258427438;42744.3588346175;3614.6746792788513;3826;4099.1801639672185;4150.190712811003;4301.526832048472;29670.55494167589;31740.365192696016;31986.520202196985;32400.351992960244;33321.83339083289;4100.159467309224;4126.154138401651;4138.399932009872;4187.057911969813;4229.97885010576;351702;355223.2238838815;356444;356590;357915;33451.16372090717;34250.31499369998;34269.82865085659;60342.39657603368;61143;36696.44955325672;36719.63280367215;36754.08114797151;36786.448203276974;36848.63151368452;15577.14325712074;15696.136712480695;15696.372145114296;15702.842971570139;15715.764263535828;13141.277229752264;13238.139520931109;13244.602661920158;13251.337433128305;13253.403596838165;8187.672493100328;8216.09622941476;8216.794580135544;8265.628046737911;8285.295749861209;3215.5980502437196;3243.9026829195163;3254.8698052078125;3281.7210537104615;3298.4392653249006;1044.070777008463;1053.3890343600692;1073.9731506712394;1094.2012330998416;1120.6245907620876;32427.51358729621;32472.83763581167;32534.83732581322;32907;33176.50235246473;1135.2620796482352;1162.4245998230929;1183.816508441193;1184.3841202574613;1187.358826233824;16867;17213.22540485681;17328.220230089675;17341;17409.390671326444;550914;553033;557153;558067;559072;57803;58291.417085829446;58331;58445.415545844;58581.4141858576;1239.8078297863844;1255.409957320058;1324.3775425549977;1352.7226918481688;1376.4562997615885;30683;33777;33998.32003359968;34028.48957265692;34383.14042148966;49588;49703.502964969884;49852;49992;50009.749951250014;397066;397441;398045;398259;399397;24522.632160517962;26700.599491008037;27476.862615686794;27883.302917427227;28366.290842729097;48519;48972.265416018075;49004.75497622489;49119;49668.25497617611;40962;41134.382984255855;41281.58718412778;42179.36730948977;42253.36619950642;41488.377674334304;41675.37486937759;41914;42143;42580.78709606432;35910;40241;40594.391084133174;40836;41126.383104254055;34917.85739283375;36715.98062106503;37543.24913501769;37626.43560346652;37948.430773538974;27126.864365678044;27590.310242244104;27755.30611734642;27844.16467505978;27873.303167420167 16:29:46 INFO - PROCESS | 26156 | |2;jquery.html;388.4910766895367;389.90642245860994;396.5320921312853;401.8151650240889;414.58955633922426;14290.571282861505;17808.376706815263;17941.551461213476;19282.32511862085;19377.32179373724;18310.267589296447;18590.16344264508;19224.51938701533;19354.806451935478;19373.225070997145;5499.532539734128;5629.296337957755;5699.088145896658;5705.543556515489;5752.482276595106;4020.9396859047138;5422.40353561108;5633.408492108331;5642.4357564243655;6042.728077236513;6374.139491168702;6395.616263024233;6399;6399.872002559946;6404.167458230423;6189.071639254103;6250.906236406435;6355.142055822451;6372.203474565679;6381.266154392235;5581.74882130301;5604;5606.579506536985;5607.719614019324;5628.409017053233;21772;22613.434664133365;23004.53990920189;23503.529929401488;23561.17535886253;2252.6395776675654;2302.309307207831;2399.712034555847;2584.655978890985;3001.504751715964;14167.858321416757;14331.928340358232;14381.280935953266;14384.784228236585;14661.193634350106;1834.8073452287451;1840.8770649903547;1873.3536929759211;1977.1597071244664;1989.1446677928484;70299;74663.62668186678;75071.62464187643;82613.17386826115;83862;10838.512266947848;10852.67441976742;11012.724681882857;11297.774044519063;11460.567429071367;13487.730245395038;13901.235432051131;15599.688006239812;15655.217239138225;15655.765163522556;7901.446898717149;8061.4760040597175;8269;8371.455855369382;8466.32269418445;7989.16384683429;8051.074126475413;8106.392020598479;8114.675412983533;8173.795655108551;4673.182193116259;4674.088552732184;4741.691790033637;4779.5220477951925;4797.18447863864;1983.7763634094597;1997.0913234478278;2041.6325061488778;2049.415916463801;2059.3718915730547;792.5363662257529;849.5794581682106;868.561376504861;878.6617152396245;968.7093871838421;14920.477783277533;15109.697806043818;15399.538013859603;15466.613334666723;15511.146886921328;909.7907481279343;926.6154545863526;927.9350445468752;933.537898740128;977.4233202410612;8377.748667539983;8668.003179634297;8687.565621718888;8768.649254029895;8901.109889011177;183780;501672;511484;528959;529602;93298.53350733203;94207.52896235474;94767.52616236874;94903;95537;1018.4245901066022;1021.5862575656871;1057.1754031855012;1072.7318170457386;1082.3451811653993;13466.326683665582;13835.515756948458;13874.722505550035;14083.084599501;14155.292235387984;37587;38213.42679859749;38588;38931.61068389393;40318.59681403266;54019.72990135024;55128;55665.16502252551;56398.718006409705;56689.43310567007;8586.742397728078;8721.65113395457;8868.556572171237;8959.104089590988;9143.497107659143;9668;13299.534516291884;13372.130811497222;13634.659133521742;13792.517261895786;11380.715482113013;11829.822552661544;11951.462184201906;12094.516219351479;12120.75758484843;11421.657350279505;11568.942155289169;11714.531418743154;12034.277943323428;12458.75082498363;11689.590864319707;12046.337451439904;12054.276743395425;12512.311822849832;12607.432665530258;8552.144785521397;8693.782655433664;8717.433366831136;8838.469691818511;8931.017588065437;9078.909210907806;11600.593979211024;11692.94153529227;11952.701182470508;11970.162088653711 16:29:46 INFO - PROCESS | 26156 | |3;mootools.html;1265.753178130264;1479.778033295006;1520.8631223189914;1634.4606279927618;1763.841254287114;8429.114942930988;8755.518446485441;8769.429987050846;9048.502332371718;9048.72853814385;8744.693935712252;8993.73018809435;8997.95501022494;8998.505082220476;8998.68504602339;2025.1291944463949;2091.717618121557;2300.919467818627;2341.800946919514;2389.689340385756;2366.1127077345996;2387.3554140382084;2398.832081754278;2399.8560086394787;2400.459896523286;2304.2280835919987;2312.4565727054214;2335.9649605255936;2336.7312759032757;2336.918207862725;1954.482062253497;2256.8420210585264;2284.668723035159;2352.6000579901456;2354.7292061412986;2362.3739708977137;2364.137089962169;2370.7392186859433;2372.430616652008;2387.713474383068;8788.296936245086;8828.20546150843;8845.336599754979;8854.3359248056;8877.55612219393;5386.111291636915;5557.527610153142;5557.888842223133;5563.36021357541;5563.388027316992;3181.9204519886957;3299.340131973615;3340.916477088068;3356.664333566648;3395.7792743471596;1086.8804431512526;1129.1192869561755;1131.8868113188698;1154.543955137716;2133.7119488868957;12629.87370126296;13105.2136871788;13107.541236056788;13109.60671179866;13116.147450415692;4614.146382919171;4674.111918735497;4779.569838714532;4820.25286080658;4838.0082083172865;10244.846327305097;10342.689719308433;10344.586216551254;10344.637937672145;10356.119729822898;5411.729413529308;5414.729263536808;5416.620836541483;5420.783168673288;5424.105022671215;4233.089885674594;4991.975040124848;5139.820106296262;5145.4854514549;5151.948480515147;3816.847326106925;3888.0668639526875;3925.6270654287796;3984.1633257015774;4092.4066010428323;1156.9710757231137;1168.5793114478781;1171.9238249513926;1187.1867770577182;1194.1163538981266;829.35724813269;864.1099667342647;911.6262332443666;923.7459698582809;926.9119433653792;5654.74553645087;5787.189793428924;5880.117982302603;5898.469137777621;5933.436323549256;478.2563114357208;483.78713366118797;489.3760455419369;968.4189486308159;1052.9262951593314;4021;4037.0916543778003;4053.2298863216483;4055.6755459563165;4082.1835632873544;11407.429628518541;11423.942880285545;11775.646730598095;11776.234544754563;11788.351640659674;11487.36819474937;11597.18819682631;11603.709907252387;11641.76716465666;11710.180287379802;8046.396520261003;8168.469049511881;8192.18078192176;8210.096889342167;8218.63016164274;5748.741306641295;5759.8560035999435;5807.680577568274;5811.506021988178;5905.143754155709;9885.11034006914;10273.178145748172;10298.897011029794;10399.48002599882;10400.635977740743;10161.644342447978;10400.843987340348;10431.68704938853;10435.217358698279;10601.46992650349;6618.470522358103;7463.589502577411;7672.578008209379;7852.136265010959;7969.481983671043;8888.24449921738;8921.776955576162;8960;8994.05562415937;9018.549072546215;7746.30283274508;7955.920440795518;7994;8104.8784268237205;8225.670973161006;8014.238647328494;8114.269715725613;8138.511689298661;8273.214044665747;8283.544405057779;7274.4907856449545;7294.744683936036;7337.669804858688;7379.520331178456;7400;5196.844094677166;5222;5248.947510524846;5261.184516399964;5270.10408230594;5150.150225212948;5277.498637629419;5290.65610735301;5317.468253174651;5409.350877894521 16:29:46 INFO - PROCESS | 26156 | |4;prototype.html;329.2575242827424;335.0785340314136;341.02126895809016;343.1489905035512;346.10186565861613;5154.768035438405;5291.3385826771655;5426.294581704378;5437.293151890253;5450.236966824643;5256.342957130359;5275.894482110365;5282.973585132069;5324.281222035024;5324.307839980806;4161.646260067882;4167.354060120686;4173.833046678129;4184.748915065105;4224.239636865363;3969.7098443005993;3972.4835771349685;4175.123224122938;4197.643200327976;4198.286291330466;4117.979410102946;4144.274751918402;4160.54234034256;4183.686223533232;4193.853215137471;4140.3168477201225;4166.1251137261215;4167.791340511263;4181.665466762652;4182.686298527623;3522.4364101743854;3694.18727879866;3711.350513660099;3733.309337772521;3745.8387899751165;5099.71951542665;5115.565176959963;5121.180611102206;5121.4110377306715;5152.458991805844;4800.855974320776;4805.303231031481;4808.100800183943;4825.324454576362;4841.903161936777;5399.352077750656;5537.640053396516;5551.252130195579;5554.472325129147;5558.166275058733;4027.436158937751;4055.8377664893665;4084.65280451162;4085.752835940251;4099.724652817685;5672.34768001681;5686.2039314496005;5706.971465142689;5736.36513593628;5868.149118377812;4086.570910054461;4100.969870932212;4176;4193.18232944579;4210.978945105316;4243.27864263076;4252.659787217015;4263.211305908417;4278.122984788173;4287.249731297011;4796.208625576811;4836.637252206098;4837.588804951548;4848.10310092634;4851.80592776285;5339.733013349317;5470.972645136749;5515.503604675519;5576.358718747315;5597.580181486404;1453.93457294422;1453.9563813085624;1467.523055007127;1474.8967572269837;1481.274175653922;943.4103685196752;955.5174636808506;965.6475386483883;966.917811985975;978.8904909919136;4774.212254977959;4776.832810851603;4799.736014519235;4811.542903424169;4892.290617860391;5054.292399064134;5080.923786143211;5097.337346144977;5099.9490005100215;5141.974290128525;4571.337156112345;4829.806807727722;4857.081452826184;4858.271259311061;4873.926891096566;2672.625832383429;2681.712777866635;2699.879549986773;2705.9052933147245;2731.426400455887;5136.869888624571;5162.716050617177;5173.793048278102;5180.849947271915;5190.455002224788;4812.72462797359;5106.259592359087;5120.820771272987;5136.845894623168;5145.922811157836;5179.663321884065;5191.273221748958;5211.661242019257;5316.362036555638;5344.412114667383;5100.2349647553165;5132.409772876167;5171.198464237898;5212.218167274939;5219.869503262449;4870.78081486341;5029.823956161516;5047.829433343697;5070.974645126751;5077.720725359993;5159.793608255778;5240.423553409046;5266.552343050884;5273.839755253838;5305.814296499604;4004.6384229362156;4053.5135783704964;4063;4115.485564304462;4125.195586860534;5562.66624002545;5678.659280443187;5733.455321744427;5760;5767.7404516796005;5519.806806761744;5571.394393715838;5629.493345598916;5639.997800780664;5666.914996274977;5559.833205003856;5560.5829562783765;5579.442055794388;5602.526433611024;5630.282763757094;5494.670319780826;5515.503604675599;5521.641093328921;5535.588424951611;5546.639468434539;5271.364317841079;5627.127795191752;5641.802536911188;5643.548516118619;5680.630759000652;5436.891262174655;5496.31296087989;5513.283273174462;5513.365962914316;5520.475554822286 16:29:46 INFO - PROCESS | 26156 | |5;yui.html;724.1382754522118;742.5915746339512;766.421351879331;774.8643987302222;791.2483141016035;14502;14534.200618965953;14664.973451858361;15285.388584456623;15291.541253762378;14137.57587272381;14201.14793112414;14314.212718300516;14344.354504047316;14377.640558986031;675.4798804920208;789.6012513680583;806.7136166660839;820.2986446588171;820.9302209312216;818.5947955761906;819.0376307838267;819.5983967855738;821.8972628421448;821.9095899451056;859.8022454835392;861.3410740783306;861.5003298087095;861.7371701631;861.9439736417144;704.9718011279568;827.3009307135461;852.6589364254286;852.9104444033411;853.8292341531657;624.073251221935;624.5908929651085;624.6751689121677;624.7594676049754;625.0561651905609;14874.181919994397;14896.478623248135;14924.403023879031;14950.252487375696;14952.177630230333;13785.724285514334;14128.293585320693;14162.079464834753;14163.079399838978;14273;11928.224665396809;12083.818742718866;12181.33002684852;12200.877991220063;12409.689757756038;4525.796339164745;4528.320751887243;4584.289435137559;4588.449386073693;4684.5549672781035;65267.34732652707;68641.65679171572;69207.99999999949;71347;71449;10062.19502439803;10248.282620216512;10287.845682314772;10382.3251488653;10721.571137154426;19650.90174549118;20029.799702002794;20956.161753529992;20963.475913102295;21140.78859211419;8427.662893484192;8560.14398560139;8570.057293697688;8574.614142363609;8751.081136480705;4740.336352910595;4770.475247722818;4791.209450440708;4931.679440836334;5091.363579552556;3732.6080761520193;3793.791341476245;3834.8082595870096;3854.479645247856;3857.8456861725776;620.1380081686459;645.8740545593564;647.4852492268658;661.1009027722293;666.1473314157886;718.5185925429975;740.8036870229286;749.726349882289;756.8297133145109;770.9306162445407;9514.476703781358;9717.46553939526;9735.707928762007;9771.462569558742;9799.314048016713;600.5165841497549;634.7016902056026;661.2197606823897;661.503872095928;749.2470067582045;4525.751083690363;4527.773611319487;4634;4650.069986002813;4769.332293478916;68424;105620.47189764002;105875;105989;106866;58559.70720146372;70656;94467.52766236124;98541;98850.50574747224;54508;54873.45126548684;85883.57058214794;85929.14070859336;86771;9704.369216000938;9808.215342772419;9877.753056173653;9914.702558923243;9956.800863982824;43687.56312436835;46506.767466162455;51629;52818.47181528136;54224.728876355366;48724;60481.55665990082;77257;77485;77683.2231677676;12404.689882753004;12572.685682858002;12596.370181490705;13314.866851331362;13379.464821407035;9215.354925155174;13860.792088118887;14831.058003583546;14979.753056940226;15346.616334591277;14044.648883777987;14081.788773168206;14100.929495352457;14132.222727750073;14456.710865782836;12949.935250323688;13039.478420863059;13154.342282885626;13241.867581324448;13440.395182216627;13999.580012599637;14220;14258.144511329354;14493.171381428576;14497.637559061108;11456.713582160513;11511.654650360502;11841.526338946345;11926.642200733992;12084.154109212623;11532.88467115318;11730.589429369931;11782.293062416282;11834;11962.940185299018 16:29:46 INFO - PROCESS | 26156 | __end_tp_report 16:29:46 INFO - PROCESS | 26156 | __start_cc_report 16:29:46 INFO - PROCESS | 26156 | _x_x_mozilla_cycle_collect,859 16:29:46 INFO - PROCESS | 26156 | __end_cc_report 16:29:46 INFO - PROCESS | 26156 | __startTimestamp1465514986189__endTimestamp 16:29:46 INFO - PROCESS | 26156 | 16:29:46 INFO - PROCESS | 26156 | ------- Summary: start ------- 16:29:46 INFO - PROCESS | 26156 | Number of tests: 6 16:29:46 INFO - PROCESS | 26156 | 16:29:46 INFO - PROCESS | 26156 | [#0] dojo.html Cycles:165 Average:5355.07 Median:5553.17 stddev:603.27 (10.9%) stddev-sans-first:577.92 16:29:46 INFO - PROCESS | 26156 | Values: 3071.9 3091.5 3122.6 3124.9 3135.6 5279.7 5386.1 5410.3 5459.8 5486.8 5391.8 5419.2 5431.9 5454.6 5457.3 4857.8 4907.7 4957.5 4968.1 5089.4 4969.4 4989.1 5033.5 5045.9 5056.9 4754.5 4857.1 4862.1 4875.5 4908.8 4855.6 4869.0 4943.3 4946.5 5000.5 4773.8 4885.7 4897.6 4915.1 4940.6 5239.8 5311.4 5338.2 5389.4 5397.0 5715.2 5758.2 5789.0 5794.8 5799.6 5570.1 5756.3 5794.5 5797.2 5854.6 5394.3 5476.3 5483.3 5483.4 5488.2 5985.9 5997.6 5999.8 6002.1 6004.3 5492.8 5565.6 5589.3 5740.7 5757.8 5719.3 5760.2 5769.0 5772.4 5799.6 5614.4 5648.0 5649.8 5655.1 5665.1 5579.9 5623.2 5682.5 5688.9 5708.9 4382.3 4385.8 4388.2 4389.2 4442.0 3923.9 3932.9 3945.4 3975.3 3984.9 5280.4 5381.3 5437.6 5452.8 5505.3 5812.3 5838.8 5840.8 5843.1 5877.7 5270.5 5512.9 5522.4 5523.6 5525.8 4946.1 4988.8 4998.7 5020.6 5026.4 5971.6 5976.4 5977.7 5980.0 5986.0 5625.7 5661.6 5795.1 5809.7 5811.2 5832.8 5893.8 5899.6 5948.2 5951.4 5614.0 5649.1 5658.0 5663.4 5665.4 5598.5 5681.8 5759.2 5766.6 5772.8 5628.5 5685.5 5686.8 5692.5 5737.6 5602.8 5604.3 5625.6 5634.3 5651.1 5418.6 5458.0 5499.3 5553.2 5560.2 5685.6 5696.9 5704.3 5706.7 5723.8 5502.5 5543.8 5546.2 5559.6 5585.1 16:29:46 INFO - PROCESS | 26156 | 16:29:46 INFO - PROCESS | 26156 | [#1] ext.html Cycles:180 Average:58292.92 Median:40899.00 stddev:118253.32 (289.1%) stddev-sans-first:118505.72 16:29:46 INFO - PROCESS | 26156 | Values: 602.1 611.5 618.0 652.2 652.9 31304.4 34848.3 41166.6 42046.6 42102.7 42841.8 43049.0 43132.0 43193.1 43250.0 8733.4 8857.6 8869.5 8871.9 8872.4 8663.5 8738.0 8738.9 8749.5 8753.1 8795.6 8797.0 8807.6 8812.1 8841.4 8741.7 8789.1 8794.3 8806.0 8809.3 8713.6 8713.7 8732.9 8738.3 8742.0 42354.6 42720.1 42724.0 42741.6 42744.4 3614.7 3826.0 4099.2 4150.2 4301.5 29670.6 31740.4 31986.5 32400.4 33321.8 4100.2 4126.2 4138.4 4187.1 4230.0 351702.0 355223.2 356444.0 356590.0 357915.0 33451.2 34250.3 34269.8 60342.4 61143.0 36696.4 36719.6 36754.1 36786.4 36848.6 15577.1 15696.1 15696.4 15702.8 15715.8 13141.3 13238.1 13244.6 13251.3 13253.4 8187.7 8216.1 8216.8 8265.6 8285.3 3215.6 3243.9 3254.9 3281.7 3298.4 1044.1 1053.4 1074.0 1094.2 1120.6 32427.5 32472.8 32534.8 32907.0 33176.5 1135.3 1162.4 1183.8 1184.4 1187.4 16867.0 17213.2 17328.2 17341.0 17409.4 550914.0 553033.0 557153.0 558067.0 559072.0 57803.0 58291.4 58331.0 58445.4 58581.4 1239.8 1255.4 1324.4 1352.7 1376.5 30683.0 33777.0 33998.3 34028.5 34383.1 49588.0 49703.5 49852.0 49992.0 50009.7 397066.0 397441.0 398045.0 398259.0 399397.0 24522.6 26700.6 27476.9 27883.3 28366.3 48519.0 48972.3 49004.8 49119.0 49668.3 40962.0 41134.4 41281.6 42179.4 42253.4 41488.4 41675.4 41914.0 42143.0 42580.8 35910.0 40241.0 40594.4 40836.0 41126.4 34917.9 36716.0 37543.2 37626.4 37948.4 27126.9 27590.3 27755.3 27844.2 27873.3 16:29:46 INFO - PROCESS | 26156 | 16:29:46 INFO - PROCESS | 26156 | [#2] jquery.html Cycles:180 Average:27572.08 Median:399.17 stddev:77875.38 (19509.2%) stddev-sans-first:78067.10 16:29:46 INFO - PROCESS | 26156 | Values: 388.5 389.9 396.5 401.8 414.6 14290.6 17808.4 17941.6 19282.3 19377.3 18310.3 18590.2 19224.5 19354.8 19373.2 5499.5 5629.3 5699.1 5705.5 5752.5 4020.9 5422.4 5633.4 5642.4 6042.7 6374.1 6395.6 6399.0 6399.9 6404.2 6189.1 6250.9 6355.1 6372.2 6381.3 5581.7 5604.0 5606.6 5607.7 5628.4 21772.0 22613.4 23004.5 23503.5 23561.2 2252.6 2302.3 2399.7 2584.7 3001.5 14167.9 14331.9 14381.3 14384.8 14661.2 1834.8 1840.9 1873.4 1977.2 1989.1 70299.0 74663.6 75071.6 82613.2 83862.0 10838.5 10852.7 11012.7 11297.8 11460.6 13487.7 13901.2 15599.7 15655.2 15655.8 7901.4 8061.5 8269.0 8371.5 8466.3 7989.2 8051.1 8106.4 8114.7 8173.8 4673.2 4674.1 4741.7 4779.5 4797.2 1983.8 1997.1 2041.6 2049.4 2059.4 792.5 849.6 868.6 878.7 968.7 14920.5 15109.7 15399.5 15466.6 15511.1 909.8 926.6 927.9 933.5 977.4 8377.7 8668.0 8687.6 8768.6 8901.1 183780.0 501672.0 511484.0 528959.0 529602.0 93298.5 94207.5 94767.5 94903.0 95537.0 1018.4 1021.6 1057.2 1072.7 1082.3 13466.3 13835.5 13874.7 14083.1 14155.3 37587.0 38213.4 38588.0 38931.6 40318.6 54019.7 55128.0 55665.2 56398.7 56689.4 8586.7 8721.7 8868.6 8959.1 9143.5 9668.0 13299.5 13372.1 13634.7 13792.5 11380.7 11829.8 11951.5 12094.5 12120.8 11421.7 11568.9 11714.5 12034.3 12458.8 11689.6 12046.3 12054.3 12512.3 12607.4 8552.1 8693.8 8717.4 8838.5 8931.0 9078.9 11600.6 11692.9 11952.7 11970.2 16:29:46 INFO - PROCESS | 26156 | 16:29:46 INFO - PROCESS | 26156 | [#3] mootools.html Cycles:180 Average:5923.75 Median:2652.02 stddev:3454.56 (130.3%) stddev-sans-first:3446.51 16:29:46 INFO - PROCESS | 26156 | Values: 1265.8 1479.8 1520.9 1634.5 1763.8 8429.1 8755.5 8769.4 9048.5 9048.7 8744.7 8993.7 8998.0 8998.5 8998.7 2025.1 2091.7 2300.9 2341.8 2389.7 2366.1 2387.4 2398.8 2399.9 2400.5 2304.2 2312.5 2336.0 2336.7 2336.9 1954.5 2256.8 2284.7 2352.6 2354.7 2362.4 2364.1 2370.7 2372.4 2387.7 8788.3 8828.2 8845.3 8854.3 8877.6 5386.1 5557.5 5557.9 5563.4 5563.4 3181.9 3299.3 3340.9 3356.7 3395.8 1086.9 1129.1 1131.9 1154.5 2133.7 12629.9 13105.2 13107.5 13109.6 13116.1 4614.1 4674.1 4779.6 4820.3 4838.0 10244.8 10342.7 10344.6 10344.6 10356.1 5411.7 5414.7 5416.6 5420.8 5424.1 4233.1 4992.0 5139.8 5145.5 5151.9 3816.8 3888.1 3925.6 3984.2 4092.4 1157.0 1168.6 1171.9 1187.2 1194.1 829.4 864.1 911.6 923.7 926.9 5654.7 5787.2 5880.1 5898.5 5933.4 478.3 483.8 489.4 968.4 1052.9 4021.0 4037.1 4053.2 4055.7 4082.2 11407.4 11423.9 11775.6 11776.2 11788.4 11487.4 11597.2 11603.7 11641.8 11710.2 8046.4 8168.5 8192.2 8210.1 8218.6 5748.7 5759.9 5807.7 5811.5 5905.1 9885.1 10273.2 10298.9 10399.5 10400.6 10161.6 10400.8 10431.7 10435.2 10601.5 6618.5 7463.6 7672.6 7852.1 7969.5 8888.2 8921.8 8960.0 8994.1 9018.5 7746.3 7955.9 7994.0 8104.9 8225.7 8014.2 8114.3 8138.5 8273.2 8283.5 7274.5 7294.7 7337.7 7379.5 7400.0 5196.8 5222.0 5248.9 5261.2 5270.1 5150.2 5277.5 5290.7 5317.5 5409.4 16:29:46 INFO - PROCESS | 26156 | 16:29:46 INFO - PROCESS | 26156 | [#4] prototype.html Cycles:180 Average:4544.42 Median:5100.09 stddev:1291.76 (25.3%) stddev-sans-first:1256.04 16:29:46 INFO - PROCESS | 26156 | Values: 329.3 335.1 341.0 343.1 346.1 5154.8 5291.3 5426.3 5437.3 5450.2 5256.3 5275.9 5283.0 5324.3 5324.3 4161.6 4167.4 4173.8 4184.7 4224.2 3969.7 3972.5 4175.1 4197.6 4198.3 4118.0 4144.3 4160.5 4183.7 4193.9 4140.3 4166.1 4167.8 4181.7 4182.7 3522.4 3694.2 3711.4 3733.3 3745.8 5099.7 5115.6 5121.2 5121.4 5152.5 4800.9 4805.3 4808.1 4825.3 4841.9 5399.4 5537.6 5551.3 5554.5 5558.2 4027.4 4055.8 4084.7 4085.8 4099.7 5672.3 5686.2 5707.0 5736.4 5868.1 4086.6 4101.0 4176.0 4193.2 4211.0 4243.3 4252.7 4263.2 4278.1 4287.2 4796.2 4836.6 4837.6 4848.1 4851.8 5339.7 5471.0 5515.5 5576.4 5597.6 1453.9 1454.0 1467.5 1474.9 1481.3 943.4 955.5 965.6 966.9 978.9 4774.2 4776.8 4799.7 4811.5 4892.3 5054.3 5080.9 5097.3 5099.9 5142.0 4571.3 4829.8 4857.1 4858.3 4873.9 2672.6 2681.7 2699.9 2705.9 2731.4 5136.9 5162.7 5173.8 5180.8 5190.5 4812.7 5106.3 5120.8 5136.8 5145.9 5179.7 5191.3 5211.7 5316.4 5344.4 5100.2 5132.4 5171.2 5212.2 5219.9 4870.8 5029.8 5047.8 5071.0 5077.7 5159.8 5240.4 5266.6 5273.8 5305.8 4004.6 4053.5 4063.0 4115.5 4125.2 5562.7 5678.7 5733.5 5760.0 5767.7 5519.8 5571.4 5629.5 5640.0 5666.9 5559.8 5560.6 5579.4 5602.5 5630.3 5494.7 5515.5 5521.6 5535.6 5546.6 5271.4 5627.1 5641.8 5643.5 5680.6 5436.9 5496.3 5513.3 5513.4 5520.5 16:29:46 INFO - PROCESS | 26156 | 16:29:46 INFO - PROCESS | 26156 | [#5] yui.html Cycles:180 Average:19145.73 Median:4769.90 stddev:26395.49 (553.4%) stddev-sans-first:26433.29 16:29:46 INFO - PROCESS | 26156 | Values: 724.1 742.6 766.4 774.9 791.2 14502.0 14534.2 14665.0 15285.4 15291.5 14137.6 14201.1 14314.2 14344.4 14377.6 675.5 789.6 806.7 820.3 820.9 818.6 819.0 819.6 821.9 821.9 859.8 861.3 861.5 861.7 861.9 705.0 827.3 852.7 852.9 853.8 624.1 624.6 624.7 624.8 625.1 14874.2 14896.5 14924.4 14950.3 14952.2 13785.7 14128.3 14162.1 14163.1 14273.0 11928.2 12083.8 12181.3 12200.9 12409.7 4525.8 4528.3 4584.3 4588.4 4684.6 65267.3 68641.7 69208.0 71347.0 71449.0 10062.2 10248.3 10287.8 10382.3 10721.6 19650.9 20029.8 20956.2 20963.5 21140.8 8427.7 8560.1 8570.1 8574.6 8751.1 4740.3 4770.5 4791.2 4931.7 5091.4 3732.6 3793.8 3834.8 3854.5 3857.8 620.1 645.9 647.5 661.1 666.1 718.5 740.8 749.7 756.8 770.9 9514.5 9717.5 9735.7 9771.5 9799.3 600.5 634.7 661.2 661.5 749.2 4525.8 4527.8 4634.0 4650.1 4769.3 68424.0 105620.5 105875.0 105989.0 106866.0 58559.7 70656.0 94467.5 98541.0 98850.5 54508.0 54873.5 85883.6 85929.1 86771.0 9704.4 9808.2 9877.8 9914.7 9956.8 43687.6 46506.8 51629.0 52818.5 54224.7 48724.0 60481.6 77257.0 77485.0 77683.2 12404.7 12572.7 12596.4 13314.9 13379.5 9215.4 13860.8 14831.1 14979.8 15346.6 14044.6 14081.8 14100.9 14132.2 14456.7 12949.9 13039.5 13154.3 13241.9 13440.4 13999.6 14220.0 14258.1 14493.2 14497.6 11456.7 11511.7 11841.5 11926.6 12084.2 11532.9 11730.6 11782.3 11834.0 11962.9 16:29:46 INFO - PROCESS | 26156 | -------- Summary: end -------- 16:29:46 INFO - PROCESS | 26156 | 16:29:46 INFO - TEST-INFO | 26156: exit 0 16:29:46 INFO - TEST-OK | dromaeo_css | took 1114419ms 16:29:46 INFO - TEST-START | kraken 16:29:46 INFO - operating with platform_type : linux_ 16:29:46 INFO - Initialising browser for kraken test... 16:29:46 INFO - TEST-INFO | started process 26349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7dlu5m/profile http://localhost:37816/getInfo.html) 16:29:51 INFO - PROCESS | 26349 | __metrics Screen width/height:1600/1200 16:29:51 INFO - PROCESS | 26349 | colorDepth:24 16:29:51 INFO - PROCESS | 26349 | Browser inner width/height: 1024/697 16:29:51 INFO - PROCESS | 26349 | __metrics 16:29:52 ERROR - PROCESS | 26349 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:29:52 INFO - PROCESS | 26349 | console.error: PushService: 16:29:52 INFO - PROCESS | 26349 | stateChangeProcessEnqueue: Error transitioning state 16:29:52 INFO - PROCESS | 26349 | UnknownError 16:29:53 INFO - TEST-INFO | 26349: exit 0 16:29:53 INFO - Browser initialized. 16:29:53 INFO - Running cycle 1/1 for kraken test... 16:29:53 INFO - TEST-INFO | started process 26433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7dlu5m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:30:05 INFO - PROCESS | 26433 | RSS: Main: 172830720 16:30:05 INFO - PROCESS | 26433 | 16:30:08 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37816/tests/kraken/driver.html?testName=audio-beat-detection) 16:30:08 INFO - PROCESS | 26433 | RSS: Main: 231178240 16:30:08 INFO - PROCESS | 26433 | 16:30:11 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37816/tests/kraken/driver.html?testName=audio-dft) 16:30:12 INFO - PROCESS | 26433 | RSS: Main: 221003776 16:30:12 INFO - PROCESS | 26433 | 16:30:15 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37816/tests/kraken/driver.html?testName=audio-fft) 16:30:15 INFO - PROCESS | 26433 | RSS: Main: 285495296 16:30:15 INFO - PROCESS | 26433 | 16:30:18 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37816/tests/kraken/driver.html?testName=audio-oscillator) 16:30:18 INFO - PROCESS | 26433 | RSS: Main: 195973120 16:30:18 INFO - PROCESS | 26433 | 16:30:20 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37816/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:30:21 INFO - PROCESS | 26433 | RSS: Main: 200445952 16:30:21 INFO - PROCESS | 26433 | 16:30:24 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37816/tests/kraken/driver.html?testName=imaging-darkroom) 16:30:25 INFO - PROCESS | 26433 | RSS: Main: 236363776 16:30:25 INFO - PROCESS | 26433 | 16:30:28 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37816/tests/kraken/driver.html?testName=imaging-desaturate) 16:30:29 INFO - PROCESS | 26433 | RSS: Main: 237096960 16:30:29 INFO - PROCESS | 26433 | 16:30:31 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37816/tests/kraken/driver.html?testName=json-parse-financial) 16:30:32 INFO - PROCESS | 26433 | RSS: Main: 236896256 16:30:32 INFO - PROCESS | 26433 | 16:30:33 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37816/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:30:34 INFO - PROCESS | 26433 | RSS: Main: 220610560 16:30:34 INFO - PROCESS | 26433 | 16:30:36 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37816/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:30:36 INFO - PROCESS | 26433 | RSS: Main: 226119680 16:30:36 INFO - PROCESS | 26433 | 16:30:38 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37816/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:30:39 INFO - PROCESS | 26433 | RSS: Main: 232996864 16:30:39 INFO - PROCESS | 26433 | 16:30:42 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37816/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:30:42 INFO - PROCESS | 26433 | RSS: Main: 239427584 16:30:42 INFO - PROCESS | 26433 | 16:30:45 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37816/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:30:46 INFO - PROCESS | 26433 | RSS: Main: 237920256 16:30:46 INFO - PROCESS | 26433 | 16:30:47 INFO - PROCESS | 26433 | Cycle 1(1): loaded http://localhost:37816/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37816/tests/kraken/driver.html?testName=ai-astar) 16:30:48 INFO - PROCESS | 26433 | RSS: Main: 280412160 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | __start_tp_report 16:30:48 INFO - PROCESS | 26433 | _x_x_mozilla_page_load 16:30:48 INFO - PROCESS | 26433 | _x_x_mozilla_page_load_details 16:30:48 INFO - PROCESS | 26433 | |i|pagename|runs| 16:30:48 INFO - PROCESS | 26433 | |0;ai-astar;110;107;110;110;110;111;109;110;109;109 16:30:48 INFO - PROCESS | 26433 | |1;audio-beat-detection;163;124;128;174;126;127;149;125;190;129 16:30:48 INFO - PROCESS | 26433 | |2;audio-dft;159;160;160;159;159;161;162;161;160;160 16:30:48 INFO - PROCESS | 26433 | |3;audio-fft;74;74;75;115;75;75;74;74;111;74 16:30:48 INFO - PROCESS | 26433 | |4;audio-oscillator;84;84;114;84;85;84;119;84;85;132 16:30:48 INFO - PROCESS | 26433 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;117;117;118 16:30:48 INFO - PROCESS | 26433 | |6;imaging-darkroom;147;146;146;146;146;147;145;146;146;146 16:30:48 INFO - PROCESS | 26433 | |7;imaging-desaturate;94;94;95;94;95;95;94;95;94;94 16:30:48 INFO - PROCESS | 26433 | |8;json-parse-financial;54;51;52;54;53;52;51;52;52;51 16:30:48 INFO - PROCESS | 26433 | |9;json-stringify-tinderbox;62;63;63;62;63;62;62;63;63;63 16:30:48 INFO - PROCESS | 26433 | |10;stanford-crypto-aes;83;81;78;79;80;80;80;80;117;80 16:30:48 INFO - PROCESS | 26433 | |11;stanford-crypto-ccm;121;127;129;130;120;124;119;128;134;127 16:30:48 INFO - PROCESS | 26433 | |12;stanford-crypto-pbkdf2;161;166;161;157;158;168;163;160;159;163 16:30:48 INFO - PROCESS | 26433 | |13;stanford-crypto-sha256-iterative;65;64;69;63;65;64;63;62;65;60 16:30:48 INFO - PROCESS | 26433 | __end_tp_report 16:30:48 INFO - PROCESS | 26433 | __start_cc_report 16:30:48 INFO - PROCESS | 26433 | _x_x_mozilla_cycle_collect,1651 16:30:48 INFO - PROCESS | 26433 | __end_cc_report 16:30:48 INFO - PROCESS | 26433 | __startTimestamp1465515048020__endTimestamp 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | ------- Summary: start ------- 16:30:48 INFO - PROCESS | 26433 | Number of tests: 14 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.08 (1.0%) stddev-sans-first:1.13 16:30:48 INFO - PROCESS | 26433 | Values: 110.0 107.0 110.0 110.0 110.0 111.0 109.0 110.0 109.0 109.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:139.00 stddev:24.16 (17.4%) stddev-sans-first:24.58 16:30:48 INFO - PROCESS | 26433 | Values: 163.0 124.0 128.0 174.0 126.0 127.0 149.0 125.0 190.0 129.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 16:30:48 INFO - PROCESS | 26433 | Values: 159.0 160.0 160.0 159.0 159.0 161.0 162.0 161.0 160.0 160.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#3] audio-fft Cycles:10 Average:82.10 Median:74.00 stddev:16.32 (22.1%) stddev-sans-first:17.04 16:30:48 INFO - PROCESS | 26433 | Values: 74.0 74.0 75.0 115.0 75.0 75.0 74.0 74.0 111.0 74.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:18.58 (22.1%) stddev-sans-first:19.24 16:30:48 INFO - PROCESS | 26433 | Values: 84.0 84.0 114.0 84.0 85.0 84.0 119.0 84.0 85.0 132.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:30:48 INFO - PROCESS | 26433 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 16:30:48 INFO - PROCESS | 26433 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 146.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:30:48 INFO - PROCESS | 26433 | Values: 94.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 94.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:1.14 (2.2%) stddev-sans-first:1.00 16:30:48 INFO - PROCESS | 26433 | Values: 54.0 51.0 52.0 54.0 53.0 52.0 51.0 52.0 52.0 51.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 16:30:48 INFO - PROCESS | 26433 | Values: 62.0 63.0 63.0 62.0 63.0 62.0 62.0 63.0 63.0 63.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:80.00 stddev:11.74 (14.7%) stddev-sans-first:12.44 16:30:48 INFO - PROCESS | 26433 | Values: 83.0 81.0 78.0 79.0 80.0 80.0 80.0 80.0 117.0 80.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:127.50 stddev:4.82 (3.8%) stddev-sans-first:4.77 16:30:48 INFO - PROCESS | 26433 | Values: 121.0 127.0 129.0 130.0 120.0 124.0 119.0 128.0 134.0 127.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:162.00 stddev:3.47 (2.1%) stddev-sans-first:3.67 16:30:48 INFO - PROCESS | 26433 | Values: 161.0 166.0 161.0 157.0 158.0 168.0 163.0 160.0 159.0 163.0 16:30:48 INFO - PROCESS | 26433 | 16:30:48 INFO - PROCESS | 26433 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:2.36 (3.7%) stddev-sans-first:2.47 16:30:48 INFO - PROCESS | 26433 | Values: 65.0 64.0 69.0 63.0 65.0 64.0 63.0 62.0 65.0 60.0 16:30:48 INFO - PROCESS | 26433 | -------- Summary: end -------- 16:30:48 INFO - PROCESS | 26433 | 16:30:49 INFO - TEST-INFO | 26433: exit 0 16:30:49 INFO - TEST-OK | kraken | took 62112ms 16:30:49 INFO - SUITE-END | took 1176s 16:30:49 INFO - Completed test suite (00:19:36) 16:30:49 INFO - javascript benchmark 16:30:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.9232019199517, 3091.4899041658123, 3122.640896296925, 3124.9218769530744, 3135.561021456995, 5279.736013199344, 5386.084365657838, 5410.323709536308, 5459.754311056002, 5486.8353949381535, 5391.78432862686, 5419.187121931712, 5431.864203394917, 5454.59090568208, 5457.345118585766, 4857.781399837007, 4907.656464047518, 4957.479464656213, 4968.056069346812, 5089.389273287192, 4969.428515720702, 4989.077020751154, 5033.496650334955, 5045.899082018357, 5056.873578160538, 4754.524547545252, 4857.101436234308, 4862.100511405366, 4875.463698993108, 4908.803647854082, 4855.562999330042, 4868.951310486886, 4943.28322393251, 4946.530079642428, 5000.499950004971, 4773.832915847928, 4885.7312847793355, 4897.6326775491625, 4915.090708218991, 4940.629452791055, 5239.816606418795, 5311.389190243133, 5338.172583249602, 5389.407165211824, 5396.973015134939, 5715.1713001614535, 5758.193852860602, 5789.0, 5794.82615521535, 5799.5650326225705, 5570.080936645449, 5756.251687280668, 5794.536437085023, 5797.159411885253, 5854.648721076749, 5394.271773310592, 5476.342838859362, 5483.287172667568, 5483.369412517532, 5488.204210389471, 5985.910211346833, 5997.550183736237, 5999.820005399845, 6002.129691194752, 6004.309504406961, 5492.80775172867, 5565.6104072714525, 5589.301337332833, 5740.68426236561, 5757.798477053283, 5719.28508936383, 5760.193572899798, 5768.971155144198, 5772.3650398456975, 5799.594028418054, 5614.354349249888, 5648.039833228361, 5649.830505084854, 5655.066913959151, 5665.12190610456, 5579.8884022320135, 5623.156526520973, 5682.516986056149, 5688.857778555486, 5708.914366284509, 4382.320740285261, 4385.780710964439, 4388.2320593896575, 4389.231884420214, 4442.0, 3923.941140882889, 3932.9016774580864, 3945.368741001426, 3975.284448799244, 3984.880453586397, 5280.419153893145, 5381.327334083239, 5437.619366644376, 5452.781888724407, 5505.3393592768325, 5812.331581868055, 5838.824835254949, 5840.766369345179, 5843.094320380348, 5877.676727779927, 5270.49930256625, 5512.862178445491, 5522.364928033247, 5523.558115350762, 5525.834224973257, 4946.1344264753525, 4988.7505624718615, 4998.6750861193905, 5020.623453241022, 5026.396832380065, 5971.611845230046, 5976.372480889531, 5977.731002104916, 5980.043193088998, 5985.970070149621, 5625.746841392229, 5661.603687741818, 5795.130730390475, 5809.738561764815, 5811.157382179645, 5832.795852145155, 5893.793717219876, 5899.6165249260375, 5948.226730525004, 5951.404859514014, 5614.045612245846, 5649.096144616841, 5658.03813351723, 5663.433656634304, 5665.405132461032, 5598.468145526169, 5681.829545113653, 5759.164921086335, 5766.596338256281, 5772.826815195551, 5628.465295796893, 5685.488306052475, 5686.800961966312, 5692.51613612831, 5737.627054241461, 5602.803901863415, 5604.299462567179, 5625.634333768292, 5634.32388113429, 5651.124075768263, 5418.593605479526, 5457.962987032452, 5499.285092937893, 5553.16702494629, 5560.165975103605, 5685.630434021776, 5696.857578560403, 5704.258446401941, 5706.714664266687, 5723.7996670116345, 5502.504774570308, 5543.833684989457, 5546.195801608825, 5559.610827242054, 5585.134304182858], "value": 5314.495742578461, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.0788194063082, 611.5382885921128, 617.9660118693472, 652.2433976587159, 652.8726898254839, 31304.373912521736, 34848.30303393931, 41166.588334116685, 42046.57953420465, 42102.73715785527, 42841.785791071, 43049.0, 43132.0, 43193.13613727724, 43250.0, 8733.388662793592, 8857.557122143899, 8869.467831930073, 8871.866921996143, 8872.423292485968, 8663.523506207157, 8737.95631021844, 8738.912610873906, 8749.518776467292, 8753.124687531259, 8795.604197811113, 8797.0, 8807.559622018873, 8812.118788121168, 8841.38110332277, 8741.737747867573, 8789.077146899548, 8794.296456283482, 8806.0, 8809.251213646783, 8713.607887645008, 8713.738587842376, 8732.8690069649, 8738.344624153215, 8742.0, 42354.57645423537, 42720.145597088194, 42724.0, 42741.57258427438, 42744.3588346175, 3614.6746792788513, 3826.0, 4099.1801639672185, 4150.190712811003, 4301.526832048472, 29670.55494167589, 31740.365192696016, 31986.520202196985, 32400.351992960244, 33321.83339083289, 4100.159467309224, 4126.154138401651, 4138.399932009872, 4187.057911969813, 4229.97885010576, 351702.0, 355223.2238838815, 356444.0, 356590.0, 357915.0, 33451.16372090717, 34250.31499369998, 34269.82865085659, 60342.39657603368, 61143.0, 36696.44955325672, 36719.63280367215, 36754.08114797151, 36786.448203276974, 36848.63151368452, 15577.14325712074, 15696.136712480695, 15696.372145114296, 15702.842971570139, 15715.764263535828, 13141.277229752264, 13238.139520931109, 13244.602661920158, 13251.337433128305, 13253.403596838165, 8187.672493100328, 8216.09622941476, 8216.794580135544, 8265.628046737911, 8285.295749861209, 3215.5980502437196, 3243.9026829195163, 3254.8698052078125, 3281.7210537104615, 3298.4392653249006, 1044.070777008463, 1053.3890343600692, 1073.9731506712394, 1094.2012330998416, 1120.6245907620876, 32427.51358729621, 32472.83763581167, 32534.83732581322, 32907.0, 33176.50235246473, 1135.2620796482352, 1162.4245998230929, 1183.816508441193, 1184.3841202574613, 1187.358826233824, 16867.0, 17213.22540485681, 17328.220230089675, 17341.0, 17409.390671326444, 550914.0, 553033.0, 557153.0, 558067.0, 559072.0, 57803.0, 58291.417085829446, 58331.0, 58445.415545844, 58581.4141858576, 1239.8078297863844, 1255.409957320058, 1324.3775425549977, 1352.7226918481688, 1376.4562997615885, 30683.0, 33777.0, 33998.32003359968, 34028.48957265692, 34383.14042148966, 49588.0, 49703.502964969884, 49852.0, 49992.0, 50009.749951250014, 397066.0, 397441.0, 398045.0, 398259.0, 399397.0, 24522.632160517962, 26700.599491008037, 27476.862615686794, 27883.302917427227, 28366.290842729097, 48519.0, 48972.265416018075, 49004.75497622489, 49119.0, 49668.25497617611, 40962.0, 41134.382984255855, 41281.58718412778, 42179.36730948977, 42253.36619950642, 41488.377674334304, 41675.37486937759, 41914.0, 42143.0, 42580.78709606432, 35910.0, 40241.0, 40594.391084133174, 40836.0, 41126.383104254055, 34917.85739283375, 36715.98062106503, 37543.24913501769, 37626.43560346652, 37948.430773538974, 27126.864365678044, 27590.310242244104, 27755.30611734642, 27844.16467505978, 27873.303167420167], "value": 18802.0185069032, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.4910766895367, 389.90642245860994, 396.5320921312853, 401.8151650240889, 414.58955633922426, 14290.571282861505, 17808.376706815263, 17941.551461213476, 19282.32511862085, 19377.32179373724, 18310.267589296447, 18590.16344264508, 19224.51938701533, 19354.806451935478, 19373.225070997145, 5499.532539734128, 5629.296337957755, 5699.088145896658, 5705.543556515489, 5752.482276595106, 4020.9396859047138, 5422.40353561108, 5633.408492108331, 5642.4357564243655, 6042.728077236513, 6374.139491168702, 6395.616263024233, 6399.0, 6399.872002559946, 6404.167458230423, 6189.071639254103, 6250.906236406435, 6355.142055822451, 6372.203474565679, 6381.266154392235, 5581.74882130301, 5604.0, 5606.579506536985, 5607.719614019324, 5628.409017053233, 21772.0, 22613.434664133365, 23004.53990920189, 23503.529929401488, 23561.17535886253, 2252.6395776675654, 2302.309307207831, 2399.712034555847, 2584.655978890985, 3001.504751715964, 14167.858321416757, 14331.928340358232, 14381.280935953266, 14384.784228236585, 14661.193634350106, 1834.8073452287451, 1840.8770649903547, 1873.3536929759211, 1977.1597071244664, 1989.1446677928484, 70299.0, 74663.62668186678, 75071.62464187643, 82613.17386826115, 83862.0, 10838.512266947848, 10852.67441976742, 11012.724681882857, 11297.774044519063, 11460.567429071367, 13487.730245395038, 13901.235432051131, 15599.688006239812, 15655.217239138225, 15655.765163522556, 7901.446898717149, 8061.4760040597175, 8269.0, 8371.455855369382, 8466.32269418445, 7989.16384683429, 8051.074126475413, 8106.392020598479, 8114.675412983533, 8173.795655108551, 4673.182193116259, 4674.088552732184, 4741.691790033637, 4779.5220477951925, 4797.18447863864, 1983.7763634094597, 1997.0913234478278, 2041.6325061488778, 2049.415916463801, 2059.3718915730547, 792.5363662257529, 849.5794581682106, 868.561376504861, 878.6617152396245, 968.7093871838421, 14920.477783277533, 15109.697806043818, 15399.538013859603, 15466.613334666723, 15511.146886921328, 909.7907481279343, 926.6154545863526, 927.9350445468752, 933.537898740128, 977.4233202410612, 8377.748667539983, 8668.003179634297, 8687.565621718888, 8768.649254029895, 8901.109889011177, 183780.0, 501672.0, 511484.0, 528959.0, 529602.0, 93298.53350733203, 94207.52896235474, 94767.52616236874, 94903.0, 95537.0, 1018.4245901066022, 1021.5862575656871, 1057.1754031855012, 1072.7318170457386, 1082.3451811653993, 13466.326683665582, 13835.515756948458, 13874.722505550035, 14083.084599501, 14155.292235387984, 37587.0, 38213.42679859749, 38588.0, 38931.61068389393, 40318.59681403266, 54019.72990135024, 55128.0, 55665.16502252551, 56398.718006409705, 56689.43310567007, 8586.742397728078, 8721.65113395457, 8868.556572171237, 8959.104089590988, 9143.497107659143, 9668.0, 13299.534516291884, 13372.130811497222, 13634.659133521742, 13792.517261895786, 11380.715482113013, 11829.822552661544, 11951.462184201906, 12094.516219351479, 12120.75758484843, 11421.657350279505, 11568.942155289169, 11714.531418743154, 12034.277943323428, 12458.75082498363, 11689.590864319707, 12046.337451439904, 12054.276743395425, 12512.311822849832, 12607.432665530258, 8552.144785521397, 8693.782655433664, 8717.433366831136, 8838.469691818511, 8931.017588065437, 9078.909210907806, 11600.593979211024, 11692.94153529227, 11952.701182470508, 11970.162088653711], "value": 9091.931643497543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.753178130264, 1479.778033295006, 1520.8631223189914, 1634.4606279927618, 1763.841254287114, 8429.114942930988, 8755.518446485441, 8769.429987050846, 9048.502332371718, 9048.72853814385, 8744.693935712252, 8993.73018809435, 8997.95501022494, 8998.505082220476, 8998.68504602339, 2025.1291944463949, 2091.717618121557, 2300.919467818627, 2341.800946919514, 2389.689340385756, 2366.1127077345996, 2387.3554140382084, 2398.832081754278, 2399.8560086394787, 2400.459896523286, 2304.2280835919987, 2312.4565727054214, 2335.9649605255936, 2336.7312759032757, 2336.918207862725, 1954.482062253497, 2256.8420210585264, 2284.668723035159, 2352.6000579901456, 2354.7292061412986, 2362.3739708977137, 2364.137089962169, 2370.7392186859433, 2372.430616652008, 2387.713474383068, 8788.296936245086, 8828.20546150843, 8845.336599754979, 8854.3359248056, 8877.55612219393, 5386.111291636915, 5557.527610153142, 5557.888842223133, 5563.36021357541, 5563.388027316992, 3181.9204519886957, 3299.340131973615, 3340.916477088068, 3356.664333566648, 3395.7792743471596, 1086.8804431512526, 1129.1192869561755, 1131.8868113188698, 1154.543955137716, 2133.7119488868957, 12629.87370126296, 13105.2136871788, 13107.541236056788, 13109.60671179866, 13116.147450415692, 4614.146382919171, 4674.111918735497, 4779.569838714532, 4820.25286080658, 4838.0082083172865, 10244.846327305097, 10342.689719308433, 10344.586216551254, 10344.637937672145, 10356.119729822898, 5411.729413529308, 5414.729263536808, 5416.620836541483, 5420.783168673288, 5424.105022671215, 4233.089885674594, 4991.975040124848, 5139.820106296262, 5145.4854514549, 5151.948480515147, 3816.847326106925, 3888.0668639526875, 3925.6270654287796, 3984.1633257015774, 4092.4066010428323, 1156.9710757231137, 1168.5793114478781, 1171.9238249513926, 1187.1867770577182, 1194.1163538981266, 829.35724813269, 864.1099667342647, 911.6262332443666, 923.7459698582809, 926.9119433653792, 5654.74553645087, 5787.189793428924, 5880.117982302603, 5898.469137777621, 5933.436323549256, 478.2563114357208, 483.78713366118797, 489.3760455419369, 968.4189486308159, 1052.9262951593314, 4021.0, 4037.0916543778003, 4053.2298863216483, 4055.6755459563165, 4082.1835632873544, 11407.429628518541, 11423.942880285545, 11775.646730598095, 11776.234544754563, 11788.351640659674, 11487.36819474937, 11597.18819682631, 11603.709907252387, 11641.76716465666, 11710.180287379802, 8046.396520261003, 8168.469049511881, 8192.18078192176, 8210.096889342167, 8218.63016164274, 5748.741306641295, 5759.8560035999435, 5807.680577568274, 5811.506021988178, 5905.143754155709, 9885.11034006914, 10273.178145748172, 10298.897011029794, 10399.48002599882, 10400.635977740743, 10161.644342447978, 10400.843987340348, 10431.68704938853, 10435.217358698279, 10601.46992650349, 6618.470522358103, 7463.589502577411, 7672.578008209379, 7852.136265010959, 7969.481983671043, 8888.24449921738, 8921.776955576162, 8960.0, 8994.05562415937, 9018.549072546215, 7746.30283274508, 7955.920440795518, 7994.0, 8104.8784268237205, 8225.670973161006, 8014.238647328494, 8114.269715725613, 8138.511689298661, 8273.214044665747, 8283.544405057779, 7274.4907856449545, 7294.744683936036, 7337.669804858688, 7379.520331178456, 7400.0, 5196.844094677166, 5222.0, 5248.947510524846, 5261.184516399964, 5270.10408230594, 5150.150225212948, 5277.498637629419, 5290.65610735301, 5317.468253174651, 5409.350877894521], "value": 4666.257458584244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.2575242827424, 335.0785340314136, 341.02126895809016, 343.1489905035512, 346.10186565861613, 5154.768035438405, 5291.3385826771655, 5426.294581704378, 5437.293151890253, 5450.236966824643, 5256.342957130359, 5275.894482110365, 5282.973585132069, 5324.281222035024, 5324.307839980806, 4161.646260067882, 4167.354060120686, 4173.833046678129, 4184.748915065105, 4224.239636865363, 3969.7098443005993, 3972.4835771349685, 4175.123224122938, 4197.643200327976, 4198.286291330466, 4117.979410102946, 4144.274751918402, 4160.54234034256, 4183.686223533232, 4193.853215137471, 4140.3168477201225, 4166.1251137261215, 4167.791340511263, 4181.665466762652, 4182.686298527623, 3522.4364101743854, 3694.18727879866, 3711.350513660099, 3733.309337772521, 3745.8387899751165, 5099.71951542665, 5115.565176959963, 5121.180611102206, 5121.4110377306715, 5152.458991805844, 4800.855974320776, 4805.303231031481, 4808.100800183943, 4825.324454576362, 4841.903161936777, 5399.352077750656, 5537.640053396516, 5551.252130195579, 5554.472325129147, 5558.166275058733, 4027.436158937751, 4055.8377664893665, 4084.65280451162, 4085.752835940251, 4099.724652817685, 5672.34768001681, 5686.2039314496005, 5706.971465142689, 5736.36513593628, 5868.149118377812, 4086.570910054461, 4100.969870932212, 4176.0, 4193.18232944579, 4210.978945105316, 4243.27864263076, 4252.659787217015, 4263.211305908417, 4278.122984788173, 4287.249731297011, 4796.208625576811, 4836.637252206098, 4837.588804951548, 4848.10310092634, 4851.80592776285, 5339.733013349317, 5470.972645136749, 5515.503604675519, 5576.358718747315, 5597.580181486404, 1453.93457294422, 1453.9563813085624, 1467.523055007127, 1474.8967572269837, 1481.274175653922, 943.4103685196752, 955.5174636808506, 965.6475386483883, 966.917811985975, 978.8904909919136, 4774.212254977959, 4776.832810851603, 4799.736014519235, 4811.542903424169, 4892.290617860391, 5054.292399064134, 5080.923786143211, 5097.337346144977, 5099.9490005100215, 5141.974290128525, 4571.337156112345, 4829.806807727722, 4857.081452826184, 4858.271259311061, 4873.926891096566, 2672.625832383429, 2681.712777866635, 2699.879549986773, 2705.9052933147245, 2731.426400455887, 5136.869888624571, 5162.716050617177, 5173.793048278102, 5180.849947271915, 5190.455002224788, 4812.72462797359, 5106.259592359087, 5120.820771272987, 5136.845894623168, 5145.922811157836, 5179.663321884065, 5191.273221748958, 5211.661242019257, 5316.362036555638, 5344.412114667383, 5100.2349647553165, 5132.409772876167, 5171.198464237898, 5212.218167274939, 5219.869503262449, 4870.78081486341, 5029.823956161516, 5047.829433343697, 5070.974645126751, 5077.720725359993, 5159.793608255778, 5240.423553409046, 5266.552343050884, 5273.839755253838, 5305.814296499604, 4004.6384229362156, 4053.5135783704964, 4063.0, 4115.485564304462, 4125.195586860534, 5562.66624002545, 5678.659280443187, 5733.455321744427, 5760.0, 5767.7404516796005, 5519.806806761744, 5571.394393715838, 5629.493345598916, 5639.997800780664, 5666.914996274977, 5559.833205003856, 5560.5829562783765, 5579.442055794388, 5602.526433611024, 5630.282763757094, 5494.670319780826, 5515.503604675599, 5521.641093328921, 5535.588424951611, 5546.639468434539, 5271.364317841079, 5627.127795191752, 5641.802536911188, 5643.548516118619, 5680.630759000652, 5436.891262174655, 5496.31296087989, 5513.283273174462, 5513.365962914316, 5520.475554822286], "value": 4139.752164839763, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.1382754522118, 742.5915746339512, 766.421351879331, 774.8643987302222, 791.2483141016035, 14502.0, 14534.200618965953, 14664.973451858361, 15285.388584456623, 15291.541253762378, 14137.57587272381, 14201.14793112414, 14314.212718300516, 14344.354504047316, 14377.640558986031, 675.4798804920208, 789.6012513680583, 806.7136166660839, 820.2986446588171, 820.9302209312216, 818.5947955761906, 819.0376307838267, 819.5983967855738, 821.8972628421448, 821.9095899451056, 859.8022454835392, 861.3410740783306, 861.5003298087095, 861.7371701631, 861.9439736417144, 704.9718011279568, 827.3009307135461, 852.6589364254286, 852.9104444033411, 853.8292341531657, 624.073251221935, 624.5908929651085, 624.6751689121677, 624.7594676049754, 625.0561651905609, 14874.181919994397, 14896.478623248135, 14924.403023879031, 14950.252487375696, 14952.177630230333, 13785.724285514334, 14128.293585320693, 14162.079464834753, 14163.079399838978, 14273.0, 11928.224665396809, 12083.818742718866, 12181.33002684852, 12200.877991220063, 12409.689757756038, 4525.796339164745, 4528.320751887243, 4584.289435137559, 4588.449386073693, 4684.5549672781035, 65267.34732652707, 68641.65679171572, 69207.99999999949, 71347.0, 71449.0, 10062.19502439803, 10248.282620216512, 10287.845682314772, 10382.3251488653, 10721.571137154426, 19650.90174549118, 20029.799702002794, 20956.161753529992, 20963.475913102295, 21140.78859211419, 8427.662893484192, 8560.14398560139, 8570.057293697688, 8574.614142363609, 8751.081136480705, 4740.336352910595, 4770.475247722818, 4791.209450440708, 4931.679440836334, 5091.363579552556, 3732.6080761520193, 3793.791341476245, 3834.8082595870096, 3854.479645247856, 3857.8456861725776, 620.1380081686459, 645.8740545593564, 647.4852492268658, 661.1009027722293, 666.1473314157886, 718.5185925429975, 740.8036870229286, 749.726349882289, 756.8297133145109, 770.9306162445407, 9514.476703781358, 9717.46553939526, 9735.707928762007, 9771.462569558742, 9799.314048016713, 600.5165841497549, 634.7016902056026, 661.2197606823897, 661.503872095928, 749.2470067582045, 4525.751083690363, 4527.773611319487, 4634.0, 4650.069986002813, 4769.332293478916, 68424.0, 105620.47189764002, 105875.0, 105989.0, 106866.0, 58559.70720146372, 70656.0, 94467.52766236124, 98541.0, 98850.50574747224, 54508.0, 54873.45126548684, 85883.57058214794, 85929.14070859336, 86771.0, 9704.369216000938, 9808.215342772419, 9877.753056173653, 9914.702558923243, 9956.800863982824, 43687.56312436835, 46506.767466162455, 51629.0, 52818.47181528136, 54224.728876355366, 48724.0, 60481.55665990082, 77257.0, 77485.0, 77683.2231677676, 12404.689882753004, 12572.685682858002, 12596.370181490705, 13314.866851331362, 13379.464821407035, 9215.354925155174, 13860.792088118887, 14831.058003583546, 14979.753056940226, 15346.616334591277, 14044.648883777987, 14081.788773168206, 14100.929495352457, 14132.222727750073, 14456.710865782836, 12949.935250323688, 13039.478420863059, 13154.342282885626, 13241.867581324448, 13440.395182216627, 13999.580012599637, 14220.0, 14258.144511329354, 14493.171381428576, 14497.637559061108, 11456.713582160513, 11511.654650360502, 11841.526338946345, 11926.642200733992, 12084.154109212623, 11532.88467115318, 11730.589429369931, 11782.293062416282, 11834.0, 11962.940185299018], "value": 7441.8504427874095, "unit": "score"}], "name": "dromaeo_css", "value": 7123.033075217604, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 107.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 124.0, 128.0, 174.0, 126.0, 127.0, 149.0, 125.0, 190.0, 129.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 159.0, 159.0, 161.0, 162.0, 161.0, 160.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 115.0, 75.0, 75.0, 74.0, 74.0, 111.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 85.0, 84.0, 119.0, 84.0, 85.0, 132.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 54.0, 53.0, 52.0, 51.0, 52.0, 52.0, 51.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 78.0, 79.0, 80.0, 80.0, 80.0, 80.0, 117.0, 80.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 127.0, 129.0, 130.0, 120.0, 124.0, 119.0, 128.0, 134.0, 127.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 161.0, 157.0, 158.0, 168.0, 163.0, 160.0, 159.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 69.0, 63.0, 65.0, 64.0, 63.0, 62.0, 65.0, 60.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1498.6, "alertThreshold": 2.0}]} 16:30:49 INFO - Return code: 0 16:30:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:30:49 ERROR - # TBPL SUCCESS # 16:30:49 INFO - Running post-action listener: _resource_record_post_action 16:30:49 INFO - ##### 16:30:49 INFO - ##### Finished run-tests step (success) 16:30:49 INFO - ##### 16:30:49 INFO - Running post-run listener: _resource_record_post_run 16:30:49 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 12288; Write bytes: 541696000; Read time: 192; Write time: 540728 16:30:49 INFO - TinderboxPrint: CPU usage
13.2% 16:30:49 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 192 16:30:49 INFO - TinderboxPrint: I/O write bytes / time
541,696,000 / 540,728 16:30:49 INFO - TinderboxPrint: CPU idle
8,273.1 (86.8%) 16:30:49 INFO - TinderboxPrint: CPU user
1,212.1 (12.7%) 16:30:49 INFO - TinderboxPrint: Swap in / out
0 / 0 16:30:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248508416; Read time: 0; Write time: 341560 16:30:49 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 12288; Write bytes: 293187584; Read time: 192; Write time: 199168 16:30:49 INFO - Running post-run listener: _upload_blobber_files 16:30:49 INFO - Blob upload gear active. 16:30:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:30:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:30:49 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:30:49 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:30:50 INFO - (blobuploader) - INFO - Open directory for files ... 16:30:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:30:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:08 INFO - (blobuploader) - INFO - Done attempting. 16:31:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:31:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:31:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:10 INFO - (blobuploader) - INFO - Done attempting. 16:31:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:31:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:12 INFO - (blobuploader) - INFO - Done attempting. 16:31:12 INFO - (blobuploader) - INFO - Iteration through files over. 16:31:12 INFO - Return code: 0 16:31:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:31:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:31:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed1e4d2972efc6e71655f1ae1b94917ab41cc5ce0beb40a896ba8e5b03e21205d945c2b91eef1d72f57bcf9673be96506d7c0fc66f7b9ae7d55b5be49922fe9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cb0c199110b73aa4fb2729288f6f5fd3718ba55557ce2efdf42d4a8edc1f6531fd0dff152bc625a24a3fd7eb9bfd9e1a89d3637c875fc62b72e61b02465b49f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e784d03467f03b0a3b423c3efd9ecffd8636cf0d11e5fbe31086fe314d232d8e3b0b4183b1307ce4c6d30a065bdf2792d67260265dbb5dd432cd7d6b65e6a300"} 16:31:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:31:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:31:12 INFO - Contents: 16:31:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed1e4d2972efc6e71655f1ae1b94917ab41cc5ce0beb40a896ba8e5b03e21205d945c2b91eef1d72f57bcf9673be96506d7c0fc66f7b9ae7d55b5be49922fe9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cb0c199110b73aa4fb2729288f6f5fd3718ba55557ce2efdf42d4a8edc1f6531fd0dff152bc625a24a3fd7eb9bfd9e1a89d3637c875fc62b72e61b02465b49f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e784d03467f03b0a3b423c3efd9ecffd8636cf0d11e5fbe31086fe314d232d8e3b0b4183b1307ce4c6d30a065bdf2792d67260265dbb5dd432cd7d6b65e6a300"} 16:31:12 INFO - Running post-run listener: copy_logs_to_upload_dir 16:31:12 INFO - Copying logs to upload dir... 16:31:12 INFO - mkdir: /builds/slave/test/build/upload/logs 16:31:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.860004 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-09 16:31:12.651600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:31:12.659110) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed1e4d2972efc6e71655f1ae1b94917ab41cc5ce0beb40a896ba8e5b03e21205d945c2b91eef1d72f57bcf9673be96506d7c0fc66f7b9ae7d55b5be49922fe9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cb0c199110b73aa4fb2729288f6f5fd3718ba55557ce2efdf42d4a8edc1f6531fd0dff152bc625a24a3fd7eb9bfd9e1a89d3637c875fc62b72e61b02465b49f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e784d03467f03b0a3b423c3efd9ecffd8636cf0d11e5fbe31086fe314d232d8e3b0b4183b1307ce4c6d30a065bdf2792d67260265dbb5dd432cd7d6b65e6a300"} build_url:https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/E3XKlrSLT96-_LM5h8FMOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed1e4d2972efc6e71655f1ae1b94917ab41cc5ce0beb40a896ba8e5b03e21205d945c2b91eef1d72f57bcf9673be96506d7c0fc66f7b9ae7d55b5be49922fe9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cb0c199110b73aa4fb2729288f6f5fd3718ba55557ce2efdf42d4a8edc1f6531fd0dff152bc625a24a3fd7eb9bfd9e1a89d3637c875fc62b72e61b02465b49f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e784d03467f03b0a3b423c3efd9ecffd8636cf0d11e5fbe31086fe314d232d8e3b0b4183b1307ce4c6d30a065bdf2792d67260265dbb5dd432cd7d6b65e6a300"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:31:12.689649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:31:12.690043) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465513815.891363-1924215205 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:31:12.777277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:31:12.777866) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:31:12.779212) ========= ========= Total master_lag: 0.19 =========