builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1466087015.39 results: success (0) buildid: 20160616043206 builduid: 7701161eed8b45c2aff31d680c0e7f10 revision: 44256084ae2e8a2777eeaf040f8bdb584a818ef8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:35.386554) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:35.387031) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:35.387324) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:35.402539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:35.403037) ========= 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=eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 07:23:35-- 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% 46.6M=0s 2016-06-16 07:23:35 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076832 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:35.493776) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:35.494196) ========= 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=eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018819 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:35.544459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:35.544830) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 44256084ae2e8a2777eeaf040f8bdb584a818ef8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 44256084ae2e8a2777eeaf040f8bdb584a818ef8 --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=eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 07:23:35,651 truncating revision to first 12 chars 2016-06-16 07:23:35,651 Setting DEBUG logging. 2016-06-16 07:23:35,651 attempt 1/10 2016-06-16 07:23:35,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/44256084ae2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 07:23:36,123 unpacking tar archive at: mozilla-inbound-44256084ae2e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.815492 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:36.375562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:36.375916) ========= script_repo_revision: 44256084ae2e8a2777eeaf040f8bdb584a818ef8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:36.376379) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:36.376677) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 07:23:36.387683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-16 07:23:36.388125) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:23:36 INFO - MultiFileLogger online at 20160616 07:23:36 in /builds/slave/test 07:23:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:23:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:23:36 INFO - {'append_to_log': False, 07:23:36 INFO - 'base_work_dir': '/builds/slave/test', 07:23:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:23:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:23:36 INFO - 'branch': 'Mozilla-Inbound', 07:23:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:23:36 INFO - 'config_files': ('talos/linux_config.py',), 07:23:36 INFO - 'default_actions': ('clobber', 07:23:36 INFO - 'read-buildbot-config', 07:23:36 INFO - 'download-and-extract', 07:23:36 INFO - 'populate-webroot', 07:23:36 INFO - 'create-virtualenv', 07:23:36 INFO - 'install', 07:23:36 INFO - 'run-tests'), 07:23:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:23:36 INFO - 'download_minidump_stackwalk': True, 07:23:36 INFO - 'download_symbols': 'ondemand', 07:23:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:23:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:23:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:23:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:23:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:23:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:23:36 INFO - 'installer_path': 'installer.exe', 07:23:36 INFO - 'log_level': 'info', 07:23:36 INFO - 'log_name': 'talos', 07:23:36 INFO - 'log_to_console': True, 07:23:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:23:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:23:36 INFO - 'opt_config_files': (), 07:23:36 INFO - 'pip_index': False, 07:23:36 INFO - 'sps_profile': False, 07:23:36 INFO - 'sps_profile_interval': 0, 07:23:36 INFO - 'suite': 'dromaeojs', 07:23:36 INFO - 'system_bits': '32', 07:23:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:23:36 INFO - 'title': 'talos-linux64-ix-010', 07:23:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:23:36 INFO - 'use_talos_json': True, 07:23:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:23:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:23:36 INFO - 'work_dir': 'build'} 07:23:36 INFO - ##### 07:23:36 INFO - ##### Running clobber step. 07:23:36 INFO - ##### 07:23:36 INFO - Running pre-action listener: _resource_record_pre_action 07:23:36 INFO - Running main action method: clobber 07:23:36 INFO - rmtree: /builds/slave/test/build 07:23:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:23:37 INFO - Running post-action listener: _resource_record_post_action 07:23:37 INFO - ##### 07:23:37 INFO - ##### Finished clobber step (success) 07:23:37 INFO - ##### 07:23:37 INFO - ##### 07:23:37 INFO - ##### Running read-buildbot-config step. 07:23:37 INFO - ##### 07:23:37 INFO - Running pre-action listener: _resource_record_pre_action 07:23:37 INFO - Running main action method: read_buildbot_config 07:23:37 INFO - Using buildbot properties: 07:23:37 INFO - { 07:23:37 INFO - "project": "", 07:23:37 INFO - "product": "firefox", 07:23:37 INFO - "script_repo_revision": "production", 07:23:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:23:37 INFO - "repository": "", 07:23:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:23:37 INFO - "buildid": "20160616043206", 07:23:37 INFO - "pgo_build": "True", 07:23:37 INFO - "basedir": "/builds/slave/test", 07:23:37 INFO - "buildnumber": 1120, 07:23:37 INFO - "slavename": "talos-linux64-ix-010", 07:23:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:23:37 INFO - "platform": "ubuntu64_hw", 07:23:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:23:37 INFO - "branch": "mozilla-inbound", 07:23:37 INFO - "repo_path": "integration/mozilla-inbound", 07:23:37 INFO - "revision": "44256084ae2e8a2777eeaf040f8bdb584a818ef8", 07:23:37 INFO - "stage_platform": "linux64-pgo", 07:23:37 INFO - "builduid": "7701161eed8b45c2aff31d680c0e7f10", 07:23:37 INFO - "slavebuilddir": "test" 07:23:37 INFO - } 07:23:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:23:37 INFO - Running post-action listener: _resource_record_post_action 07:23:37 INFO - ##### 07:23:37 INFO - ##### Finished read-buildbot-config step (success) 07:23:37 INFO - ##### 07:23:37 INFO - ##### 07:23:37 INFO - ##### Running download-and-extract step. 07:23:37 INFO - ##### 07:23:37 INFO - Running pre-action listener: _resource_record_pre_action 07:23:37 INFO - Running main action method: download_and_extract 07:23:37 INFO - mkdir: /builds/slave/test/build/tests 07:23: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')]} 07:23:37 INFO - https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:23:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:23:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:23:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/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 07:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/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 07:23:38 INFO - Downloaded 1361 bytes. 07:23:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:23:38 INFO - Using the following test package requirements: 07:23:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:23:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:23:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:23:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:38 INFO - u'jsshell-linux-x86_64.zip'], 07:23:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:23:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:23:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:23:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:23:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:23:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:23:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:23:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:23:38 INFO - https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:23:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:23:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:23:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/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 07:23:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/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 07:23:39 INFO - Downloaded 24220980 bytes. 07:23:39 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'] 07:23:39 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 07:23:40 INFO - Return code: 0 07:23:40 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 07:23: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')]} 07:23:40 INFO - https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/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 07:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/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 07:23:41 INFO - Downloaded 24220980 bytes. 07:23:41 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'] 07:23:41 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 07:23:43 INFO - Return code: 0 07:23: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')]} 07:23:43 INFO - https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:23:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:23:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:23:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/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 07:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/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 07:23:44 INFO - Downloaded 14405384 bytes. 07:23:44 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'] 07:23:44 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 07:23:44 INFO - Return code: 0 07:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:23:44 INFO - https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:23:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:23:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:23:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/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 07:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3dwgPn_SZiDbUurYp-_Lg/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 07:23:46 INFO - Downloaded 59400571 bytes. 07:23:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:23:46 INFO - mkdir: /builds/slave/test/properties 07:23:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:23:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:23:46 INFO - Contents: 07:23:46 INFO - build_url:https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:23:46 INFO - Running post-action listener: _resource_record_post_action 07:23:46 INFO - Running post-action listener: set_extra_try_arguments 07:23:46 INFO - ##### 07:23:46 INFO - ##### Finished download-and-extract step (success) 07:23:46 INFO - ##### 07:23:46 INFO - ##### 07:23:46 INFO - ##### Running populate-webroot step. 07:23:46 INFO - ##### 07:23:46 INFO - Running pre-action listener: _resource_record_pre_action 07:23:46 INFO - Running main action method: populate_webroot 07:23:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:23:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:23:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:23:46 INFO - '--tppagecycles', 07:23:46 INFO - '7'], 07:23:46 INFO - 'tests': ['tsvgm']}}, 07:23:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:23:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:23:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:23:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:23:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:46 INFO - 'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:46 INFO - 'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['damp', 'tps']}, 07:23:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:46 INFO - 'tests': ['damp', 'tps']}, 07:23:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['dromaeo_dom']}, 07:23:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:23:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['basic_compositor_video']}, 07:23:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:23:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['a11yr', 07:23:46 INFO - 'ts_paint', 07:23:46 INFO - 'tpaint', 07:23:46 INFO - 'sessionrestore', 07:23:46 INFO - 'sessionrestore_no_auto_restore', 07:23:46 INFO - 'tabpaint']}, 07:23:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:23:46 INFO - 'ts_paint', 07:23:46 INFO - 'tpaint', 07:23:46 INFO - 'sessionrestore', 07:23:46 INFO - 'sessionrestore_no_auto_restore', 07:23:46 INFO - 'tabpaint']}, 07:23:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:23:46 INFO - 'ts_paint', 07:23:46 INFO - 'tpaint', 07:23:46 INFO - 'sessionrestore', 07:23:46 INFO - 'sessionrestore_no_auto_restore', 07:23:46 INFO - 'tabpaint']}, 07:23:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:23:46 INFO - 'ts_paint', 07:23:46 INFO - 'tpaint', 07:23:46 INFO - 'sessionrestore', 07:23:46 INFO - 'sessionrestore_no_auto_restore', 07:23:46 INFO - 'tabpaint']}, 07:23:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['a11yr', 07:23:46 INFO - 'ts_paint', 07:23:46 INFO - 'tpaint', 07:23:46 INFO - 'sessionrestore', 07:23:46 INFO - 'sessionrestore_no_auto_restore', 07:23:46 INFO - 'tabpaint']}, 07:23:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['a11yr', 07:23:46 INFO - 'ts_paint', 07:23:46 INFO - 'tpaint', 07:23:46 INFO - 'sessionrestore', 07:23:46 INFO - 'sessionrestore_no_auto_restore', 07:23:46 INFO - 'tabpaint']}, 07:23:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['tsvgx', 07:23:46 INFO - 'tsvgr_opacity', 07:23:46 INFO - 'tart', 07:23:46 INFO - 'tscrollx', 07:23:46 INFO - 'cart']}, 07:23:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:23:46 INFO - 'tsvgr_opacity', 07:23:46 INFO - 'tart', 07:23:46 INFO - 'tscrollx', 07:23:46 INFO - 'cart']}, 07:23:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:46 INFO - 'talos_options': ['--disable-e10s'], 07:23:46 INFO - 'tests': ['tp5o']}, 07:23:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:46 INFO - 'tests': ['tp5o']}, 07:23:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:46 INFO - 'talos_options': ['--disable-e10s', 07:23:46 INFO - '--xperf_path', 07:23:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:46 INFO - 'tests': ['tp5n']}, 07:23:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:23:46 INFO - 'talos_options': ['--xperf_path', 07:23:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:46 INFO - 'tests': ['tp5n']}}, 07:23:46 INFO - 'talos.zip': {'path': '', 07:23:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:23:46 INFO - Running post-action listener: _resource_record_post_action 07:23:46 INFO - ##### 07:23:46 INFO - ##### Finished populate-webroot step (success) 07:23:46 INFO - ##### 07:23:46 INFO - ##### 07:23:46 INFO - ##### Running create-virtualenv step. 07:23:46 INFO - ##### 07:23:46 INFO - Running pre-action listener: _resource_record_pre_action 07:23:46 INFO - Running main action method: create_virtualenv 07:23:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:23:46 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 07:23:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:23:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:23:46 INFO - Using real prefix '/usr' 07:23:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:23:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:23:49 INFO - Installing pip.................done. 07:23:49 INFO - Return code: 0 07:23:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:23:49 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')]} 07:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:49 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')]} 07:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:49 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 0x7f67bceaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', '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 07:23:49 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 07:23:49 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 07:23:49 INFO - Using env: {'DISPLAY': ':0', 07:23:49 INFO - 'HOME': '/home/cltbld', 07:23:49 INFO - 'LANG': 'en_US.UTF-8', 07:23:49 INFO - 'LANGUAGE': 'en_US:en', 07:23:49 INFO - 'LOGNAME': 'cltbld', 07:23:49 INFO - 'MAIL': '/var/mail/cltbld', 07:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:49 INFO - 'MOZ_NO_REMOTE': '1', 07:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:49 INFO - 'NO_EM_RESTART': '1', 07:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:49 INFO - 'PWD': '/builds/slave/test', 07:23:49 INFO - 'SHELL': '/bin/bash', 07:23:49 INFO - 'SHLVL': '1', 07:23:49 INFO - 'TERM': 'linux', 07:23:49 INFO - 'TMOUT': '86400', 07:23:49 INFO - 'USER': 'cltbld', 07:23:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:49 INFO - '_': '/tools/buildbot/bin/python'} 07:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:49 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 07:23:49 INFO - Cleaning up... 07:23:49 INFO - Return code: 0 07:23:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:23:49 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')]} 07:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:49 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')]} 07:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:49 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 0x7f67bceaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', '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 07:23:49 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 07:23:49 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 07:23:49 INFO - Using env: {'DISPLAY': ':0', 07:23:49 INFO - 'HOME': '/home/cltbld', 07:23:49 INFO - 'LANG': 'en_US.UTF-8', 07:23:49 INFO - 'LANGUAGE': 'en_US:en', 07:23:49 INFO - 'LOGNAME': 'cltbld', 07:23:49 INFO - 'MAIL': '/var/mail/cltbld', 07:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:49 INFO - 'MOZ_NO_REMOTE': '1', 07:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:49 INFO - 'NO_EM_RESTART': '1', 07:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:49 INFO - 'PWD': '/builds/slave/test', 07:23:49 INFO - 'SHELL': '/bin/bash', 07:23:49 INFO - 'SHLVL': '1', 07:23:49 INFO - 'TERM': 'linux', 07:23:49 INFO - 'TMOUT': '86400', 07:23:49 INFO - 'USER': 'cltbld', 07:23:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:49 INFO - '_': '/tools/buildbot/bin/python'} 07:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:49 INFO - Downloading/unpacking psutil>=3.1.1 07:23:49 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 07:23:49 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 07:23:49 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 07:23:49 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 07:23:49 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 07:23:49 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 07:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:23:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:51 INFO - Installing collected packages: psutil 07:23:51 INFO - Running setup.py install for psutil 07:23:52 INFO - building 'psutil._psutil_linux' extension 07:23:52 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 07:23:52 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 07:23:52 INFO - building 'psutil._psutil_posix' extension 07:23:52 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 07:23:52 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 07:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:52 INFO - Successfully installed psutil 07:23:52 INFO - Cleaning up... 07:23:52 INFO - Return code: 0 07:23:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f67bceaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', '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 07:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:23:52 INFO - Using env: {'DISPLAY': ':0', 07:23:52 INFO - 'HOME': '/home/cltbld', 07:23:52 INFO - 'LANG': 'en_US.UTF-8', 07:23:52 INFO - 'LANGUAGE': 'en_US:en', 07:23:52 INFO - 'LOGNAME': 'cltbld', 07:23:52 INFO - 'MAIL': '/var/mail/cltbld', 07:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:52 INFO - 'MOZ_NO_REMOTE': '1', 07:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:52 INFO - 'NO_EM_RESTART': '1', 07:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:52 INFO - 'PWD': '/builds/slave/test', 07:23:52 INFO - 'SHELL': '/bin/bash', 07:23:52 INFO - 'SHLVL': '1', 07:23:52 INFO - 'TERM': 'linux', 07:23:52 INFO - 'TMOUT': '86400', 07:23:52 INFO - 'USER': 'cltbld', 07:23:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:52 INFO - '_': '/tools/buildbot/bin/python'} 07:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:23:52 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 07:23:52 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 07:23:52 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 07:23:52 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 07:23:52 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 07:23:52 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 07:23:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:23:54 INFO - Installing collected packages: mozsystemmonitor 07:23:54 INFO - Running setup.py install for mozsystemmonitor 07:23:55 INFO - Successfully installed mozsystemmonitor 07:23:55 INFO - Cleaning up... 07:23:56 INFO - Return code: 0 07:23:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:23:56 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')]} 07:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:56 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')]} 07:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:56 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 0x7f67bceaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', '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 07:23:56 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 07:23:56 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 07:23:56 INFO - Using env: {'DISPLAY': ':0', 07:23:56 INFO - 'HOME': '/home/cltbld', 07:23:56 INFO - 'LANG': 'en_US.UTF-8', 07:23:56 INFO - 'LANGUAGE': 'en_US:en', 07:23:56 INFO - 'LOGNAME': 'cltbld', 07:23:56 INFO - 'MAIL': '/var/mail/cltbld', 07:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:56 INFO - 'MOZ_NO_REMOTE': '1', 07:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:56 INFO - 'NO_EM_RESTART': '1', 07:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:56 INFO - 'PWD': '/builds/slave/test', 07:23:56 INFO - 'SHELL': '/bin/bash', 07:23:56 INFO - 'SHLVL': '1', 07:23:56 INFO - 'TERM': 'linux', 07:23:56 INFO - 'TMOUT': '86400', 07:23:56 INFO - 'USER': 'cltbld', 07:23:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:56 INFO - '_': '/tools/buildbot/bin/python'} 07:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:56 INFO - Downloading/unpacking jsonschema==2.5.1 07:23:56 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 07:23:56 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 07:23:56 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 07:23:56 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 07:23:56 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 07:23:56 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 07:23:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:23:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:58 INFO - Downloading functools32-3.2.3-2.tar.gz 07:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:23:58 INFO - warning: no files found matching '*.txt' 07:23:58 INFO - no previously-included directories found matching 'build' 07:23:58 INFO - no previously-included directories found matching 'dist' 07:23:58 INFO - no previously-included directories found matching '.git*' 07:23:58 INFO - Installing collected packages: jsonschema, functools32 07:23:58 INFO - Running setup.py install for functools32 07:23:58 INFO - warning: no files found matching '*.txt' 07:23:58 INFO - no previously-included directories found matching 'build' 07:23:58 INFO - no previously-included directories found matching 'dist' 07:23:58 INFO - no previously-included directories found matching '.git*' 07:23:58 INFO - Successfully installed jsonschema functools32 07:23:58 INFO - Cleaning up... 07:23:58 INFO - Return code: 0 07:23:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:23:58 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')]} 07:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:58 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')]} 07:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:58 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 0x7f67bceaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', '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 07:23:58 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 07:23:58 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 07:23:58 INFO - Using env: {'DISPLAY': ':0', 07:23:58 INFO - 'HOME': '/home/cltbld', 07:23:58 INFO - 'LANG': 'en_US.UTF-8', 07:23:58 INFO - 'LANGUAGE': 'en_US:en', 07:23:58 INFO - 'LOGNAME': 'cltbld', 07:23:58 INFO - 'MAIL': '/var/mail/cltbld', 07:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:58 INFO - 'MOZ_NO_REMOTE': '1', 07:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:23:58 INFO - 'NO_EM_RESTART': '1', 07:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:58 INFO - 'PWD': '/builds/slave/test', 07:23:58 INFO - 'SHELL': '/bin/bash', 07:23:58 INFO - 'SHLVL': '1', 07:23:58 INFO - 'TERM': 'linux', 07:23:58 INFO - 'TMOUT': '86400', 07:23:58 INFO - 'USER': 'cltbld', 07:23:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:58 INFO - '_': '/tools/buildbot/bin/python'} 07:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:23:59 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 07:23:59 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 07:23:59 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 07:23:59 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 07:23:59 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 07:23:59 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 07:24:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:24:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:24:01 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 07:24:01 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 07:24:01 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 07:24:01 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 07:24:01 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 07:24:01 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 07:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:24:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:24:01 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 07:24:01 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 07:24:01 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 07:24:01 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 07:24:01 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 07:24:01 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 07:24:01 INFO - Downloading docopt-0.6.1.tar.gz 07:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:24:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:24:01 INFO - Running setup.py install for blobuploader 07:24:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:24:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:24:01 INFO - Running setup.py install for requests 07:24:02 INFO - Running setup.py install for docopt 07:24:02 INFO - Successfully installed blobuploader requests docopt 07:24:02 INFO - Cleaning up... 07:24:02 INFO - Return code: 0 07:24:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:02 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')]} 07:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:02 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')]} 07:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:02 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 0x7f67bceaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', '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 07:24:02 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 07:24:02 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 07:24:02 INFO - Using env: {'DISPLAY': ':0', 07:24:02 INFO - 'HOME': '/home/cltbld', 07:24:02 INFO - 'LANG': 'en_US.UTF-8', 07:24:02 INFO - 'LANGUAGE': 'en_US:en', 07:24:02 INFO - 'LOGNAME': 'cltbld', 07:24:02 INFO - 'MAIL': '/var/mail/cltbld', 07:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:02 INFO - 'MOZ_NO_REMOTE': '1', 07:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:02 INFO - 'NO_EM_RESTART': '1', 07:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:02 INFO - 'PWD': '/builds/slave/test', 07:24:02 INFO - 'SHELL': '/bin/bash', 07:24:02 INFO - 'SHLVL': '1', 07:24:02 INFO - 'TERM': 'linux', 07:24:02 INFO - 'TMOUT': '86400', 07:24:02 INFO - 'USER': 'cltbld', 07:24:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:02 INFO - '_': '/tools/buildbot/bin/python'} 07:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:24:02 INFO - Running setup.py (path:/tmp/pip-1QbjB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:24:02 INFO - Running setup.py (path:/tmp/pip-aj0OD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:24:02 INFO - Running setup.py (path:/tmp/pip-gQZQbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:24:02 INFO - Running setup.py (path:/tmp/pip-BTr6Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:24:02 INFO - Running setup.py (path:/tmp/pip-fH5XTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:24:02 INFO - Running setup.py (path:/tmp/pip-AV2ORC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:24:02 INFO - Running setup.py (path:/tmp/pip-cO6t5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:24:03 INFO - Running setup.py (path:/tmp/pip-TURrUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:24:03 INFO - Running setup.py (path:/tmp/pip-hS6nnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:24:03 INFO - Running setup.py (path:/tmp/pip-7S2tTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:24:03 INFO - Running setup.py (path:/tmp/pip-gu87_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:24:03 INFO - Running setup.py (path:/tmp/pip-D02acr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:24:03 INFO - Running setup.py (path:/tmp/pip-Py4j03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:24:03 INFO - Running setup.py (path:/tmp/pip-n4SWBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:03 INFO - Running setup.py (path:/tmp/pip-Iya4s0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:24:03 INFO - Running setup.py (path:/tmp/pip-NRsulE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:24:03 INFO - Running setup.py (path:/tmp/pip-sjs1Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:24:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:24:03 INFO - Running setup.py install for manifestparser 07:24:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:24:03 INFO - Running setup.py install for mozcrash 07:24:03 INFO - Running setup.py install for mozdebug 07:24:04 INFO - Running setup.py install for mozdevice 07:24:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:24:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:24:04 INFO - Running setup.py install for mozfile 07:24:04 INFO - Running setup.py install for mozhttpd 07:24:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:24:04 INFO - Running setup.py install for mozinfo 07:24:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:24:04 INFO - Running setup.py install for mozInstall 07:24:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:24:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:24:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:24:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:24:04 INFO - Running setup.py install for mozleak 07:24:04 INFO - Running setup.py install for mozlog 07:24:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:24:04 INFO - Running setup.py install for moznetwork 07:24:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:24:04 INFO - Running setup.py install for mozprocess 07:24:04 INFO - Running setup.py install for mozprofile 07:24:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:24:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:24:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:24:05 INFO - Running setup.py install for mozrunner 07:24:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:24:05 INFO - Running setup.py install for mozscreenshot 07:24:05 INFO - Running setup.py install for moztest 07:24:05 INFO - Running setup.py install for mozversion 07:24:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:24:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:24:05 INFO - Cleaning up... 07:24:05 INFO - Return code: 0 07:24:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:05 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 0x7f67bceaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', '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 07:24:05 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 07:24:05 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 07:24:05 INFO - Using env: {'DISPLAY': ':0', 07:24:05 INFO - 'HOME': '/home/cltbld', 07:24:05 INFO - 'LANG': 'en_US.UTF-8', 07:24:05 INFO - 'LANGUAGE': 'en_US:en', 07:24:05 INFO - 'LOGNAME': 'cltbld', 07:24:05 INFO - 'MAIL': '/var/mail/cltbld', 07:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:05 INFO - 'MOZ_NO_REMOTE': '1', 07:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:05 INFO - 'NO_EM_RESTART': '1', 07:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:05 INFO - 'PWD': '/builds/slave/test', 07:24:05 INFO - 'SHELL': '/bin/bash', 07:24:05 INFO - 'SHLVL': '1', 07:24:05 INFO - 'TERM': 'linux', 07:24:05 INFO - 'TMOUT': '86400', 07:24:05 INFO - 'USER': 'cltbld', 07:24:05 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:05 INFO - '_': '/tools/buildbot/bin/python'} 07:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:24:05 INFO - Running setup.py (path:/tmp/pip-DCeHmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:24:05 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)) 07:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:24:05 INFO - Running setup.py (path:/tmp/pip-E51N8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:24:05 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)) 07:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:24:05 INFO - Running setup.py (path:/tmp/pip-xg0XqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:24:05 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)) 07:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:24:05 INFO - Running setup.py (path:/tmp/pip-5Schfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:24:06 INFO - Running setup.py (path:/tmp/pip-CHeTMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:24:06 INFO - Running setup.py (path:/tmp/pip-PhE0Kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:24:06 INFO - Running setup.py (path:/tmp/pip-4DD56U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:24:06 INFO - Running setup.py (path:/tmp/pip-f6SNU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:24:06 INFO - Running setup.py (path:/tmp/pip-6ThSa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:24:06 INFO - Running setup.py (path:/tmp/pip-ZkWuqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:24:06 INFO - Running setup.py (path:/tmp/pip-QBhGru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:24:06 INFO - Running setup.py (path:/tmp/pip-t0mT5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:24:06 INFO - Running setup.py (path:/tmp/pip-xsHA8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:24:06 INFO - Running setup.py (path:/tmp/pip-nSa5Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:06 INFO - Running setup.py (path:/tmp/pip-pwc7s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:24:06 INFO - Running setup.py (path:/tmp/pip-OjxD3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:24:06 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)) 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:24:06 INFO - Running setup.py (path:/tmp/pip-u7iGAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:24:06 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)) 07:24:06 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)) 07:24:06 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)) 07:24:06 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)) 07:24:06 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)) 07:24:06 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)) 07:24:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:24:06 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 07:24:06 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 07:24:06 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 07:24:06 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 07:24:06 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 07:24:06 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 07:24:08 INFO - Downloading blessings-1.6.tar.gz 07:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:24:08 INFO - Installing collected packages: blessings 07:24:08 INFO - Running setup.py install for blessings 07:24:09 INFO - Successfully installed blessings 07:24:09 INFO - Cleaning up... 07:24:09 INFO - Return code: 0 07:24:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:24:09 INFO - Reading from file tmpfile_stdout 07:24:09 INFO - Current package versions: 07:24:09 INFO - argparse == 1.2.1 07:24:09 INFO - blessings == 1.6 07:24:09 INFO - blobuploader == 1.2.4 07:24:09 INFO - docopt == 0.6.1 07:24:09 INFO - functools32 == 3.2.3-2 07:24:09 INFO - jsonschema == 2.5.1 07:24:09 INFO - manifestparser == 1.1 07:24:09 INFO - mozInstall == 1.12 07:24:09 INFO - mozcrash == 0.17 07:24:09 INFO - mozdebug == 0.1 07:24:09 INFO - mozdevice == 0.48 07:24:09 INFO - mozfile == 1.2 07:24:09 INFO - mozhttpd == 0.7 07:24:09 INFO - mozinfo == 0.9 07:24:09 INFO - mozleak == 0.1 07:24:09 INFO - mozlog == 3.2 07:24:09 INFO - moznetwork == 0.27 07:24:09 INFO - mozprocess == 0.22 07:24:09 INFO - mozprofile == 0.28 07:24:09 INFO - mozrunner == 6.11 07:24:09 INFO - mozscreenshot == 0.1 07:24:09 INFO - mozsystemmonitor == 0.3 07:24:09 INFO - moztest == 0.7 07:24:09 INFO - mozversion == 1.4 07:24:09 INFO - psutil == 3.1.1 07:24:09 INFO - requests == 1.2.3 07:24:09 INFO - wsgiref == 0.1.2 07:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:09 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 0x7f67bceaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', '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 07:24:09 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 07:24:09 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 07:24:09 INFO - Using env: {'DISPLAY': ':0', 07:24:09 INFO - 'HOME': '/home/cltbld', 07:24:09 INFO - 'LANG': 'en_US.UTF-8', 07:24:09 INFO - 'LANGUAGE': 'en_US:en', 07:24:09 INFO - 'LOGNAME': 'cltbld', 07:24:09 INFO - 'MAIL': '/var/mail/cltbld', 07:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:09 INFO - 'MOZ_NO_REMOTE': '1', 07:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:09 INFO - 'NO_EM_RESTART': '1', 07:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:09 INFO - 'PWD': '/builds/slave/test', 07:24:09 INFO - 'SHELL': '/bin/bash', 07:24:09 INFO - 'SHLVL': '1', 07:24:09 INFO - 'TERM': 'linux', 07:24:09 INFO - 'TMOUT': '86400', 07:24:09 INFO - 'USER': 'cltbld', 07:24:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:09 INFO - '_': '/tools/buildbot/bin/python'} 07:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:09 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)) 07:24:09 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)) 07:24:09 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)) 07:24:09 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)) 07:24:09 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)) 07:24:09 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)) 07:24:09 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)) 07:24:09 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)) 07:24:09 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)) 07:24:09 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)) 07:24:09 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)) 07:24:09 INFO - Cleaning up... 07:24:09 INFO - Return code: 0 07:24:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:09 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 0x7f67bceaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', '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 07:24:09 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 07:24:09 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 07:24:09 INFO - Using env: {'DISPLAY': ':0', 07:24:09 INFO - 'HOME': '/home/cltbld', 07:24:09 INFO - 'LANG': 'en_US.UTF-8', 07:24:09 INFO - 'LANGUAGE': 'en_US:en', 07:24:09 INFO - 'LOGNAME': 'cltbld', 07:24:09 INFO - 'MAIL': '/var/mail/cltbld', 07:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:09 INFO - 'MOZ_NO_REMOTE': '1', 07:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:09 INFO - 'NO_EM_RESTART': '1', 07:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:09 INFO - 'PWD': '/builds/slave/test', 07:24:09 INFO - 'SHELL': '/bin/bash', 07:24:09 INFO - 'SHLVL': '1', 07:24:09 INFO - 'TERM': 'linux', 07:24:09 INFO - 'TMOUT': '86400', 07:24:09 INFO - 'USER': 'cltbld', 07:24:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:09 INFO - '_': '/tools/buildbot/bin/python'} 07:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:24:09 INFO - Cleaning up... 07:24:09 INFO - Return code: 0 07:24:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:09 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 0x7f67bceaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2300350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, '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': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', '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 07:24:09 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 07:24:09 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 07:24:09 INFO - Using env: {'DISPLAY': ':0', 07:24:09 INFO - 'HOME': '/home/cltbld', 07:24:09 INFO - 'LANG': 'en_US.UTF-8', 07:24:09 INFO - 'LANGUAGE': 'en_US:en', 07:24:09 INFO - 'LOGNAME': 'cltbld', 07:24:09 INFO - 'MAIL': '/var/mail/cltbld', 07:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:09 INFO - 'MOZ_NO_REMOTE': '1', 07:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:09 INFO - 'NO_EM_RESTART': '1', 07:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:09 INFO - 'PWD': '/builds/slave/test', 07:24:09 INFO - 'SHELL': '/bin/bash', 07:24:09 INFO - 'SHLVL': '1', 07:24:09 INFO - 'TERM': 'linux', 07:24:09 INFO - 'TMOUT': '86400', 07:24:09 INFO - 'USER': 'cltbld', 07:24:09 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:09 INFO - '_': '/tools/buildbot/bin/python'} 07:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:09 INFO - Downloading/unpacking flake8 07:24:09 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 07:24:09 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 07:24:09 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 07:24:09 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 07:24:09 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 07:24:09 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 07:24:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:24:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:24:11 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 07:24:11 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 07:24:11 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 07:24:11 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 07:24:11 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 07:24:11 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 07:24:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:24:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:24:12 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 07:24:12 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 07:24:12 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 07:24:12 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 07:24:12 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 07:24:12 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 07:24:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:24:12 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 07:24:12 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 07:24:12 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 07:24:12 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 07:24:12 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 07:24:12 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 07:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:24:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:24:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:24:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:24:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:24:12 INFO - no previously-included directories found matching 'docs/_build' 07:24:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:24:12 INFO - Running setup.py install for pep8 07:24:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:24:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:24:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:24:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:24:12 INFO - no previously-included directories found matching 'docs/_build' 07:24:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:24:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:24:12 INFO - Cleaning up... 07:24:12 INFO - Return code: 0 07:24:12 INFO - Running post-action listener: _resource_record_post_action 07:24:12 INFO - Running post-action listener: _start_resource_monitoring 07:24:12 INFO - Starting resource monitoring. 07:24:12 INFO - ##### 07:24:12 INFO - ##### Finished create-virtualenv step (success) 07:24:12 INFO - ##### 07:24:12 INFO - ##### 07:24:12 INFO - ##### Running install step. 07:24:12 INFO - ##### 07:24:12 INFO - Running pre-action listener: _resource_record_pre_action 07:24:12 INFO - Running main action method: install 07:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:24:13 INFO - Reading from file tmpfile_stdout 07:24:13 INFO - Detecting whether we're running mozinstall >=1.0... 07:24:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:24:13 INFO - Reading from file tmpfile_stdout 07:24:13 INFO - Output received: 07:24:13 INFO - Usage: mozinstall [options] installer 07:24:13 INFO - Options: 07:24:13 INFO - -h, --help show this help message and exit 07:24:13 INFO - -d DEST, --destination=DEST 07:24:13 INFO - Directory to install application into. [default: 07:24:13 INFO - "/builds/slave/test"] 07:24:13 INFO - --app=APP Application being installed. [default: firefox] 07:24:13 INFO - mkdir: /builds/slave/test/build/application 07:24:13 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'] 07:24:13 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 07:24:29 INFO - Reading from file tmpfile_stdout 07:24:29 INFO - Output received: 07:24:29 INFO - /builds/slave/test/build/application/firefox/firefox 07:24:29 INFO - Running post-action listener: _resource_record_post_action 07:24:29 INFO - ##### 07:24:29 INFO - ##### Finished install step (success) 07:24:29 INFO - ##### 07:24:29 INFO - ##### 07:24:29 INFO - ##### Running run-tests step. 07:24:29 INFO - ##### 07:24:29 INFO - Running pre-action listener: _resource_record_pre_action 07:24:29 INFO - Running main action method: run_tests 07:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:24:29 INFO - Python 2.7.3 07:24:29 INFO - Return code: 0 07:24:29 INFO - grabbing minidump binary from tooltool 07:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:24:29 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 0x238f1c0>, '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 0x23900c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2390550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:24:29 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 07:24:29 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 07:24:29 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 07:24:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:24:30 INFO - Return code: 0 07:24:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:24:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:24:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:24:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:24:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:24:30 INFO - Return code: 0 07:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 07:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 07:24:30 INFO - Using env: {'DISPLAY': ':0', 07:24:30 INFO - 'HOME': '/home/cltbld', 07:24:30 INFO - 'LANG': 'en_US.UTF-8', 07:24:30 INFO - 'LANGUAGE': 'en_US:en', 07:24:30 INFO - 'LOGNAME': 'cltbld', 07:24:30 INFO - 'MAIL': '/var/mail/cltbld', 07:24:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:24:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:30 INFO - 'MOZ_NO_REMOTE': '1', 07:24:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:24:30 INFO - 'NO_EM_RESTART': '1', 07:24:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:30 INFO - 'PWD': '/builds/slave/test', 07:24:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:24:30 INFO - 'SHELL': '/bin/bash', 07:24:30 INFO - 'SHLVL': '1', 07:24:30 INFO - 'TERM': 'linux', 07:24:30 INFO - 'TMOUT': '86400', 07:24:30 INFO - 'USER': 'cltbld', 07:24:30 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588', 07:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:30 INFO - '_': '/tools/buildbot/bin/python'} 07:24:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 07:24:31 INFO - mozversion application_buildid: 20160616043206 07:24:31 INFO - mozversion application_changeset: 44256084ae2e8a2777eeaf040f8bdb584a818ef8 07:24:31 INFO - mozversion application_display_name: Nightly 07:24:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:24:31 INFO - mozversion application_name: Firefox 07:24:31 INFO - mozversion application_remotingname: firefox 07:24:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:24:31 INFO - mozversion application_vendor: Mozilla 07:24:31 INFO - mozversion application_version: 50.0a1 07:24:31 INFO - mozversion platform_buildid: 20160616043206 07:24:31 INFO - mozversion platform_changeset: 44256084ae2e8a2777eeaf040f8bdb584a818ef8 07:24:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:24:31 INFO - mozversion platform_version: 50.0a1 07:24:31 INFO - using testdate: 1466087071 07:24:31 INFO - actual date: 1466087071 07:24:31 INFO - starting webserver on 'localhost:49370' 07:24:31 INFO - SUITE-START | Running 2 tests 07:24:31 INFO - TEST-START | dromaeo_css 07:24:31 INFO - operating with platform_type : linux_ 07:24:31 INFO - Initialising browser for dromaeo_css test... 07:24:31 INFO - TEST-INFO | started process 28561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPnri6L/profile http://localhost:49370/getInfo.html) 07:24:35 INFO - PROCESS | 28561 | __metrics Screen width/height:1600/1200 07:24:35 INFO - PROCESS | 28561 | colorDepth:24 07:24:35 INFO - PROCESS | 28561 | Browser inner width/height: 1024/697 07:24:35 INFO - PROCESS | 28561 | __metrics 07:24:37 INFO - PROCESS | 28561 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:24:38 INFO - TEST-INFO | 28561: exit 0 07:24:38 INFO - Browser initialized. 07:24:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:24:38 INFO - TEST-INFO | started process 28646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPnri6L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:24:49 INFO - PROCESS | 28646 | RSS: Main: 174055424 07:24:49 INFO - PROCESS | 28646 | 07:25:40 INFO - PROCESS | 28646 | 1466087140656 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] 07:27:49 INFO - PROCESS | 28646 | Cycle 1(1): loaded http://localhost:49370/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49370/tests/dromaeo/cssquery-ext.html) 07:27:50 INFO - PROCESS | 28646 | RSS: Main: 274509824 07:27:50 INFO - PROCESS | 28646 | 07:30:53 INFO - PROCESS | 28646 | Cycle 1(1): loaded http://localhost:49370/tests/dromaeo/cssquery-ext.html (next: http://localhost:49370/tests/dromaeo/cssquery-jquery.html) 07:30:53 INFO - PROCESS | 28646 | RSS: Main: 257302528 07:30:53 INFO - PROCESS | 28646 | 07:33:56 INFO - PROCESS | 28646 | Cycle 1(1): loaded http://localhost:49370/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49370/tests/dromaeo/cssquery-mootools.html) 07:33:56 INFO - PROCESS | 28646 | RSS: Main: 259604480 07:33:56 INFO - PROCESS | 28646 | 07:36:58 INFO - PROCESS | 28646 | Cycle 1(1): loaded http://localhost:49370/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49370/tests/dromaeo/cssquery-prototype.html) 07:36:59 INFO - PROCESS | 28646 | RSS: Main: 260194304 07:36:59 INFO - PROCESS | 28646 | 07:40:01 INFO - PROCESS | 28646 | Cycle 1(1): loaded http://localhost:49370/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49370/tests/dromaeo/cssquery-yui.html) 07:40:02 INFO - PROCESS | 28646 | RSS: Main: 240758784 07:40:02 INFO - PROCESS | 28646 | 07:43:05 INFO - PROCESS | 28646 | Cycle 1(1): loaded http://localhost:49370/tests/dromaeo/cssquery-yui.html (next: http://localhost:49370/tests/dromaeo/cssquery-dojo.html) 07:43:05 INFO - PROCESS | 28646 | RSS: Main: 285868032 07:43:05 INFO - PROCESS | 28646 | 07:43:05 INFO - PROCESS | 28646 | __start_tp_report 07:43:05 INFO - PROCESS | 28646 | _x_x_mozilla_page_load 07:43:05 INFO - PROCESS | 28646 | _x_x_mozilla_page_load_details 07:43:05 INFO - PROCESS | 28646 | |i|pagename|runs| 07:43:05 INFO - PROCESS | 28646 | |0;dojo.html;3099.2406860319225;3100.9534856977143;3130.420872138654;3142.6543080261154;3164.9841750791256;5296.788128474866;5362.919556206655;5421.674699518032;5452.2912021437205;5455.836324910254;5437.3475182978;5455;5460.863478413042;5478.424765399625;5505.064139096353;4893.608511319095;4986.4514903360605;4986.975065124688;5009.123403404408;5162.432132465426;5058.013687330972;5078;5102.158143906269;5129.487051294859;5134.306868572751;4860.781264843091;4902.656814023002;4919.21292593187;4941.332920055783;4948.826791062295;4937.753112344404;4960.776765045545;5024.32171656829;5028.622853285981;5067.417247016567;4854.927176092361;4954.108260513106;4968.378952630921;4992.850214493571;5033.270175824521;5352.197170424429;5422.186671999192;5449.128139497661;5462.426445223234;5465.234867118606;5819.738111784937;5824.155497452845;5849.85375365615;5851.1223316502865;5877.9118313225335;5732.168835518826;5838.1534677471955;5941.257342832146;5979.730912108966;5982.0727787193055;5491.560675145979;5521.1442226454965;5563;5570.526505247019;5574.581906356999;6027.30685971119;6055.455009049207;6059.030555111161;6062.211912451353;6064.090386442069;5579.2746942897165;5685.886282274331;5773.134029895466;5834.649921004753;5842.123681447817;5887.322957859816;5896.410358964069;5935.762569497172;5949.881002379928;5953.166556682068;5821.912671309934;5858.736356863951;5862.267216597926;5869.853253668693;5875.618084824473;5695.088785794336;5755.165501002331;5804.767809287666;5829.242198514166;5895.35151133375;4385.473743150842;4389.319655453346;4394.890127746832;4395.714278571946;4424.137293227854;3937.7046721496004;3961.6830653547645;3982.681385489212;4015.1768887378016;4040.696947728932;5372.838814835562;5428.9185662215095;5475.7262136893;5534.7786088556;5535.723213839292;5935.228420305332;5937.643741375531;5942.197803296586;5944.791932282349;5951.196588460589;5521.917171242435;5522.889542209134;5528.44715528452;5530.004599172107;5532.446755324516;4762;4809.735464549483;4859.902801944012;4862.294967229732;4895.608351331956;5950.047992321208;5954.374790647006;5956.940430595725;5966.284045914518;5971.7611295547695;5736.856578585569;5810.331811841692;5831.70841457917;5838.795642152504;5844.181814545882;5925.288965324189;5987.0121429963565;6003.039513677791;6007.038873780174;6024.939750602438;5692.6299790513485;5743.8851222976145;5747.109198074305;5748.770049197985;5761.711914404347;5688.63023903445;5770.567207459541;5811.215485909348;5818.796342128006;5823.970880145742;5692.032354499662;5733.627314224562;5740.827775166752;5791.8552036199435;5797.275340582427;5649.20911072442;5702.714864256854;5706.543476521952;5708.571857110816;5728.312602487562;5492.615516913777;5561.777528898961;5645.745941432728;5649.20911072442;5653.717314134359;5744.253247078021;5809.331926828299;5815.94184058154;5817.214676018683;5830.096335068071;5610.5231055360755;5646.689432081111;5647.491725744702;5663;5682.261306030189 07:43:05 INFO - PROCESS | 28646 | |1;ext.html;590.8316129902976;607.3653032580952;610.9663968481733;613.7483631710996;630.3349965786095;32409.351812963727;35156;35216.295674086505;35224.119397015085;35251.64748352516;42001;43077.353839692354;43231.78384108083;47563;47588.76205618967;8757.649694012232;8920.330975176856;8992.820143597157;8996.370254082216;9000.234980026673;8879.467231966071;8966.14821591951;8971.147740964598;8974.641014359418;8978.23684986777;9008.144226298524;9038.774030649221;9043.050479699636;9050.230730387924;9052.547372631376;8955.104489551026;8986.595603197806;8990.28077753778;9012.324075694316;9013.729588112334;8902.599383027778;8925.73222803317;8988.820223595492;8997.505137217451;8998.05520420353;42776;43244.56755432437;43265.134697306195;43294.35058474125;43319.78340108311;3446.172918499567;3542.1852973816167;4137.710360274782;4224.408582798411;4313.698041137121;32113.357732845212;32771;33411.6658833411;33499;34783.30433391318;4115.176964607061;4463.352813841975;4505.842295519641;4538.319252112176;4584.335271385664;338396;338819;339905;340182;340874.9999999975;59475;59512;59841.401585983585;59895;59920;62048.68975655093;62394;62497;62497.37502625006;62624;16590.17049147562;16747.497575072768;16789.748153777702;16793.83206167947;16815.41146059882;12869.549565765154;12922;12928.612141635766;12929.159604625858;12959.157654752411;15683.372665093268;17095.91452042732;17183.3985810496;17410.34601712835;17541.210645520983;5005.299258103868;5777.277840269966;5966.19456373384;5997.550183736237;6060.848478788065;980.7793246519618;1040.095117247999;1089.760252744395;1101.8402331661864;1166.0962753865651;31616.209594759854;32194.517082243787;32376.028719138463;32430.513542296885;32436.837815811243;1096.572336788653;1102.685734565645;1129.057237206925;1136.6021892337615;1175.2067354535654;16585.50243492697;16809.243584038748;17066.2320195589;17082.658346833243;17172.39896603613;516435;522956;524696;525756;526660;57227;57480;57626;57697.13454298189;57793.711031444574;1226.7546490701716;1232.0759430427179;1321.6960099177243;1332.6068809701162;1356.9389377478037;29931.251718707208;33133.50299745554;33154.33691326112;33342.28775532551;33367.66632333645;49701.25448118353;50184.74907625438;50187.74906125446;50232;50310.74844625754;397578;398804;402301;402900.81144725496;403166;33109.66890331066;34925.47611785775;36296.81851590831;41301.38047929344;41316.79341603273;42889.57110428856;47698.76150619225;47914.5208547924;48755;48924.2661360087;38670;40080.799596003;40756;41477.170456590095;42139.7893010533;39996.60003399929;40098;40931.7953410243;40962;41099.58900410958;39981.2003759929;40476.79761601173;40611.390829138174;40896;41479.7926010368;34910;37263.25473490461;37278.6272137286;37868.810655947644;37895.24209515739;28217.858910705316;28370.716292837635;28449.146525604265;28451.715482844906;28673 07:43:05 INFO - PROCESS | 28646 | |2;jquery.html;378.44557722935895;389.87116663328175;393.7243929249528;399.20956506117886;407.4845320669354;14723.705525889476;15729.37082516698;17822.821771782277;19535.804641953575;19543.70684439733;18535.536611584717;18705.34531291405;18796;18820.24719011241;18914.905425472854;5436.836894893159;5642.097264437691;5657.915131273035;5677.744501497422;5681.062624666945;4023.577524359944;5565.526930210937;5671.06427439472;5951.940480595204;6288.71700773464;6319.715612797412;6368.363163683641;6368.968155159241;6373.808785736435;6378.968105159468;6049.425304596057;6220.688965551704;6222.377762223787;6223.284322302902;6224.315325314189;4951.282064100686;5503.862403439906;5505.642133261365;5508.4491550845;5510.531604813596;12937.353132343345;13176.60470185896;13639.590812275648;13652.795208071886;13665.111767735165;2214.7785221477884;2654.973450265492;2736.7947403944786;2752.6972033076345;2824.308044529083;9334.29090111117;10172.389656620626;10240.692779216635;14515.637109072251;14876.702465950728;1936.4771511691906;1937.6705959986837;1992.392320342295;2052.548439343357;2094.172801743303;61304.57822170197;72205.6389718048;86548;94771.52614236885;95483.9999999993;15798.289076991563;16408.425705100264;17078.829211707973;17634.382796602313;17846.003119126664;30180.24549386283;30229.848850755607;30468.23829404238;30496.69503304983;30531.69468305333;9389.295802814817;9777.168940640126;9864.753381165528;9943.403395796275;10003.24975626831;8258.298044666271;8300.252977231958;8400.579971001425;8482.363822713321;8540.530270835165;8218.383621228431;8601.35489838252;8695.434796738318;8704.91295087041;9095.727128186032;3355.8154301513164;3395.898123056312;3534.899516560777;3540.274243780019;3602.370269703079;852.1904191018433;977.5112443778111;995.8107959487675;1033.1528146919604;1069.4011353641986;18418.447446576625;18482.353117640818;18505.5373615658;18710.158042888103;19006.904965475085;972.954074370055;981.2983716642635;997.9301448898652;1020.806046851096;1035.782485678001;9768.316217864824;10391;10421.791564168674;10451.895481045092;10472.424016679155;451312;453031;462925;463589;467361;84460.57769711112;85852.57073714591;85947.57026214829;86761.56619216864;87211;918.205752024494;927.3693888155984;937.9437233765859;945.1824172091092;1004.2819384140374;16257.918710406373;16287.755683664991;16411.179441027663;16597.41909033178;16689.66620667604;40418.59581404148;41781.79109104557;42409.78795106005;42583.5741642592;42636.802239831515;56557;56924.71537642285;57265.427345726006;57533.71233143807;60368.39631603628;7550;7820.608969551614;8633.96392432912;8711.91288087111;8770;12984.285864277555;13130.868691312964;13232.206067635972;13442.529511467052;13493.527726529524;11085.778284434105;11333.773324533628;11406.54373825071;11786.705332366759;11826.231294965799;11545.48045337945;11648.301101933912;11849.644510664693;12027.579034733742;12035;11533.653990380302;11537.250078744855;11741.47163377633;11965.940170299093;12006.879931200576;7848.136704962564;7967;7981.40139489529;8015.218015911647;8058.234467725557;10732.73168170802;11631.185816992729;11818.113641477095;11836.644900652995;11849.881501184878 07:43:05 INFO - PROCESS | 28646 | |3;mootools.html;1312.8621494743045;1449.6738233897372;1487.7470829958907;1586.6350739329953;1790.418114112913;8093.352531797457;8600.311975041997;8607.569621518931;8789.472631642106;8847.20375166235;8481.491110533372;8678.262347700438;8678.609462574184;8683.26192273656;8756.737297881058;2016.3950814755588;2173.7717539658347;2248.168177774226;2316.1198744477074;2344.507653392781;2232.096001119541;2236.630955892284;2241.002753774571;2242.686023956647;2244.708187935566;2315.8147348212187;2328;2328.3015095471374;2330.2193765088714;2336.9298921032396;1908.3130073173647;2184.9890750546147;2225.5660146271484;2243.24851174855;2250.8874556272203;2278.464560828204;2288.3706980580305;2297.6783250344965;2297.85063970843;2297.862128272309;8610.698625548075;8641.395102342838;8663.696770612998;8667;8698.739037828813;4957.801687932479;5081.974590127025;5091.618128640367;5091.79632814687;5096.490350964874;3176.142441540771;3181.8727250909938;3324.850381732828;3350.9497357539412;3358.378699940519;1126.0653657464286;1126.2172789911015;1132.6828488023366;1137.3858116617016;1139.777743340049;11720.179587428884;11738.178327517076;11749.530018799238;11754.588589399416;11764;4276.102018576134;4318.071614602875;4429.468463784367;4435.534268901719;4439.600435960779;10206.081452669296;10236.590536378462;10239.897601024044;10241.590336386611;10245.948770256251;5050.671706339076;5052.0653679068755;5052.722100284446;5056.418511871182;5059.19052951526;4185.434966279513;4526.502084770673;4634.490206077328;4646.163690535668;4717.033008233304;3726.1802403471193;3813.466114743938;3816.8434834318523;3819.8472061117245;3904.7461914976;1184.8045072562932;1198.8081906894854;1202.4288462980014;1218.6770505815966;1230.846144231971;762.2986852096085;944.1313991128178;954.6038394066385;973.3673112476805;1003.5333569890037;5788.594798364074;5880.941190588125;6050.122732203806;6148.1699970504305;6180.351063138396;941.1388579449726;972.9173020293355;976.2824324121765;993.7465946183821;995.2983146881576;4056.9391459128137;4153.460050193456;4162.375643653416;4191.874243772691;4244.363345498138;10222.591096356062;10485.475726213659;10508.264421490423;10570.048695617277;10588.947055264829;10339.844902326471;10375.740606484747;10449.268551201343;10488.108510776518;10499.47502624881;7727.768166955;7835;7988.360931125496;8056.073551541648;8057.556834374049;5825.2135961644635;5924.407559244041;5940.940590594038;6083.66539840313;6244;9745.220382369534;9853.06395892389;9912.411237728189;10009.799804003733;10174.745631359276;10060.496975151067;10088.747781305527;10153.796924061626;10179.440130792582;10181.949090254502;7331.890021649786;7587.734429294948;7895.84208315842;8077.63650635711;8206.261436470746;8112.351011919151;8164.877526836984;8179.509229446252;8244.051934027664;8261.09127995932;7086.114235720535;7198.316159964795;7199.280071992759;7409.073865766779;7416.332530072319;7153.320434558708;7314.451416143704;7382.483226174117;7396;7465;6916.20463646687;6945.68744406513;6997.580145191305;7008.299170082951;7008.649567521706;4815.277708343777;5022.748862556785;5080.593552515716;5082.4409314976065;5264.63147579681;5029.723365214948;5090.592752579859;5116.7953281869795;5322;5486.890262194814 07:43:05 INFO - PROCESS | 28646 | |4;prototype.html;317.2322978392292;334.12292731579606;335.1119533236922;340.93010932758756;341.3105526835791;5119.976004799037;5216.765245563949;5339.813106541267;5343.251944727736;5350.5184533391985;5100.373307746513;5251.711155886424;5260;5273.683578985254;5298.629095963284;4183.916321673565;4188.895277618069;4191.748495090289;4196.817654819492;4231.873043808675;4034.354503279476;4036.777977211252;4233.915321693565;4238.194742998836;4264.5095813981325;4135.870026936115;4149;4159.712158312931;4165.500139983191;4191.392248124021;4154.480689913761;4173.9582604173875;4185.476815398075;4196.412502249687;4212.178625168062;3388.9491657625153;3739.607341229159;3742.176721121349;3743.794091324976;3751.7748935063983;5052.473763118441;5066.746662666852;5066.873328166788;5096.61775366849;5111.335526381584;4668.206404911173;4674.452423429239;4682;4690.226112691402;4702.741349225791;5300.310959575269;5380.61180610817;5466.535344495723;5481.820544084421;5500.614956953015;3952.3873799561115;3971.245463361952;3975.5626881043063;3980;3985.9800700996598;5647.491725744702;5673.773049078032;5681.119426488901;5689.260396148516;5724.742386592572;4049.53430355507;4053.9391909121387;4075.816588253536;4079.224947260011;4082.1223436961195;3885.494885664902;4080.469538959916;4092.5498195198506;4103.651189648914;4110.506739191316;4699.013207226452;4704.247320428715;4717.292406139107;4726.598239149642;4726.905461890812;5592.888142237132;5610.691411972381;5622.662640241599;5629.634073785191;5703.94477021744;1334.3995202159067;1343.5230493174977;1371.136184203965;1386.6671998720235;1390.4855203574741;868.8001759595328;884.951327676984;887.9023307436177;891.2558014058204;900.4147304252158;4755;4757.215059515142;4777.157591233211;4777.450593181759;4784.928226076611;4922.384701912261;4935.629827762932;4989;5010.549050585465;5093.770780314895;4430.20256353853;4688.944987377813;4762.880927976828;4783.091212669582;4792.185328494164;2642.2205449392477;2644.6694163229595;2677.928828468628;2681.9195424137306;2684.3691732442862;5104.566111880532;5147.452011254453;5150.871228219325;5182.378114626269;5200.349956255468;4684.407301517501;5035.395752509649;5057.342545469065;5076.390833100052;5135.512126347991;5068.873278168076;5089.8727531812;5119.2065229888685;5125.743712814345;5144.845654630367;5005.8748531285555;5019.52314530119;5071.416787069535;5083.872903177302;5126.487351264844;4804.231322988305;4867.150482816507;5015.322931404214;5038.874028149326;5103.642745007814;5164.255914461985;5192.767110142524;5211.687298762086;5217.156649625887;5252.816151434681;3644.872429464956;3690.7970061646865;3698.3556756918933;3705.4437136402235;3711.9443208352436;4728.834490792806;5013.373328333958;5043.5460808527405;5045.646804723781;5049.26785616091;4856.295837103529;4879.268109783561;4892.8532144035735;4938.950610493849;4988.900221995613;4848.369711937426;4867.031111022203;4882.414110306786;4888.2178851383605;4922.655414120977;4565.474970378449;4751.099560175819;4808.543188397097;4825.541573550507;4861.95138048615;4919.532644398776;4922.335484709662;4923.950760492349;4932.062908047459;4938.580095752984;4856.344393506973;4883.291922671122;4926.3349447824085;4944.505549445027;4956.6530342877095 07:43:05 INFO - PROCESS | 28646 | |5;yui.html;695.2838576266446;698.9126359205096;701.3547536266634;727.6761840980762;754.7169811320755;16175.595610109753;16715.080670563115;16764;16821.83178168218;16862.5784355391;14805.851941480581;15540.844591554081;15596;15613.68772624547;15622;805.7341077444444;812.8414959082982;819.5492479136481;823.6087858267305;824.9463784853996;665.1320027364287;786.4023342259895;804.1476035402492;805.5649949027518;833.1543483364389;854.5001174313003;858;859.2739135430551;859.7592674051244;860.101194252005;690.1993687322681;856.9528675922821;857.34413173922;860.2300940658139;860.4880096342666;600.9669468179248;607.5838050935124;618.5824568416346;628.0579131303045;628.5600079944012;15566.766498502531;15599.220038998119;15634.765478517831;15639.530814075595;15711.685766284725;13508.121972071784;14049.297535123305;14148.646283842883;14323.641908952359;14459.710805783825;12168.81746773799;12211.26732396059;12267.38663066843;12353.320567368792;12399.690007749788;4275.636570891478;4357.433533640638;4379.7372157670325;4429.512753597101;4449.822007119711;75802;76406.23593764102;76787.23212767857;77192;79653.20346796516;11170;11283.830742538868;11396.487158077907;11530.36065442848;11597.246178998337;21199.644224139003;21441.249556265455;21550.46123846885;21597.24409645655;21606.567868642538;8396.958015209884;8546.401751877309;8556.315494760403;8695.869561956575;8778.60496277669;4540.72755634663;4586.2661974083985;4586.4496260448295;4867.5132486751045;5003.899922001539;3203.9747280869897;3364.7308215342714;3372.7976321420792;3374.6119196292248;3379.0707555422455;571.1290282319413;579.9217105690763;581.3692144023697;581.3808294166699;647.5046589359144;700.2682197103936;705.5131958948309;720.2893128819055;750.6697053296532;772.3975299266581;9482.715518534455;9602.183814375856;9940.453275069796;10047.447390393452;10119.696409107739;719.9784006479814;725.2638571849577;730.4083692209327;741.1624863903862;762.2910693055512;4467.287012202158;4558.293464513005;4725.692829966041;4732.787024583902;4810.39870016248;98540;100654.49672751735;102511.4874425638;116018.41990789992;126201.36899315445;87534;90625.09374906166;108826;112122.43938780254;112369.43815280871;85541.57229213939;88613.55693221492;89075;90567.54716226508;92431.5378423117;9884.851727223953;10171.593136274467;10562.577496900038;10611.41637209961;10693.89306106929;49872.25191622056;50188.247176291654;51459.48540514697;52400.47599523956;53575.19637205367;73900.26099738934;76046.61976690081;77435.42573026725;78272;79109.20890791019;12948.28784416866;13211.207327560378;13334.533291334757;13420.798688019882;14293.35679894428;14596.854031459974;14706.338214780146;15012.6997460048;15395.07629542231;15473.613159671098;14127.717445650824;14176.787348189579;14586.562403127924;14620.926895365455;14632.487862924747;13409.463621455032;13568.118072325267;13980.860191397956;13985.720285594027;14041.789373159207;13170.407331669907;13181.209127452383;13182.868171318163;13189.142705724098;13227.470901163846;11201.226004836519;11620.477078531318;11702.180847340604;11935.582254621047;12240.510379585074;11416.543338266376;11578.652640420802;11624.767504650028;11722.706932326419;12056.216345937486 07:43:05 INFO - PROCESS | 28646 | __end_tp_report 07:43:05 INFO - PROCESS | 28646 | __start_cc_report 07:43:05 INFO - PROCESS | 28646 | _x_x_mozilla_cycle_collect,906 07:43:05 INFO - PROCESS | 28646 | __end_cc_report 07:43:05 INFO - PROCESS | 28646 | __startTimestamp1466088185279__endTimestamp 07:43:05 INFO - PROCESS | 28646 | 07:43:05 INFO - PROCESS | 28646 | ------- Summary: start ------- 07:43:05 INFO - PROCESS | 28646 | Number of tests: 6 07:43:05 INFO - PROCESS | 28646 | 07:43:05 INFO - PROCESS | 28646 | [#0] dojo.html Cycles:165 Average:5424.79 Median:5649.21 stddev:627.07 (11.1%) stddev-sans-first:601.87 07:43:05 INFO - PROCESS | 28646 | Values: 3099.2 3101.0 3130.4 3142.7 3165.0 5296.8 5362.9 5421.7 5452.3 5455.8 5437.3 5455.0 5460.9 5478.4 5505.1 4893.6 4986.5 4987.0 5009.1 5162.4 5058.0 5078.0 5102.2 5129.5 5134.3 4860.8 4902.7 4919.2 4941.3 4948.8 4937.8 4960.8 5024.3 5028.6 5067.4 4854.9 4954.1 4968.4 4992.9 5033.3 5352.2 5422.2 5449.1 5462.4 5465.2 5819.7 5824.2 5849.9 5851.1 5877.9 5732.2 5838.2 5941.3 5979.7 5982.1 5491.6 5521.1 5563.0 5570.5 5574.6 6027.3 6055.5 6059.0 6062.2 6064.1 5579.3 5685.9 5773.1 5834.6 5842.1 5887.3 5896.4 5935.8 5949.9 5953.2 5821.9 5858.7 5862.3 5869.9 5875.6 5695.1 5755.2 5804.8 5829.2 5895.4 4385.5 4389.3 4394.9 4395.7 4424.1 3937.7 3961.7 3982.7 4015.2 4040.7 5372.8 5428.9 5475.7 5534.8 5535.7 5935.2 5937.6 5942.2 5944.8 5951.2 5521.9 5522.9 5528.4 5530.0 5532.4 4762.0 4809.7 4859.9 4862.3 4895.6 5950.0 5954.4 5956.9 5966.3 5971.8 5736.9 5810.3 5831.7 5838.8 5844.2 5925.3 5987.0 6003.0 6007.0 6024.9 5692.6 5743.9 5747.1 5748.8 5761.7 5688.6 5770.6 5811.2 5818.8 5824.0 5692.0 5733.6 5740.8 5791.9 5797.3 5649.2 5702.7 5706.5 5708.6 5728.3 5492.6 5561.8 5645.7 5649.2 5653.7 5744.3 5809.3 5815.9 5817.2 5830.1 5610.5 5646.7 5647.5 5663.0 5682.3 07:43:05 INFO - PROCESS | 28646 | 07:43:05 INFO - PROCESS | 28646 | [#1] ext.html Cycles:180 Average:58697.33 Median:22607.38 stddev:113329.20 (501.3%) stddev-sans-first:113563.15 07:43:05 INFO - PROCESS | 28646 | Values: 590.8 607.4 611.0 613.7 630.3 32409.4 35156.0 35216.3 35224.1 35251.6 42001.0 43077.4 43231.8 47563.0 47588.8 8757.6 8920.3 8992.8 8996.4 9000.2 8879.5 8966.1 8971.1 8974.6 8978.2 9008.1 9038.8 9043.1 9050.2 9052.5 8955.1 8986.6 8990.3 9012.3 9013.7 8902.6 8925.7 8988.8 8997.5 8998.1 42776.0 43244.6 43265.1 43294.4 43319.8 3446.2 3542.2 4137.7 4224.4 4313.7 32113.4 32771.0 33411.7 33499.0 34783.3 4115.2 4463.4 4505.8 4538.3 4584.3 338396.0 338819.0 339905.0 340182.0 340875.0 59475.0 59512.0 59841.4 59895.0 59920.0 62048.7 62394.0 62497.0 62497.4 62624.0 16590.2 16747.5 16789.7 16793.8 16815.4 12869.5 12922.0 12928.6 12929.2 12959.2 15683.4 17095.9 17183.4 17410.3 17541.2 5005.3 5777.3 5966.2 5997.6 6060.8 980.8 1040.1 1089.8 1101.8 1166.1 31616.2 32194.5 32376.0 32430.5 32436.8 1096.6 1102.7 1129.1 1136.6 1175.2 16585.5 16809.2 17066.2 17082.7 17172.4 516435.0 522956.0 524696.0 525756.0 526660.0 57227.0 57480.0 57626.0 57697.1 57793.7 1226.8 1232.1 1321.7 1332.6 1356.9 29931.3 33133.5 33154.3 33342.3 33367.7 49701.3 50184.7 50187.7 50232.0 50310.7 397578.0 398804.0 402301.0 402900.8 403166.0 33109.7 34925.5 36296.8 41301.4 41316.8 42889.6 47698.8 47914.5 48755.0 48924.3 38670.0 40080.8 40756.0 41477.2 42139.8 39996.6 40098.0 40931.8 40962.0 41099.6 39981.2 40476.8 40611.4 40896.0 41479.8 34910.0 37263.3 37278.6 37868.8 37895.2 28217.9 28370.7 28449.1 28451.7 28673.0 07:43:05 INFO - PROCESS | 28646 | 07:43:05 INFO - PROCESS | 28646 | [#2] jquery.html Cycles:180 Average:28476.86 Median:391.80 stddev:75809.26 (19349.1%) stddev-sans-first:75992.57 07:43:05 INFO - PROCESS | 28646 | Values: 378.4 389.9 393.7 399.2 407.5 14723.7 15729.4 17822.8 19535.8 19543.7 18535.5 18705.3 18796.0 18820.2 18914.9 5436.8 5642.1 5657.9 5677.7 5681.1 4023.6 5565.5 5671.1 5951.9 6288.7 6319.7 6368.4 6369.0 6373.8 6379.0 6049.4 6220.7 6222.4 6223.3 6224.3 4951.3 5503.9 5505.6 5508.4 5510.5 12937.4 13176.6 13639.6 13652.8 13665.1 2214.8 2655.0 2736.8 2752.7 2824.3 9334.3 10172.4 10240.7 14515.6 14876.7 1936.5 1937.7 1992.4 2052.5 2094.2 61304.6 72205.6 86548.0 94771.5 95484.0 15798.3 16408.4 17078.8 17634.4 17846.0 30180.2 30229.8 30468.2 30496.7 30531.7 9389.3 9777.2 9864.8 9943.4 10003.2 8258.3 8300.3 8400.6 8482.4 8540.5 8218.4 8601.4 8695.4 8704.9 9095.7 3355.8 3395.9 3534.9 3540.3 3602.4 852.2 977.5 995.8 1033.2 1069.4 18418.4 18482.4 18505.5 18710.2 19006.9 973.0 981.3 997.9 1020.8 1035.8 9768.3 10391.0 10421.8 10451.9 10472.4 451312.0 453031.0 462925.0 463589.0 467361.0 84460.6 85852.6 85947.6 86761.6 87211.0 918.2 927.4 937.9 945.2 1004.3 16257.9 16287.8 16411.2 16597.4 16689.7 40418.6 41781.8 42409.8 42583.6 42636.8 56557.0 56924.7 57265.4 57533.7 60368.4 7550.0 7820.6 8634.0 8711.9 8770.0 12984.3 13130.9 13232.2 13442.5 13493.5 11085.8 11333.8 11406.5 11786.7 11826.2 11545.5 11648.3 11849.6 12027.6 12035.0 11533.7 11537.3 11741.5 11965.9 12006.9 7848.1 7967.0 7981.4 8015.2 8058.2 10732.7 11631.2 11818.1 11836.6 11849.9 07:43:05 INFO - PROCESS | 28646 | 07:43:05 INFO - PROCESS | 28646 | [#3] mootools.html Cycles:180 Average:5665.64 Median:4640.33 stddev:3207.47 (69.1%) stddev-sans-first:3199.79 07:43:05 INFO - PROCESS | 28646 | Values: 1312.9 1449.7 1487.7 1586.6 1790.4 8093.4 8600.3 8607.6 8789.5 8847.2 8481.5 8678.3 8678.6 8683.3 8756.7 2016.4 2173.8 2248.2 2316.1 2344.5 2232.1 2236.6 2241.0 2242.7 2244.7 2315.8 2328.0 2328.3 2330.2 2336.9 1908.3 2185.0 2225.6 2243.2 2250.9 2278.5 2288.4 2297.7 2297.9 2297.9 8610.7 8641.4 8663.7 8667.0 8698.7 4957.8 5082.0 5091.6 5091.8 5096.5 3176.1 3181.9 3324.9 3350.9 3358.4 1126.1 1126.2 1132.7 1137.4 1139.8 11720.2 11738.2 11749.5 11754.6 11764.0 4276.1 4318.1 4429.5 4435.5 4439.6 10206.1 10236.6 10239.9 10241.6 10245.9 5050.7 5052.1 5052.7 5056.4 5059.2 4185.4 4526.5 4634.5 4646.2 4717.0 3726.2 3813.5 3816.8 3819.8 3904.7 1184.8 1198.8 1202.4 1218.7 1230.8 762.3 944.1 954.6 973.4 1003.5 5788.6 5880.9 6050.1 6148.2 6180.4 941.1 972.9 976.3 993.7 995.3 4056.9 4153.5 4162.4 4191.9 4244.4 10222.6 10485.5 10508.3 10570.0 10588.9 10339.8 10375.7 10449.3 10488.1 10499.5 7727.8 7835.0 7988.4 8056.1 8057.6 5825.2 5924.4 5940.9 6083.7 6244.0 9745.2 9853.1 9912.4 10009.8 10174.7 10060.5 10088.7 10153.8 10179.4 10181.9 7331.9 7587.7 7895.8 8077.6 8206.3 8112.4 8164.9 8179.5 8244.1 8261.1 7086.1 7198.3 7199.3 7409.1 7416.3 7153.3 7314.5 7382.5 7396.0 7465.0 6916.2 6945.7 6997.6 7008.3 7008.6 4815.3 5022.7 5080.6 5082.4 5264.6 5029.7 5090.6 5116.8 5322.0 5486.9 07:43:05 INFO - PROCESS | 28646 | 07:43:05 INFO - PROCESS | 28646 | [#4] prototype.html Cycles:180 Average:4374.15 Median:4864.49 stddev:1229.39 (25.3%) stddev-sans-first:1194.54 07:43:05 INFO - PROCESS | 28646 | Values: 317.2 334.1 335.1 340.9 341.3 5120.0 5216.8 5339.8 5343.3 5350.5 5100.4 5251.7 5260.0 5273.7 5298.6 4183.9 4188.9 4191.7 4196.8 4231.9 4034.4 4036.8 4233.9 4238.2 4264.5 4135.9 4149.0 4159.7 4165.5 4191.4 4154.5 4174.0 4185.5 4196.4 4212.2 3388.9 3739.6 3742.2 3743.8 3751.8 5052.5 5066.7 5066.9 5096.6 5111.3 4668.2 4674.5 4682.0 4690.2 4702.7 5300.3 5380.6 5466.5 5481.8 5500.6 3952.4 3971.2 3975.6 3980.0 3986.0 5647.5 5673.8 5681.1 5689.3 5724.7 4049.5 4053.9 4075.8 4079.2 4082.1 3885.5 4080.5 4092.5 4103.7 4110.5 4699.0 4704.2 4717.3 4726.6 4726.9 5592.9 5610.7 5622.7 5629.6 5703.9 1334.4 1343.5 1371.1 1386.7 1390.5 868.8 885.0 887.9 891.3 900.4 4755.0 4757.2 4777.2 4777.5 4784.9 4922.4 4935.6 4989.0 5010.5 5093.8 4430.2 4688.9 4762.9 4783.1 4792.2 2642.2 2644.7 2677.9 2681.9 2684.4 5104.6 5147.5 5150.9 5182.4 5200.3 4684.4 5035.4 5057.3 5076.4 5135.5 5068.9 5089.9 5119.2 5125.7 5144.8 5005.9 5019.5 5071.4 5083.9 5126.5 4804.2 4867.2 5015.3 5038.9 5103.6 5164.3 5192.8 5211.7 5217.2 5252.8 3644.9 3690.8 3698.4 3705.4 3711.9 4728.8 5013.4 5043.5 5045.6 5049.3 4856.3 4879.3 4892.9 4939.0 4988.9 4848.4 4867.0 4882.4 4888.2 4922.7 4565.5 4751.1 4808.5 4825.5 4862.0 4919.5 4922.3 4924.0 4932.1 4938.6 4856.3 4883.3 4926.3 4944.5 4956.7 07:43:05 INFO - PROCESS | 28646 | 07:43:05 INFO - PROCESS | 28646 | [#5] yui.html Cycles:180 Average:21078.58 Median:4404.62 stddev:30062.89 (682.5%) stddev-sans-first:30108.26 07:43:05 INFO - PROCESS | 28646 | Values: 695.3 698.9 701.4 727.7 754.7 16175.6 16715.1 16764.0 16821.8 16862.6 14805.9 15540.8 15596.0 15613.7 15622.0 805.7 812.8 819.5 823.6 824.9 665.1 786.4 804.1 805.6 833.2 854.5 858.0 859.3 859.8 860.1 690.2 857.0 857.3 860.2 860.5 601.0 607.6 618.6 628.1 628.6 15566.8 15599.2 15634.8 15639.5 15711.7 13508.1 14049.3 14148.6 14323.6 14459.7 12168.8 12211.3 12267.4 12353.3 12399.7 4275.6 4357.4 4379.7 4429.5 4449.8 75802.0 76406.2 76787.2 77192.0 79653.2 11170.0 11283.8 11396.5 11530.4 11597.2 21199.6 21441.2 21550.5 21597.2 21606.6 8397.0 8546.4 8556.3 8695.9 8778.6 4540.7 4586.3 4586.4 4867.5 5003.9 3204.0 3364.7 3372.8 3374.6 3379.1 571.1 579.9 581.4 581.4 647.5 700.3 705.5 720.3 750.7 772.4 9482.7 9602.2 9940.5 10047.4 10119.7 720.0 725.3 730.4 741.2 762.3 4467.3 4558.3 4725.7 4732.8 4810.4 98540.0 100654.5 102511.5 116018.4 126201.4 87534.0 90625.1 108826.0 112122.4 112369.4 85541.6 88613.6 89075.0 90567.5 92431.5 9884.9 10171.6 10562.6 10611.4 10693.9 49872.3 50188.2 51459.5 52400.5 53575.2 73900.3 76046.6 77435.4 78272.0 79109.2 12948.3 13211.2 13334.5 13420.8 14293.4 14596.9 14706.3 15012.7 15395.1 15473.6 14127.7 14176.8 14586.6 14620.9 14632.5 13409.5 13568.1 13980.9 13985.7 14041.8 13170.4 13181.2 13182.9 13189.1 13227.5 11201.2 11620.5 11702.2 11935.6 12240.5 11416.5 11578.7 11624.8 11722.7 12056.2 07:43:05 INFO - PROCESS | 28646 | -------- Summary: end -------- 07:43:05 INFO - PROCESS | 28646 | 07:43:06 INFO - TEST-INFO | 28646: exit 0 07:43:06 INFO - TEST-OK | dromaeo_css | took 1114928ms 07:43:06 INFO - TEST-START | kraken 07:43:06 INFO - operating with platform_type : linux_ 07:43:06 INFO - Initialising browser for kraken test... 07:43:06 INFO - TEST-INFO | started process 28833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCngx_v/profile http://localhost:49370/getInfo.html) 07:43:10 INFO - PROCESS | 28833 | __metrics Screen width/height:1600/1200 07:43:10 INFO - PROCESS | 28833 | colorDepth:24 07:43:10 INFO - PROCESS | 28833 | Browser inner width/height: 1024/697 07:43:10 INFO - PROCESS | 28833 | __metrics 07:43:12 INFO - PROCESS | 28833 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:43:13 INFO - TEST-INFO | 28833: exit 0 07:43:13 INFO - Browser initialized. 07:43:13 INFO - Running cycle 1/1 for kraken test... 07:43:13 INFO - TEST-INFO | started process 28919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCngx_v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:43:24 INFO - PROCESS | 28919 | RSS: Main: 173785088 07:43:24 INFO - PROCESS | 28919 | 07:43:27 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49370/tests/kraken/driver.html?testName=audio-beat-detection) 07:43:28 INFO - PROCESS | 28919 | RSS: Main: 233095168 07:43:28 INFO - PROCESS | 28919 | 07:43:31 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49370/tests/kraken/driver.html?testName=audio-dft) 07:43:31 INFO - PROCESS | 28919 | RSS: Main: 220807168 07:43:31 INFO - PROCESS | 28919 | 07:43:34 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49370/tests/kraken/driver.html?testName=audio-fft) 07:43:35 INFO - PROCESS | 28919 | RSS: Main: 286683136 07:43:35 INFO - PROCESS | 28919 | 07:43:37 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49370/tests/kraken/driver.html?testName=audio-oscillator) 07:43:38 INFO - PROCESS | 28919 | RSS: Main: 197922816 07:43:38 INFO - PROCESS | 28919 | 07:43:40 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49370/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:43:40 INFO - PROCESS | 28919 | RSS: Main: 202575872 07:43:40 INFO - PROCESS | 28919 | 07:43:43 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49370/tests/kraken/driver.html?testName=imaging-darkroom) 07:43:44 INFO - PROCESS | 28919 | RSS: Main: 238411776 07:43:44 INFO - PROCESS | 28919 | 07:43:48 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49370/tests/kraken/driver.html?testName=imaging-desaturate) 07:43:48 INFO - PROCESS | 28919 | RSS: Main: 238469120 07:43:48 INFO - PROCESS | 28919 | 07:43:51 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49370/tests/kraken/driver.html?testName=json-parse-financial) 07:43:52 INFO - PROCESS | 28919 | RSS: Main: 238886912 07:43:52 INFO - PROCESS | 28919 | 07:43:53 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49370/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:43:54 INFO - PROCESS | 28919 | RSS: Main: 225988608 07:43:54 INFO - PROCESS | 28919 | 07:43:55 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49370/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:43:56 INFO - PROCESS | 28919 | RSS: Main: 229457920 07:43:56 INFO - PROCESS | 28919 | 07:43:58 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49370/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:43:59 INFO - PROCESS | 28919 | RSS: Main: 237330432 07:43:59 INFO - PROCESS | 28919 | 07:44:01 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:44:02 INFO - PROCESS | 28919 | RSS: Main: 241041408 07:44:02 INFO - PROCESS | 28919 | 07:44:05 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:44:05 INFO - PROCESS | 28919 | RSS: Main: 242954240 07:44:05 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | Cycle 1(1): loaded http://localhost:49370/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49370/tests/kraken/driver.html?testName=ai-astar) 07:44:07 INFO - PROCESS | 28919 | RSS: Main: 285876224 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | __start_tp_report 07:44:07 INFO - PROCESS | 28919 | _x_x_mozilla_page_load 07:44:07 INFO - PROCESS | 28919 | _x_x_mozilla_page_load_details 07:44:07 INFO - PROCESS | 28919 | |i|pagename|runs| 07:44:07 INFO - PROCESS | 28919 | |0;ai-astar;111;106;112;109;111;110;111;111;109;110 07:44:07 INFO - PROCESS | 28919 | |1;audio-beat-detection;148;123;128;180;126;128;155;130;163;124 07:44:07 INFO - PROCESS | 28919 | |2;audio-dft;161;160;160;162;160;166;161;162;160;161 07:44:07 INFO - PROCESS | 28919 | |3;audio-fft;74;75;75;134;77;77;76;76;107;75 07:44:07 INFO - PROCESS | 28919 | |4;audio-oscillator;86;85;121;84;84;85;127;84;85;133 07:44:07 INFO - PROCESS | 28919 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;116;117 07:44:07 INFO - PROCESS | 28919 | |6;imaging-darkroom;149;146;146;146;148;146;146;146;146;145 07:44:07 INFO - PROCESS | 28919 | |7;imaging-desaturate;94;95;95;94;95;94;95;94;95;95 07:44:07 INFO - PROCESS | 28919 | |8;json-parse-financial;52;51;52;53;53;52;52;53;52;52 07:44:07 INFO - PROCESS | 28919 | |9;json-stringify-tinderbox;61;61;61;62;61;61;61;61;60;61 07:44:07 INFO - PROCESS | 28919 | |10;stanford-crypto-aes;80;86;79;79;82;83;81;82;114;80 07:44:07 INFO - PROCESS | 28919 | |11;stanford-crypto-ccm;127;133;132;128;120;127;121;133;151;124 07:44:07 INFO - PROCESS | 28919 | |12;stanford-crypto-pbkdf2;160;160;162;158;160;160;157;163;161;157 07:44:07 INFO - PROCESS | 28919 | |13;stanford-crypto-sha256-iterative;63;63;63;67;64;73;63;63;66;61 07:44:07 INFO - PROCESS | 28919 | __end_tp_report 07:44:07 INFO - PROCESS | 28919 | __start_cc_report 07:44:07 INFO - PROCESS | 28919 | _x_x_mozilla_cycle_collect,1634 07:44:07 INFO - PROCESS | 28919 | __end_cc_report 07:44:07 INFO - PROCESS | 28919 | __startTimestamp1466088247668__endTimestamp 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | ------- Summary: start ------- 07:44:07 INFO - PROCESS | 28919 | Number of tests: 14 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.70 (1.5%) stddev-sans-first:1.76 07:44:07 INFO - PROCESS | 28919 | Values: 111.0 106.0 112.0 109.0 111.0 110.0 111.0 111.0 109.0 110.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:139.00 stddev:19.85 (14.3%) stddev-sans-first:20.86 07:44:07 INFO - PROCESS | 28919 | Values: 148.0 123.0 128.0 180.0 126.0 128.0 155.0 130.0 163.0 124.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.83 (1.1%) stddev-sans-first:1.94 07:44:07 INFO - PROCESS | 28919 | Values: 161.0 160.0 160.0 162.0 160.0 166.0 161.0 162.0 160.0 161.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#3] audio-fft Cycles:10 Average:84.60 Median:75.50 stddev:19.98 (26.5%) stddev-sans-first:20.83 07:44:07 INFO - PROCESS | 28919 | Values: 74.0 75.0 75.0 134.0 77.0 77.0 76.0 76.0 107.0 75.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:84.50 stddev:20.63 (24.4%) stddev-sans-first:21.47 07:44:07 INFO - PROCESS | 28919 | Values: 86.0 85.0 121.0 84.0 84.0 85.0 127.0 84.0 85.0 133.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 07:44:07 INFO - PROCESS | 28919 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.17 (0.8%) stddev-sans-first:0.78 07:44:07 INFO - PROCESS | 28919 | Values: 149.0 146.0 146.0 146.0 148.0 146.0 146.0 146.0 146.0 145.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:44:07 INFO - PROCESS | 28919 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 07:44:07 INFO - PROCESS | 28919 | Values: 52.0 51.0 52.0 53.0 53.0 52.0 52.0 53.0 52.0 52.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 07:44:07 INFO - PROCESS | 28919 | Values: 61.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 60.0 61.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:81.50 stddev:10.54 (12.9%) stddev-sans-first:11.05 07:44:07 INFO - PROCESS | 28919 | Values: 80.0 86.0 79.0 79.0 82.0 83.0 81.0 82.0 114.0 80.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:130.00 stddev:8.82 (6.8%) stddev-sans-first:9.31 07:44:07 INFO - PROCESS | 28919 | Values: 127.0 133.0 132.0 128.0 120.0 127.0 121.0 133.0 151.0 124.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:160.00 stddev:1.99 (1.2%) stddev-sans-first:2.11 07:44:07 INFO - PROCESS | 28919 | Values: 160.0 160.0 162.0 158.0 160.0 160.0 157.0 163.0 161.0 157.0 07:44:07 INFO - PROCESS | 28919 | 07:44:07 INFO - PROCESS | 28919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:63.50 stddev:3.41 (5.4%) stddev-sans-first:3.56 07:44:07 INFO - PROCESS | 28919 | Values: 63.0 63.0 63.0 67.0 64.0 73.0 63.0 63.0 66.0 61.0 07:44:07 INFO - PROCESS | 28919 | -------- Summary: end -------- 07:44:07 INFO - PROCESS | 28919 | 07:44:08 INFO - TEST-INFO | 28919: exit 0 07:44:08 INFO - TEST-OK | kraken | took 62637ms 07:44:08 INFO - SUITE-END | took 1177s 07:44:08 INFO - Completed test suite (00:19:37) 07:44:08 INFO - javascript benchmark 07:44:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.2406860319225, 3100.9534856977143, 3130.420872138654, 3142.6543080261154, 3164.9841750791256, 5296.788128474866, 5362.919556206655, 5421.674699518032, 5452.2912021437205, 5455.836324910254, 5437.3475182978, 5455.0, 5460.863478413042, 5478.424765399625, 5505.064139096353, 4893.608511319095, 4986.4514903360605, 4986.975065124688, 5009.123403404408, 5162.432132465426, 5058.013687330972, 5078.0, 5102.158143906269, 5129.487051294859, 5134.306868572751, 4860.781264843091, 4902.656814023002, 4919.21292593187, 4941.332920055783, 4948.826791062295, 4937.753112344404, 4960.776765045545, 5024.32171656829, 5028.622853285981, 5067.417247016567, 4854.927176092361, 4954.108260513106, 4968.378952630921, 4992.850214493571, 5033.270175824521, 5352.197170424429, 5422.186671999192, 5449.128139497661, 5462.426445223234, 5465.234867118606, 5819.738111784937, 5824.155497452845, 5849.85375365615, 5851.1223316502865, 5877.9118313225335, 5732.168835518826, 5838.1534677471955, 5941.257342832146, 5979.730912108966, 5982.0727787193055, 5491.560675145979, 5521.1442226454965, 5563.0, 5570.526505247019, 5574.581906356999, 6027.30685971119, 6055.455009049207, 6059.030555111161, 6062.211912451353, 6064.090386442069, 5579.2746942897165, 5685.886282274331, 5773.134029895466, 5834.649921004753, 5842.123681447817, 5887.322957859816, 5896.410358964069, 5935.762569497172, 5949.881002379928, 5953.166556682068, 5821.912671309934, 5858.736356863951, 5862.267216597926, 5869.853253668693, 5875.618084824473, 5695.088785794336, 5755.165501002331, 5804.767809287666, 5829.242198514166, 5895.35151133375, 4385.473743150842, 4389.319655453346, 4394.890127746832, 4395.714278571946, 4424.137293227854, 3937.7046721496004, 3961.6830653547645, 3982.681385489212, 4015.1768887378016, 4040.696947728932, 5372.838814835562, 5428.9185662215095, 5475.7262136893, 5534.7786088556, 5535.723213839292, 5935.228420305332, 5937.643741375531, 5942.197803296586, 5944.791932282349, 5951.196588460589, 5521.917171242435, 5522.889542209134, 5528.44715528452, 5530.004599172107, 5532.446755324516, 4762.0, 4809.735464549483, 4859.902801944012, 4862.294967229732, 4895.608351331956, 5950.047992321208, 5954.374790647006, 5956.940430595725, 5966.284045914518, 5971.7611295547695, 5736.856578585569, 5810.331811841692, 5831.70841457917, 5838.795642152504, 5844.181814545882, 5925.288965324189, 5987.0121429963565, 6003.039513677791, 6007.038873780174, 6024.939750602438, 5692.6299790513485, 5743.8851222976145, 5747.109198074305, 5748.770049197985, 5761.711914404347, 5688.63023903445, 5770.567207459541, 5811.215485909348, 5818.796342128006, 5823.970880145742, 5692.032354499662, 5733.627314224562, 5740.827775166752, 5791.8552036199435, 5797.275340582427, 5649.20911072442, 5702.714864256854, 5706.543476521952, 5708.571857110816, 5728.312602487562, 5492.615516913777, 5561.777528898961, 5645.745941432728, 5649.20911072442, 5653.717314134359, 5744.253247078021, 5809.331926828299, 5815.94184058154, 5817.214676018683, 5830.096335068071, 5610.5231055360755, 5646.689432081111, 5647.491725744702, 5663.0, 5682.261306030189], "value": 5381.497374168534, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.8316129902976, 607.3653032580952, 610.9663968481733, 613.7483631710996, 630.3349965786095, 32409.351812963727, 35156.0, 35216.295674086505, 35224.119397015085, 35251.64748352516, 42001.0, 43077.353839692354, 43231.78384108083, 47563.0, 47588.76205618967, 8757.649694012232, 8920.330975176856, 8992.820143597157, 8996.370254082216, 9000.234980026673, 8879.467231966071, 8966.14821591951, 8971.147740964598, 8974.641014359418, 8978.23684986777, 9008.144226298524, 9038.774030649221, 9043.050479699636, 9050.230730387924, 9052.547372631376, 8955.104489551026, 8986.595603197806, 8990.28077753778, 9012.324075694316, 9013.729588112334, 8902.599383027778, 8925.73222803317, 8988.820223595492, 8997.505137217451, 8998.05520420353, 42776.0, 43244.56755432437, 43265.134697306195, 43294.35058474125, 43319.78340108311, 3446.172918499567, 3542.1852973816167, 4137.710360274782, 4224.408582798411, 4313.698041137121, 32113.357732845212, 32771.0, 33411.6658833411, 33499.0, 34783.30433391318, 4115.176964607061, 4463.352813841975, 4505.842295519641, 4538.319252112176, 4584.335271385664, 338396.0, 338819.0, 339905.0, 340182.0, 340874.9999999975, 59475.0, 59512.0, 59841.401585983585, 59895.0, 59920.0, 62048.68975655093, 62394.0, 62497.0, 62497.37502625006, 62624.0, 16590.17049147562, 16747.497575072768, 16789.748153777702, 16793.83206167947, 16815.41146059882, 12869.549565765154, 12922.0, 12928.612141635766, 12929.159604625858, 12959.157654752411, 15683.372665093268, 17095.91452042732, 17183.3985810496, 17410.34601712835, 17541.210645520983, 5005.299258103868, 5777.277840269966, 5966.19456373384, 5997.550183736237, 6060.848478788065, 980.7793246519618, 1040.095117247999, 1089.760252744395, 1101.8402331661864, 1166.0962753865651, 31616.209594759854, 32194.517082243787, 32376.028719138463, 32430.513542296885, 32436.837815811243, 1096.572336788653, 1102.685734565645, 1129.057237206925, 1136.6021892337615, 1175.2067354535654, 16585.50243492697, 16809.243584038748, 17066.2320195589, 17082.658346833243, 17172.39896603613, 516435.0, 522956.0, 524696.0, 525756.0, 526660.0, 57227.0, 57480.0, 57626.0, 57697.13454298189, 57793.711031444574, 1226.7546490701716, 1232.0759430427179, 1321.6960099177243, 1332.6068809701162, 1356.9389377478037, 29931.251718707208, 33133.50299745554, 33154.33691326112, 33342.28775532551, 33367.66632333645, 49701.25448118353, 50184.74907625438, 50187.74906125446, 50232.0, 50310.74844625754, 397578.0, 398804.0, 402301.0, 402900.81144725496, 403166.0, 33109.66890331066, 34925.47611785775, 36296.81851590831, 41301.38047929344, 41316.79341603273, 42889.57110428856, 47698.76150619225, 47914.5208547924, 48755.0, 48924.2661360087, 38670.0, 40080.799596003, 40756.0, 41477.170456590095, 42139.7893010533, 39996.60003399929, 40098.0, 40931.7953410243, 40962.0, 41099.58900410958, 39981.2003759929, 40476.79761601173, 40611.390829138174, 40896.0, 41479.7926010368, 34910.0, 37263.25473490461, 37278.6272137286, 37868.810655947644, 37895.24209515739, 28217.858910705316, 28370.716292837635, 28449.146525604265, 28451.715482844906, 28673.0], "value": 20075.528921991754, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.44557722935895, 389.87116663328175, 393.7243929249528, 399.20956506117886, 407.4845320669354, 14723.705525889476, 15729.37082516698, 17822.821771782277, 19535.804641953575, 19543.70684439733, 18535.536611584717, 18705.34531291405, 18796.0, 18820.24719011241, 18914.905425472854, 5436.836894893159, 5642.097264437691, 5657.915131273035, 5677.744501497422, 5681.062624666945, 4023.577524359944, 5565.526930210937, 5671.06427439472, 5951.940480595204, 6288.71700773464, 6319.715612797412, 6368.363163683641, 6368.968155159241, 6373.808785736435, 6378.968105159468, 6049.425304596057, 6220.688965551704, 6222.377762223787, 6223.284322302902, 6224.315325314189, 4951.282064100686, 5503.862403439906, 5505.642133261365, 5508.4491550845, 5510.531604813596, 12937.353132343345, 13176.60470185896, 13639.590812275648, 13652.795208071886, 13665.111767735165, 2214.7785221477884, 2654.973450265492, 2736.7947403944786, 2752.6972033076345, 2824.308044529083, 9334.29090111117, 10172.389656620626, 10240.692779216635, 14515.637109072251, 14876.702465950728, 1936.4771511691906, 1937.6705959986837, 1992.392320342295, 2052.548439343357, 2094.172801743303, 61304.57822170197, 72205.6389718048, 86548.0, 94771.52614236885, 95483.9999999993, 15798.289076991563, 16408.425705100264, 17078.829211707973, 17634.382796602313, 17846.003119126664, 30180.24549386283, 30229.848850755607, 30468.23829404238, 30496.69503304983, 30531.69468305333, 9389.295802814817, 9777.168940640126, 9864.753381165528, 9943.403395796275, 10003.24975626831, 8258.298044666271, 8300.252977231958, 8400.579971001425, 8482.363822713321, 8540.530270835165, 8218.383621228431, 8601.35489838252, 8695.434796738318, 8704.91295087041, 9095.727128186032, 3355.8154301513164, 3395.898123056312, 3534.899516560777, 3540.274243780019, 3602.370269703079, 852.1904191018433, 977.5112443778111, 995.8107959487675, 1033.1528146919604, 1069.4011353641986, 18418.447446576625, 18482.353117640818, 18505.5373615658, 18710.158042888103, 19006.904965475085, 972.954074370055, 981.2983716642635, 997.9301448898652, 1020.806046851096, 1035.782485678001, 9768.316217864824, 10391.0, 10421.791564168674, 10451.895481045092, 10472.424016679155, 451312.0, 453031.0, 462925.0, 463589.0, 467361.0, 84460.57769711112, 85852.57073714591, 85947.57026214829, 86761.56619216864, 87211.0, 918.205752024494, 927.3693888155984, 937.9437233765859, 945.1824172091092, 1004.2819384140374, 16257.918710406373, 16287.755683664991, 16411.179441027663, 16597.41909033178, 16689.66620667604, 40418.59581404148, 41781.79109104557, 42409.78795106005, 42583.5741642592, 42636.802239831515, 56557.0, 56924.71537642285, 57265.427345726006, 57533.71233143807, 60368.39631603628, 7550.0, 7820.608969551614, 8633.96392432912, 8711.91288087111, 8770.0, 12984.285864277555, 13130.868691312964, 13232.206067635972, 13442.529511467052, 13493.527726529524, 11085.778284434105, 11333.773324533628, 11406.54373825071, 11786.705332366759, 11826.231294965799, 11545.48045337945, 11648.301101933912, 11849.644510664693, 12027.579034733742, 12035.0, 11533.653990380302, 11537.250078744855, 11741.47163377633, 11965.940170299093, 12006.879931200576, 7848.136704962564, 7967.0, 7981.40139489529, 8015.218015911647, 8058.234467725557, 10732.73168170802, 11631.185816992729, 11818.113641477095, 11836.644900652995, 11849.881501184878], "value": 9707.260986203779, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.8621494743045, 1449.6738233897372, 1487.7470829958907, 1586.6350739329953, 1790.418114112913, 8093.352531797457, 8600.311975041997, 8607.569621518931, 8789.472631642106, 8847.20375166235, 8481.491110533372, 8678.262347700438, 8678.609462574184, 8683.26192273656, 8756.737297881058, 2016.3950814755588, 2173.7717539658347, 2248.168177774226, 2316.1198744477074, 2344.507653392781, 2232.096001119541, 2236.630955892284, 2241.002753774571, 2242.686023956647, 2244.708187935566, 2315.8147348212187, 2328.0, 2328.3015095471374, 2330.2193765088714, 2336.9298921032396, 1908.3130073173647, 2184.9890750546147, 2225.5660146271484, 2243.24851174855, 2250.8874556272203, 2278.464560828204, 2288.3706980580305, 2297.6783250344965, 2297.85063970843, 2297.862128272309, 8610.698625548075, 8641.395102342838, 8663.696770612998, 8667.0, 8698.739037828813, 4957.801687932479, 5081.974590127025, 5091.618128640367, 5091.79632814687, 5096.490350964874, 3176.142441540771, 3181.8727250909938, 3324.850381732828, 3350.9497357539412, 3358.378699940519, 1126.0653657464286, 1126.2172789911015, 1132.6828488023366, 1137.3858116617016, 1139.777743340049, 11720.179587428884, 11738.178327517076, 11749.530018799238, 11754.588589399416, 11764.0, 4276.102018576134, 4318.071614602875, 4429.468463784367, 4435.534268901719, 4439.600435960779, 10206.081452669296, 10236.590536378462, 10239.897601024044, 10241.590336386611, 10245.948770256251, 5050.671706339076, 5052.0653679068755, 5052.722100284446, 5056.418511871182, 5059.19052951526, 4185.434966279513, 4526.502084770673, 4634.490206077328, 4646.163690535668, 4717.033008233304, 3726.1802403471193, 3813.466114743938, 3816.8434834318523, 3819.8472061117245, 3904.7461914976, 1184.8045072562932, 1198.8081906894854, 1202.4288462980014, 1218.6770505815966, 1230.846144231971, 762.2986852096085, 944.1313991128178, 954.6038394066385, 973.3673112476805, 1003.5333569890037, 5788.594798364074, 5880.941190588125, 6050.122732203806, 6148.1699970504305, 6180.351063138396, 941.1388579449726, 972.9173020293355, 976.2824324121765, 993.7465946183821, 995.2983146881576, 4056.9391459128137, 4153.460050193456, 4162.375643653416, 4191.874243772691, 4244.363345498138, 10222.591096356062, 10485.475726213659, 10508.264421490423, 10570.048695617277, 10588.947055264829, 10339.844902326471, 10375.740606484747, 10449.268551201343, 10488.108510776518, 10499.47502624881, 7727.768166955, 7835.0, 7988.360931125496, 8056.073551541648, 8057.556834374049, 5825.2135961644635, 5924.407559244041, 5940.940590594038, 6083.66539840313, 6244.0, 9745.220382369534, 9853.06395892389, 9912.411237728189, 10009.799804003733, 10174.745631359276, 10060.496975151067, 10088.747781305527, 10153.796924061626, 10179.440130792582, 10181.949090254502, 7331.890021649786, 7587.734429294948, 7895.84208315842, 8077.63650635711, 8206.261436470746, 8112.351011919151, 8164.877526836984, 8179.509229446252, 8244.051934027664, 8261.09127995932, 7086.114235720535, 7198.316159964795, 7199.280071992759, 7409.073865766779, 7416.332530072319, 7153.320434558708, 7314.451416143704, 7382.483226174117, 7396.0, 7465.0, 6916.20463646687, 6945.68744406513, 6997.580145191305, 7008.299170082951, 7008.649567521706, 4815.277708343777, 5022.748862556785, 5080.593552515716, 5082.4409314976065, 5264.63147579681, 5029.723365214948, 5090.592752579859, 5116.7953281869795, 5322.0, 5486.890262194814], "value": 4536.860119207589, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2322978392292, 334.12292731579606, 335.1119533236922, 340.93010932758756, 341.3105526835791, 5119.976004799037, 5216.765245563949, 5339.813106541267, 5343.251944727736, 5350.5184533391985, 5100.373307746513, 5251.711155886424, 5260.0, 5273.683578985254, 5298.629095963284, 4183.916321673565, 4188.895277618069, 4191.748495090289, 4196.817654819492, 4231.873043808675, 4034.354503279476, 4036.777977211252, 4233.915321693565, 4238.194742998836, 4264.5095813981325, 4135.870026936115, 4149.0, 4159.712158312931, 4165.500139983191, 4191.392248124021, 4154.480689913761, 4173.9582604173875, 4185.476815398075, 4196.412502249687, 4212.178625168062, 3388.9491657625153, 3739.607341229159, 3742.176721121349, 3743.794091324976, 3751.7748935063983, 5052.473763118441, 5066.746662666852, 5066.873328166788, 5096.61775366849, 5111.335526381584, 4668.206404911173, 4674.452423429239, 4682.0, 4690.226112691402, 4702.741349225791, 5300.310959575269, 5380.61180610817, 5466.535344495723, 5481.820544084421, 5500.614956953015, 3952.3873799561115, 3971.245463361952, 3975.5626881043063, 3980.0, 3985.9800700996598, 5647.491725744702, 5673.773049078032, 5681.119426488901, 5689.260396148516, 5724.742386592572, 4049.53430355507, 4053.9391909121387, 4075.816588253536, 4079.224947260011, 4082.1223436961195, 3885.494885664902, 4080.469538959916, 4092.5498195198506, 4103.651189648914, 4110.506739191316, 4699.013207226452, 4704.247320428715, 4717.292406139107, 4726.598239149642, 4726.905461890812, 5592.888142237132, 5610.691411972381, 5622.662640241599, 5629.634073785191, 5703.94477021744, 1334.3995202159067, 1343.5230493174977, 1371.136184203965, 1386.6671998720235, 1390.4855203574741, 868.8001759595328, 884.951327676984, 887.9023307436177, 891.2558014058204, 900.4147304252158, 4755.0, 4757.215059515142, 4777.157591233211, 4777.450593181759, 4784.928226076611, 4922.384701912261, 4935.629827762932, 4989.0, 5010.549050585465, 5093.770780314895, 4430.20256353853, 4688.944987377813, 4762.880927976828, 4783.091212669582, 4792.185328494164, 2642.2205449392477, 2644.6694163229595, 2677.928828468628, 2681.9195424137306, 2684.3691732442862, 5104.566111880532, 5147.452011254453, 5150.871228219325, 5182.378114626269, 5200.349956255468, 4684.407301517501, 5035.395752509649, 5057.342545469065, 5076.390833100052, 5135.512126347991, 5068.873278168076, 5089.8727531812, 5119.2065229888685, 5125.743712814345, 5144.845654630367, 5005.8748531285555, 5019.52314530119, 5071.416787069535, 5083.872903177302, 5126.487351264844, 4804.231322988305, 4867.150482816507, 5015.322931404214, 5038.874028149326, 5103.642745007814, 5164.255914461985, 5192.767110142524, 5211.687298762086, 5217.156649625887, 5252.816151434681, 3644.872429464956, 3690.7970061646865, 3698.3556756918933, 3705.4437136402235, 3711.9443208352436, 4728.834490792806, 5013.373328333958, 5043.5460808527405, 5045.646804723781, 5049.26785616091, 4856.295837103529, 4879.268109783561, 4892.8532144035735, 4938.950610493849, 4988.900221995613, 4848.369711937426, 4867.031111022203, 4882.414110306786, 4888.2178851383605, 4922.655414120977, 4565.474970378449, 4751.099560175819, 4808.543188397097, 4825.541573550507, 4861.95138048615, 4919.532644398776, 4922.335484709662, 4923.950760492349, 4932.062908047459, 4938.580095752984, 4856.344393506973, 4883.291922671122, 4926.3349447824085, 4944.505549445027, 4956.6530342877095], "value": 3985.914976006349, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.2838576266446, 698.9126359205096, 701.3547536266634, 727.6761840980762, 754.7169811320755, 16175.595610109753, 16715.080670563115, 16764.0, 16821.83178168218, 16862.5784355391, 14805.851941480581, 15540.844591554081, 15596.0, 15613.68772624547, 15622.0, 805.7341077444444, 812.8414959082982, 819.5492479136481, 823.6087858267305, 824.9463784853996, 665.1320027364287, 786.4023342259895, 804.1476035402492, 805.5649949027518, 833.1543483364389, 854.5001174313003, 858.0, 859.2739135430551, 859.7592674051244, 860.101194252005, 690.1993687322681, 856.9528675922821, 857.34413173922, 860.2300940658139, 860.4880096342666, 600.9669468179248, 607.5838050935124, 618.5824568416346, 628.0579131303045, 628.5600079944012, 15566.766498502531, 15599.220038998119, 15634.765478517831, 15639.530814075595, 15711.685766284725, 13508.121972071784, 14049.297535123305, 14148.646283842883, 14323.641908952359, 14459.710805783825, 12168.81746773799, 12211.26732396059, 12267.38663066843, 12353.320567368792, 12399.690007749788, 4275.636570891478, 4357.433533640638, 4379.7372157670325, 4429.512753597101, 4449.822007119711, 75802.0, 76406.23593764102, 76787.23212767857, 77192.0, 79653.20346796516, 11170.0, 11283.830742538868, 11396.487158077907, 11530.36065442848, 11597.246178998337, 21199.644224139003, 21441.249556265455, 21550.46123846885, 21597.24409645655, 21606.567868642538, 8396.958015209884, 8546.401751877309, 8556.315494760403, 8695.869561956575, 8778.60496277669, 4540.72755634663, 4586.2661974083985, 4586.4496260448295, 4867.5132486751045, 5003.899922001539, 3203.9747280869897, 3364.7308215342714, 3372.7976321420792, 3374.6119196292248, 3379.0707555422455, 571.1290282319413, 579.9217105690763, 581.3692144023697, 581.3808294166699, 647.5046589359144, 700.2682197103936, 705.5131958948309, 720.2893128819055, 750.6697053296532, 772.3975299266581, 9482.715518534455, 9602.183814375856, 9940.453275069796, 10047.447390393452, 10119.696409107739, 719.9784006479814, 725.2638571849577, 730.4083692209327, 741.1624863903862, 762.2910693055512, 4467.287012202158, 4558.293464513005, 4725.692829966041, 4732.787024583902, 4810.39870016248, 98540.0, 100654.49672751735, 102511.4874425638, 116018.41990789992, 126201.36899315445, 87534.0, 90625.09374906166, 108826.0, 112122.43938780254, 112369.43815280871, 85541.57229213939, 88613.55693221492, 89075.0, 90567.54716226508, 92431.5378423117, 9884.851727223953, 10171.593136274467, 10562.577496900038, 10611.41637209961, 10693.89306106929, 49872.25191622056, 50188.247176291654, 51459.48540514697, 52400.47599523956, 53575.19637205367, 73900.26099738934, 76046.61976690081, 77435.42573026725, 78272.0, 79109.20890791019, 12948.28784416866, 13211.207327560378, 13334.533291334757, 13420.798688019882, 14293.35679894428, 14596.854031459974, 14706.338214780146, 15012.6997460048, 15395.07629542231, 15473.613159671098, 14127.717445650824, 14176.787348189579, 14586.562403127924, 14620.926895365455, 14632.487862924747, 13409.463621455032, 13568.118072325267, 13980.860191397956, 13985.720285594027, 14041.789373159207, 13170.407331669907, 13181.209127452383, 13182.868171318163, 13189.142705724098, 13227.470901163846, 11201.226004836519, 11620.477078531318, 11702.180847340604, 11935.582254621047, 12240.510379585074, 11416.543338266376, 11578.652640420802, 11624.767504650028, 11722.706932326419, 12056.216345937486], "value": 7659.886451633557, "unit": "score"}], "name": "dromaeo_css", "value": 7250.538666421558, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 109.0, 111.0, 110.0, 111.0, 111.0, 109.0, 110.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 128.0, 180.0, 126.0, 128.0, 155.0, 130.0, 163.0, 124.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 160.0, 166.0, 161.0, 162.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 134.0, 77.0, 77.0, 76.0, 76.0, 107.0, 75.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 121.0, 84.0, 84.0, 85.0, 127.0, 84.0, 85.0, 133.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 53.0, 53.0, 52.0, 52.0, 53.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 79.0, 79.0, 82.0, 83.0, 81.0, 82.0, 114.0, 80.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 133.0, 132.0, 128.0, 120.0, 127.0, 121.0, 133.0, 151.0, 124.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 158.0, 160.0, 160.0, 157.0, 163.0, 161.0, 157.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 67.0, 64.0, 73.0, 63.0, 63.0, 66.0, 61.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1503.2999999999997, "alertThreshold": 2.0}]} 07:44:08 INFO - Return code: 0 07:44:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:44:08 INFO - # TBPL SUCCESS # 07:44:08 INFO - Running post-action listener: _resource_record_post_action 07:44:08 INFO - ##### 07:44:08 INFO - ##### Finished run-tests step (success) 07:44:08 INFO - ##### 07:44:08 INFO - Running post-run listener: _resource_record_post_run 07:44:09 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 294424576; Read time: 396; Write time: 371840 07:44:09 INFO - TinderboxPrint: CPU usage
13.3% 07:44:09 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 396 07:44:09 INFO - TinderboxPrint: I/O write bytes / time
294,424,576 / 371,840 07:44:09 INFO - TinderboxPrint: CPU idle
8,271.7 (86.7%) 07:44:09 INFO - TinderboxPrint: CPU user
1,220.4 (12.8%) 07:44:09 INFO - TinderboxPrint: Swap in / out
0 / 0 07:44:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 3325952; Read time: 0; Write time: 216 07:44:09 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 12288; Write bytes: 291098624; Read time: 396; Write time: 371624 07:44:09 INFO - Running post-run listener: _upload_blobber_files 07:44:09 INFO - Blob upload gear active. 07:44:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:44:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:44:10 INFO - (blobuploader) - INFO - Open directory for files ... 07:44:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:44:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:44:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:10 INFO - (blobuploader) - INFO - Done attempting. 07:44:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:44:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:44:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:14 INFO - (blobuploader) - INFO - Done attempting. 07:44:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:44:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:44:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:15 INFO - (blobuploader) - INFO - Done attempting. 07:44:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:44:15 INFO - Return code: 0 07:44:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:44:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:44:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49156d9f39a9200f5acbc804f6c450aa7a65ef361050f208540323ebc69b3f5b821dc86f87edfe32f33b8a608f2acdf1ffa59dfa3d49645be6b623d98bced332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6fc3dd760ec34eceff9ffba760e0a2b12f991ca48efe0b820de2b8d2c3c04f587d8538946093b541b878d08a16752b37f19ab9134dbc73ff1076b92e19df4b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74aa4d3fd0a6c30be436ed37f24e430b365bddc2b89ed44eeb3628b31d8cf1668be7eabbf7ebfcbb3db21177d975157d94be5e2a11e2d14f555d404c978b3cae"} 07:44:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:44:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:44:15 INFO - Contents: 07:44:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49156d9f39a9200f5acbc804f6c450aa7a65ef361050f208540323ebc69b3f5b821dc86f87edfe32f33b8a608f2acdf1ffa59dfa3d49645be6b623d98bced332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6fc3dd760ec34eceff9ffba760e0a2b12f991ca48efe0b820de2b8d2c3c04f587d8538946093b541b878d08a16752b37f19ab9134dbc73ff1076b92e19df4b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74aa4d3fd0a6c30be436ed37f24e430b365bddc2b89ed44eeb3628b31d8cf1668be7eabbf7ebfcbb3db21177d975157d94be5e2a11e2d14f555d404c978b3cae"} 07:44:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:44:15 INFO - Copying logs to upload dir... 07:44:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:44:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.299930 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-16 07:44:15.713015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 07:44:15.717423) ========= 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=eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49156d9f39a9200f5acbc804f6c450aa7a65ef361050f208540323ebc69b3f5b821dc86f87edfe32f33b8a608f2acdf1ffa59dfa3d49645be6b623d98bced332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6fc3dd760ec34eceff9ffba760e0a2b12f991ca48efe0b820de2b8d2c3c04f587d8538946093b541b878d08a16752b37f19ab9134dbc73ff1076b92e19df4b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74aa4d3fd0a6c30be436ed37f24e430b365bddc2b89ed44eeb3628b31d8cf1668be7eabbf7ebfcbb3db21177d975157d94be5e2a11e2d14f555d404c978b3cae"} build_url:https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/L3dwgPn_SZiDbUurYp-_Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49156d9f39a9200f5acbc804f6c450aa7a65ef361050f208540323ebc69b3f5b821dc86f87edfe32f33b8a608f2acdf1ffa59dfa3d49645be6b623d98bced332", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6fc3dd760ec34eceff9ffba760e0a2b12f991ca48efe0b820de2b8d2c3c04f587d8538946093b541b878d08a16752b37f19ab9134dbc73ff1076b92e19df4b57", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74aa4d3fd0a6c30be436ed37f24e430b365bddc2b89ed44eeb3628b31d8cf1668be7eabbf7ebfcbb3db21177d975157d94be5e2a11e2d14f555d404c978b3cae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 07:44:15.750904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:44:15.751312) ========= 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=eca2ab57546de7b41f256b19000001ef-1466087014.813430-1139372588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 07:44:15.835111) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 07:44:15.835451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 07:44:15.835785) ========= ========= Total master_lag: 0.19 =========