builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1465611028.06 results: success (0) buildid: 20160610163005 builduid: f8f0c5bd7cc646cab024f7fefb3ef2c8 revision: 8d51d4e1930f5df3d99e714513400b7e76a90306 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:28.056318) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:28.056907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:28.057236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:28.168889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:28.169215) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 19:10:28-- 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% 40.5M=0s 2016-06-10 19:10:28 (40.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103659 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:28.287829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:28.288159) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019355 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:28.344171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:28.344810) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8d51d4e1930f5df3d99e714513400b7e76a90306 --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 8d51d4e1930f5df3d99e714513400b7e76a90306 --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=9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 19:10:28,621 truncating revision to first 12 chars 2016-06-10 19:10:28,621 Setting DEBUG logging. 2016-06-10 19:10:28,621 attempt 1/10 2016-06-10 19:10:28,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8d51d4e1930f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 19:10:28,932 unpacking tar archive at: mozilla-inbound-8d51d4e1930f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651292 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:29.013629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:29.013941) ========= script_repo_revision: 8d51d4e1930f5df3d99e714513400b7e76a90306 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:29.014383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:29.014715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 19:10:29.031989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 18 secs) (at 2016-06-10 19:10:29.032296) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:10:29 INFO - MultiFileLogger online at 20160610 19:10:29 in /builds/slave/test 19:10:29 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 19:10:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:10:29 INFO - {'append_to_log': False, 19:10:29 INFO - 'base_work_dir': '/builds/slave/test', 19:10:29 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:10:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:10:29 INFO - 'branch': 'Mozilla-Inbound', 19:10:29 INFO - 'buildbot_json_path': 'buildprops.json', 19:10:29 INFO - 'config_files': ('talos/linux_config.py',), 19:10:29 INFO - 'default_actions': ('clobber', 19:10:29 INFO - 'read-buildbot-config', 19:10:29 INFO - 'download-and-extract', 19:10:29 INFO - 'populate-webroot', 19:10:29 INFO - 'create-virtualenv', 19:10:29 INFO - 'install', 19:10:29 INFO - 'run-tests'), 19:10:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:10:29 INFO - 'download_minidump_stackwalk': True, 19:10:29 INFO - 'download_symbols': 'ondemand', 19:10:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:10:29 INFO - 'tooltool.py': '/tools/tooltool.py', 19:10:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:10:29 INFO - '/tools/misc-python/virtualenv.py')}, 19:10:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:10:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:10:29 INFO - 'installer_path': 'installer.exe', 19:10:29 INFO - 'log_level': 'info', 19:10:29 INFO - 'log_name': 'talos', 19:10:29 INFO - 'log_to_console': True, 19:10:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:10:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:10:29 INFO - 'opt_config_files': (), 19:10:29 INFO - 'pip_index': False, 19:10:29 INFO - 'sps_profile': False, 19:10:29 INFO - 'sps_profile_interval': 0, 19:10:29 INFO - 'suite': 'dromaeojs', 19:10:29 INFO - 'system_bits': '32', 19:10:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:10:29 INFO - 'title': 'talos-linux64-ix-040', 19:10:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:10:29 INFO - 'use_talos_json': True, 19:10:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:10:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:10:29 INFO - 'work_dir': 'build'} 19:10:29 INFO - ##### 19:10:29 INFO - ##### Running clobber step. 19:10:29 INFO - ##### 19:10:29 INFO - Running pre-action listener: _resource_record_pre_action 19:10:29 INFO - Running main action method: clobber 19:10:29 INFO - rmtree: /builds/slave/test/build 19:10:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:10:30 INFO - Running post-action listener: _resource_record_post_action 19:10:30 INFO - ##### 19:10:30 INFO - ##### Finished clobber step (success) 19:10:30 INFO - ##### 19:10:30 INFO - ##### 19:10:30 INFO - ##### Running read-buildbot-config step. 19:10:30 INFO - ##### 19:10:30 INFO - Running pre-action listener: _resource_record_pre_action 19:10:30 INFO - Running main action method: read_buildbot_config 19:10:30 INFO - Using buildbot properties: 19:10:30 INFO - { 19:10:30 INFO - "project": "", 19:10:30 INFO - "product": "firefox", 19:10:30 INFO - "script_repo_revision": "production", 19:10:30 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:10:30 INFO - "repository": "", 19:10:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:10:30 INFO - "buildid": "20160610163005", 19:10:30 INFO - "pgo_build": "True", 19:10:30 INFO - "basedir": "/builds/slave/test", 19:10:30 INFO - "buildnumber": 1086, 19:10:30 INFO - "slavename": "talos-linux64-ix-040", 19:10:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:10:30 INFO - "platform": "ubuntu64_hw", 19:10:30 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:10:30 INFO - "branch": "mozilla-inbound", 19:10:30 INFO - "repo_path": "integration/mozilla-inbound", 19:10:30 INFO - "revision": "8d51d4e1930f5df3d99e714513400b7e76a90306", 19:10:30 INFO - "stage_platform": "linux64-pgo", 19:10:30 INFO - "builduid": "f8f0c5bd7cc646cab024f7fefb3ef2c8", 19:10:30 INFO - "slavebuilddir": "test" 19:10:30 INFO - } 19:10:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:10:30 INFO - Running post-action listener: _resource_record_post_action 19:10:30 INFO - ##### 19:10:30 INFO - ##### Finished read-buildbot-config step (success) 19:10:30 INFO - ##### 19:10:30 INFO - ##### 19:10:30 INFO - ##### Running download-and-extract step. 19:10:30 INFO - ##### 19:10:30 INFO - Running pre-action listener: _resource_record_pre_action 19:10:30 INFO - Running main action method: download_and_extract 19:10:30 INFO - mkdir: /builds/slave/test/build/tests 19:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:30 INFO - https://queue.taskcluster.net/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:10:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:10:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:10:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/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 19:10:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/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 19:10:41 INFO - Downloaded 1361 bytes. 19:10:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:10:41 INFO - Using the following test package requirements: 19:10:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:10:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:10:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:41 INFO - u'jsshell-linux-x86_64.zip'], 19:10:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:10:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:10:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:10:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:10:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:10:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:41 INFO - https://queue.taskcluster.net/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:10:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:10:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/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 19:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/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 19:10:45 INFO - Downloaded 24465277 bytes. 19:10:45 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'] 19:10:45 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 19:10:46 INFO - Return code: 0 19:10:46 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 19:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:46 INFO - https://queue.taskcluster.net/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:10:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:10:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/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 19:10:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/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 19:10:58 INFO - Downloaded 24465277 bytes. 19:10:58 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'] 19:10:58 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 19:11:00 INFO - Return code: 0 19:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:00 INFO - https://queue.taskcluster.net/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:11:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/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 19:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/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 19:11:02 INFO - Downloaded 10833377 bytes. 19:11:02 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'] 19:11:02 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 19:11:02 INFO - Return code: 0 19:11: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')]} 19:11:02 INFO - https://queue.taskcluster.net/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:11:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/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 19:11:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YhsHP_GGSj6eYShKSvkUpA/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 19:11:04 INFO - Downloaded 59316563 bytes. 19:11:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:04 INFO - mkdir: /builds/slave/test/properties 19:11:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:11:04 INFO - Writing to file /builds/slave/test/properties/build_url 19:11:04 INFO - Contents: 19:11:04 INFO - build_url:https://queue.taskcluster.net/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:05 INFO - Running post-action listener: _resource_record_post_action 19:11:05 INFO - Running post-action listener: set_extra_try_arguments 19:11:05 INFO - ##### 19:11:05 INFO - ##### Finished download-and-extract step (success) 19:11:05 INFO - ##### 19:11:05 INFO - ##### 19:11:05 INFO - ##### Running populate-webroot step. 19:11:05 INFO - ##### 19:11:05 INFO - Running pre-action listener: _resource_record_pre_action 19:11:05 INFO - Running main action method: populate_webroot 19:11:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:05 INFO - '--tppagecycles', 19:11:05 INFO - '7'], 19:11:05 INFO - 'tests': ['tsvgm']}}, 19:11:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:11:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:11:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:11:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:11:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:05 INFO - 'talos_options': ['--disable-e10s'], 19:11:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:05 INFO - 'talos_options': ['--disable-e10s'], 19:11:05 INFO - 'tests': ['damp', 'tps']}, 19:11:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:05 INFO - 'tests': ['damp', 'tps']}, 19:11:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:11:05 INFO - 'tests': ['dromaeo_dom']}, 19:11:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:11:05 INFO - 'tests': ['a11yr', 19:11:05 INFO - 'ts_paint', 19:11:05 INFO - 'tpaint', 19:11:05 INFO - 'sessionrestore', 19:11:05 INFO - 'sessionrestore_no_auto_restore', 19:11:05 INFO - 'tabpaint']}, 19:11:05 INFO - 'other-e10s': {'tests': ['a11yr', 19:11:05 INFO - 'ts_paint', 19:11:05 INFO - 'tpaint', 19:11:05 INFO - 'sessionrestore', 19:11:05 INFO - 'sessionrestore_no_auto_restore', 19:11:05 INFO - 'tabpaint']}, 19:11:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:11:05 INFO - 'ts_paint', 19:11:05 INFO - 'tpaint', 19:11:05 INFO - 'sessionrestore', 19:11:05 INFO - 'sessionrestore_no_auto_restore', 19:11:05 INFO - 'tabpaint']}, 19:11:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:11:05 INFO - 'ts_paint', 19:11:05 INFO - 'tpaint', 19:11:05 INFO - 'sessionrestore', 19:11:05 INFO - 'sessionrestore_no_auto_restore', 19:11:05 INFO - 'tabpaint']}, 19:11:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:11:05 INFO - 'tests': ['a11yr', 19:11:05 INFO - 'ts_paint', 19:11:05 INFO - 'tpaint', 19:11:05 INFO - 'sessionrestore', 19:11:05 INFO - 'sessionrestore_no_auto_restore', 19:11:05 INFO - 'tabpaint']}, 19:11:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:11:05 INFO - 'tests': ['a11yr', 19:11:05 INFO - 'ts_paint', 19:11:05 INFO - 'tpaint', 19:11:05 INFO - 'sessionrestore', 19:11:05 INFO - 'sessionrestore_no_auto_restore', 19:11:05 INFO - 'tabpaint']}, 19:11:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:11:05 INFO - 'tests': ['tsvgx', 19:11:05 INFO - 'tsvgr_opacity', 19:11:05 INFO - 'tart', 19:11:05 INFO - 'tscrollx', 19:11:05 INFO - 'cart']}, 19:11:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:11:05 INFO - 'tsvgr_opacity', 19:11:05 INFO - 'tart', 19:11:05 INFO - 'tscrollx', 19:11:05 INFO - 'cart']}, 19:11:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:05 INFO - 'talos_options': ['--disable-e10s'], 19:11:05 INFO - 'tests': ['tp5o']}, 19:11:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:05 INFO - 'tests': ['tp5o']}, 19:11:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:05 INFO - 'talos_options': ['--disable-e10s', 19:11:05 INFO - '--xperf_path', 19:11:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:05 INFO - 'tests': ['tp5n']}, 19:11:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:05 INFO - 'talos_options': ['--xperf_path', 19:11:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:05 INFO - 'tests': ['tp5n']}}, 19:11:05 INFO - 'talos.zip': {'path': '', 19:11:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:05 INFO - Running post-action listener: _resource_record_post_action 19:11:05 INFO - ##### 19:11:05 INFO - ##### Finished populate-webroot step (success) 19:11:05 INFO - ##### 19:11:05 INFO - ##### 19:11:05 INFO - ##### Running create-virtualenv step. 19:11:05 INFO - ##### 19:11:05 INFO - Running pre-action listener: _resource_record_pre_action 19:11:05 INFO - Running main action method: create_virtualenv 19:11:05 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:05 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 19:11:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:05 INFO - Using real prefix '/usr' 19:11:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:06 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:08 INFO - Installing pip.................done. 19:11:08 INFO - Return code: 0 19:11:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11:08 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')]} 19:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:08 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')]} 19:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:08 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 0x7f6d1fe1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', '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 19:11:08 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 19:11:08 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 19:11:08 INFO - Using env: {'DISPLAY': ':0', 19:11:08 INFO - 'HOME': '/home/cltbld', 19:11:08 INFO - 'LANG': 'en_US.UTF-8', 19:11:08 INFO - 'LANGUAGE': 'en_US:en', 19:11:08 INFO - 'LOGNAME': 'cltbld', 19:11:08 INFO - 'MAIL': '/var/mail/cltbld', 19:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:08 INFO - 'MOZ_NO_REMOTE': '1', 19:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:08 INFO - 'NO_EM_RESTART': '1', 19:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:08 INFO - 'PWD': '/builds/slave/test', 19:11:08 INFO - 'SHELL': '/bin/bash', 19:11:08 INFO - 'SHLVL': '1', 19:11:08 INFO - 'TERM': 'linux', 19:11:08 INFO - 'TMOUT': '86400', 19:11:08 INFO - 'USER': 'cltbld', 19:11:08 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:08 INFO - '_': '/tools/buildbot/bin/python'} 19:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:08 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 19:11:08 INFO - Cleaning up... 19:11:08 INFO - Return code: 0 19:11:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:11:08 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')]} 19:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:08 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')]} 19:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:08 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 0x7f6d1fe1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', '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 19:11:08 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 19:11:08 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 19:11:08 INFO - Using env: {'DISPLAY': ':0', 19:11:08 INFO - 'HOME': '/home/cltbld', 19:11:08 INFO - 'LANG': 'en_US.UTF-8', 19:11:08 INFO - 'LANGUAGE': 'en_US:en', 19:11:08 INFO - 'LOGNAME': 'cltbld', 19:11:08 INFO - 'MAIL': '/var/mail/cltbld', 19:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:08 INFO - 'MOZ_NO_REMOTE': '1', 19:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:08 INFO - 'NO_EM_RESTART': '1', 19:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:08 INFO - 'PWD': '/builds/slave/test', 19:11:08 INFO - 'SHELL': '/bin/bash', 19:11:08 INFO - 'SHLVL': '1', 19:11:08 INFO - 'TERM': 'linux', 19:11:08 INFO - 'TMOUT': '86400', 19:11:08 INFO - 'USER': 'cltbld', 19:11:08 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:08 INFO - '_': '/tools/buildbot/bin/python'} 19:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:08 INFO - Downloading/unpacking psutil>=3.1.1 19:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:10 INFO - Installing collected packages: psutil 19:11:10 INFO - Running setup.py install for psutil 19:11:10 INFO - building 'psutil._psutil_linux' extension 19:11:10 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 19:11:10 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 19:11:10 INFO - building 'psutil._psutil_posix' extension 19:11:10 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 19:11:11 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 19:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:11 INFO - Successfully installed psutil 19:11:11 INFO - Cleaning up... 19:11:11 INFO - Return code: 0 19:11:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:11 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 0x7f6d1fe1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', '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 19:11:11 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 19:11:11 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 19:11:11 INFO - Using env: {'DISPLAY': ':0', 19:11:11 INFO - 'HOME': '/home/cltbld', 19:11:11 INFO - 'LANG': 'en_US.UTF-8', 19:11:11 INFO - 'LANGUAGE': 'en_US:en', 19:11:11 INFO - 'LOGNAME': 'cltbld', 19:11:11 INFO - 'MAIL': '/var/mail/cltbld', 19:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:11 INFO - 'MOZ_NO_REMOTE': '1', 19:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:11 INFO - 'NO_EM_RESTART': '1', 19:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:11 INFO - 'PWD': '/builds/slave/test', 19:11:11 INFO - 'SHELL': '/bin/bash', 19:11:11 INFO - 'SHLVL': '1', 19:11:11 INFO - 'TERM': 'linux', 19:11:11 INFO - 'TMOUT': '86400', 19:11:11 INFO - 'USER': 'cltbld', 19:11:11 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:11 INFO - '_': '/tools/buildbot/bin/python'} 19:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11: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 19:11:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:11:13 INFO - Installing collected packages: mozsystemmonitor 19:11:13 INFO - Running setup.py install for mozsystemmonitor 19:11:13 INFO - Successfully installed mozsystemmonitor 19:11:13 INFO - Cleaning up... 19:11:13 INFO - Return code: 0 19:11:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:11:13 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')]} 19:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:13 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')]} 19:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:13 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 0x7f6d1fe1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', '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 19:11:13 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 19:11:13 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 19:11:13 INFO - Using env: {'DISPLAY': ':0', 19:11:13 INFO - 'HOME': '/home/cltbld', 19:11:13 INFO - 'LANG': 'en_US.UTF-8', 19:11:13 INFO - 'LANGUAGE': 'en_US:en', 19:11:13 INFO - 'LOGNAME': 'cltbld', 19:11:13 INFO - 'MAIL': '/var/mail/cltbld', 19:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:13 INFO - 'MOZ_NO_REMOTE': '1', 19:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:13 INFO - 'NO_EM_RESTART': '1', 19:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:13 INFO - 'PWD': '/builds/slave/test', 19:11:13 INFO - 'SHELL': '/bin/bash', 19:11:13 INFO - 'SHLVL': '1', 19:11:13 INFO - 'TERM': 'linux', 19:11:13 INFO - 'TMOUT': '86400', 19:11:13 INFO - 'USER': 'cltbld', 19:11:13 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:13 INFO - '_': '/tools/buildbot/bin/python'} 19:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:13 INFO - Downloading/unpacking jsonschema==2.5.1 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 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 19:11:13 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 19:11:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:11:15 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 19:11:15 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 19:11:15 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 19:11:15 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 19:11:15 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 19:11:15 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 19:11:15 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:15 INFO - warning: no files found matching '*.txt' 19:11:15 INFO - no previously-included directories found matching 'build' 19:11:15 INFO - no previously-included directories found matching 'dist' 19:11:15 INFO - no previously-included directories found matching '.git*' 19:11:15 INFO - Installing collected packages: jsonschema, functools32 19:11:15 INFO - Running setup.py install for functools32 19:11:15 INFO - warning: no files found matching '*.txt' 19:11:15 INFO - no previously-included directories found matching 'build' 19:11:15 INFO - no previously-included directories found matching 'dist' 19:11:15 INFO - no previously-included directories found matching '.git*' 19:11:15 INFO - Successfully installed jsonschema functools32 19:11:15 INFO - Cleaning up... 19:11:16 INFO - Return code: 0 19:11:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6d1fe1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', '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 19:11:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:11:16 INFO - Using env: {'DISPLAY': ':0', 19:11:16 INFO - 'HOME': '/home/cltbld', 19:11:16 INFO - 'LANG': 'en_US.UTF-8', 19:11:16 INFO - 'LANGUAGE': 'en_US:en', 19:11:16 INFO - 'LOGNAME': 'cltbld', 19:11:16 INFO - 'MAIL': '/var/mail/cltbld', 19:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:16 INFO - 'MOZ_NO_REMOTE': '1', 19:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:16 INFO - 'NO_EM_RESTART': '1', 19:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:16 INFO - 'PWD': '/builds/slave/test', 19:11:16 INFO - 'SHELL': '/bin/bash', 19:11:16 INFO - 'SHLVL': '1', 19:11:16 INFO - 'TERM': 'linux', 19:11:16 INFO - 'TMOUT': '86400', 19:11:16 INFO - 'USER': 'cltbld', 19:11:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:16 INFO - '_': '/tools/buildbot/bin/python'} 19:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:16 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:16 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 19:11:16 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 19:11:16 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 19:11:16 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 19:11:16 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 19:11:16 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 19:11:18 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:11:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:18 INFO - Downloading docopt-0.6.1.tar.gz 19:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:18 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:18 INFO - Running setup.py install for blobuploader 19:11:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:11:18 INFO - Running setup.py install for requests 19:11:19 INFO - Running setup.py install for docopt 19:11:19 INFO - Successfully installed blobuploader requests docopt 19:11:19 INFO - Cleaning up... 19:11:19 INFO - Return code: 0 19:11:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:19 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 0x7f6d1fe1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', '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 19:11:19 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 19:11:19 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 19:11:19 INFO - Using env: {'DISPLAY': ':0', 19:11:19 INFO - 'HOME': '/home/cltbld', 19:11:19 INFO - 'LANG': 'en_US.UTF-8', 19:11:19 INFO - 'LANGUAGE': 'en_US:en', 19:11:19 INFO - 'LOGNAME': 'cltbld', 19:11:19 INFO - 'MAIL': '/var/mail/cltbld', 19:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:19 INFO - 'MOZ_NO_REMOTE': '1', 19:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:19 INFO - 'NO_EM_RESTART': '1', 19:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:19 INFO - 'PWD': '/builds/slave/test', 19:11:19 INFO - 'SHELL': '/bin/bash', 19:11:19 INFO - 'SHLVL': '1', 19:11:19 INFO - 'TERM': 'linux', 19:11:19 INFO - 'TMOUT': '86400', 19:11:19 INFO - 'USER': 'cltbld', 19:11:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:19 INFO - '_': '/tools/buildbot/bin/python'} 19:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:19 INFO - Running setup.py (path:/tmp/pip-Z_sxvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:19 INFO - Running setup.py (path:/tmp/pip-uaL7At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:19 INFO - Running setup.py (path:/tmp/pip-VK3ZXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:19 INFO - Running setup.py (path:/tmp/pip-Fipytn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:20 INFO - Running setup.py (path:/tmp/pip-QEm0tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:20 INFO - Running setup.py (path:/tmp/pip-Dnger1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:20 INFO - Running setup.py (path:/tmp/pip-XSko6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:20 INFO - Running setup.py (path:/tmp/pip-8idLG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:20 INFO - Running setup.py (path:/tmp/pip-3nyU2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:20 INFO - Running setup.py (path:/tmp/pip-9W7fyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:20 INFO - Running setup.py (path:/tmp/pip-JcAbKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:20 INFO - Running setup.py (path:/tmp/pip-cvmRmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:20 INFO - Running setup.py (path:/tmp/pip-lDPyBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:20 INFO - Running setup.py (path:/tmp/pip-8fbWbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:20 INFO - Running setup.py (path:/tmp/pip-bXtqKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:20 INFO - Running setup.py (path:/tmp/pip-IIFknk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:20 INFO - Running setup.py (path:/tmp/pip-NBBOIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:20 INFO - Running setup.py install for manifestparser 19:11:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:21 INFO - Running setup.py install for mozcrash 19:11:21 INFO - Running setup.py install for mozdebug 19:11:21 INFO - Running setup.py install for mozdevice 19:11:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:11:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:21 INFO - Running setup.py install for mozfile 19:11:21 INFO - Running setup.py install for mozhttpd 19:11:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:21 INFO - Running setup.py install for mozinfo 19:11:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:21 INFO - Running setup.py install for mozInstall 19:11:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:21 INFO - Running setup.py install for mozleak 19:11:21 INFO - Running setup.py install for mozlog 19:11:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:21 INFO - Running setup.py install for moznetwork 19:11:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:22 INFO - Running setup.py install for mozprocess 19:11:22 INFO - Running setup.py install for mozprofile 19:11:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:22 INFO - Running setup.py install for mozrunner 19:11:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:22 INFO - Running setup.py install for mozscreenshot 19:11:22 INFO - Running setup.py install for moztest 19:11:22 INFO - Running setup.py install for mozversion 19:11:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:22 INFO - Cleaning up... 19:11:22 INFO - Return code: 0 19:11:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:22 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 0x7f6d1fe1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', '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 19:11:22 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 19:11:22 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 19:11:22 INFO - Using env: {'DISPLAY': ':0', 19:11:22 INFO - 'HOME': '/home/cltbld', 19:11:22 INFO - 'LANG': 'en_US.UTF-8', 19:11:22 INFO - 'LANGUAGE': 'en_US:en', 19:11:22 INFO - 'LOGNAME': 'cltbld', 19:11:22 INFO - 'MAIL': '/var/mail/cltbld', 19:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:22 INFO - 'MOZ_NO_REMOTE': '1', 19:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:22 INFO - 'NO_EM_RESTART': '1', 19:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:22 INFO - 'PWD': '/builds/slave/test', 19:11:22 INFO - 'SHELL': '/bin/bash', 19:11:22 INFO - 'SHLVL': '1', 19:11:22 INFO - 'TERM': 'linux', 19:11:22 INFO - 'TMOUT': '86400', 19:11:22 INFO - 'USER': 'cltbld', 19:11:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:22 INFO - '_': '/tools/buildbot/bin/python'} 19:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:22 INFO - Running setup.py (path:/tmp/pip-RVuX1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:23 INFO - Running setup.py (path:/tmp/pip-dRDWIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:23 INFO - Running setup.py (path:/tmp/pip-ih0ZFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:23 INFO - Running setup.py (path:/tmp/pip-9QGv4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:23 INFO - Running setup.py (path:/tmp/pip-570dRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:23 INFO - Running setup.py (path:/tmp/pip-fhpvGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:23 INFO - Running setup.py (path:/tmp/pip-GjwNev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:23 INFO - Running setup.py (path:/tmp/pip-i__ipy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:23 INFO - Running setup.py (path:/tmp/pip-ndLQ3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:23 INFO - Running setup.py (path:/tmp/pip-iCclIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:23 INFO - Running setup.py (path:/tmp/pip-5vDgYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:23 INFO - Running setup.py (path:/tmp/pip-zvHuu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:23 INFO - Running setup.py (path:/tmp/pip-ya6RDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:23 INFO - Running setup.py (path:/tmp/pip-aAJszZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:23 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)) 19:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:23 INFO - Running setup.py (path:/tmp/pip-naQPuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:24 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)) 19:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:24 INFO - Running setup.py (path:/tmp/pip-XmyiCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:24 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)) 19:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:24 INFO - Running setup.py (path:/tmp/pip-QpF2E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:24 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)) 19:11:24 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)) 19:11:24 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)) 19:11:24 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)) 19:11:24 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)) 19:11:24 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)) 19:11:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:26 INFO - Downloading blessings-1.6.tar.gz 19:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:26 INFO - Installing collected packages: blessings 19:11:26 INFO - Running setup.py install for blessings 19:11:26 INFO - Successfully installed blessings 19:11:26 INFO - Cleaning up... 19:11:26 INFO - Return code: 0 19:11:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:26 INFO - Reading from file tmpfile_stdout 19:11:26 INFO - Current package versions: 19:11:26 INFO - argparse == 1.2.1 19:11:26 INFO - blessings == 1.6 19:11:26 INFO - blobuploader == 1.2.4 19:11:26 INFO - docopt == 0.6.1 19:11:26 INFO - functools32 == 3.2.3-2 19:11:26 INFO - jsonschema == 2.5.1 19:11:26 INFO - manifestparser == 1.1 19:11:26 INFO - mozInstall == 1.12 19:11:26 INFO - mozcrash == 0.17 19:11:26 INFO - mozdebug == 0.1 19:11:26 INFO - mozdevice == 0.48 19:11:26 INFO - mozfile == 1.2 19:11:26 INFO - mozhttpd == 0.7 19:11:26 INFO - mozinfo == 0.9 19:11:26 INFO - mozleak == 0.1 19:11:26 INFO - mozlog == 3.2 19:11:26 INFO - moznetwork == 0.27 19:11:26 INFO - mozprocess == 0.22 19:11:26 INFO - mozprofile == 0.28 19:11:26 INFO - mozrunner == 6.11 19:11:26 INFO - mozscreenshot == 0.1 19:11:26 INFO - mozsystemmonitor == 0.3 19:11:26 INFO - moztest == 0.7 19:11:26 INFO - mozversion == 1.4 19:11:26 INFO - psutil == 3.1.1 19:11:26 INFO - requests == 1.2.3 19:11:26 INFO - wsgiref == 0.1.2 19:11:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:26 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 0x7f6d1fe1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', '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 19:11:26 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 19:11:26 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 19:11:26 INFO - Using env: {'DISPLAY': ':0', 19:11:26 INFO - 'HOME': '/home/cltbld', 19:11:26 INFO - 'LANG': 'en_US.UTF-8', 19:11:26 INFO - 'LANGUAGE': 'en_US:en', 19:11:26 INFO - 'LOGNAME': 'cltbld', 19:11:26 INFO - 'MAIL': '/var/mail/cltbld', 19:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:26 INFO - 'MOZ_NO_REMOTE': '1', 19:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:26 INFO - 'NO_EM_RESTART': '1', 19:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:26 INFO - 'PWD': '/builds/slave/test', 19:11:26 INFO - 'SHELL': '/bin/bash', 19:11:26 INFO - 'SHLVL': '1', 19:11:26 INFO - 'TERM': 'linux', 19:11:26 INFO - 'TMOUT': '86400', 19:11:26 INFO - 'USER': 'cltbld', 19:11:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:26 INFO - '_': '/tools/buildbot/bin/python'} 19:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:26 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)) 19:11:26 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)) 19:11:26 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)) 19:11:26 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)) 19:11:26 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)) 19:11:26 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)) 19:11:26 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)) 19:11:26 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)) 19:11:26 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)) 19:11:26 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)) 19:11:26 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)) 19:11:26 INFO - Cleaning up... 19:11:26 INFO - Return code: 0 19:11:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:26 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 0x7f6d1fe1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', '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 19:11:26 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 19:11:26 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 19:11:26 INFO - Using env: {'DISPLAY': ':0', 19:11:26 INFO - 'HOME': '/home/cltbld', 19:11:26 INFO - 'LANG': 'en_US.UTF-8', 19:11:26 INFO - 'LANGUAGE': 'en_US:en', 19:11:26 INFO - 'LOGNAME': 'cltbld', 19:11:26 INFO - 'MAIL': '/var/mail/cltbld', 19:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:26 INFO - 'MOZ_NO_REMOTE': '1', 19:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:26 INFO - 'NO_EM_RESTART': '1', 19:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:26 INFO - 'PWD': '/builds/slave/test', 19:11:26 INFO - 'SHELL': '/bin/bash', 19:11:26 INFO - 'SHLVL': '1', 19:11:26 INFO - 'TERM': 'linux', 19:11:26 INFO - 'TMOUT': '86400', 19:11:26 INFO - 'USER': 'cltbld', 19:11:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:26 INFO - '_': '/tools/buildbot/bin/python'} 19:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:11:26 INFO - Cleaning up... 19:11:26 INFO - Return code: 0 19:11:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:26 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 0x7f6d1fe1df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', '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 19:11:26 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 19:11:26 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 19:11:26 INFO - Using env: {'DISPLAY': ':0', 19:11:26 INFO - 'HOME': '/home/cltbld', 19:11:26 INFO - 'LANG': 'en_US.UTF-8', 19:11:26 INFO - 'LANGUAGE': 'en_US:en', 19:11:26 INFO - 'LOGNAME': 'cltbld', 19:11:26 INFO - 'MAIL': '/var/mail/cltbld', 19:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:26 INFO - 'MOZ_NO_REMOTE': '1', 19:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:26 INFO - 'NO_EM_RESTART': '1', 19:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:26 INFO - 'PWD': '/builds/slave/test', 19:11:26 INFO - 'SHELL': '/bin/bash', 19:11:26 INFO - 'SHLVL': '1', 19:11:26 INFO - 'TERM': 'linux', 19:11:26 INFO - 'TMOUT': '86400', 19:11:26 INFO - 'USER': 'cltbld', 19:11:26 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:26 INFO - '_': '/tools/buildbot/bin/python'} 19:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:27 INFO - Downloading/unpacking flake8 19:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:11:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:11:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:11:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:29 INFO - no previously-included directories found matching 'docs/_build' 19:11:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:11:29 INFO - Running setup.py install for pep8 19:11:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:11:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:11:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:11:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:11:29 INFO - no previously-included directories found matching 'docs/_build' 19:11:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:11:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:11:29 INFO - Cleaning up... 19:11:30 INFO - Return code: 0 19:11:30 INFO - Running post-action listener: _resource_record_post_action 19:11:30 INFO - Running post-action listener: _start_resource_monitoring 19:11:30 INFO - Starting resource monitoring. 19:11:30 INFO - ##### 19:11:30 INFO - ##### Finished create-virtualenv step (success) 19:11:30 INFO - ##### 19:11:30 INFO - ##### 19:11:30 INFO - ##### Running install step. 19:11:30 INFO - ##### 19:11:30 INFO - Running pre-action listener: _resource_record_pre_action 19:11:30 INFO - Running main action method: install 19:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:30 INFO - Reading from file tmpfile_stdout 19:11:30 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:30 INFO - Reading from file tmpfile_stdout 19:11:30 INFO - Output received: 19:11:30 INFO - Usage: mozinstall [options] installer 19:11:30 INFO - Options: 19:11:30 INFO - -h, --help show this help message and exit 19:11:30 INFO - -d DEST, --destination=DEST 19:11:30 INFO - Directory to install application into. [default: 19:11:30 INFO - "/builds/slave/test"] 19:11:30 INFO - --app=APP Application being installed. [default: firefox] 19:11:30 INFO - mkdir: /builds/slave/test/build/application 19:11:30 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'] 19:11:30 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 19:11:47 INFO - Reading from file tmpfile_stdout 19:11:47 INFO - Output received: 19:11:47 INFO - /builds/slave/test/build/application/firefox/firefox 19:11:47 INFO - Running post-action listener: _resource_record_post_action 19:11:47 INFO - ##### 19:11:47 INFO - ##### Finished install step (success) 19:11:47 INFO - ##### 19:11:47 INFO - ##### 19:11:47 INFO - ##### Running run-tests step. 19:11:47 INFO - ##### 19:11:47 INFO - Running pre-action listener: _resource_record_pre_action 19:11:47 INFO - Running main action method: run_tests 19:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:11:47 INFO - Python 2.7.3 19:11:47 INFO - Return code: 0 19:11:47 INFO - grabbing minidump binary from tooltool 19:11:47 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')]} 19:11:47 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 0x10581c0>, '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 0x10590c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:11:47 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 19:11:47 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 19:11:47 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 19:11:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:47 INFO - Return code: 0 19:11:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:11:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:11:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:11:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:11:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:11:48 INFO - Return code: 0 19:11:48 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/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 19:11:48 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/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 19:11:48 INFO - Using env: {'DISPLAY': ':0', 19:11:48 INFO - 'HOME': '/home/cltbld', 19:11:48 INFO - 'LANG': 'en_US.UTF-8', 19:11:48 INFO - 'LANGUAGE': 'en_US:en', 19:11:48 INFO - 'LOGNAME': 'cltbld', 19:11:48 INFO - 'MAIL': '/var/mail/cltbld', 19:11:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:48 INFO - 'MOZ_NO_REMOTE': '1', 19:11:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:48 INFO - 'NO_EM_RESTART': '1', 19:11:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:48 INFO - 'PWD': '/builds/slave/test', 19:11:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:48 INFO - 'SHELL': '/bin/bash', 19:11:48 INFO - 'SHLVL': '1', 19:11:48 INFO - 'TERM': 'linux', 19:11:48 INFO - 'TMOUT': '86400', 19:11:48 INFO - 'USER': 'cltbld', 19:11:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138', 19:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:48 INFO - '_': '/tools/buildbot/bin/python'} 19:11:48 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/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 19:11:48 INFO - mozversion application_buildid: 20160610163005 19:11:48 INFO - mozversion application_changeset: 8d51d4e1930f5df3d99e714513400b7e76a90306 19:11:48 INFO - mozversion application_display_name: Nightly 19:11:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:48 INFO - mozversion application_name: Firefox 19:11:48 INFO - mozversion application_remotingname: firefox 19:11:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:11:48 INFO - mozversion application_vendor: Mozilla 19:11:48 INFO - mozversion application_version: 50.0a1 19:11:48 INFO - mozversion platform_buildid: 20160610163005 19:11:48 INFO - mozversion platform_changeset: 8d51d4e1930f5df3d99e714513400b7e76a90306 19:11:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:11:48 INFO - mozversion platform_version: 50.0a1 19:11:48 INFO - using testdate: 1465611108 19:11:48 INFO - actual date: 1465611108 19:11:48 INFO - starting webserver on 'localhost:54229' 19:11:48 INFO - SUITE-START | Running 2 tests 19:11:48 INFO - TEST-START | dromaeo_css 19:11:48 INFO - operating with platform_type : linux_ 19:11:48 INFO - Initialising browser for dromaeo_css test... 19:11:48 INFO - TEST-INFO | started process 8502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUkFarZ/profile http://localhost:54229/getInfo.html) 19:11:52 INFO - PROCESS | 8502 | __metrics Screen width/height:1600/1200 19:11:52 INFO - PROCESS | 8502 | colorDepth:24 19:11:52 INFO - PROCESS | 8502 | Browser inner width/height: 1024/697 19:11:52 INFO - PROCESS | 8502 | __metrics 19:11:53 ERROR - PROCESS | 8502 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:11:53 INFO - PROCESS | 8502 | console.error: PushService: 19:11:53 INFO - PROCESS | 8502 | stateChangeProcessEnqueue: Error transitioning state 19:11:53 INFO - PROCESS | 8502 | UnknownError 19:11:54 INFO - TEST-INFO | 8502: exit 0 19:11:54 INFO - Browser initialized. 19:11:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:54 INFO - TEST-INFO | started process 8586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUkFarZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:06 INFO - PROCESS | 8586 | RSS: Main: 173842432 19:12:06 INFO - PROCESS | 8586 | 19:12:58 INFO - PROCESS | 8586 | 1465611178104 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] 19:15:05 INFO - PROCESS | 8586 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54229/tests/dromaeo/cssquery-ext.html) 19:15:06 INFO - PROCESS | 8586 | RSS: Main: 269058048 19:15:06 INFO - PROCESS | 8586 | 19:18:09 INFO - PROCESS | 8586 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-ext.html (next: http://localhost:54229/tests/dromaeo/cssquery-jquery.html) 19:18:09 INFO - PROCESS | 8586 | RSS: Main: 257798144 19:18:09 INFO - PROCESS | 8586 | 19:21:11 INFO - PROCESS | 8586 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54229/tests/dromaeo/cssquery-mootools.html) 19:21:12 INFO - PROCESS | 8586 | RSS: Main: 255115264 19:21:12 INFO - PROCESS | 8586 | 19:24:14 INFO - PROCESS | 8586 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54229/tests/dromaeo/cssquery-prototype.html) 19:24:14 INFO - PROCESS | 8586 | RSS: Main: 253153280 19:24:14 INFO - PROCESS | 8586 | 19:27:17 INFO - PROCESS | 8586 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54229/tests/dromaeo/cssquery-yui.html) 19:27:18 INFO - PROCESS | 8586 | RSS: Main: 244056064 19:27:18 INFO - PROCESS | 8586 | 19:30:21 INFO - PROCESS | 8586 | Cycle 1(1): loaded http://localhost:54229/tests/dromaeo/cssquery-yui.html (next: http://localhost:54229/tests/dromaeo/cssquery-dojo.html) 19:30:21 INFO - PROCESS | 8586 | RSS: Main: 282173440 19:30:21 INFO - PROCESS | 8586 | 19:30:21 INFO - PROCESS | 8586 | __start_tp_report 19:30:21 INFO - PROCESS | 8586 | _x_x_mozilla_page_load 19:30:21 INFO - PROCESS | 8586 | _x_x_mozilla_page_load_details 19:30:21 INFO - PROCESS | 8586 | |i|pagename|runs| 19:30:21 INFO - PROCESS | 8586 | |0;dojo.html;3047.6952304769525;3057.7400920921737;3072.8309942953138;3094.4120617082767;3115.43922094023;5079.212722028083;5140.460251673567;5217.452167522408;5327.413984461706;5338.759755810988;5269.947300526994;5282.154855223165;5288.524032837044;5307.973460132704;5350.384705758839;4714.9528504714945;4786.2581299898575;4831.420229572456;4836.41962964443;4978.178600530908;4786.880327991793;4793.976030119845;4822.541858523452;4847.200211965039;4879.316895634614;4680.859574212762;4789.377380940473;4798.424189097295;4812.109759694467;4877.195262781619;4806.158922188638;4817.156997525419;4881.658283920092;4885.535874091991;4929.531694489017;4725.432948046257;4823.951760482385;4845.781939812717;4851.417829860439;4885.804567817283;5227.555657769056;5310.0441920454305;5336.866578335573;5401.621886467949;5405.243265942732;5699.230603868507;5707.029804933171;5726.141078838166;5731.856703582402;5732.398098199712;5534.529564986981;5592.273004509388;5774.48029677331;5787.826365209008;5790.13148027795;5262.368515778093;5316.57467402603;5365.08793505105;5368.4363141869935;5368.597355198376;5890.293164820249;5898.705064746746;5902.645841249453;5902.940970590325;5904.350521442638;5413.810516631977;5458.426865179099;5517.641353312022;5677.403872593401;5688.146777983336;5687.914681279784;5695.202671625976;5696.259486266758;5738.885222295531;5751.252337196138;5660.782931669711;5674.1488776683;5674.319081710139;5679.602427830095;5680.176374425685;5466.34403871538;5611.102223644198;5668.093105103246;5675.971620141873;5686.886262274814;4346.36977638247;4371.213181627338;4375.78121093944;4376.277914144131;4408.382826404306;3920.666743326792;3932.2528719543197;3939.8227079781477;3973.205358928226;4005.8998525036523;5128.897422051538;5132.101882170605;5258.894822103536;5282.894342113136;5295.708736019479;5668.178114173505;5676.801311954062;5681.204631351614;5681.687507187145;5723.141528770718;5316.468353164652;5316.680999140064;5321.308229930084;5326.866828329323;5372.91940620891;4714.599259062949;4893.314935908976;4944;4945.604351651859;4974.477679843637;5898.8820223595285;5900.20347253124;5902.970485147633;5914.172015917775;5914.763409463573;5440.972795135999;5720.998825205489;5734.655920644775;5736.225609542826;5738.512226460631;5743.052396354722;5771.855703607275;5779.739911703899;5856.853578660568;5912.172295878667;5574.136008918624;5574.888502229852;5576.247206627054;5579.497845193952;5586.497215250647;5453.045716999589;5665.093585026376;5676.858078548069;5677;5680.545556355564;5436.157395603688;5495.972520137374;5496.80761173357;5535.086710692691;5540.002799496129;5453.1547610118905;5505.532029777513;5514.696691681996;5519.69641669712;5523.696196709219;5189.532942035235;5301.125314323093;5396.865078372915;5430.9185362218805;5479.205515200194;5520.447955204448;5608.046632072476;5609.831705048855;5610.158476228435;5610.775568977195;5379.220013098157;5410.1343784994215;5411.107167317506;5413.7834486620095;5422.701751403711 19:30:21 INFO - PROCESS | 8586 | |1;ext.html;607.7842365960084;633.5596760251627;634.235745926159;640.9134766806479;655.8065370715639;32010.839945800268;35285;35321.64678353216;35350.46974295384;42198;41300.173996520054;45461.99999999992;45614.543854561445;45630.31554526685;45732.31401528972;8913.955430222855;9060.320475964296;9062.592183351731;9062.773430664252;9068.047854975232;8725.171108744658;8780.121987801233;8826;8826.646934122627;8827.867581986275;8981.865272020925;8996.325275604357;8996.730098097067;9017.549122543847;9020.503872287054;8925.866112008325;8953.865692014626;8965.058668839776;8967.237784788302;8977.730668079936;8878;8964.462132272085;8973.955130224307;8993.460392376413;8994.370394072417;39054;39334.60665393338;39392.80303598492;39426.60573394258;39449.60550394488;3511.613722490524;3580.104973756561;3581.8746343877838;3822.4648549203134;3942.2903877302074;32984.52821530815;33191.83404082964;33452.6654733452;33605;33665.831670841486;4346.673999450054;4414.933775993362;4432.889177770549;4527.818887244506;4585.58729714324;316103;316144;316945;319045;319198;57922.4207757917;58194.7090264546;58354;58589;58612;49206.75396622994;49379.25931111036;49481.752591236815;49491.50508494941;49537;15670.764938525932;15704.528864134094;15842.287097080429;15882.364705411885;15884.126373049594;11576.710582235512;11595.710107247218;11649.184557080924;11678.299302041905;11681.415929203506;16222.51332460028;18202.817971820376;18225.63548729018;18278.360257391192;18334.54163645893;6194.225721784777;6268.03958972112;6473.967630161819;6525.89059859825;6648.8670226595195;795.7970717467009;863.87905693203;912.3248795891126;1051.942143182117;1061.442742560162;32441.675583243865;32502;32930.34139317248;33059.66940330614;33168.839090632195;1090.3839330778085;1185.5257896841333;1201.3993003498251;1225.5955534673537;1266.2782214138037;17262.395816146625;17352.739708904377;17433.389831355842;17442.215100320514;17466.485525343178;473272;473605;474887;475196;476398;58297.417025830044;58350.7082464585;58433.70783146057;58734.70632646809;58869.70565147147;1160.988390116105;1172.5544293168712;1172.5602898912907;1266.5883587833991;1282.0576875996135;29844;31291.84354078215;31515;31803.681963180996;31866.522002170448;45063.774681127696;54187.45812541824;55922.72038639781;56048.719756402585;61437.385626143165;440361;441970;444409;445761;447129;26135.954561818075;27845.303867403476;28193.295167620152;28898.422031559672;29448.091078418645;48811.755941220064;49081.75459122682;49241.75379123082;49468.75265623649;50066.49933500764;40782;41625.58374416217;42141;42182.578174219096;42801.785991069846;40622.59377406306;40832.591674082876;41101.79449102735;41345;42064.78967605143;40940.59059409368;41228.79385603053;41510.377344340464;42066.57933420627;42905.57094429016;27987.72012279851;29211;29256.56115158317;29257;29590;27341.589876151476;27425.31436714098;27445.039423620077;27631.861840690668;27641.861790690917 19:30:21 INFO - PROCESS | 8586 | |2;jquery.html;403.71336351190655;403.967682585393;404.91294371710075;407.2262700868351;426.31150691633;17701.645967080665;19023;19517.121729522187;19548.31580894667;20036.799632003676;16827.91586042071;17502.387416440426;17508.82491175088;18955.62088758224;19262.13320400582;5246.239295302188;5321.733913304339;5376.596755243353;5381.650192737479;5406.432324605899;5135.2040433732645;5202.739863006854;5260.368755749316;5282.154855223165;5338.145896656536;5207.869803254911;5250.501202385767;5251.55361794248;5287.735613219343;5290.55030322423;5180;5277;5279.472052794728;5296.364436267634;5302.09864323066;5050.84847454577;5147.356580427447;5181.948180518184;5258.447862974371;5264.947350526522;14388.13671179722;14479;15786.052836829713;22831.543369132523;23118.42203944898;2286.4626812699003;2325.093213646679;2435.2450740270574;2484.701835779718;2769.584562315649;10266.7433314167;10443.738906527322;10558.472076396227;10882.945585272102;10989.560417583287;1919.2610844824703;1948.1428171604448;1952.824245817869;1966.193860517181;2002.209127394671;81241.59379203126;85525.14474855296;85741.57129214377;85930;86754;11107.888921110685;11117.722056948642;11388.487518061707;11646.534138634359;12024.819627705592;16186.352545898268;16191.190440477929;16210.432634857723;16227.971503562054;16291.918540407221;7408.222136675679;7489;7738.458307918504;7788.688452461952;7863.960680196562;7118.323759242864;7143.82140446493;7258.0927384076995;7354.521956072838;7375.856742204859;4886.877828054327;4900.387451568554;4916.861165393066;4944.752762361867;5040.243963405445;2019.686948522952;2025.2709024751077;2033.8271246944175;2061.7023175557088;2119.3747844385944;881.6209030116983;954.7279025477706;994.1698681600944;1002.3084071990303;1008.6822650864954;18298;18927.432177034712;19517.609647806963;19624.116914738872;19624.509387265432;884.6019291318804;961.5192403798101;970.6360114956891;996.3175224970918;1005.2410430125209;10395.428251446092;10776.730581735519;10963.616273430393;10970;10975;440654;445378;446367;447123;447389;59188;89919.55040224757;91273.54363228274;93546;94595;952.7951490429591;954.4559601027487;964.9096520931303;971.0774763974111;976.829054915387;16585.66828663444;16935.576610584834;17120.229589668244;17220.913895430444;17642.29430822804;29646.555301670924;38534.843954681404;40476.59523404728;41287.587124128375;41747.582524174366;55217;56959;57011.14483282837;57265.427345726006;57744.71127644335;8888.73333799987;8935.687250946186;8984.86522702173;9149;9239.815203695754;11398.316101033965;13397.263150526425;13461.798073028716;13586.660333491742;13769.931150344184;11957.728031674302;12073.75852482963;12127.514899403925;12141.453634586289;12536.310502922062;11758.529658813552;11864.22882512634;11936.10479214045;11972.880271197177;12001.579944701894;11698.122640801803;11916.940415297868;12057.51769929228;12059.57791477294;12138.575149869712;9382.390144640576;11181.440927953732;12293.692657683629;12358.876411235773;12581;11641.301521908712;11772.29172810562;12162.939185304016;12600.558980436008;12850.228986260854 19:30:21 INFO - PROCESS | 8586 | |3;mootools.html;1202.9398530073506;1331.4407948661565;1413.258039529247;1440.6110350205445;1733.3499937523436;8577.656893724252;8993;9026.50354230518;9277.90722092779;9283.350165488418;8952.283817294618;9126.680566180185;9136.588853501591;9137.497437640926;9143.588538515765;2047.907844147017;2267.1044937249776;2315.6642286868437;2346.0263990443946;2352.9176478823247;2377.3105799318178;2395.700537432821;2396.3529846941315;2406.470576473173;2407.434252950555;2247.9100835966624;2267.5804976079394;2294.300238427279;2296.70142881426;2297.115610489965;1957.031269521589;2124.3626911926513;2178.0525471419983;2178.814800741923;2190.44143743346;2297.908083676651;2301.8964146613444;2316.6061769499224;2318.5594737000083;2320.3734991552187;9194.95402522983;9252.30607704418;9257.074292570756;9260.212881905047;9265.768355791091;5150.562202212816;5268.446813084647;5274.973625131888;5284.180951952415;5289.44460831611;3066.3713938642527;3250.7074363307415;3311.536384906115;3312.850921708529;3322.684344987222;981.7644915725451;1001.1140140975217;1007.7480629842539;1017.6183931025865;1026.5996261458038;13045.217286962717;13072.86927130726;13147;13152.539661111816;13159.934200329033;4629.745364004944;4690.81236750533;4723.622110231173;4754.572088512051;4795.400574928134;10890.782184356269;10914.563417463212;10917.727056823644;10919.508622112024;10920.726981825359;5118.872028199325;5173.379194496609;5175.792968281226;5183.766730497136;5186.740662966837;4219.894502637459;4650.790714417859;4801.591864691541;4804.135255654016;4866.46468888422;4084.346504559256;4109.691773116969;4158.209940111369;4170.311898536768;4209.873703788891;1307.6730817295677;1307.843058832927;1316.6905777142365;1323.4243104249683;1329.1692692067459;857.4469467193625;875.8992715837633;910.2854259406466;922.2345453273766;941.9199368053792;5716.914246286309;5874.676892770939;5926.407359264039;6011.969940150271;6051.8487037823525;410.75560041775094;411.7673514464378;429.63481041115426;434.9913001740011;435.7407342631129;3803.866864659779;3939.487866577384;3967.900802479961;3988.74073185242;4019.979900100481;11102.2783519071;11217;11605.88394116065;11645.883541164649;11668.649940501798;11464.770704586028;11607.361595112181;11626.302421854547;11635.476403561861;11638.185327027197;8319.66721331152;8353.122922093215;8534.82930341402;8546.914530854612;8561.443506172203;5894.2926848778425;5933.584649074523;6038.396160383926;6060.939390606038;6152.78465253714;10609.89390106089;10669.679909602724;10752.247342685936;10753.946230268799;10772.353658780497;10081.69754907354;10437.112845408225;10465.058144767008;10662.306950048533;10771;7052.294770522906;7984.880226796487;8182.67269309221;8296.087430382533;8582.613782379933;8694.82610347802;8934.195922367018;9023.864642030243;9045;9046.231070359094;7733.92266077332;7985.2014798519685;8029.638666259915;8074.273315401642;8178.3457323412795;7717.073951125901;7808.141104478616;7950.761477155695;7960.659588976305;8000.6399712011935;6935.167779866449;6940.7917762467205;7009.474289428212;7057.329553692391;7086.078809754905;4654.743989080633;4694.671373003857;4722.456917454399;4746.62027037843;4948.15881300187;4856.368672072608;4890.19311813561;4977.9502204978935;5024.120778863611;5058.215976523497 19:30:21 INFO - PROCESS | 8586 | |4;prototype.html;335.1470507558264;336.0456304096366;340.6202084675586;343.1233199176104;343.7421933549838;5279.4192638809745;5283.550898173655;5284.947150528498;5291.656042357244;5294.497022782839;5201.349831271091;5216.843494695156;5241.135212689902;5246.973765131179;5247;3979.602039796012;4009.3985902114623;4122.154958233555;4148.548008197137;4170.8540201092965;4105.445764821756;4106.917861642765;4111.444954931076;4113.753174809521;4150.792460376969;3921.941170882439;4060.573639767826;4103.38449232616;4119.258533463975;4152.937705934413;3981.362981922893;4136.131412403399;4138.317177665666;4146.958530414718;4148.8340466381305;3671.7429779915415;3677.5403074615674;3693.5752388475403;3695.9630403695887;3696.7597106188014;5108;5111.284420181178;5121.795128194868;5123.23248479274;5124.385073791132;4508.864734057984;4734.526547345273;4761.47623761386;4775.856724298276;4782.521747825224;5443.727813609304;5480.259870064968;5517.69652669103;5524.254225679522;5538.9169162462595;4032.5885939921086;4036.1120553478186;4039.515258169009;4041.7574945503366;4044.5753195914594;5485.286912701324;5683.460071293221;5686;5742.167385729088;5755.798547050833;4117.3618089196225;4148.336266197394;4151.99999999994;4158.272302347077;4160.209560183555;4191.245575796386;4216;4233.470816147981;4242.618164365222;4245.724027938174;4573.147875110585;4722.181959945446;4722.598579120745;4734.218853889139;4789;5445.53712934405;5455.699936503451;5467.289252397242;5499;5503.972480137573;1453.4331610671848;1460.8904332174916;1469.1258701072845;1478.8760541987951;1480.9111453312835;960.6013504395597;975.3903810118676;977.3061126600052;992.4739887859446;1022.6676330192718;5227.876006658586;5241.371035475691;5247.632665713363;5262.526372626482;5273.2861819908685;5551.833444996576;5558.333000040021;5560.749766260528;5572.554195664418;5583.581231407661;4998.400191976986;5171.482851714798;5181.108895253205;5189.532942035159;5205.401378841406;2924.9122526324245;2926.239177813784;2966.383321089968;2973.583698282199;2978.285211549256;5523.861903452365;5689.630174038674;5712.371639119693;5726.942730572641;5740.311162660508;5767.480926716532;5780.942190578125;5790.594658373873;5796.913046304308;5798.536117110621;5725;5765.798197063083;5778.797742078923;5785.537157027512;5826.708664566755;5498.395176530498;5604.6917419542315;5616.634918730269;5630.915536266877;5638.36487418644;5548.639338442988;5601.24383208278;5616.831495055155;5622.24099746529;5627.155926611041;5662.320521537277;5778.219940308173;5805.10020946754;5853.239078919713;5854.2389489366105;4072.714909956275;4079.7960101995377;4080.5307389649383;4096.2831504486;4115.691323150716;5690.71546422669;5701.173329867229;5720.713964301685;5732.799352022659;5757.251557297524;5349.1976203569775;5424.264235444778;5581.386047534686;5590.385057643737;5591.524720398812;5423.783048678167;5428.782848686008;5430.42980487059;5441.29263195782;5443.891122177613;5166.586673066221;5224.817131400535;5331.800344922362;5343.919841202307;5385.219143224289;5446.50981411659;5469.343678758574;5494.945050549603;5501.697406642513;5505.201745746925;5337.706426146599;5359.72211809987;5361.169018802092;5380.246765452918;5394.298741163623 19:30:21 INFO - PROCESS | 8586 | |5;yui.html;724.5942272327497;773.3078894389525;777.3936329662863;785.9214078592141;806.2985202873501;14499.637509062279;15811.260761316245;15816.76274855878;15817.367305307802;15821.129837858913;14178.078424902375;14187.716245675081;14205.92897035516;14265.71468570628;14335.283235838218;663.6947004377992;778.6885245901642;784.4273680213419;795.0975642645581;797.0554892452434;787.8542469643135;793.0483419896119;796.3629096722627;797.7845981584968;798.6046906781152;852.1435956863344;854.1202561361807;854.6495936665968;854.7179430787825;854.8974123105236;699.1470406104544;813.0771574263224;823.1192623892438;824.72371755462;848.855694531928;611.8470382404399;612.4518555892496;612.5895649914523;612.6018088242633;613.1814028272262;14119.082259653193;14150.433982640681;14155;14158.929205353907;14162.92918535411;12264.509419623204;12928.77953869752;12947;12951.67620809478;13053.738925221538;12364.75270494594;12633.311717463977;12701.555445559361;12872.034597405138;13001.739965200642;4341.41390912226;4401.823927042915;4423.270160423526;4586.587207151372;4587.082583483317;69813.30186698119;70608.64695676489;70825;71077;71202;9639.421634701941;9913.950430247802;9996.100350968447;10036.849447258297;10095.192384609214;20322.695159572617;20329.593408131754;20626.793732062488;20664.48338791542;20665.58668826615;7965.243301886311;7976.162502937108;8000.199980001953;8042.798930026679;8126.187381261945;4803.5916947059895;4824.662273640882;4834.661573689878;4910.459849416561;4993.825216117419;3377.257003459235;3478;3478.339115568034;3478.9478157827652;3486.790792552455;599.0714392691398;600.67263341479;601.1463721515458;601.176388347966;619.3496828330235;581.3808294166699;622.2595111817013;624.4504835744516;683.6274230544366;687.9621620810804;8530.65877364911;9132.771680707903;9164.645126724474;9355.391899526508;9373.812523749486;650.0476801485846;671.8891382921861;673.4242222899351;675.6689222281145;680.1633990192091;4157.210130075276;4201.810918508674;4296.763677997677;4342.717723347972;4387.714798538085;64975;78826;102812;103656.48171759093;109297;91354.54322728344;93205.53397233106;95458.13625591104;96495;97147.51426242823;70097.2990270101;81323.5933820339;81827.5908620465;83005;83843.5807820957;8649.913500865163;9462.111313696385;9488.430694158096;9603.951980240054;9612.711618651452;35497.82251088728;35762.463563046054;44295;45953.31070033885;50093.49906501034;42276;70700.29299706937;70990.29009709836;71209;74233;12586.811197831857;12594.677558856554;12611.558595449114;12827.935860321011;13170.60488185356;13496.055276130577;13633.795493067413;13756.17462952226;13821.723565528431;13824.092447181107;12346.814797778221;12488.500459981498;12620.621381358575;12721.55474558386;12822.67943301425;12690.619281421572;12711.80932285998;12855.421506032439;13013;13200.735985280433;12437.751244974868;12594.307313097868;12792.808107878203;13027.609171724864;13239.66900827487;10391.896081039093;10426.843597346198;10789.136869050613;10911.399873007062;10970.286931349438;10590.4704764763;10686.39253415033;10717.732056698645;10790.19073569501;10813.189010824377 19:30:21 INFO - PROCESS | 8586 | __end_tp_report 19:30:21 INFO - PROCESS | 8586 | __start_cc_report 19:30:21 INFO - PROCESS | 8586 | _x_x_mozilla_cycle_collect,872 19:30:21 INFO - PROCESS | 8586 | __end_cc_report 19:30:21 INFO - PROCESS | 8586 | __startTimestamp1465612221315__endTimestamp 19:30:21 INFO - PROCESS | 8586 | 19:30:21 INFO - PROCESS | 8586 | ------- Summary: start ------- 19:30:21 INFO - PROCESS | 8586 | Number of tests: 6 19:30:21 INFO - PROCESS | 8586 | 19:30:21 INFO - PROCESS | 8586 | [#0] dojo.html Cycles:165 Average:5263.93 Median:5413.81 stddev:590.65 (10.9%) stddev-sans-first:566.30 19:30:21 INFO - PROCESS | 8586 | Values: 3047.7 3057.7 3072.8 3094.4 3115.4 5079.2 5140.5 5217.5 5327.4 5338.8 5269.9 5282.2 5288.5 5308.0 5350.4 4715.0 4786.3 4831.4 4836.4 4978.2 4786.9 4794.0 4822.5 4847.2 4879.3 4680.9 4789.4 4798.4 4812.1 4877.2 4806.2 4817.2 4881.7 4885.5 4929.5 4725.4 4824.0 4845.8 4851.4 4885.8 5227.6 5310.0 5336.9 5401.6 5405.2 5699.2 5707.0 5726.1 5731.9 5732.4 5534.5 5592.3 5774.5 5787.8 5790.1 5262.4 5316.6 5365.1 5368.4 5368.6 5890.3 5898.7 5902.6 5902.9 5904.4 5413.8 5458.4 5517.6 5677.4 5688.1 5687.9 5695.2 5696.3 5738.9 5751.3 5660.8 5674.1 5674.3 5679.6 5680.2 5466.3 5611.1 5668.1 5676.0 5686.9 4346.4 4371.2 4375.8 4376.3 4408.4 3920.7 3932.3 3939.8 3973.2 4005.9 5128.9 5132.1 5258.9 5282.9 5295.7 5668.2 5676.8 5681.2 5681.7 5723.1 5316.5 5316.7 5321.3 5326.9 5372.9 4714.6 4893.3 4944.0 4945.6 4974.5 5898.9 5900.2 5903.0 5914.2 5914.8 5441.0 5721.0 5734.7 5736.2 5738.5 5743.1 5771.9 5779.7 5856.9 5912.2 5574.1 5574.9 5576.2 5579.5 5586.5 5453.0 5665.1 5676.9 5677.0 5680.5 5436.2 5496.0 5496.8 5535.1 5540.0 5453.2 5505.5 5514.7 5519.7 5523.7 5189.5 5301.1 5396.9 5430.9 5479.2 5520.4 5608.0 5609.8 5610.2 5610.8 5379.2 5410.1 5411.1 5413.8 5422.7 19:30:21 INFO - PROCESS | 8586 | 19:30:21 INFO - PROCESS | 8586 | [#1] ext.html Cycles:180 Average:57202.45 Median:41845.19 stddev:110510.23 (264.1%) stddev-sans-first:110738.55 19:30:21 INFO - PROCESS | 8586 | Values: 607.8 633.6 634.2 640.9 655.8 32010.8 35285.0 35321.6 35350.5 42198.0 41300.2 45462.0 45614.5 45630.3 45732.3 8914.0 9060.3 9062.6 9062.8 9068.0 8725.2 8780.1 8826.0 8826.6 8827.9 8981.9 8996.3 8996.7 9017.5 9020.5 8925.9 8953.9 8965.1 8967.2 8977.7 8878.0 8964.5 8974.0 8993.5 8994.4 39054.0 39334.6 39392.8 39426.6 39449.6 3511.6 3580.1 3581.9 3822.5 3942.3 32984.5 33191.8 33452.7 33605.0 33665.8 4346.7 4414.9 4432.9 4527.8 4585.6 316103.0 316144.0 316945.0 319045.0 319198.0 57922.4 58194.7 58354.0 58589.0 58612.0 49206.8 49379.3 49481.8 49491.5 49537.0 15670.8 15704.5 15842.3 15882.4 15884.1 11576.7 11595.7 11649.2 11678.3 11681.4 16222.5 18202.8 18225.6 18278.4 18334.5 6194.2 6268.0 6474.0 6525.9 6648.9 795.8 863.9 912.3 1051.9 1061.4 32441.7 32502.0 32930.3 33059.7 33168.8 1090.4 1185.5 1201.4 1225.6 1266.3 17262.4 17352.7 17433.4 17442.2 17466.5 473272.0 473605.0 474887.0 475196.0 476398.0 58297.4 58350.7 58433.7 58734.7 58869.7 1161.0 1172.6 1172.6 1266.6 1282.1 29844.0 31291.8 31515.0 31803.7 31866.5 45063.8 54187.5 55922.7 56048.7 61437.4 440361.0 441970.0 444409.0 445761.0 447129.0 26136.0 27845.3 28193.3 28898.4 29448.1 48811.8 49081.8 49241.8 49468.8 50066.5 40782.0 41625.6 42141.0 42182.6 42801.8 40622.6 40832.6 41101.8 41345.0 42064.8 40940.6 41228.8 41510.4 42066.6 42905.6 27987.7 29211.0 29256.6 29257.0 29590.0 27341.6 27425.3 27445.0 27631.9 27641.9 19:30:21 INFO - PROCESS | 8586 | 19:30:21 INFO - PROCESS | 8586 | [#2] jquery.html Cycles:180 Average:27497.63 Median:2627.14 stddev:73655.23 (2803.6%) stddev-sans-first:73833.76 19:30:21 INFO - PROCESS | 8586 | Values: 403.7 404.0 404.9 407.2 426.3 17701.6 19023.0 19517.1 19548.3 20036.8 16827.9 17502.4 17508.8 18955.6 19262.1 5246.2 5321.7 5376.6 5381.7 5406.4 5135.2 5202.7 5260.4 5282.2 5338.1 5207.9 5250.5 5251.6 5287.7 5290.6 5180.0 5277.0 5279.5 5296.4 5302.1 5050.8 5147.4 5181.9 5258.4 5264.9 14388.1 14479.0 15786.1 22831.5 23118.4 2286.5 2325.1 2435.2 2484.7 2769.6 10266.7 10443.7 10558.5 10882.9 10989.6 1919.3 1948.1 1952.8 1966.2 2002.2 81241.6 85525.1 85741.6 85930.0 86754.0 11107.9 11117.7 11388.5 11646.5 12024.8 16186.4 16191.2 16210.4 16228.0 16291.9 7408.2 7489.0 7738.5 7788.7 7864.0 7118.3 7143.8 7258.1 7354.5 7375.9 4886.9 4900.4 4916.9 4944.8 5040.2 2019.7 2025.3 2033.8 2061.7 2119.4 881.6 954.7 994.2 1002.3 1008.7 18298.0 18927.4 19517.6 19624.1 19624.5 884.6 961.5 970.6 996.3 1005.2 10395.4 10776.7 10963.6 10970.0 10975.0 440654.0 445378.0 446367.0 447123.0 447389.0 59188.0 89919.6 91273.5 93546.0 94595.0 952.8 954.5 964.9 971.1 976.8 16585.7 16935.6 17120.2 17220.9 17642.3 29646.6 38534.8 40476.6 41287.6 41747.6 55217.0 56959.0 57011.1 57265.4 57744.7 8888.7 8935.7 8984.9 9149.0 9239.8 11398.3 13397.3 13461.8 13586.7 13769.9 11957.7 12073.8 12127.5 12141.5 12536.3 11758.5 11864.2 11936.1 11972.9 12001.6 11698.1 11916.9 12057.5 12059.6 12138.6 9382.4 11181.4 12293.7 12358.9 12581.0 11641.3 11772.3 12162.9 12600.6 12850.2 19:30:21 INFO - PROCESS | 8586 | 19:30:21 INFO - PROCESS | 8586 | [#3] mootools.html Cycles:180 Average:5922.82 Median:4640.27 stddev:3553.47 (76.6%) stddev-sans-first:3545.74 19:30:21 INFO - PROCESS | 8586 | Values: 1202.9 1331.4 1413.3 1440.6 1733.3 8577.7 8993.0 9026.5 9277.9 9283.4 8952.3 9126.7 9136.6 9137.5 9143.6 2047.9 2267.1 2315.7 2346.0 2352.9 2377.3 2395.7 2396.4 2406.5 2407.4 2247.9 2267.6 2294.3 2296.7 2297.1 1957.0 2124.4 2178.1 2178.8 2190.4 2297.9 2301.9 2316.6 2318.6 2320.4 9195.0 9252.3 9257.1 9260.2 9265.8 5150.6 5268.4 5275.0 5284.2 5289.4 3066.4 3250.7 3311.5 3312.9 3322.7 981.8 1001.1 1007.7 1017.6 1026.6 13045.2 13072.9 13147.0 13152.5 13159.9 4629.7 4690.8 4723.6 4754.6 4795.4 10890.8 10914.6 10917.7 10919.5 10920.7 5118.9 5173.4 5175.8 5183.8 5186.7 4219.9 4650.8 4801.6 4804.1 4866.5 4084.3 4109.7 4158.2 4170.3 4209.9 1307.7 1307.8 1316.7 1323.4 1329.2 857.4 875.9 910.3 922.2 941.9 5716.9 5874.7 5926.4 6012.0 6051.8 410.8 411.8 429.6 435.0 435.7 3803.9 3939.5 3967.9 3988.7 4020.0 11102.3 11217.0 11605.9 11645.9 11668.6 11464.8 11607.4 11626.3 11635.5 11638.2 8319.7 8353.1 8534.8 8546.9 8561.4 5894.3 5933.6 6038.4 6060.9 6152.8 10609.9 10669.7 10752.2 10753.9 10772.4 10081.7 10437.1 10465.1 10662.3 10771.0 7052.3 7984.9 8182.7 8296.1 8582.6 8694.8 8934.2 9023.9 9045.0 9046.2 7733.9 7985.2 8029.6 8074.3 8178.3 7717.1 7808.1 7950.8 7960.7 8000.6 6935.2 6940.8 7009.5 7057.3 7086.1 4654.7 4694.7 4722.5 4746.6 4948.2 4856.4 4890.2 4978.0 5024.1 5058.2 19:30:21 INFO - PROCESS | 8586 | 19:30:21 INFO - PROCESS | 8586 | [#4] prototype.html Cycles:180 Average:4639.57 Median:5255.08 stddev:1337.72 (25.5%) stddev-sans-first:1301.88 19:30:21 INFO - PROCESS | 8586 | Values: 335.1 336.0 340.6 343.1 343.7 5279.4 5283.6 5284.9 5291.7 5294.5 5201.3 5216.8 5241.1 5247.0 5247.0 3979.6 4009.4 4122.2 4148.5 4170.9 4105.4 4106.9 4111.4 4113.8 4150.8 3921.9 4060.6 4103.4 4119.3 4152.9 3981.4 4136.1 4138.3 4147.0 4148.8 3671.7 3677.5 3693.6 3696.0 3696.8 5108.0 5111.3 5121.8 5123.2 5124.4 4508.9 4734.5 4761.5 4775.9 4782.5 5443.7 5480.3 5517.7 5524.3 5538.9 4032.6 4036.1 4039.5 4041.8 4044.6 5485.3 5683.5 5686.0 5742.2 5755.8 4117.4 4148.3 4152.0 4158.3 4160.2 4191.2 4216.0 4233.5 4242.6 4245.7 4573.1 4722.2 4722.6 4734.2 4789.0 5445.5 5455.7 5467.3 5499.0 5504.0 1453.4 1460.9 1469.1 1478.9 1480.9 960.6 975.4 977.3 992.5 1022.7 5227.9 5241.4 5247.6 5262.5 5273.3 5551.8 5558.3 5560.7 5572.6 5583.6 4998.4 5171.5 5181.1 5189.5 5205.4 2924.9 2926.2 2966.4 2973.6 2978.3 5523.9 5689.6 5712.4 5726.9 5740.3 5767.5 5780.9 5790.6 5796.9 5798.5 5725.0 5765.8 5778.8 5785.5 5826.7 5498.4 5604.7 5616.6 5630.9 5638.4 5548.6 5601.2 5616.8 5622.2 5627.2 5662.3 5778.2 5805.1 5853.2 5854.2 4072.7 4079.8 4080.5 4096.3 4115.7 5690.7 5701.2 5720.7 5732.8 5757.3 5349.2 5424.3 5581.4 5590.4 5591.5 5423.8 5428.8 5430.4 5441.3 5443.9 5166.6 5224.8 5331.8 5343.9 5385.2 5446.5 5469.3 5494.9 5501.7 5505.2 5337.7 5359.7 5361.2 5380.2 5394.3 19:30:21 INFO - PROCESS | 8586 | 19:30:21 INFO - PROCESS | 8586 | [#5] yui.html Cycles:180 Average:18938.80 Median:4814.13 stddev:26643.92 (553.5%) stddev-sans-first:26683.56 19:30:21 INFO - PROCESS | 8586 | Values: 724.6 773.3 777.4 785.9 806.3 14499.6 15811.3 15816.8 15817.4 15821.1 14178.1 14187.7 14205.9 14265.7 14335.3 663.7 778.7 784.4 795.1 797.1 787.9 793.0 796.4 797.8 798.6 852.1 854.1 854.6 854.7 854.9 699.1 813.1 823.1 824.7 848.9 611.8 612.5 612.6 612.6 613.2 14119.1 14150.4 14155.0 14158.9 14162.9 12264.5 12928.8 12947.0 12951.7 13053.7 12364.8 12633.3 12701.6 12872.0 13001.7 4341.4 4401.8 4423.3 4586.6 4587.1 69813.3 70608.6 70825.0 71077.0 71202.0 9639.4 9914.0 9996.1 10036.8 10095.2 20322.7 20329.6 20626.8 20664.5 20665.6 7965.2 7976.2 8000.2 8042.8 8126.2 4803.6 4824.7 4834.7 4910.5 4993.8 3377.3 3478.0 3478.3 3478.9 3486.8 599.1 600.7 601.1 601.2 619.3 581.4 622.3 624.5 683.6 688.0 8530.7 9132.8 9164.6 9355.4 9373.8 650.0 671.9 673.4 675.7 680.2 4157.2 4201.8 4296.8 4342.7 4387.7 64975.0 78826.0 102812.0 103656.5 109297.0 91354.5 93205.5 95458.1 96495.0 97147.5 70097.3 81323.6 81827.6 83005.0 83843.6 8649.9 9462.1 9488.4 9604.0 9612.7 35497.8 35762.5 44295.0 45953.3 50093.5 42276.0 70700.3 70990.3 71209.0 74233.0 12586.8 12594.7 12611.6 12827.9 13170.6 13496.1 13633.8 13756.2 13821.7 13824.1 12346.8 12488.5 12620.6 12721.6 12822.7 12690.6 12711.8 12855.4 13013.0 13200.7 12437.8 12594.3 12792.8 13027.6 13239.7 10391.9 10426.8 10789.1 10911.4 10970.3 10590.5 10686.4 10717.7 10790.2 10813.2 19:30:21 INFO - PROCESS | 8586 | -------- Summary: end -------- 19:30:21 INFO - PROCESS | 8586 | 19:30:21 INFO - TEST-INFO | 8586: exit 0 19:30:22 INFO - TEST-OK | dromaeo_css | took 1113647ms 19:30:22 INFO - TEST-START | kraken 19:30:22 INFO - operating with platform_type : linux_ 19:30:22 INFO - Initialising browser for kraken test... 19:30:22 INFO - TEST-INFO | started process 8775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdxAM6/profile http://localhost:54229/getInfo.html) 19:30:26 INFO - PROCESS | 8775 | __metrics Screen width/height:1600/1200 19:30:26 INFO - PROCESS | 8775 | colorDepth:24 19:30:26 INFO - PROCESS | 8775 | Browser inner width/height: 1024/697 19:30:26 INFO - PROCESS | 8775 | __metrics 19:30:27 ERROR - PROCESS | 8775 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:30:27 INFO - PROCESS | 8775 | console.error: PushService: 19:30:27 INFO - PROCESS | 8775 | stateChangeProcessEnqueue: Error transitioning state 19:30:27 INFO - PROCESS | 8775 | UnknownError 19:30:28 INFO - TEST-INFO | 8775: exit 0 19:30:28 INFO - Browser initialized. 19:30:28 INFO - Running cycle 1/1 for kraken test... 19:30:28 INFO - TEST-INFO | started process 8857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAdxAM6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:30:40 INFO - PROCESS | 8857 | RSS: Main: 173203456 19:30:40 INFO - PROCESS | 8857 | 19:30:42 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54229/tests/kraken/driver.html?testName=audio-beat-detection) 19:30:43 INFO - PROCESS | 8857 | RSS: Main: 232046592 19:30:43 INFO - PROCESS | 8857 | 19:30:46 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54229/tests/kraken/driver.html?testName=audio-dft) 19:30:46 INFO - PROCESS | 8857 | RSS: Main: 220114944 19:30:46 INFO - PROCESS | 8857 | 19:30:49 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54229/tests/kraken/driver.html?testName=audio-fft) 19:30:50 INFO - PROCESS | 8857 | RSS: Main: 286986240 19:30:50 INFO - PROCESS | 8857 | 19:30:52 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54229/tests/kraken/driver.html?testName=audio-oscillator) 19:30:53 INFO - PROCESS | 8857 | RSS: Main: 196800512 19:30:53 INFO - PROCESS | 8857 | 19:30:55 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:55 INFO - PROCESS | 8857 | RSS: Main: 201445376 19:30:55 INFO - PROCESS | 8857 | 19:30:58 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54229/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:59 INFO - PROCESS | 8857 | RSS: Main: 237416448 19:30:59 INFO - PROCESS | 8857 | 19:31:03 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54229/tests/kraken/driver.html?testName=imaging-desaturate) 19:31:03 INFO - PROCESS | 8857 | RSS: Main: 238333952 19:31:03 INFO - PROCESS | 8857 | 19:31:06 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54229/tests/kraken/driver.html?testName=json-parse-financial) 19:31:07 INFO - PROCESS | 8857 | RSS: Main: 238313472 19:31:07 INFO - PROCESS | 8857 | 19:31:08 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:09 INFO - PROCESS | 8857 | RSS: Main: 220377088 19:31:09 INFO - PROCESS | 8857 | 19:31:10 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:11 INFO - PROCESS | 8857 | RSS: Main: 226484224 19:31:11 INFO - PROCESS | 8857 | 19:31:13 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:14 INFO - PROCESS | 8857 | RSS: Main: 234668032 19:31:14 INFO - PROCESS | 8857 | 19:31:16 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:17 INFO - PROCESS | 8857 | RSS: Main: 239157248 19:31:17 INFO - PROCESS | 8857 | 19:31:20 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:20 INFO - PROCESS | 8857 | RSS: Main: 240963584 19:31:20 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | Cycle 1(1): loaded http://localhost:54229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54229/tests/kraken/driver.html?testName=ai-astar) 19:31:22 INFO - PROCESS | 8857 | RSS: Main: 283533312 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | __start_tp_report 19:31:22 INFO - PROCESS | 8857 | _x_x_mozilla_page_load 19:31:22 INFO - PROCESS | 8857 | _x_x_mozilla_page_load_details 19:31:22 INFO - PROCESS | 8857 | |i|pagename|runs| 19:31:22 INFO - PROCESS | 8857 | |0;ai-astar;111;107;109;109;111;112;109;112;112;110 19:31:22 INFO - PROCESS | 8857 | |1;audio-beat-detection;158;129;127;189;136;127;153;128;167;129 19:31:22 INFO - PROCESS | 8857 | |2;audio-dft;160;160;161;160;160;161;160;161;160;160 19:31:22 INFO - PROCESS | 8857 | |3;audio-fft;75;75;79;129;76;76;76;74;105;75 19:31:22 INFO - PROCESS | 8857 | |4;audio-oscillator;84;86;112;84;85;84;115;86;85;119 19:31:22 INFO - PROCESS | 8857 | |5;imaging-gaussian-blur;117;118;117;117;116;116;117;117;116;117 19:31:22 INFO - PROCESS | 8857 | |6;imaging-darkroom;147;148;146;146;145;145;148;145;148;146 19:31:22 INFO - PROCESS | 8857 | |7;imaging-desaturate;95;95;95;94;95;95;95;96;96;95 19:31:22 INFO - PROCESS | 8857 | |8;json-parse-financial;54;53;53;54;53;52;54;54;52;54 19:31:22 INFO - PROCESS | 8857 | |9;json-stringify-tinderbox;61;61;61;62;61;61;62;62;62;61 19:31:22 INFO - PROCESS | 8857 | |10;stanford-crypto-aes;79;78;77;78;81;79;81;81;115;80 19:31:22 INFO - PROCESS | 8857 | |11;stanford-crypto-ccm;126;125;120;123;119;129;129;127;130;124 19:31:22 INFO - PROCESS | 8857 | |12;stanford-crypto-pbkdf2;157;158;162;158;159;157;162;157;159;160 19:31:22 INFO - PROCESS | 8857 | |13;stanford-crypto-sha256-iterative;66;63;63;62;66;63;63;65;62;66 19:31:22 INFO - PROCESS | 8857 | __end_tp_report 19:31:22 INFO - PROCESS | 8857 | __start_cc_report 19:31:22 INFO - PROCESS | 8857 | _x_x_mozilla_cycle_collect,1637 19:31:22 INFO - PROCESS | 8857 | __end_cc_report 19:31:22 INFO - PROCESS | 8857 | __startTimestamp1465612282576__endTimestamp 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | ------- Summary: start ------- 19:31:22 INFO - PROCESS | 8857 | Number of tests: 14 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.69 (1.5%) stddev-sans-first:1.76 19:31:22 INFO - PROCESS | 8857 | Values: 111.0 107.0 109.0 109.0 111.0 112.0 109.0 112.0 112.0 110.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:144.50 stddev:21.55 (14.9%) stddev-sans-first:22.28 19:31:22 INFO - PROCESS | 8857 | Values: 158.0 129.0 127.0 189.0 136.0 127.0 153.0 128.0 167.0 129.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 19:31:22 INFO - PROCESS | 8857 | Values: 160.0 160.0 161.0 160.0 160.0 161.0 160.0 161.0 160.0 160.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.50 stddev:18.34 (24.3%) stddev-sans-first:19.16 19:31:22 INFO - PROCESS | 8857 | Values: 75.0 75.0 79.0 129.0 76.0 76.0 76.0 74.0 105.0 75.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.50 stddev:14.83 (17.6%) stddev-sans-first:15.28 19:31:22 INFO - PROCESS | 8857 | Values: 84.0 86.0 112.0 84.0 85.0 84.0 115.0 86.0 85.0 119.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 19:31:22 INFO - PROCESS | 8857 | Values: 117.0 118.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:1.26 (0.9%) stddev-sans-first:1.32 19:31:22 INFO - PROCESS | 8857 | Values: 147.0 148.0 146.0 146.0 145.0 145.0 148.0 145.0 148.0 146.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 19:31:22 INFO - PROCESS | 8857 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 96.0 95.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 19:31:22 INFO - PROCESS | 8857 | Values: 54.0 53.0 53.0 54.0 53.0 52.0 54.0 54.0 52.0 54.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 19:31:22 INFO - PROCESS | 8857 | Values: 61.0 61.0 61.0 62.0 61.0 61.0 62.0 62.0 62.0 61.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:79.50 stddev:11.37 (14.3%) stddev-sans-first:11.97 19:31:22 INFO - PROCESS | 8857 | Values: 79.0 78.0 77.0 78.0 81.0 79.0 81.0 81.0 115.0 80.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.50 stddev:3.77 (3.0%) stddev-sans-first:3.98 19:31:22 INFO - PROCESS | 8857 | Values: 126.0 125.0 120.0 123.0 119.0 129.0 129.0 127.0 130.0 124.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:159.00 stddev:1.91 (1.2%) stddev-sans-first:1.90 19:31:22 INFO - PROCESS | 8857 | Values: 157.0 158.0 162.0 158.0 159.0 157.0 162.0 157.0 159.0 160.0 19:31:22 INFO - PROCESS | 8857 | 19:31:22 INFO - PROCESS | 8857 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.66 (2.6%) stddev-sans-first:1.58 19:31:22 INFO - PROCESS | 8857 | Values: 66.0 63.0 63.0 62.0 66.0 63.0 63.0 65.0 62.0 66.0 19:31:22 INFO - PROCESS | 8857 | -------- Summary: end -------- 19:31:22 INFO - PROCESS | 8857 | 19:31:23 INFO - TEST-INFO | 8857: exit 0 19:31:23 INFO - TEST-OK | kraken | took 61484ms 19:31:23 INFO - SUITE-END | took 1175s 19:31:23 INFO - Completed test suite (00:19:35) 19:31:23 INFO - javascript benchmark 19:31:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3047.6952304769525, 3057.7400920921737, 3072.8309942953138, 3094.4120617082767, 3115.43922094023, 5079.212722028083, 5140.460251673567, 5217.452167522408, 5327.413984461706, 5338.759755810988, 5269.947300526994, 5282.154855223165, 5288.524032837044, 5307.973460132704, 5350.384705758839, 4714.9528504714945, 4786.2581299898575, 4831.420229572456, 4836.41962964443, 4978.178600530908, 4786.880327991793, 4793.976030119845, 4822.541858523452, 4847.200211965039, 4879.316895634614, 4680.859574212762, 4789.377380940473, 4798.424189097295, 4812.109759694467, 4877.195262781619, 4806.158922188638, 4817.156997525419, 4881.658283920092, 4885.535874091991, 4929.531694489017, 4725.432948046257, 4823.951760482385, 4845.781939812717, 4851.417829860439, 4885.804567817283, 5227.555657769056, 5310.0441920454305, 5336.866578335573, 5401.621886467949, 5405.243265942732, 5699.230603868507, 5707.029804933171, 5726.141078838166, 5731.856703582402, 5732.398098199712, 5534.529564986981, 5592.273004509388, 5774.48029677331, 5787.826365209008, 5790.13148027795, 5262.368515778093, 5316.57467402603, 5365.08793505105, 5368.4363141869935, 5368.597355198376, 5890.293164820249, 5898.705064746746, 5902.645841249453, 5902.940970590325, 5904.350521442638, 5413.810516631977, 5458.426865179099, 5517.641353312022, 5677.403872593401, 5688.146777983336, 5687.914681279784, 5695.202671625976, 5696.259486266758, 5738.885222295531, 5751.252337196138, 5660.782931669711, 5674.1488776683, 5674.319081710139, 5679.602427830095, 5680.176374425685, 5466.34403871538, 5611.102223644198, 5668.093105103246, 5675.971620141873, 5686.886262274814, 4346.36977638247, 4371.213181627338, 4375.78121093944, 4376.277914144131, 4408.382826404306, 3920.666743326792, 3932.2528719543197, 3939.8227079781477, 3973.205358928226, 4005.8998525036523, 5128.897422051538, 5132.101882170605, 5258.894822103536, 5282.894342113136, 5295.708736019479, 5668.178114173505, 5676.801311954062, 5681.204631351614, 5681.687507187145, 5723.141528770718, 5316.468353164652, 5316.680999140064, 5321.308229930084, 5326.866828329323, 5372.91940620891, 4714.599259062949, 4893.314935908976, 4944.0, 4945.604351651859, 4974.477679843637, 5898.8820223595285, 5900.20347253124, 5902.970485147633, 5914.172015917775, 5914.763409463573, 5440.972795135999, 5720.998825205489, 5734.655920644775, 5736.225609542826, 5738.512226460631, 5743.052396354722, 5771.855703607275, 5779.739911703899, 5856.853578660568, 5912.172295878667, 5574.136008918624, 5574.888502229852, 5576.247206627054, 5579.497845193952, 5586.497215250647, 5453.045716999589, 5665.093585026376, 5676.858078548069, 5677.0, 5680.545556355564, 5436.157395603688, 5495.972520137374, 5496.80761173357, 5535.086710692691, 5540.002799496129, 5453.1547610118905, 5505.532029777513, 5514.696691681996, 5519.69641669712, 5523.696196709219, 5189.532942035235, 5301.125314323093, 5396.865078372915, 5430.9185362218805, 5479.205515200194, 5520.447955204448, 5608.046632072476, 5609.831705048855, 5610.158476228435, 5610.775568977195, 5379.220013098157, 5410.1343784994215, 5411.107167317506, 5413.7834486620095, 5422.701751403711], "value": 5224.881373754691, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.7842365960084, 633.5596760251627, 634.235745926159, 640.9134766806479, 655.8065370715639, 32010.839945800268, 35285.0, 35321.64678353216, 35350.46974295384, 42198.0, 41300.173996520054, 45461.99999999992, 45614.543854561445, 45630.31554526685, 45732.31401528972, 8913.955430222855, 9060.320475964296, 9062.592183351731, 9062.773430664252, 9068.047854975232, 8725.171108744658, 8780.121987801233, 8826.0, 8826.646934122627, 8827.867581986275, 8981.865272020925, 8996.325275604357, 8996.730098097067, 9017.549122543847, 9020.503872287054, 8925.866112008325, 8953.865692014626, 8965.058668839776, 8967.237784788302, 8977.730668079936, 8878.0, 8964.462132272085, 8973.955130224307, 8993.460392376413, 8994.370394072417, 39054.0, 39334.60665393338, 39392.80303598492, 39426.60573394258, 39449.60550394488, 3511.613722490524, 3580.104973756561, 3581.8746343877838, 3822.4648549203134, 3942.2903877302074, 32984.52821530815, 33191.83404082964, 33452.6654733452, 33605.0, 33665.831670841486, 4346.673999450054, 4414.933775993362, 4432.889177770549, 4527.818887244506, 4585.58729714324, 316103.0, 316144.0, 316945.0, 319045.0, 319198.0, 57922.4207757917, 58194.7090264546, 58354.0, 58589.0, 58612.0, 49206.75396622994, 49379.25931111036, 49481.752591236815, 49491.50508494941, 49537.0, 15670.764938525932, 15704.528864134094, 15842.287097080429, 15882.364705411885, 15884.126373049594, 11576.710582235512, 11595.710107247218, 11649.184557080924, 11678.299302041905, 11681.415929203506, 16222.51332460028, 18202.817971820376, 18225.63548729018, 18278.360257391192, 18334.54163645893, 6194.225721784777, 6268.03958972112, 6473.967630161819, 6525.89059859825, 6648.8670226595195, 795.7970717467009, 863.87905693203, 912.3248795891126, 1051.942143182117, 1061.442742560162, 32441.675583243865, 32502.0, 32930.34139317248, 33059.66940330614, 33168.839090632195, 1090.3839330778085, 1185.5257896841333, 1201.3993003498251, 1225.5955534673537, 1266.2782214138037, 17262.395816146625, 17352.739708904377, 17433.389831355842, 17442.215100320514, 17466.485525343178, 473272.0, 473605.0, 474887.0, 475196.0, 476398.0, 58297.417025830044, 58350.7082464585, 58433.70783146057, 58734.70632646809, 58869.70565147147, 1160.988390116105, 1172.5544293168712, 1172.5602898912907, 1266.5883587833991, 1282.0576875996135, 29844.0, 31291.84354078215, 31515.0, 31803.681963180996, 31866.522002170448, 45063.774681127696, 54187.45812541824, 55922.72038639781, 56048.719756402585, 61437.385626143165, 440361.0, 441970.0, 444409.0, 445761.0, 447129.0, 26135.954561818075, 27845.303867403476, 28193.295167620152, 28898.422031559672, 29448.091078418645, 48811.755941220064, 49081.75459122682, 49241.75379123082, 49468.75265623649, 50066.49933500764, 40782.0, 41625.58374416217, 42141.0, 42182.578174219096, 42801.785991069846, 40622.59377406306, 40832.591674082876, 41101.79449102735, 41345.0, 42064.78967605143, 40940.59059409368, 41228.79385603053, 41510.377344340464, 42066.57933420627, 42905.57094429016, 27987.72012279851, 29211.0, 29256.56115158317, 29257.0, 29590.0, 27341.589876151476, 27425.31436714098, 27445.039423620077, 27631.861840690668, 27641.861790690917], "value": 19578.3378637037, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.71336351190655, 403.967682585393, 404.91294371710075, 407.2262700868351, 426.31150691633, 17701.645967080665, 19023.0, 19517.121729522187, 19548.31580894667, 20036.799632003676, 16827.91586042071, 17502.387416440426, 17508.82491175088, 18955.62088758224, 19262.13320400582, 5246.239295302188, 5321.733913304339, 5376.596755243353, 5381.650192737479, 5406.432324605899, 5135.2040433732645, 5202.739863006854, 5260.368755749316, 5282.154855223165, 5338.145896656536, 5207.869803254911, 5250.501202385767, 5251.55361794248, 5287.735613219343, 5290.55030322423, 5180.0, 5277.0, 5279.472052794728, 5296.364436267634, 5302.09864323066, 5050.84847454577, 5147.356580427447, 5181.948180518184, 5258.447862974371, 5264.947350526522, 14388.13671179722, 14479.0, 15786.052836829713, 22831.543369132523, 23118.42203944898, 2286.4626812699003, 2325.093213646679, 2435.2450740270574, 2484.701835779718, 2769.584562315649, 10266.7433314167, 10443.738906527322, 10558.472076396227, 10882.945585272102, 10989.560417583287, 1919.2610844824703, 1948.1428171604448, 1952.824245817869, 1966.193860517181, 2002.209127394671, 81241.59379203126, 85525.14474855296, 85741.57129214377, 85930.0, 86754.0, 11107.888921110685, 11117.722056948642, 11388.487518061707, 11646.534138634359, 12024.819627705592, 16186.352545898268, 16191.190440477929, 16210.432634857723, 16227.971503562054, 16291.918540407221, 7408.222136675679, 7489.0, 7738.458307918504, 7788.688452461952, 7863.960680196562, 7118.323759242864, 7143.82140446493, 7258.0927384076995, 7354.521956072838, 7375.856742204859, 4886.877828054327, 4900.387451568554, 4916.861165393066, 4944.752762361867, 5040.243963405445, 2019.686948522952, 2025.2709024751077, 2033.8271246944175, 2061.7023175557088, 2119.3747844385944, 881.6209030116983, 954.7279025477706, 994.1698681600944, 1002.3084071990303, 1008.6822650864954, 18298.0, 18927.432177034712, 19517.609647806963, 19624.116914738872, 19624.509387265432, 884.6019291318804, 961.5192403798101, 970.6360114956891, 996.3175224970918, 1005.2410430125209, 10395.428251446092, 10776.730581735519, 10963.616273430393, 10970.0, 10975.0, 440654.0, 445378.0, 446367.0, 447123.0, 447389.0, 59188.0, 89919.55040224757, 91273.54363228274, 93546.0, 94595.0, 952.7951490429591, 954.4559601027487, 964.9096520931303, 971.0774763974111, 976.829054915387, 16585.66828663444, 16935.576610584834, 17120.229589668244, 17220.913895430444, 17642.29430822804, 29646.555301670924, 38534.843954681404, 40476.59523404728, 41287.587124128375, 41747.582524174366, 55217.0, 56959.0, 57011.14483282837, 57265.427345726006, 57744.71127644335, 8888.73333799987, 8935.687250946186, 8984.86522702173, 9149.0, 9239.815203695754, 11398.316101033965, 13397.263150526425, 13461.798073028716, 13586.660333491742, 13769.931150344184, 11957.728031674302, 12073.75852482963, 12127.514899403925, 12141.453634586289, 12536.310502922062, 11758.529658813552, 11864.22882512634, 11936.10479214045, 11972.880271197177, 12001.579944701894, 11698.122640801803, 11916.940415297868, 12057.51769929228, 12059.57791477294, 12138.575149869712, 9382.390144640576, 11181.440927953732, 12293.692657683629, 12358.876411235773, 12581.0, 11641.301521908712, 11772.29172810562, 12162.939185304016, 12600.558980436008, 12850.228986260854], "value": 9120.431244514755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1202.9398530073506, 1331.4407948661565, 1413.258039529247, 1440.6110350205445, 1733.3499937523436, 8577.656893724252, 8993.0, 9026.50354230518, 9277.90722092779, 9283.350165488418, 8952.283817294618, 9126.680566180185, 9136.588853501591, 9137.497437640926, 9143.588538515765, 2047.907844147017, 2267.1044937249776, 2315.6642286868437, 2346.0263990443946, 2352.9176478823247, 2377.3105799318178, 2395.700537432821, 2396.3529846941315, 2406.470576473173, 2407.434252950555, 2247.9100835966624, 2267.5804976079394, 2294.300238427279, 2296.70142881426, 2297.115610489965, 1957.031269521589, 2124.3626911926513, 2178.0525471419983, 2178.814800741923, 2190.44143743346, 2297.908083676651, 2301.8964146613444, 2316.6061769499224, 2318.5594737000083, 2320.3734991552187, 9194.95402522983, 9252.30607704418, 9257.074292570756, 9260.212881905047, 9265.768355791091, 5150.562202212816, 5268.446813084647, 5274.973625131888, 5284.180951952415, 5289.44460831611, 3066.3713938642527, 3250.7074363307415, 3311.536384906115, 3312.850921708529, 3322.684344987222, 981.7644915725451, 1001.1140140975217, 1007.7480629842539, 1017.6183931025865, 1026.5996261458038, 13045.217286962717, 13072.86927130726, 13147.0, 13152.539661111816, 13159.934200329033, 4629.745364004944, 4690.81236750533, 4723.622110231173, 4754.572088512051, 4795.400574928134, 10890.782184356269, 10914.563417463212, 10917.727056823644, 10919.508622112024, 10920.726981825359, 5118.872028199325, 5173.379194496609, 5175.792968281226, 5183.766730497136, 5186.740662966837, 4219.894502637459, 4650.790714417859, 4801.591864691541, 4804.135255654016, 4866.46468888422, 4084.346504559256, 4109.691773116969, 4158.209940111369, 4170.311898536768, 4209.873703788891, 1307.6730817295677, 1307.843058832927, 1316.6905777142365, 1323.4243104249683, 1329.1692692067459, 857.4469467193625, 875.8992715837633, 910.2854259406466, 922.2345453273766, 941.9199368053792, 5716.914246286309, 5874.676892770939, 5926.407359264039, 6011.969940150271, 6051.8487037823525, 410.75560041775094, 411.7673514464378, 429.63481041115426, 434.9913001740011, 435.7407342631129, 3803.866864659779, 3939.487866577384, 3967.900802479961, 3988.74073185242, 4019.979900100481, 11102.2783519071, 11217.0, 11605.88394116065, 11645.883541164649, 11668.649940501798, 11464.770704586028, 11607.361595112181, 11626.302421854547, 11635.476403561861, 11638.185327027197, 8319.66721331152, 8353.122922093215, 8534.82930341402, 8546.914530854612, 8561.443506172203, 5894.2926848778425, 5933.584649074523, 6038.396160383926, 6060.939390606038, 6152.78465253714, 10609.89390106089, 10669.679909602724, 10752.247342685936, 10753.946230268799, 10772.353658780497, 10081.69754907354, 10437.112845408225, 10465.058144767008, 10662.306950048533, 10771.0, 7052.294770522906, 7984.880226796487, 8182.67269309221, 8296.087430382533, 8582.613782379933, 8694.82610347802, 8934.195922367018, 9023.864642030243, 9045.0, 9046.231070359094, 7733.92266077332, 7985.2014798519685, 8029.638666259915, 8074.273315401642, 8178.3457323412795, 7717.073951125901, 7808.141104478616, 7950.761477155695, 7960.659588976305, 8000.6399712011935, 6935.167779866449, 6940.7917762467205, 7009.474289428212, 7057.329553692391, 7086.078809754905, 4654.743989080633, 4694.671373003857, 4722.456917454399, 4746.62027037843, 4948.15881300187, 4856.368672072608, 4890.19311813561, 4977.9502204978935, 5024.120778863611, 5058.215976523497], "value": 4556.450416580317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.1470507558264, 336.0456304096366, 340.6202084675586, 343.1233199176104, 343.7421933549838, 5279.4192638809745, 5283.550898173655, 5284.947150528498, 5291.656042357244, 5294.497022782839, 5201.349831271091, 5216.843494695156, 5241.135212689902, 5246.973765131179, 5247.0, 3979.602039796012, 4009.3985902114623, 4122.154958233555, 4148.548008197137, 4170.8540201092965, 4105.445764821756, 4106.917861642765, 4111.444954931076, 4113.753174809521, 4150.792460376969, 3921.941170882439, 4060.573639767826, 4103.38449232616, 4119.258533463975, 4152.937705934413, 3981.362981922893, 4136.131412403399, 4138.317177665666, 4146.958530414718, 4148.8340466381305, 3671.7429779915415, 3677.5403074615674, 3693.5752388475403, 3695.9630403695887, 3696.7597106188014, 5108.0, 5111.284420181178, 5121.795128194868, 5123.23248479274, 5124.385073791132, 4508.864734057984, 4734.526547345273, 4761.47623761386, 4775.856724298276, 4782.521747825224, 5443.727813609304, 5480.259870064968, 5517.69652669103, 5524.254225679522, 5538.9169162462595, 4032.5885939921086, 4036.1120553478186, 4039.515258169009, 4041.7574945503366, 4044.5753195914594, 5485.286912701324, 5683.460071293221, 5686.0, 5742.167385729088, 5755.798547050833, 4117.3618089196225, 4148.336266197394, 4151.99999999994, 4158.272302347077, 4160.209560183555, 4191.245575796386, 4216.0, 4233.470816147981, 4242.618164365222, 4245.724027938174, 4573.147875110585, 4722.181959945446, 4722.598579120745, 4734.218853889139, 4789.0, 5445.53712934405, 5455.699936503451, 5467.289252397242, 5499.0, 5503.972480137573, 1453.4331610671848, 1460.8904332174916, 1469.1258701072845, 1478.8760541987951, 1480.9111453312835, 960.6013504395597, 975.3903810118676, 977.3061126600052, 992.4739887859446, 1022.6676330192718, 5227.876006658586, 5241.371035475691, 5247.632665713363, 5262.526372626482, 5273.2861819908685, 5551.833444996576, 5558.333000040021, 5560.749766260528, 5572.554195664418, 5583.581231407661, 4998.400191976986, 5171.482851714798, 5181.108895253205, 5189.532942035159, 5205.401378841406, 2924.9122526324245, 2926.239177813784, 2966.383321089968, 2973.583698282199, 2978.285211549256, 5523.861903452365, 5689.630174038674, 5712.371639119693, 5726.942730572641, 5740.311162660508, 5767.480926716532, 5780.942190578125, 5790.594658373873, 5796.913046304308, 5798.536117110621, 5725.0, 5765.798197063083, 5778.797742078923, 5785.537157027512, 5826.708664566755, 5498.395176530498, 5604.6917419542315, 5616.634918730269, 5630.915536266877, 5638.36487418644, 5548.639338442988, 5601.24383208278, 5616.831495055155, 5622.24099746529, 5627.155926611041, 5662.320521537277, 5778.219940308173, 5805.10020946754, 5853.239078919713, 5854.2389489366105, 4072.714909956275, 4079.7960101995377, 4080.5307389649383, 4096.2831504486, 4115.691323150716, 5690.71546422669, 5701.173329867229, 5720.713964301685, 5732.799352022659, 5757.251557297524, 5349.1976203569775, 5424.264235444778, 5581.386047534686, 5590.385057643737, 5591.524720398812, 5423.783048678167, 5428.782848686008, 5430.42980487059, 5441.29263195782, 5443.891122177613, 5166.586673066221, 5224.817131400535, 5331.800344922362, 5343.919841202307, 5385.219143224289, 5446.50981411659, 5469.343678758574, 5494.945050549603, 5501.697406642513, 5505.201745746925, 5337.706426146599, 5359.72211809987, 5361.169018802092, 5380.246765452918, 5394.298741163623], "value": 4220.022871345596, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.5942272327497, 773.3078894389525, 777.3936329662863, 785.9214078592141, 806.2985202873501, 14499.637509062279, 15811.260761316245, 15816.76274855878, 15817.367305307802, 15821.129837858913, 14178.078424902375, 14187.716245675081, 14205.92897035516, 14265.71468570628, 14335.283235838218, 663.6947004377992, 778.6885245901642, 784.4273680213419, 795.0975642645581, 797.0554892452434, 787.8542469643135, 793.0483419896119, 796.3629096722627, 797.7845981584968, 798.6046906781152, 852.1435956863344, 854.1202561361807, 854.6495936665968, 854.7179430787825, 854.8974123105236, 699.1470406104544, 813.0771574263224, 823.1192623892438, 824.72371755462, 848.855694531928, 611.8470382404399, 612.4518555892496, 612.5895649914523, 612.6018088242633, 613.1814028272262, 14119.082259653193, 14150.433982640681, 14155.0, 14158.929205353907, 14162.92918535411, 12264.509419623204, 12928.77953869752, 12947.0, 12951.67620809478, 13053.738925221538, 12364.75270494594, 12633.311717463977, 12701.555445559361, 12872.034597405138, 13001.739965200642, 4341.41390912226, 4401.823927042915, 4423.270160423526, 4586.587207151372, 4587.082583483317, 69813.30186698119, 70608.64695676489, 70825.0, 71077.0, 71202.0, 9639.421634701941, 9913.950430247802, 9996.100350968447, 10036.849447258297, 10095.192384609214, 20322.695159572617, 20329.593408131754, 20626.793732062488, 20664.48338791542, 20665.58668826615, 7965.243301886311, 7976.162502937108, 8000.199980001953, 8042.798930026679, 8126.187381261945, 4803.5916947059895, 4824.662273640882, 4834.661573689878, 4910.459849416561, 4993.825216117419, 3377.257003459235, 3478.0, 3478.339115568034, 3478.9478157827652, 3486.790792552455, 599.0714392691398, 600.67263341479, 601.1463721515458, 601.176388347966, 619.3496828330235, 581.3808294166699, 622.2595111817013, 624.4504835744516, 683.6274230544366, 687.9621620810804, 8530.65877364911, 9132.771680707903, 9164.645126724474, 9355.391899526508, 9373.812523749486, 650.0476801485846, 671.8891382921861, 673.4242222899351, 675.6689222281145, 680.1633990192091, 4157.210130075276, 4201.810918508674, 4296.763677997677, 4342.717723347972, 4387.714798538085, 64975.0, 78826.0, 102812.0, 103656.48171759093, 109297.0, 91354.54322728344, 93205.53397233106, 95458.13625591104, 96495.0, 97147.51426242823, 70097.2990270101, 81323.5933820339, 81827.5908620465, 83005.0, 83843.5807820957, 8649.913500865163, 9462.111313696385, 9488.430694158096, 9603.951980240054, 9612.711618651452, 35497.82251088728, 35762.463563046054, 44295.0, 45953.31070033885, 50093.49906501034, 42276.0, 70700.29299706937, 70990.29009709836, 71209.0, 74233.0, 12586.811197831857, 12594.677558856554, 12611.558595449114, 12827.935860321011, 13170.60488185356, 13496.055276130577, 13633.795493067413, 13756.17462952226, 13821.723565528431, 13824.092447181107, 12346.814797778221, 12488.500459981498, 12620.621381358575, 12721.55474558386, 12822.67943301425, 12690.619281421572, 12711.80932285998, 12855.421506032439, 13013.0, 13200.735985280433, 12437.751244974868, 12594.307313097868, 12792.808107878203, 13027.609171724864, 13239.66900827487, 10391.896081039093, 10426.843597346198, 10789.136869050613, 10911.399873007062, 10970.286931349438, 10590.4704764763, 10686.39253415033, 10717.732056698645, 10790.19073569501, 10813.189010824377], "value": 7185.430442825382, "unit": "score"}], "name": "dromaeo_css", "value": 7107.515315767256, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 109.0, 109.0, 111.0, 112.0, 109.0, 112.0, 112.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 127.0, 189.0, 136.0, 127.0, 153.0, 128.0, 167.0, 129.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 161.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 79.0, 129.0, 76.0, 76.0, 76.0, 74.0, 105.0, 75.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 112.0, 84.0, 85.0, 84.0, 115.0, 86.0, 85.0, 119.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 145.0, 145.0, 148.0, 145.0, 148.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 53.0, 52.0, 54.0, 54.0, 52.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 78.0, 81.0, 79.0, 81.0, 81.0, 115.0, 80.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 120.0, 123.0, 119.0, 129.0, 129.0, 127.0, 130.0, 124.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 162.0, 158.0, 159.0, 157.0, 162.0, 157.0, 159.0, 160.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 62.0, 66.0, 63.0, 63.0, 65.0, 62.0, 66.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1496.7000000000003, "alertThreshold": 2.0}]} 19:31:23 INFO - Return code: 0 19:31:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:31:23 ERROR - # TBPL SUCCESS # 19:31:23 INFO - Running post-action listener: _resource_record_post_action 19:31:23 INFO - ##### 19:31:23 INFO - ##### Finished run-tests step (success) 19:31:23 INFO - ##### 19:31:23 INFO - Running post-run listener: _resource_record_post_run 19:31:23 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541765632; Read time: 12; Write time: 471636 19:31:23 INFO - TinderboxPrint: CPU usage
13.2% 19:31:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:31:23 INFO - TinderboxPrint: I/O write bytes / time
541,765,632 / 471,636 19:31:23 INFO - TinderboxPrint: CPU idle
8,265.9 (86.8%) 19:31:23 INFO - TinderboxPrint: CPU user
1,206.0 (12.7%) 19:31:23 INFO - TinderboxPrint: Swap in / out
0 / 0 19:31:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254464000; Read time: 0; Write time: 306592 19:31:23 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287301632; Read time: 12; Write time: 165044 19:31:24 INFO - Running post-run listener: _upload_blobber_files 19:31:24 INFO - Blob upload gear active. 19:31:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:24 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 19:31:24 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'] 19:31:24 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 19:31:24 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:31:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:28 INFO - (blobuploader) - INFO - Done attempting. 19:31:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:31:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:31:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:29 INFO - (blobuploader) - INFO - Done attempting. 19:31:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:31:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:31:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:30 INFO - (blobuploader) - INFO - Done attempting. 19:31:30 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:30 INFO - Return code: 0 19:31:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:31:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/899dbf1ea31af8ec7ef64f578ef734f110caca868e2aa58d6bdb0e474912f5890f431ed93f017137da5515fe41f4f5b4d7e53c25e305326f23e2231097aa45fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7be8a3f848025fcce8878d95d42aa96b23c4caec9a816774e4a10f9a9df676e999d6cea7e0da6c78eeca6b6e4fff71fb1ce883b537f699bec40a25bc15569ee3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/218fb2d6d33d3e4eaa496948f4e287333f394bf0298b8b974e5a0032b4502a91cf10fa295da1c0406feacb97ad2472f8da4a574fa2cabb55289f21216be4bcda"} 19:31:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:31:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:31:30 INFO - Contents: 19:31:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/899dbf1ea31af8ec7ef64f578ef734f110caca868e2aa58d6bdb0e474912f5890f431ed93f017137da5515fe41f4f5b4d7e53c25e305326f23e2231097aa45fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7be8a3f848025fcce8878d95d42aa96b23c4caec9a816774e4a10f9a9df676e999d6cea7e0da6c78eeca6b6e4fff71fb1ce883b537f699bec40a25bc15569ee3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/218fb2d6d33d3e4eaa496948f4e287333f394bf0298b8b974e5a0032b4502a91cf10fa295da1c0406feacb97ad2472f8da4a574fa2cabb55289f21216be4bcda"} 19:31:30 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:30 INFO - Copying logs to upload dir... 19:31:30 INFO - mkdir: /builds/slave/test/build/upload/logs 19:31:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.446013 ========= master_lag: 76.64 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 18 secs) (at 2016-06-10 19:32:47.118615) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 19:32:47.122635) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138 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/899dbf1ea31af8ec7ef64f578ef734f110caca868e2aa58d6bdb0e474912f5890f431ed93f017137da5515fe41f4f5b4d7e53c25e305326f23e2231097aa45fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7be8a3f848025fcce8878d95d42aa96b23c4caec9a816774e4a10f9a9df676e999d6cea7e0da6c78eeca6b6e4fff71fb1ce883b537f699bec40a25bc15569ee3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/218fb2d6d33d3e4eaa496948f4e287333f394bf0298b8b974e5a0032b4502a91cf10fa295da1c0406feacb97ad2472f8da4a574fa2cabb55289f21216be4bcda"} build_url:https://queue.taskcluster.net/v1/task/YhsHP_GGSj6eYShKSvkUpA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/YhsHP_GGSj6eYShKSvkUpA/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/899dbf1ea31af8ec7ef64f578ef734f110caca868e2aa58d6bdb0e474912f5890f431ed93f017137da5515fe41f4f5b4d7e53c25e305326f23e2231097aa45fe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7be8a3f848025fcce8878d95d42aa96b23c4caec9a816774e4a10f9a9df676e999d6cea7e0da6c78eeca6b6e4fff71fb1ce883b537f699bec40a25bc15569ee3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/218fb2d6d33d3e4eaa496948f4e287333f394bf0298b8b974e5a0032b4502a91cf10fa295da1c0406feacb97ad2472f8da4a574fa2cabb55289f21216be4bcda"}' ========= master_lag: 0.40 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 19:32:47.530543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:32:47.530930) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465609884.485986-485691138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 19:32:47.569192) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 19:32:47.569523) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 19:32:48.237806) ========= ========= Total master_lag: 77.14 =========