builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1466522439.27 results: success (0) buildid: 20160621055203 builduid: b93ff7a19cfe4a109cca2c9f3648efd4 revision: 74b32ea89a8c73e35c6ee8ce3bed7bf81528bdab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:39.271740) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:39.272162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:39.272456) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:39.287177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:39.287493) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 08:20:39-- 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% 24.2M=0s 2016-06-21 08:20:39 (24.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:39.426651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:39.426937) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019581 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:39.477272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:39.477630) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 74b32ea89a8c73e35c6ee8ce3bed7bf81528bdab --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 74b32ea89a8c73e35c6ee8ce3bed7bf81528bdab --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=74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 08:20:39,679 truncating revision to first 12 chars 2016-06-21 08:20:39,679 Setting DEBUG logging. 2016-06-21 08:20:39,679 attempt 1/10 2016-06-21 08:20:39,679 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/74b32ea89a8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 08:20:39,991 unpacking tar archive at: mozilla-aurora-74b32ea89a8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:40.135403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:40.135877) ========= script_repo_revision: 74b32ea89a8c73e35c6ee8ce3bed7bf81528bdab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:40.136532) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:40.137014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 08:20:40.148059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-21 08:20:40.148599) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:20:40 INFO - MultiFileLogger online at 20160621 08:20:40 in /builds/slave/test 08:20:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:20:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:20:40 INFO - {'append_to_log': False, 08:20:40 INFO - 'base_work_dir': '/builds/slave/test', 08:20:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:20:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:20:40 INFO - 'branch': 'Mozilla-Aurora', 08:20:40 INFO - 'buildbot_json_path': 'buildprops.json', 08:20:40 INFO - 'config_files': ('talos/linux_config.py',), 08:20:40 INFO - 'default_actions': ('clobber', 08:20:40 INFO - 'read-buildbot-config', 08:20:40 INFO - 'download-and-extract', 08:20:40 INFO - 'populate-webroot', 08:20:40 INFO - 'create-virtualenv', 08:20:40 INFO - 'install', 08:20:40 INFO - 'run-tests'), 08:20:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:20:40 INFO - 'download_minidump_stackwalk': True, 08:20:40 INFO - 'download_symbols': 'ondemand', 08:20:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:20:40 INFO - 'tooltool.py': '/tools/tooltool.py', 08:20:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:20:40 INFO - '/tools/misc-python/virtualenv.py')}, 08:20:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:20:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:20:40 INFO - 'installer_path': 'installer.exe', 08:20:40 INFO - 'log_level': 'info', 08:20:40 INFO - 'log_name': 'talos', 08:20:40 INFO - 'log_to_console': True, 08:20:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:20:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:20:40 INFO - 'opt_config_files': (), 08:20:40 INFO - 'pip_index': False, 08:20:40 INFO - 'sps_profile': False, 08:20:40 INFO - 'sps_profile_interval': 0, 08:20:40 INFO - 'suite': 'dromaeojs-e10s', 08:20:40 INFO - 'system_bits': '32', 08:20:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:20:40 INFO - 'title': 'talos-linux64-ix-042', 08:20:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:20:40 INFO - 'use_talos_json': True, 08:20:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:20:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:20:40 INFO - 'work_dir': 'build'} 08:20:40 INFO - ##### 08:20:40 INFO - ##### Running clobber step. 08:20:40 INFO - ##### 08:20:40 INFO - Running pre-action listener: _resource_record_pre_action 08:20:40 INFO - Running main action method: clobber 08:20:40 INFO - rmtree: /builds/slave/test/build 08:20:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:20:41 INFO - Running post-action listener: _resource_record_post_action 08:20:41 INFO - ##### 08:20:41 INFO - ##### Finished clobber step (success) 08:20:41 INFO - ##### 08:20:41 INFO - ##### 08:20:41 INFO - ##### Running read-buildbot-config step. 08:20:41 INFO - ##### 08:20:41 INFO - Running pre-action listener: _resource_record_pre_action 08:20:41 INFO - Running main action method: read_buildbot_config 08:20:41 INFO - Using buildbot properties: 08:20:41 INFO - { 08:20:41 INFO - "project": "", 08:20:41 INFO - "product": "firefox", 08:20:41 INFO - "script_repo_revision": "production", 08:20:41 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:20:41 INFO - "repository": "", 08:20:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:20:41 INFO - "buildid": "20160621055203", 08:20:41 INFO - "pgo_build": "True", 08:20:41 INFO - "basedir": "/builds/slave/test", 08:20:41 INFO - "buildnumber": 408, 08:20:41 INFO - "slavename": "talos-linux64-ix-042", 08:20:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:20:41 INFO - "platform": "ubuntu64_hw", 08:20:41 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:20:41 INFO - "branch": "mozilla-aurora", 08:20:41 INFO - "repo_path": "releases/mozilla-aurora", 08:20:41 INFO - "revision": "74b32ea89a8c73e35c6ee8ce3bed7bf81528bdab", 08:20:41 INFO - "stage_platform": "linux64-pgo", 08:20:41 INFO - "builduid": "b93ff7a19cfe4a109cca2c9f3648efd4", 08:20:41 INFO - "slavebuilddir": "test" 08:20:41 INFO - } 08:20:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 08:20:41 INFO - Running post-action listener: _resource_record_post_action 08:20:41 INFO - ##### 08:20:41 INFO - ##### Finished read-buildbot-config step (success) 08:20:41 INFO - ##### 08:20:41 INFO - ##### 08:20:41 INFO - ##### Running download-and-extract step. 08:20:41 INFO - ##### 08:20:41 INFO - Running pre-action listener: _resource_record_pre_action 08:20:41 INFO - Running main action method: download_and_extract 08:20:41 INFO - mkdir: /builds/slave/test/build/tests 08:20: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')]} 08:20:41 INFO - https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:20:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:20:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:20:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:20:47 INFO - Downloaded 1361 bytes. 08:20:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:20:47 INFO - Using the following test package requirements: 08:20:47 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 08:20:47 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:47 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:20:47 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:47 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:20:47 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:47 INFO - u'jsshell-linux-x86_64.zip'], 08:20:47 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:47 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:20:47 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 08:20:47 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:47 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:20:47 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:47 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:20:47 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:47 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:20:47 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:47 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:20:47 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:20: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')]} 08:20:47 INFO - https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:20:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:20:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:20:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:20:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:03 INFO - Downloaded 24474216 bytes. 08:21:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:04 INFO - Return code: 0 08:21:04 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:21:04 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')]} 08:21:04 INFO - https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:21:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:21:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:21:06 INFO - Downloaded 24474216 bytes. 08:21:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:21:07 INFO - Return code: 0 08:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:07 INFO - https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:21:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 08:21:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 08:21:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 08:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:21:08 INFO - Downloaded 10833369 bytes. 08:21:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:21:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:21:08 INFO - Return code: 0 08:21: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')]} 08:21:08 INFO - https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:21:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:21:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:21:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:21:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:21:10 INFO - Downloaded 63620994 bytes. 08:21:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:21:10 INFO - mkdir: /builds/slave/test/properties 08:21:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:10 INFO - Contents: 08:21:10 INFO - build_url:https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:21:10 INFO - Running post-action listener: _resource_record_post_action 08:21:10 INFO - Running post-action listener: set_extra_try_arguments 08:21:10 INFO - ##### 08:21:10 INFO - ##### Finished download-and-extract step (success) 08:21:10 INFO - ##### 08:21:10 INFO - ##### 08:21:10 INFO - ##### Running populate-webroot step. 08:21:10 INFO - ##### 08:21:10 INFO - Running pre-action listener: _resource_record_pre_action 08:21:10 INFO - Running main action method: populate_webroot 08:21:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:10 INFO - '--tppagecycles', 08:21:10 INFO - '7'], 08:21:10 INFO - 'tests': ['tsvgm']}}, 08:21:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:10 INFO - 'talos_options': ['--disable-e10s'], 08:21:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:10 INFO - 'talos_options': ['--disable-e10s'], 08:21:10 INFO - 'tests': ['damp', 'tps']}, 08:21:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:10 INFO - 'tests': ['damp', 'tps']}, 08:21:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:10 INFO - 'tests': ['dromaeo_dom']}, 08:21:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:10 INFO - 'tests': ['a11yr', 08:21:10 INFO - 'ts_paint', 08:21:10 INFO - 'tpaint', 08:21:10 INFO - 'sessionrestore', 08:21:10 INFO - 'sessionrestore_no_auto_restore', 08:21:10 INFO - 'tabpaint']}, 08:21:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:10 INFO - 'ts_paint', 08:21:10 INFO - 'tpaint', 08:21:10 INFO - 'sessionrestore', 08:21:10 INFO - 'sessionrestore_no_auto_restore', 08:21:10 INFO - 'tabpaint']}, 08:21:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:10 INFO - 'ts_paint', 08:21:10 INFO - 'tpaint', 08:21:10 INFO - 'sessionrestore', 08:21:10 INFO - 'sessionrestore_no_auto_restore', 08:21:10 INFO - 'tabpaint']}, 08:21:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:10 INFO - 'ts_paint', 08:21:10 INFO - 'tpaint', 08:21:10 INFO - 'sessionrestore', 08:21:10 INFO - 'sessionrestore_no_auto_restore', 08:21:10 INFO - 'tabpaint']}, 08:21:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:10 INFO - 'tests': ['a11yr', 08:21:10 INFO - 'ts_paint', 08:21:10 INFO - 'tpaint', 08:21:10 INFO - 'sessionrestore', 08:21:10 INFO - 'sessionrestore_no_auto_restore', 08:21:10 INFO - 'tabpaint']}, 08:21:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:10 INFO - 'tests': ['a11yr', 08:21:10 INFO - 'ts_paint', 08:21:10 INFO - 'tpaint', 08:21:10 INFO - 'sessionrestore', 08:21:10 INFO - 'sessionrestore_no_auto_restore', 08:21:10 INFO - 'tabpaint']}, 08:21:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:10 INFO - 'tests': ['tsvgx', 08:21:10 INFO - 'tsvgr_opacity', 08:21:10 INFO - 'tart', 08:21:10 INFO - 'tscrollx', 08:21:10 INFO - 'cart']}, 08:21:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:10 INFO - 'tsvgr_opacity', 08:21:10 INFO - 'tart', 08:21:10 INFO - 'tscrollx', 08:21:10 INFO - 'cart']}, 08:21:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:10 INFO - 'talos_options': ['--disable-e10s'], 08:21:10 INFO - 'tests': ['tp5o']}, 08:21:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:10 INFO - 'tests': ['tp5o']}, 08:21:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:10 INFO - 'talos_options': ['--disable-e10s', 08:21:10 INFO - '--xperf_path', 08:21:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:10 INFO - 'tests': ['tp5n']}, 08:21:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:10 INFO - 'talos_options': ['--xperf_path', 08:21:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:10 INFO - 'tests': ['tp5n']}}, 08:21:10 INFO - 'talos.zip': {'path': '', 08:21:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:10 INFO - Running post-action listener: _resource_record_post_action 08:21:10 INFO - ##### 08:21:10 INFO - ##### Finished populate-webroot step (success) 08:21:10 INFO - ##### 08:21:10 INFO - ##### 08:21:10 INFO - ##### Running create-virtualenv step. 08:21:10 INFO - ##### 08:21:10 INFO - Running pre-action listener: _resource_record_pre_action 08:21:10 INFO - Running main action method: create_virtualenv 08:21:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:10 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 08:21:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:10 INFO - Using real prefix '/usr' 08:21:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:13 INFO - Installing pip.................done. 08:21:13 INFO - Return code: 0 08:21:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98210bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1258020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', '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 08:21: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', 'pip>=1.5'] in /builds/slave/test/build 08:21: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 pip>=1.5 08:21:13 INFO - Using env: {'DISPLAY': ':0', 08:21:13 INFO - 'HOME': '/home/cltbld', 08:21:13 INFO - 'LANG': 'en_US.UTF-8', 08:21:13 INFO - 'LANGUAGE': 'en_US:en', 08:21:13 INFO - 'LOGNAME': 'cltbld', 08:21:13 INFO - 'MAIL': '/var/mail/cltbld', 08:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:13 INFO - 'MOZ_NO_REMOTE': '1', 08:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:13 INFO - 'NO_EM_RESTART': '1', 08:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:13 INFO - 'PWD': '/builds/slave/test', 08:21:13 INFO - 'SHELL': '/bin/bash', 08:21:13 INFO - 'SHLVL': '1', 08:21:13 INFO - 'TERM': 'linux', 08:21:13 INFO - 'TMOUT': '86400', 08:21:13 INFO - 'USER': 'cltbld', 08:21:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:13 INFO - '_': '/tools/buildbot/bin/python'} 08:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:13 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 08:21:13 INFO - Cleaning up... 08:21:13 INFO - Return code: 0 08:21:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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', '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 0x7fa98210bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1258020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', '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 08:21: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:21: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 psutil>=3.1.1 08:21:13 INFO - Using env: {'DISPLAY': ':0', 08:21:13 INFO - 'HOME': '/home/cltbld', 08:21:13 INFO - 'LANG': 'en_US.UTF-8', 08:21:13 INFO - 'LANGUAGE': 'en_US:en', 08:21:13 INFO - 'LOGNAME': 'cltbld', 08:21:13 INFO - 'MAIL': '/var/mail/cltbld', 08:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:13 INFO - 'MOZ_NO_REMOTE': '1', 08:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:13 INFO - 'NO_EM_RESTART': '1', 08:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:13 INFO - 'PWD': '/builds/slave/test', 08:21:13 INFO - 'SHELL': '/bin/bash', 08:21:13 INFO - 'SHLVL': '1', 08:21:13 INFO - 'TERM': 'linux', 08:21:13 INFO - 'TMOUT': '86400', 08:21:13 INFO - 'USER': 'cltbld', 08:21:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:13 INFO - '_': '/tools/buildbot/bin/python'} 08:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:13 INFO - Downloading/unpacking psutil>=3.1.1 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:15 INFO - Installing collected packages: psutil 08:21:15 INFO - Running setup.py install for psutil 08:21:15 INFO - building 'psutil._psutil_linux' extension 08:21:15 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 08:21:16 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 08:21:16 INFO - building 'psutil._psutil_posix' extension 08:21:16 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 08:21:16 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 08:21:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:16 INFO - Successfully installed psutil 08:21:16 INFO - Cleaning up... 08:21:16 INFO - Return code: 0 08:21:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98210bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1258020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', '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 08:21: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:21: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 mozsystemmonitor==0.3 08:21:16 INFO - Using env: {'DISPLAY': ':0', 08:21:16 INFO - 'HOME': '/home/cltbld', 08:21:16 INFO - 'LANG': 'en_US.UTF-8', 08:21:16 INFO - 'LANGUAGE': 'en_US:en', 08:21:16 INFO - 'LOGNAME': 'cltbld', 08:21:16 INFO - 'MAIL': '/var/mail/cltbld', 08:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:16 INFO - 'MOZ_NO_REMOTE': '1', 08:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:16 INFO - 'NO_EM_RESTART': '1', 08:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:16 INFO - 'PWD': '/builds/slave/test', 08:21:16 INFO - 'SHELL': '/bin/bash', 08:21:16 INFO - 'SHLVL': '1', 08:21:16 INFO - 'TERM': 'linux', 08:21:16 INFO - 'TMOUT': '86400', 08:21:16 INFO - 'USER': 'cltbld', 08:21:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:16 INFO - '_': '/tools/buildbot/bin/python'} 08:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:21:18 INFO - Installing collected packages: mozsystemmonitor 08:21:18 INFO - Running setup.py install for mozsystemmonitor 08:21:18 INFO - Successfully installed mozsystemmonitor 08:21:18 INFO - Cleaning up... 08:21:18 INFO - Return code: 0 08:21:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:18 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 0x7fa98210bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1258020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', '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 08:21:18 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 08:21:18 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 08:21:18 INFO - Using env: {'DISPLAY': ':0', 08:21:18 INFO - 'HOME': '/home/cltbld', 08:21:18 INFO - 'LANG': 'en_US.UTF-8', 08:21:18 INFO - 'LANGUAGE': 'en_US:en', 08:21:18 INFO - 'LOGNAME': 'cltbld', 08:21:18 INFO - 'MAIL': '/var/mail/cltbld', 08:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:18 INFO - 'MOZ_NO_REMOTE': '1', 08:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:18 INFO - 'NO_EM_RESTART': '1', 08:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:18 INFO - 'PWD': '/builds/slave/test', 08:21:18 INFO - 'SHELL': '/bin/bash', 08:21:18 INFO - 'SHLVL': '1', 08:21:18 INFO - 'TERM': 'linux', 08:21:18 INFO - 'TMOUT': '86400', 08:21:18 INFO - 'USER': 'cltbld', 08:21:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:18 INFO - '_': '/tools/buildbot/bin/python'} 08:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:18 INFO - Downloading/unpacking jsonschema==2.5.1 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:21:20 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 08:21:20 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 08:21:20 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 08:21:20 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 08:21:20 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 08:21:20 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 08:21:20 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:21 INFO - warning: no files found matching '*.txt' 08:21:21 INFO - no previously-included directories found matching 'build' 08:21:21 INFO - no previously-included directories found matching 'dist' 08:21:21 INFO - no previously-included directories found matching '.git*' 08:21:21 INFO - Installing collected packages: jsonschema, functools32 08:21:21 INFO - Running setup.py install for functools32 08:21:21 INFO - warning: no files found matching '*.txt' 08:21:21 INFO - no previously-included directories found matching 'build' 08:21:21 INFO - no previously-included directories found matching 'dist' 08:21:21 INFO - no previously-included directories found matching '.git*' 08:21:21 INFO - Successfully installed jsonschema functools32 08:21:21 INFO - Cleaning up... 08:21:21 INFO - Return code: 0 08:21:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa98210bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1258020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', '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 08:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:21:21 INFO - Using env: {'DISPLAY': ':0', 08:21:21 INFO - 'HOME': '/home/cltbld', 08:21:21 INFO - 'LANG': 'en_US.UTF-8', 08:21:21 INFO - 'LANGUAGE': 'en_US:en', 08:21:21 INFO - 'LOGNAME': 'cltbld', 08:21:21 INFO - 'MAIL': '/var/mail/cltbld', 08:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:21 INFO - 'MOZ_NO_REMOTE': '1', 08:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:21 INFO - 'NO_EM_RESTART': '1', 08:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:21 INFO - 'PWD': '/builds/slave/test', 08:21:21 INFO - 'SHELL': '/bin/bash', 08:21:21 INFO - 'SHLVL': '1', 08:21:21 INFO - 'TERM': 'linux', 08:21:21 INFO - 'TMOUT': '86400', 08:21:21 INFO - 'USER': 'cltbld', 08:21:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:21 INFO - '_': '/tools/buildbot/bin/python'} 08:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:21 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:23 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:23 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 08:21:23 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 08:21:23 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 08:21:23 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 08:21:23 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 08:21:23 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 08:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:23 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 08:21:23 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 08:21:23 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 08:21:23 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 08:21:23 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 08:21:23 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 08:21:23 INFO - Downloading docopt-0.6.1.tar.gz 08:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:24 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:24 INFO - Running setup.py install for blobuploader 08:21:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:24 INFO - Running setup.py install for requests 08:21:24 INFO - Running setup.py install for docopt 08:21:24 INFO - Successfully installed blobuploader requests docopt 08:21:24 INFO - Cleaning up... 08:21:24 INFO - Return code: 0 08:21:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:24 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 0x7fa98210bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1258020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', '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 08:21:24 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 08:21:24 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 08:21:24 INFO - Using env: {'DISPLAY': ':0', 08:21:24 INFO - 'HOME': '/home/cltbld', 08:21:24 INFO - 'LANG': 'en_US.UTF-8', 08:21:24 INFO - 'LANGUAGE': 'en_US:en', 08:21:24 INFO - 'LOGNAME': 'cltbld', 08:21:24 INFO - 'MAIL': '/var/mail/cltbld', 08:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:24 INFO - 'MOZ_NO_REMOTE': '1', 08:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:24 INFO - 'NO_EM_RESTART': '1', 08:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:24 INFO - 'PWD': '/builds/slave/test', 08:21:24 INFO - 'SHELL': '/bin/bash', 08:21:24 INFO - 'SHLVL': '1', 08:21:24 INFO - 'TERM': 'linux', 08:21:24 INFO - 'TMOUT': '86400', 08:21:24 INFO - 'USER': 'cltbld', 08:21:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:24 INFO - '_': '/tools/buildbot/bin/python'} 08:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:24 INFO - Running setup.py (path:/tmp/pip-qibb_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:24 INFO - Running setup.py (path:/tmp/pip-2Goorl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:25 INFO - Running setup.py (path:/tmp/pip-G4nEPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:25 INFO - Running setup.py (path:/tmp/pip-aL3DuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:25 INFO - Running setup.py (path:/tmp/pip-Mys0oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:25 INFO - Running setup.py (path:/tmp/pip-yPeoTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:25 INFO - Running setup.py (path:/tmp/pip-TkuP2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:25 INFO - Running setup.py (path:/tmp/pip-VLvzh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:25 INFO - Running setup.py (path:/tmp/pip-xjsqCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:25 INFO - Running setup.py (path:/tmp/pip-_7y_WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:25 INFO - Running setup.py (path:/tmp/pip-wBdc4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:25 INFO - Running setup.py (path:/tmp/pip-cFrQZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:25 INFO - Running setup.py (path:/tmp/pip-WkcI_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:25 INFO - Running setup.py (path:/tmp/pip-nCACE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:25 INFO - Running setup.py (path:/tmp/pip-PVOFpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:25 INFO - Running setup.py (path:/tmp/pip-UZcmMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:26 INFO - Running setup.py (path:/tmp/pip-tQB69y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:26 INFO - Running setup.py install for manifestparser 08:21:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:26 INFO - Running setup.py install for mozcrash 08:21:26 INFO - Running setup.py install for mozdebug 08:21:26 INFO - Running setup.py install for mozdevice 08:21:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:26 INFO - Running setup.py install for mozfile 08:21:26 INFO - Running setup.py install for mozhttpd 08:21:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:26 INFO - Running setup.py install for mozinfo 08:21:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:26 INFO - Running setup.py install for mozInstall 08:21:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:26 INFO - Running setup.py install for mozleak 08:21:27 INFO - Running setup.py install for mozlog 08:21:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:27 INFO - Running setup.py install for moznetwork 08:21:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:27 INFO - Running setup.py install for mozprocess 08:21:27 INFO - Running setup.py install for mozprofile 08:21:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:27 INFO - Running setup.py install for mozrunner 08:21:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:27 INFO - Running setup.py install for mozscreenshot 08:21:27 INFO - Running setup.py install for moztest 08:21:27 INFO - Running setup.py install for mozversion 08:21:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:27 INFO - Cleaning up... 08:21:27 INFO - Return code: 0 08:21:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:27 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 0x7fa98210bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1258020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', '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 08:21:27 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 08:21:27 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 08:21:27 INFO - Using env: {'DISPLAY': ':0', 08:21:27 INFO - 'HOME': '/home/cltbld', 08:21:27 INFO - 'LANG': 'en_US.UTF-8', 08:21:27 INFO - 'LANGUAGE': 'en_US:en', 08:21:27 INFO - 'LOGNAME': 'cltbld', 08:21:27 INFO - 'MAIL': '/var/mail/cltbld', 08:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:27 INFO - 'MOZ_NO_REMOTE': '1', 08:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:27 INFO - 'NO_EM_RESTART': '1', 08:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:27 INFO - 'PWD': '/builds/slave/test', 08:21:27 INFO - 'SHELL': '/bin/bash', 08:21:27 INFO - 'SHLVL': '1', 08:21:27 INFO - 'TERM': 'linux', 08:21:27 INFO - 'TMOUT': '86400', 08:21:27 INFO - 'USER': 'cltbld', 08:21:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:27 INFO - '_': '/tools/buildbot/bin/python'} 08:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:28 INFO - Running setup.py (path:/tmp/pip-n_wG2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:28 INFO - Running setup.py (path:/tmp/pip-qdUsC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:28 INFO - Running setup.py (path:/tmp/pip-6HyJuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:28 INFO - Running setup.py (path:/tmp/pip-mTCSSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:28 INFO - Running setup.py (path:/tmp/pip-Ua4Fdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:28 INFO - Running setup.py (path:/tmp/pip-lQRCxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:28 INFO - Running setup.py (path:/tmp/pip-KRHQ19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:28 INFO - Running setup.py (path:/tmp/pip-JOiFvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:28 INFO - Running setup.py (path:/tmp/pip-wdj6hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:28 INFO - Running setup.py (path:/tmp/pip-2CkeHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:28 INFO - Running setup.py (path:/tmp/pip-yeVq7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:28 INFO - Running setup.py (path:/tmp/pip-TwY2mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:28 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)) 08:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:29 INFO - Running setup.py (path:/tmp/pip-vwokwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:29 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)) 08:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:29 INFO - Running setup.py (path:/tmp/pip-x0X4UC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:29 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)) 08:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:29 INFO - Running setup.py (path:/tmp/pip-XQdbYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:29 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)) 08:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:29 INFO - Running setup.py (path:/tmp/pip-bct5rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:29 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)) 08:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:29 INFO - Running setup.py (path:/tmp/pip-qB71r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:29 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)) 08:21:29 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)) 08:21:29 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)) 08:21:29 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)) 08:21:29 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)) 08:21:29 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)) 08:21:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21: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 08:21:31 INFO - Downloading blessings-1.6.tar.gz 08:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:31 INFO - Installing collected packages: blessings 08:21:31 INFO - Running setup.py install for blessings 08:21:31 INFO - Successfully installed blessings 08:21:31 INFO - Cleaning up... 08:21:31 INFO - Return code: 0 08:21:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:31 INFO - Reading from file tmpfile_stdout 08:21:31 INFO - Current package versions: 08:21:31 INFO - argparse == 1.2.1 08:21:31 INFO - blessings == 1.6 08:21:31 INFO - blobuploader == 1.2.4 08:21:31 INFO - docopt == 0.6.1 08:21:31 INFO - functools32 == 3.2.3-2 08:21:31 INFO - jsonschema == 2.5.1 08:21:31 INFO - manifestparser == 1.1 08:21:31 INFO - mozInstall == 1.12 08:21:31 INFO - mozcrash == 0.17 08:21:31 INFO - mozdebug == 0.1 08:21:31 INFO - mozdevice == 0.48 08:21:31 INFO - mozfile == 1.2 08:21:31 INFO - mozhttpd == 0.7 08:21:31 INFO - mozinfo == 0.9 08:21:31 INFO - mozleak == 0.1 08:21:31 INFO - mozlog == 3.2 08:21:31 INFO - moznetwork == 0.27 08:21:31 INFO - mozprocess == 0.22 08:21:31 INFO - mozprofile == 0.28 08:21:31 INFO - mozrunner == 6.11 08:21:31 INFO - mozscreenshot == 0.1 08:21:31 INFO - mozsystemmonitor == 0.3 08:21:31 INFO - moztest == 0.7 08:21:31 INFO - mozversion == 1.4 08:21:31 INFO - psutil == 3.1.1 08:21:31 INFO - requests == 1.2.3 08:21:31 INFO - wsgiref == 0.1.2 08:21:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:31 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')]} 08:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:31 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')]} 08:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:31 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 0x7fa98210bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1258020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', '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 08:21:31 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 08:21:31 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 08:21:31 INFO - Using env: {'DISPLAY': ':0', 08:21:31 INFO - 'HOME': '/home/cltbld', 08:21:31 INFO - 'LANG': 'en_US.UTF-8', 08:21:31 INFO - 'LANGUAGE': 'en_US:en', 08:21:31 INFO - 'LOGNAME': 'cltbld', 08:21:31 INFO - 'MAIL': '/var/mail/cltbld', 08:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:31 INFO - 'MOZ_NO_REMOTE': '1', 08:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:31 INFO - 'NO_EM_RESTART': '1', 08:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:31 INFO - 'PWD': '/builds/slave/test', 08:21:31 INFO - 'SHELL': '/bin/bash', 08:21:31 INFO - 'SHLVL': '1', 08:21:31 INFO - 'TERM': 'linux', 08:21:31 INFO - 'TMOUT': '86400', 08:21:31 INFO - 'USER': 'cltbld', 08:21:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:31 INFO - '_': '/tools/buildbot/bin/python'} 08:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:31 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)) 08:21:31 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)) 08:21:31 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)) 08:21:31 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)) 08:21:31 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)) 08:21:31 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)) 08:21:31 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)) 08:21:31 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)) 08:21:31 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)) 08:21:31 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)) 08:21:31 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)) 08:21:31 INFO - Cleaning up... 08:21:31 INFO - Return code: 0 08:21:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21:31 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')]} 08:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:31 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')]} 08:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:31 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 0x7fa98210bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1258020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', '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 08:21:31 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 08:21:31 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 08:21:31 INFO - Using env: {'DISPLAY': ':0', 08:21:31 INFO - 'HOME': '/home/cltbld', 08:21:31 INFO - 'LANG': 'en_US.UTF-8', 08:21:31 INFO - 'LANGUAGE': 'en_US:en', 08:21:31 INFO - 'LOGNAME': 'cltbld', 08:21:31 INFO - 'MAIL': '/var/mail/cltbld', 08:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:31 INFO - 'MOZ_NO_REMOTE': '1', 08:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:31 INFO - 'NO_EM_RESTART': '1', 08:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:31 INFO - 'PWD': '/builds/slave/test', 08:21:31 INFO - 'SHELL': '/bin/bash', 08:21:31 INFO - 'SHLVL': '1', 08:21:31 INFO - 'TERM': 'linux', 08:21:31 INFO - 'TMOUT': '86400', 08:21:31 INFO - 'USER': 'cltbld', 08:21:31 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:31 INFO - '_': '/tools/buildbot/bin/python'} 08:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:21:32 INFO - Cleaning up... 08:21:32 INFO - Return code: 0 08:21:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa98210bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1258020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', '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 08:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:21:32 INFO - Using env: {'DISPLAY': ':0', 08:21:32 INFO - 'HOME': '/home/cltbld', 08:21:32 INFO - 'LANG': 'en_US.UTF-8', 08:21:32 INFO - 'LANGUAGE': 'en_US:en', 08:21:32 INFO - 'LOGNAME': 'cltbld', 08:21:32 INFO - 'MAIL': '/var/mail/cltbld', 08:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:32 INFO - 'MOZ_NO_REMOTE': '1', 08:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:32 INFO - 'NO_EM_RESTART': '1', 08:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:32 INFO - 'PWD': '/builds/slave/test', 08:21:32 INFO - 'SHELL': '/bin/bash', 08:21:32 INFO - 'SHLVL': '1', 08:21:32 INFO - 'TERM': 'linux', 08:21:32 INFO - 'TMOUT': '86400', 08:21:32 INFO - 'USER': 'cltbld', 08:21:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:32 INFO - '_': '/tools/buildbot/bin/python'} 08:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:32 INFO - Downloading/unpacking flake8 08:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:21:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:21:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 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 08:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:21:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:34 INFO - no previously-included directories found matching 'docs/_build' 08:21:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:21:35 INFO - Running setup.py install for pep8 08:21:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:21:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:21:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:21:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:21:35 INFO - no previously-included directories found matching 'docs/_build' 08:21:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:21:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:21:35 INFO - Cleaning up... 08:21:35 INFO - Return code: 0 08:21:35 INFO - Running post-action listener: _resource_record_post_action 08:21:35 INFO - Running post-action listener: _start_resource_monitoring 08:21:35 INFO - Starting resource monitoring. 08:21:35 INFO - ##### 08:21:35 INFO - ##### Finished create-virtualenv step (success) 08:21:35 INFO - ##### 08:21:35 INFO - ##### 08:21:35 INFO - ##### Running install step. 08:21:35 INFO - ##### 08:21:35 INFO - Running pre-action listener: _resource_record_pre_action 08:21:35 INFO - Running main action method: install 08:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:35 INFO - Reading from file tmpfile_stdout 08:21:35 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:35 INFO - Reading from file tmpfile_stdout 08:21:35 INFO - Output received: 08:21:35 INFO - Usage: mozinstall [options] installer 08:21:35 INFO - Options: 08:21:35 INFO - -h, --help show this help message and exit 08:21:35 INFO - -d DEST, --destination=DEST 08:21:35 INFO - Directory to install application into. [default: 08:21:35 INFO - "/builds/slave/test"] 08:21:35 INFO - --app=APP Application being installed. [default: firefox] 08:21:35 INFO - mkdir: /builds/slave/test/build/application 08:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:21:51 INFO - Reading from file tmpfile_stdout 08:21:51 INFO - Output received: 08:21:51 INFO - /builds/slave/test/build/application/firefox/firefox 08:21:51 INFO - Running post-action listener: _resource_record_post_action 08:21:51 INFO - ##### 08:21:51 INFO - ##### Finished install step (success) 08:21:51 INFO - ##### 08:21:51 INFO - ##### 08:21:51 INFO - ##### Running run-tests step. 08:21:51 INFO - ##### 08:21:51 INFO - Running pre-action listener: _resource_record_pre_action 08:21:51 INFO - Running main action method: run_tests 08:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:51 INFO - Python 2.7.3 08:21:51 INFO - Return code: 0 08:21:51 INFO - grabbing minidump binary from tooltool 08:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:51 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 0x12ea2e0>, '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 0x1256140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12565d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:51 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 08:21:51 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 08:21:51 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 08:21:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:51 INFO - Return code: 0 08:21:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:21:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:21:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:21:52 INFO - Return code: 0 08:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:21:52 INFO - Using env: {'DISPLAY': ':0', 08:21:52 INFO - 'HOME': '/home/cltbld', 08:21:52 INFO - 'LANG': 'en_US.UTF-8', 08:21:52 INFO - 'LANGUAGE': 'en_US:en', 08:21:52 INFO - 'LOGNAME': 'cltbld', 08:21:52 INFO - 'MAIL': '/var/mail/cltbld', 08:21:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:52 INFO - 'MOZ_NO_REMOTE': '1', 08:21:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:52 INFO - 'NO_EM_RESTART': '1', 08:21:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:52 INFO - 'PWD': '/builds/slave/test', 08:21:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:52 INFO - 'SHELL': '/bin/bash', 08:21:52 INFO - 'SHLVL': '1', 08:21:52 INFO - 'TERM': 'linux', 08:21:52 INFO - 'TMOUT': '86400', 08:21:52 INFO - 'USER': 'cltbld', 08:21:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439', 08:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:52 INFO - '_': '/tools/buildbot/bin/python'} 08:21:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:21:52 INFO - mozversion application_buildid: 20160621055203 08:21:52 INFO - mozversion application_changeset: 74b32ea89a8c73e35c6ee8ce3bed7bf81528bdab 08:21:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:21:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:52 INFO - mozversion application_name: Firefox 08:21:52 INFO - mozversion application_remotingname: firefox-dev 08:21:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:21:52 INFO - mozversion application_vendor: Mozilla 08:21:52 INFO - mozversion application_version: 49.0a2 08:21:52 INFO - mozversion platform_buildid: 20160621055203 08:21:52 INFO - mozversion platform_changeset: 74b32ea89a8c73e35c6ee8ce3bed7bf81528bdab 08:21:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:21:52 INFO - mozversion platform_version: 49.0a2 08:21:52 INFO - using testdate: 1466522512 08:21:52 INFO - actual date: 1466522512 08:21:52 INFO - starting webserver on 'localhost:51978' 08:21:52 INFO - SUITE-START | Running 2 tests 08:21:52 INFO - TEST-START | dromaeo_css 08:21:52 INFO - operating with platform_type : linux_ 08:21:52 INFO - Initialising browser for dromaeo_css test... 08:21:52 INFO - TEST-INFO | started process 13208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbcHNc3/profile http://localhost:51978/getInfo.html) 08:21:57 INFO - PROCESS | 13208 | __metrics Screen width/height:1600/1200 08:21:57 INFO - PROCESS | 13208 | colorDepth:24 08:21:57 INFO - PROCESS | 13208 | Browser inner width/height: 1024/697 08:21:57 INFO - PROCESS | 13208 | __metrics 08:21:58 ERROR - PROCESS | 13208 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 08:21:59 INFO - TEST-INFO | 13208: exit 0 08:21:59 INFO - Browser initialized. 08:21:59 INFO - Running cycle 1/1 for dromaeo_css test... 08:21:59 INFO - TEST-INFO | started process 13334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbcHNc3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:11 INFO - PROCESS | 13334 | RSS: Main: 155992064 08:22:11 INFO - PROCESS | 13334 | 08:23:00 INFO - PROCESS | 13334 | 1466522580658 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] 08:25:08 INFO - PROCESS | 13334 | Cycle 1(1): loaded http://localhost:51978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51978/tests/dromaeo/cssquery-ext.html) 08:25:09 INFO - PROCESS | 13334 | RSS: Main: 160432128 08:25:09 INFO - PROCESS | 13334 | 08:28:11 INFO - PROCESS | 13334 | Cycle 1(1): loaded http://localhost:51978/tests/dromaeo/cssquery-ext.html (next: http://localhost:51978/tests/dromaeo/cssquery-jquery.html) 08:28:12 INFO - PROCESS | 13334 | RSS: Main: 157995008 08:28:12 INFO - PROCESS | 13334 | 08:31:14 INFO - PROCESS | 13334 | Cycle 1(1): loaded http://localhost:51978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51978/tests/dromaeo/cssquery-mootools.html) 08:31:14 INFO - PROCESS | 13334 | RSS: Main: 157630464 08:31:14 INFO - PROCESS | 13334 | 08:34:16 INFO - PROCESS | 13334 | Cycle 1(1): loaded http://localhost:51978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51978/tests/dromaeo/cssquery-prototype.html) 08:34:17 INFO - PROCESS | 13334 | RSS: Main: 157159424 08:34:17 INFO - PROCESS | 13334 | 08:37:19 INFO - PROCESS | 13334 | Cycle 1(1): loaded http://localhost:51978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51978/tests/dromaeo/cssquery-yui.html) 08:37:20 INFO - PROCESS | 13334 | RSS: Main: 159850496 08:37:20 INFO - PROCESS | 13334 | 08:40:22 INFO - PROCESS | 13334 | Cycle 1(1): loaded http://localhost:51978/tests/dromaeo/cssquery-yui.html (next: http://localhost:51978/tests/dromaeo/cssquery-dojo.html) 08:40:22 INFO - PROCESS | 13334 | RSS: Main: 159477760 08:40:22 INFO - PROCESS | 13334 | 08:40:22 INFO - PROCESS | 13334 | __start_tp_report 08:40:22 INFO - PROCESS | 13334 | _x_x_mozilla_page_load 08:40:22 INFO - PROCESS | 13334 | _x_x_mozilla_page_load_details 08:40:22 INFO - PROCESS | 13334 | |i|pagename|runs| 08:40:22 INFO - PROCESS | 13334 | |0;dojo.html;3414.061133188373;3450.1202193440668;3468.774529655572;3475.3223121491305;3481.8955431337054;5865.824025279248;5882.647041177533;5923.703814809259;5988.7604495820115;5990.9101363479585;5991.161237426763;5995.370486098951;6041.969790151054;6045.546584006206;6046.395360463963;5318.787248510064;5362.812301569426;5398.865028374283;5451.400345961941;5477.178423236506;5250.7637156328055;5265.710385928773;5474.42518535554;5482.39693633702;5519.144532597454;5331.546818520411;5336.893262134755;5372.7045012524295;5391.272178255944;5402.945970540283;5357.142857142858;5379.919301210485;5382.111951527993;5383.084875571162;5399.379071406799;5245.8196905696295;5386.461353864622;5425.538829199483;5431.456854314576;5448.536874365684;5683.715814209314;5708.65748055118;5766.971165144189;5818.505427038707;5822.097574875901;6380.011098279728;6388.904166437507;6390.93609063908;6401.935980640181;6415.775447859302;6473.158489396348;6484.124643173159;6489.123968264271;6499.155109835691;6503.829310724068;5787.421257874179;5824.737886795105;5875.2949646042325;5907.1434641976675;5936.495397891142;6405.29541750407;6464.353564643592;6468.870622587522;6491.7078731457195;6495.1556297681;6090.908636370458;6229.065640153923;6264.248290205113;6276.843078922972;6283.654399008007;6152.692365381713;6191.349908259658;6214.9689251553455;6336.809895703136;6346.079818426302;6320.778772742932;6331.651759153198;6334.619922804646;6335.049742538656;6338.936610633927;6116.4879456621975;6260.248770147611;6316.9368306317265;6321.304656487782;6338.080978258219;4749.928751068736;4826.469088400273;4834.564889159992;4838.685485443435;4853.4418541867435;4267.786610669454;4308.9353659695125;4309.159713855831;4312.072904325585;4334.393184954109;5992.400759923973;6117.847053823601;6119.571629985859;6172.598781079216;6176.938230617726;6101.816945491642;6312.337204593543;6389.297177310492;6405.167328247298;6447.9355206447335;6150.538709596798;6176.4441200292185;6200.782972595937;6217.595856269328;6223.813285601439;5365.597580181502;5408.702521361284;5437.809676661377;5526.309211348582;5557.194206840067;6670.299618540081;6689.130413046273;6694.196696396463;6696.229933557605;6737.663116844138;6438;6504.447121994684;6516.869662606816;6521.67391630426;6526.347365263436;6420.357964203542;6520.576162549419;6521.445677117498;6610.70251838678;6674.365935236145;6314.084457753692;6321.589096708699;6322.367763223825;6334;6341.270753863365;6431.517636177399;6446.387593178641;6449.419552240133;6471.741130354922;6474.287828338973;6023.819285421444;6110.4980065817745;6130.887362651087;6188.752449902134;6261.373862613702;6229.719662615284;6281.497480201664;6284.74861005573;6286.937130628635;6293.874122517615;5910.497607703222;6150.292716337678;6173.969130154321;6180.6291622502795;6183.96908015475;6178.320384757763;6201.534884883742;6237.064440333805;6334.429901308904;6362.968185159045;6139.2325959255095;6180.443760061616;6181.1655426516845;6191;6197.721102550306 08:40:22 INFO - PROCESS | 13334 | |1;ext.html;624.6751689121656;644.1722386733047;663.9634820084897;664.4949838123026;698.2075344484016;39471.80264098679;40988;44119;44244.336334955;44410.555894441044;44880.775596121974;45866;45971;45975;46006.079878402496;8728.214460698537;8968.372213945026;8975.506347150937;8988.910110898873;8990.190882820545;8825.161609647073;9005.54972251388;9008.549572521348;9009.639614415448;9033.503157326344;8985.14641109097;8989.55052247385;9017.143371379709;9066.501342426163;9079.046700096495;8983.595738191798;9010.098990100938;9014.50420226884;9036.322275829307;9049.909500904972;8856.114388561156;8937.106289371075;8941.59762810675;8956.149165829302;8970.775730606721;30709.232269193224;30845.074647760604;30937.0718878434;30965.22586935322;31067.533986990213;3816.446615240802;3925.8625948091967;4000.5199376074765;4409.559044095597;4563.201439748064;33400.49899251513;33453.33093338144;33492.16269593255;33872.83063584691;34181.48727769085;4695.483496815347;4756.31033500144;4780.37855078841;4814.374131362935;4821.903561928777;309203;309290;311000;311258.99999999773;312154;38734.80632596819;64311.678441607495;64948;64980.35019649837;65309;38336.61663383386;41486;41584.58415415868;41932;41933;17762.200700968486;17950.640987180184;18005.369812056517;18018.279268829363;18052.368167114088;15030.473933412279;15055.171965542;15087;15114.395424183129;15161.545153645407;9333.579988900516;9355.25157987373;9359.391639543408;9396.060393960686;9424.717258482257;3517.683408493248;3590.4973303737497;3616.276744651028;3621.040424287566;3672.2288319453214;1127.4475507001673;1137.2494153858413;1139.6125317391961;1152.423788105947;1180.2741314091772;34061.65938340585;34238.14404639854;34345.31309373798;34395.484067739;35129.47305790415;1204.7710934922336;1230.7476967221698;1234.3951463782682;1246.333211731719;1259.0808709642013;17651.117444127744;17929.19318630665;17971.820281797278;18023.369182078826;18309.176087076114;569049;574047;603655;618205;922109;61339;68013.65993170002;68093;68266.317336826;68289.65855170692;1492.7686208637679;1495.0506428418032;1496.0500082447725;1510.7884896114554;1512.6445285357931;34130.65869341275;35221.82389088038;35379.82310088536;35583.288334233686;35824.64175358213;58772.4122758767;59163;59232;59363.1095533576;59374.40625593689;509074;510115;510353;511609;518872;49186;49670.50329496659;50577.49422505728;50889;51238.48761512486;53172.73413632907;54008.839646415276;54587.72706136603;54590.45409545854;55706.44293557013;45743.77128114338;46276.305855412866;47164;47559.52440475551;47695.28457073216;44965.77517112393;45399.319010215535;46210.768946155054;46250.7687461574;47391.28913066238;45941.31088033749;46102;46309;46768.53231467642;46895.29657055215;38053.61946380501;38935;38956;40460.79769601133;40564.79717601511;30008.69991300059;30442.695573043988;30607.846960765055;30904.536431953988;31073.223169420944 08:40:22 INFO - PROCESS | 13334 | |2;jquery.html;431.73879802719335;435.80171022184896;439.2116151508043;439.6504778700934;451.6951058035827;18679.159437825296;19575.804241957576;20270.39188824334;20640.174393024263;20674.173033078696;18739.06304684767;19150.808491915075;19624.018799060024;19634;19825.405237842853;5076.46697096805;5371.194320851884;5377.65045272058;5383.757730902099;5392.40683524812;5425.755840987145;5453.454654534555;5472.425395333473;5585.58108141889;5873.089671100986;5924.822255332347;5952.821415357546;5959.761609535613;5974.372690867462;5998.520118390518;5482.314710661168;5488.945110548883;5501.257330260403;5921.851953701149;5935.050391937291;5306.442823503554;5316.415194328621;5335.466453354672;5347.144456886918;5347.866303342409;15113.924430377887;23242.65136022944;23669.52660946789;23773.405664858343;23898;2468.9753102468926;2504.7476261869065;2579.019972410472;2634.6826586706648;2862.2415060009116;10921.290116142425;11205.383703896283;11328.207025508218;11330.433478326133;13871.861281387159;2109.725735654355;2151.053536443975;2155.665871789875;2177.4882902517897;2196.2203417786777;82274;90383.54808225982;104459.95540044579;106675.46662266717;111706.44146779214;18932.242710291433;19153.90423047904;19517.350362161615;19983.600327993357;20872.47818804542;36300;36335;36662;36723.63276367202;37079.25841483155;10921.563137474572;11012.944935275433;11030.283031603081;11051.72370690739;11292.37891915936;9162.358634895627;9210.585523651453;9267.582958766872;9310.86033709495;9769.120779129913;9769.169620582188;9941.304108712466;9984;10001;10088.49557522121;3667.6646706586826;3737.383331750231;3830.8467661293234;3915.5888631693833;3938.5667576566557;942.1285311087217;1022.8210063239052;1036.8341065429645;1053.210092430677;1118.9888101119047;19543.60912781765;19652.508687282647;19690.40928772139;19966;20079.899600502195;1057.5716834681966;1086.293908959167;1104.8177050786692;1121.5009320852305;1125.426032723317;11086.223964322582;11091.72270693239;11159.94420027911;11161.888381116247;11269;502510;505805;510230;511468;522510;81092.59453702693;88902.55548722215;99815;100734;102282.48858755658;1038.444432228769;1054.7943151085465;1059.89930956559;1081.7566047639218;1084.1976937066513;18027.909860450614;18117.275308987493;18363.449096527125;18402.907985459988;18438.35465758692;43374.78312608417;43809.34285985777;44143;44281.33577996268;44499.55500444954;58167.709161453924;58349.416505836096;59920;61259;61645;9018.864717029119;9181.035991220826;9258;9458.763530911783;9595.712128636153;12756.170848894792;13290.534831280858;13303.401346939218;13889.72220555563;13940.372683229481;11497.367644779282;11694.181407301407;11813.586524471602;11831.881681183078;11925.403729813648;11560.190786644855;11775.705607359885;11796.233244839059;11881;12217.266963981834;11678.182527223353;11761.647150585497;11811.881881181078;11886.465109069939;12004.75990480168;9016.549172541216;9214.723558293263;9229.169374756304;9264.11990860867;9282.118198771106;10962.177836662122;11611.767764644828;11725.648230553097;11770.52917883275;11960.162788604714 08:40:22 INFO - PROCESS | 13334 | |3;mootools.html;1604.8555629993302;1607.8070631524215;1855.1188185611836;1923.403744839099;1936.1287420660697;9441.480718560477;9756.4633945133;10037.498125093753;10119.898801011988;10135.138513226375;10111.898881011188;10213.948930255357;10224.897751022487;10258.589656413735;10290.02244786744;2561.206026131905;2577.3814284571754;2579.342267721728;2587.611858221263;2596.260065881215;2547.4140947581973;2578.419855532509;2581.4837032593464;2587.3660953066433;2590.9870450647813;2515.8993640254366;2518.8236823422367;2581.6385706001174;2600.8179427440086;2600.9089681861046;2493.750624937501;2517.207079769885;2520.6723125993685;2532.670752802133;2534.8859301331486;2523.129520315488;2553.2850801775535;2555.8083143764106;2581.3030481770006;2602.5705758549816;9923.751906202331;10010.199184065257;10048.296619236657;10057;10061.748456288578;5895.174675545427;6008.459238668497;6026.035834266497;6073.848153796146;6149.046897730859;3626.6373362663785;3713.702903767719;3784.810759462016;3822.3502004658994;3847.0959324558708;1287.813267076278;1317.3018300300855;1326.6086504481104;1349.2444231230543;1360.7414591227634;13872.098313609584;13894.305284735723;13913.513027044004;13930;13944.372503237277;4996.375453068366;5046.899062018739;5078.339815823919;5085.593152547787;5095.439501654815;10929.508172132273;10946.945265273622;10951.069159121405;10954.671359859218;10998.06516446095;5808.82573522795;5867.589268751147;5869.236999190163;5915.852103697442;5949.762009519571;4903.289023091703;5205.7917683293;5306.044911915815;5331.466853314715;5513.751881165357;4378.540253273424;4416.470023597189;4455.866324010285;4529.954700452953;4530.818767249273;1312;1315.7171208190284;1322.510671051717;1333.153447560806;1344.7848344264871;892.9196372326392;966.4829316315737;1052.7841792432532;1067.3115840283128;1074.984139987704;6629.270780214172;6658.234303055114;6799.11611490503;6854.2117656469145;6968.477364197705;1056.2131212246925;1094.43089593411;1098.319042193845;1125.3641692443744;1154.7067284641255;4692.131955588227;4844.95155048452;4924.212126059813;5015.799368025311;5035.9928014397265;12126.818097728365;12688.429020694091;12711.491540338468;12758.425870835648;12785.872141278654;12441.75116497665;12534.435950382254;12626.747465050648;12816.295103769382;12890.097693161577;9196.356255062215;9298.442093474414;9423.62305507772;9496;9497.525123743786;6600.405963463311;6635.170603674541;6689.464842812466;6823.93176068233;6970.686319115551;11169.106471482099;11299.887001129884;11587.942060289644;11645.941770291094;11720.941395292968;11540.653780386601;11679.824802627798;11796;11813.173077884809;11854.881451185378;7968.601569921597;8692.130786921258;8773.517456539952;8918.554072296229;8995.280377569648;9585.712428627152;9671.419714817133;9680.85478717834;9692.951535242279;9706.272029597667;8396.580170991549;8471.788205294917;8474.91525084766;8552.486850788973;8584.141585841366;8338.24955753985;8382.329413646772;8578.056413794353;8666.956665216634;8674.522901240493;7838.451308408585;7860.174681658572;7918.2477664621765;7941.205879412013;7955.204479551999;5364.785408583769;5526.86182845416;5539.639923404966;5617.7191140442;5632.549396048388;5570.192322113352;5818.796342128175;5888.852778680567;5894.38108998549;5933.732982015733 08:40:22 INFO - PROCESS | 13334 | |4;prototype.html;353.58037479519714;353.9964600353996;356.6487010294859;356.8162396365872;359.99460008099874;5875.353711091777;5921.615095018826;5940.910886336708;5966.164736936832;5982.611130276529;5701.77192912283;5759.4816466518005;5786.884262314762;5793.246877905877;5803.6227645203135;4469.664775141878;4472.127935052666;4491.550844915515;4500.572445617661;4510.233260345749;4482.932756008662;4499.1901457737595;4506.369108324837;4511.70673906195;4513.390692256553;4454.554544545552;4481.193385190664;4500.527444618317;4509.368688383629;4515.983903621692;4443.711158774686;4478.507364189936;4495.730256184639;4501.347304640809;4504.864854054351;3958.5447673517624;3980.6218409251073;3985.6612187964056;3992.2414741199077;4004.799760012017;5615.2700148980775;5646.915296270518;5673.631213971079;5702.54379649627;5721;4994.35073440454;5118.468256902725;5136.5890728741615;5173;5178.818741344073;6042.909356359658;6081.087836824512;6089.421504957022;6092.958858782314;6119.87760244797;4295.806688699016;4389.858636754435;4390.078083602447;4395.670324725626;4408.515063343029;6148.784792532285;6297.6536290504;6302.968485157545;6306.653134077624;6309.432151106376;4390.648748100144;4399.472063352418;4433.866983990485;4433.869363312335;4444.666600019981;4435.911281774346;4476.149531588988;4476.798544065525;4482.350059241392;4491.550844915548;5055.747212639353;5065.569426598707;5105.7191854448365;5161;5180.404253510819;6077.875593015307;6099.664518451527;6101.206843110367;6146.815595532141;6162.366972752225;1545.1964978211493;1547.9458218962282;1550.8759299256033;1553.7902383178127;1566.169929937135;937.4047479850344;967.6501280713507;975.4683697384942;977.8533220017055;992.9503524823874;5098;5325.973370133124;5333.546648534841;5354.892902142014;5406.864828379322;5504.339479262514;5520.723963801875;5573.665580065209;5576.247206627135;5617;4920.941997470561;5258.2112683097075;5313.574914006947;5347.91431341777;5347.946520534822;2921.583032229367;2936.3540021195304;2945.9263518412213;2969.391274788663;2971.286891146109;5686.402927692616;5700.25896633435;5712.7714891403875;5731.312242530923;5743.425657434307;5938.524918006549;6437.9678101610125;6459.741610335628;6473.352664733583;6475.190601174853;6510.707018184193;6565.441937435276;6573.506986975996;6591.538592298589;6633.568818026813;6142.433679411722;6295.716692748929;6352.237731472253;6354.777582784581;6369.7452101915405;6076.848078798065;6252.687365631609;6281.623102613858;6295.622262664255;6295.905561416491;6459.806205813833;6483.805485835433;6499.252585952676;6600.966995164993;6610.239822420291;4455.576720211704;4481.574250446202;4487.282034874404;4511.729296242236;4518.88702782433;6313;6322.905156422749;6352.7612115637;6390.584612000205;6455.128012876214;6158.199434073542;6207.472364848858;6207.720652570555;6211.2857021441305;6229.190205273286;5974.761009559569;6070.3019152798;6146.231721034871;6160;6204.286507051746;6019;6034.78878239277;6080.452759251689;6100.908486372797;6129.816105516842;6196.628202307876;6198.504119670325;6226.25284965807;6241.594296370721;6268.122462855113;5794.855128621818;6028.969855150872;6082.36135205797;6096.969515152396;6127.111568822585 08:40:22 INFO - PROCESS | 13334 | |5;yui.html;728.7995801154682;782.6008735544871;789.5617932047718;840.0339609449132;879.9604017819196;13981.930090349546;15059.247037648129;15107.244637768123;15259.694806103898;15395.692086158284;15113.244337783095;15292.84707152928;15295.311710973005;15298.84701152988;15307.92346038271;710.0662628643317;837.5770236030827;853.2875049333813;859.6131740716671;862.8533149364623;842.4524059361434;844.2148801614496;849.587949844325;851.1233429567556;852.5438890193748;899.4063917814244;900.5362238447204;903.7108125399875;905.3119629081913;906.4561263242068;890.4568213389826;893.3076865429312;897.6050537763396;898.5013317608724;904.0507467159489;662.3045801907978;665.1618960110247;665.8867992441296;667.2693400726197;667.7696194812781;14474;14585.854141458556;14595.883596878499;14600.853991460055;14624.976251662281;14660.633484162874;15005.474808381654;15180.924095379452;15415.537533874001;15774.132422716746;12270.202436841666;12620.55828046023;12783.936080319632;12871.712828717147;13000.544980925622;3981.3828856527284;3984.6812255019527;4005.819738111792;4033.052232725307;4095.4675892133832;75250;76293.23706762973;76840;76972.61513692452;77359.22640773577;12002.279863208236;12244.81632775509;12423.462773489713;12434.937825310997;12455.22510069712;24016.63975040376;24030.87984560066;24063.398415039414;24173.274801755975;24255.757442425704;8573.356998225157;8609.870851937227;8753.912460875437;8788.033316335199;8798.86801697975;4833.95166048335;4991.251312303184;5004.474530174352;5028.874278143076;5119.360079990001;3826.215625796705;3919.6472317490993;3932.7640341579595;3940.0937784309194;3940.9605903941165;619.9132121502993;625.8842114208886;655.8721049395417;659.4032400677395;661.0282884160276;701.3512500936613;711.370437163104;744.0327574153579;765.456525866641;775.7812655804395;10111.595536178618;10138.188944884392;10296.07335339823;10304.948475257726;10382.221333400024;629.820501157168;657.4181849063613;712.2663656433881;716.8781307177792;731.6305265840716;4795.688280261772;4988;5010.098182327143;5029.2958985742025;5046.671966322251;70800.2919970804;71018.64490677514;72467.55064898673;72741;124082.37958810148;86926.1307386918;105923.47038264759;107950;111544;113283;96008.51995739977;96262.51868740612;97398;98345.50827245817;100007;9471;9536.85694714566;9554;9588.424694518351;9595.328327017321;48367;53876.75148413989;54082;56315.436845632656;57343.42656573381;54560;67781;69463;70123.69124665743;77529.8370524454;13683.315834208448;13991;14078.366473508922;14292.285385730464;14404.495842645458;13705.177689338672;14376.640583985483;14632.634184145481;14945.476908308592;15207.163606001775;13716.314184290944;13721.931390342985;13763.174209547458;14297.857021429652;14694.485693000694;12707.809382859079;12744.10791244604;13052.086353955132;13227.735445290848;13900.096493727875;11490.885091149315;11667.883321167019;11918.344491053076;12680.6829829255;14098.577042688736;11260.7747845041;11518;11730.824037639271;11746;11884.762304753684;11282.717932051764;11488.655340339803;11492.770144596894;11629.53481860716;11909.285442873455 08:40:22 INFO - PROCESS | 13334 | __end_tp_report 08:40:22 INFO - PROCESS | 13334 | __start_cc_report 08:40:22 INFO - PROCESS | 13334 | _x_x_mozilla_cycle_collect,334 08:40:22 INFO - PROCESS | 13334 | __end_cc_report 08:40:22 INFO - PROCESS | 13334 | __startTimestamp1466523622622__endTimestamp 08:40:22 INFO - PROCESS | 13334 | 08:40:22 INFO - PROCESS | 13334 | ------- Summary: start ------- 08:40:22 INFO - PROCESS | 13334 | Number of tests: 6 08:40:22 INFO - PROCESS | 13334 | 08:40:22 INFO - PROCESS | 13334 | [#0] dojo.html Cycles:165 Average:5913.35 Median:6176.94 stddev:686.86 (11.1%) stddev-sans-first:660.39 08:40:22 INFO - PROCESS | 13334 | Values: 3414.1 3450.1 3468.8 3475.3 3481.9 5865.8 5882.6 5923.7 5988.8 5990.9 5991.2 5995.4 6042.0 6045.5 6046.4 5318.8 5362.8 5398.9 5451.4 5477.2 5250.8 5265.7 5474.4 5482.4 5519.1 5331.5 5336.9 5372.7 5391.3 5402.9 5357.1 5379.9 5382.1 5383.1 5399.4 5245.8 5386.5 5425.5 5431.5 5448.5 5683.7 5708.7 5767.0 5818.5 5822.1 6380.0 6388.9 6390.9 6401.9 6415.8 6473.2 6484.1 6489.1 6499.2 6503.8 5787.4 5824.7 5875.3 5907.1 5936.5 6405.3 6464.4 6468.9 6491.7 6495.2 6090.9 6229.1 6264.2 6276.8 6283.7 6152.7 6191.3 6215.0 6336.8 6346.1 6320.8 6331.7 6334.6 6335.0 6338.9 6116.5 6260.2 6316.9 6321.3 6338.1 4749.9 4826.5 4834.6 4838.7 4853.4 4267.8 4308.9 4309.2 4312.1 4334.4 5992.4 6117.8 6119.6 6172.6 6176.9 6101.8 6312.3 6389.3 6405.2 6447.9 6150.5 6176.4 6200.8 6217.6 6223.8 5365.6 5408.7 5437.8 5526.3 5557.2 6670.3 6689.1 6694.2 6696.2 6737.7 6438.0 6504.4 6516.9 6521.7 6526.3 6420.4 6520.6 6521.4 6610.7 6674.4 6314.1 6321.6 6322.4 6334.0 6341.3 6431.5 6446.4 6449.4 6471.7 6474.3 6023.8 6110.5 6130.9 6188.8 6261.4 6229.7 6281.5 6284.7 6286.9 6293.9 5910.5 6150.3 6174.0 6180.6 6184.0 6178.3 6201.5 6237.1 6334.4 6363.0 6139.2 6180.4 6181.2 6191.0 6197.7 08:40:22 INFO - PROCESS | 13334 | 08:40:22 INFO - PROCESS | 13334 | [#1] ext.html Cycles:180 Average:65714.82 Median:45903.66 stddev:138914.41 (302.6%) stddev-sans-first:139218.13 08:40:22 INFO - PROCESS | 13334 | Values: 624.7 644.2 664.0 664.5 698.2 39471.8 40988.0 44119.0 44244.3 44410.6 44880.8 45866.0 45971.0 45975.0 46006.1 8728.2 8968.4 8975.5 8988.9 8990.2 8825.2 9005.5 9008.5 9009.6 9033.5 8985.1 8989.6 9017.1 9066.5 9079.0 8983.6 9010.1 9014.5 9036.3 9049.9 8856.1 8937.1 8941.6 8956.1 8970.8 30709.2 30845.1 30937.1 30965.2 31067.5 3816.4 3925.9 4000.5 4409.6 4563.2 33400.5 33453.3 33492.2 33872.8 34181.5 4695.5 4756.3 4780.4 4814.4 4821.9 309203.0 309290.0 311000.0 311259.0 312154.0 38734.8 64311.7 64948.0 64980.4 65309.0 38336.6 41486.0 41584.6 41932.0 41933.0 17762.2 17950.6 18005.4 18018.3 18052.4 15030.5 15055.2 15087.0 15114.4 15161.5 9333.6 9355.3 9359.4 9396.1 9424.7 3517.7 3590.5 3616.3 3621.0 3672.2 1127.4 1137.2 1139.6 1152.4 1180.3 34061.7 34238.1 34345.3 34395.5 35129.5 1204.8 1230.7 1234.4 1246.3 1259.1 17651.1 17929.2 17971.8 18023.4 18309.2 569049.0 574047.0 603655.0 618205.0 922109.0 61339.0 68013.7 68093.0 68266.3 68289.7 1492.8 1495.1 1496.1 1510.8 1512.6 34130.7 35221.8 35379.8 35583.3 35824.6 58772.4 59163.0 59232.0 59363.1 59374.4 509074.0 510115.0 510353.0 511609.0 518872.0 49186.0 49670.5 50577.5 50889.0 51238.5 53172.7 54008.8 54587.7 54590.5 55706.4 45743.8 46276.3 47164.0 47559.5 47695.3 44965.8 45399.3 46210.8 46250.8 47391.3 45941.3 46102.0 46309.0 46768.5 46895.3 38053.6 38935.0 38956.0 40460.8 40564.8 30008.7 30442.7 30607.8 30904.5 31073.2 08:40:22 INFO - PROCESS | 13334 | 08:40:22 INFO - PROCESS | 13334 | [#2] jquery.html Cycles:180 Average:31555.98 Median:2186.85 stddev:84343.53 (3856.8%) stddev-sans-first:84547.76 08:40:22 INFO - PROCESS | 13334 | Values: 431.7 435.8 439.2 439.7 451.7 18679.2 19575.8 20270.4 20640.2 20674.2 18739.1 19150.8 19624.0 19634.0 19825.4 5076.5 5371.2 5377.7 5383.8 5392.4 5425.8 5453.5 5472.4 5585.6 5873.1 5924.8 5952.8 5959.8 5974.4 5998.5 5482.3 5488.9 5501.3 5921.9 5935.1 5306.4 5316.4 5335.5 5347.1 5347.9 15113.9 23242.7 23669.5 23773.4 23898.0 2469.0 2504.7 2579.0 2634.7 2862.2 10921.3 11205.4 11328.2 11330.4 13871.9 2109.7 2151.1 2155.7 2177.5 2196.2 82274.0 90383.5 104460.0 106675.5 111706.4 18932.2 19153.9 19517.4 19983.6 20872.5 36300.0 36335.0 36662.0 36723.6 37079.3 10921.6 11012.9 11030.3 11051.7 11292.4 9162.4 9210.6 9267.6 9310.9 9769.1 9769.2 9941.3 9984.0 10001.0 10088.5 3667.7 3737.4 3830.8 3915.6 3938.6 942.1 1022.8 1036.8 1053.2 1119.0 19543.6 19652.5 19690.4 19966.0 20079.9 1057.6 1086.3 1104.8 1121.5 1125.4 11086.2 11091.7 11159.9 11161.9 11269.0 502510.0 505805.0 510230.0 511468.0 522510.0 81092.6 88902.6 99815.0 100734.0 102282.5 1038.4 1054.8 1059.9 1081.8 1084.2 18027.9 18117.3 18363.4 18402.9 18438.4 43374.8 43809.3 44143.0 44281.3 44499.6 58167.7 58349.4 59920.0 61259.0 61645.0 9018.9 9181.0 9258.0 9458.8 9595.7 12756.2 13290.5 13303.4 13889.7 13940.4 11497.4 11694.2 11813.6 11831.9 11925.4 11560.2 11775.7 11796.2 11881.0 12217.3 11678.2 11761.6 11811.9 11886.5 12004.8 9016.5 9214.7 9229.2 9264.1 9282.1 10962.2 11611.8 11725.6 11770.5 11960.2 08:40:22 INFO - PROCESS | 13334 | 08:40:22 INFO - PROCESS | 13334 | [#3] mootools.html Cycles:180 Average:6548.38 Median:3670.17 stddev:3760.71 (102.5%) stddev-sans-first:3752.91 08:40:22 INFO - PROCESS | 13334 | Values: 1604.9 1607.8 1855.1 1923.4 1936.1 9441.5 9756.5 10037.5 10119.9 10135.1 10111.9 10213.9 10224.9 10258.6 10290.0 2561.2 2577.4 2579.3 2587.6 2596.3 2547.4 2578.4 2581.5 2587.4 2591.0 2515.9 2518.8 2581.6 2600.8 2600.9 2493.8 2517.2 2520.7 2532.7 2534.9 2523.1 2553.3 2555.8 2581.3 2602.6 9923.8 10010.2 10048.3 10057.0 10061.7 5895.2 6008.5 6026.0 6073.8 6149.0 3626.6 3713.7 3784.8 3822.4 3847.1 1287.8 1317.3 1326.6 1349.2 1360.7 13872.1 13894.3 13913.5 13930.0 13944.4 4996.4 5046.9 5078.3 5085.6 5095.4 10929.5 10946.9 10951.1 10954.7 10998.1 5808.8 5867.6 5869.2 5915.9 5949.8 4903.3 5205.8 5306.0 5331.5 5513.8 4378.5 4416.5 4455.9 4530.0 4530.8 1312.0 1315.7 1322.5 1333.2 1344.8 892.9 966.5 1052.8 1067.3 1075.0 6629.3 6658.2 6799.1 6854.2 6968.5 1056.2 1094.4 1098.3 1125.4 1154.7 4692.1 4845.0 4924.2 5015.8 5036.0 12126.8 12688.4 12711.5 12758.4 12785.9 12441.8 12534.4 12626.7 12816.3 12890.1 9196.4 9298.4 9423.6 9496.0 9497.5 6600.4 6635.2 6689.5 6823.9 6970.7 11169.1 11299.9 11587.9 11645.9 11720.9 11540.7 11679.8 11796.0 11813.2 11854.9 7968.6 8692.1 8773.5 8918.6 8995.3 9585.7 9671.4 9680.9 9693.0 9706.3 8396.6 8471.8 8474.9 8552.5 8584.1 8338.2 8382.3 8578.1 8667.0 8674.5 7838.5 7860.2 7918.2 7941.2 7955.2 5364.8 5526.9 5539.6 5617.7 5632.5 5570.2 5818.8 5888.9 5894.4 5933.7 08:40:22 INFO - PROCESS | 13334 | 08:40:22 INFO - PROCESS | 13334 | [#4] prototype.html Cycles:180 Average:5068.23 Median:5702.16 stddev:1516.49 (26.6%) stddev-sans-first:1478.88 08:40:22 INFO - PROCESS | 13334 | Values: 353.6 354.0 356.6 356.8 360.0 5875.4 5921.6 5940.9 5966.2 5982.6 5701.8 5759.5 5786.9 5793.2 5803.6 4469.7 4472.1 4491.6 4500.6 4510.2 4482.9 4499.2 4506.4 4511.7 4513.4 4454.6 4481.2 4500.5 4509.4 4516.0 4443.7 4478.5 4495.7 4501.3 4504.9 3958.5 3980.6 3985.7 3992.2 4004.8 5615.3 5646.9 5673.6 5702.5 5721.0 4994.4 5118.5 5136.6 5173.0 5178.8 6042.9 6081.1 6089.4 6093.0 6119.9 4295.8 4389.9 4390.1 4395.7 4408.5 6148.8 6297.7 6303.0 6306.7 6309.4 4390.6 4399.5 4433.9 4433.9 4444.7 4435.9 4476.1 4476.8 4482.4 4491.6 5055.7 5065.6 5105.7 5161.0 5180.4 6077.9 6099.7 6101.2 6146.8 6162.4 1545.2 1547.9 1550.9 1553.8 1566.2 937.4 967.7 975.5 977.9 993.0 5098.0 5326.0 5333.5 5354.9 5406.9 5504.3 5520.7 5573.7 5576.2 5617.0 4920.9 5258.2 5313.6 5347.9 5347.9 2921.6 2936.4 2945.9 2969.4 2971.3 5686.4 5700.3 5712.8 5731.3 5743.4 5938.5 6438.0 6459.7 6473.4 6475.2 6510.7 6565.4 6573.5 6591.5 6633.6 6142.4 6295.7 6352.2 6354.8 6369.7 6076.8 6252.7 6281.6 6295.6 6295.9 6459.8 6483.8 6499.3 6601.0 6610.2 4455.6 4481.6 4487.3 4511.7 4518.9 6313.0 6322.9 6352.8 6390.6 6455.1 6158.2 6207.5 6207.7 6211.3 6229.2 5974.8 6070.3 6146.2 6160.0 6204.3 6019.0 6034.8 6080.5 6100.9 6129.8 6196.6 6198.5 6226.3 6241.6 6268.1 5794.9 6029.0 6082.4 6097.0 6127.1 08:40:22 INFO - PROCESS | 13334 | 08:40:22 INFO - PROCESS | 13334 | [#5] yui.html Cycles:180 Average:20481.25 Median:4445.58 stddev:28742.17 (646.5%) stddev-sans-first:28784.53 08:40:22 INFO - PROCESS | 13334 | Values: 728.8 782.6 789.6 840.0 880.0 13981.9 15059.2 15107.2 15259.7 15395.7 15113.2 15292.8 15295.3 15298.8 15307.9 710.1 837.6 853.3 859.6 862.9 842.5 844.2 849.6 851.1 852.5 899.4 900.5 903.7 905.3 906.5 890.5 893.3 897.6 898.5 904.1 662.3 665.2 665.9 667.3 667.8 14474.0 14585.9 14595.9 14600.9 14625.0 14660.6 15005.5 15180.9 15415.5 15774.1 12270.2 12620.6 12783.9 12871.7 13000.5 3981.4 3984.7 4005.8 4033.1 4095.5 75250.0 76293.2 76840.0 76972.6 77359.2 12002.3 12244.8 12423.5 12434.9 12455.2 24016.6 24030.9 24063.4 24173.3 24255.8 8573.4 8609.9 8753.9 8788.0 8798.9 4834.0 4991.3 5004.5 5028.9 5119.4 3826.2 3919.6 3932.8 3940.1 3941.0 619.9 625.9 655.9 659.4 661.0 701.4 711.4 744.0 765.5 775.8 10111.6 10138.2 10296.1 10304.9 10382.2 629.8 657.4 712.3 716.9 731.6 4795.7 4988.0 5010.1 5029.3 5046.7 70800.3 71018.6 72467.6 72741.0 124082.4 86926.1 105923.5 107950.0 111544.0 113283.0 96008.5 96262.5 97398.0 98345.5 100007.0 9471.0 9536.9 9554.0 9588.4 9595.3 48367.0 53876.8 54082.0 56315.4 57343.4 54560.0 67781.0 69463.0 70123.7 77529.8 13683.3 13991.0 14078.4 14292.3 14404.5 13705.2 14376.6 14632.6 14945.5 15207.2 13716.3 13721.9 13763.2 14297.9 14694.5 12707.8 12744.1 13052.1 13227.7 13900.1 11490.9 11667.9 11918.3 12680.7 14098.6 11260.8 11518.0 11730.8 11746.0 11884.8 11282.7 11488.7 11492.8 11629.5 11909.3 08:40:22 INFO - PROCESS | 13334 | -------- Summary: end -------- 08:40:22 INFO - PROCESS | 13334 | 08:40:23 INFO - TEST-INFO | 13334: exit 0 08:40:23 INFO - TEST-OK | dromaeo_css | took 1110711ms 08:40:23 INFO - TEST-START | kraken 08:40:23 INFO - operating with platform_type : linux_ 08:40:23 INFO - Initialising browser for kraken test... 08:40:23 INFO - TEST-INFO | started process 13585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXSqhhA/profile http://localhost:51978/getInfo.html) 08:40:27 INFO - PROCESS | 13585 | __metrics Screen width/height:1600/1200 08:40:27 INFO - PROCESS | 13585 | colorDepth:24 08:40:27 INFO - PROCESS | 13585 | Browser inner width/height: 1024/697 08:40:27 INFO - PROCESS | 13585 | __metrics 08:40:28 ERROR - PROCESS | 13585 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 08:40:29 INFO - TEST-INFO | 13585: exit 0 08:40:29 INFO - Browser initialized. 08:40:29 INFO - Running cycle 1/1 for kraken test... 08:40:29 INFO - TEST-INFO | started process 13715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXSqhhA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:41 INFO - PROCESS | 13715 | RSS: Main: 156487680 08:40:41 INFO - PROCESS | 13715 | 08:40:43 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51978/tests/kraken/driver.html?testName=audio-beat-detection) 08:40:44 INFO - PROCESS | 13715 | RSS: Main: 161218560 08:40:44 INFO - PROCESS | 13715 | 08:40:47 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51978/tests/kraken/driver.html?testName=audio-dft) 08:40:47 INFO - PROCESS | 13715 | RSS: Main: 160874496 08:40:47 INFO - PROCESS | 13715 | 08:40:50 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51978/tests/kraken/driver.html?testName=audio-fft) 08:40:51 INFO - PROCESS | 13715 | RSS: Main: 161525760 08:40:51 INFO - PROCESS | 13715 | 08:40:53 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51978/tests/kraken/driver.html?testName=audio-oscillator) 08:40:53 INFO - PROCESS | 13715 | RSS: Main: 161288192 08:40:53 INFO - PROCESS | 13715 | 08:40:56 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:56 INFO - PROCESS | 13715 | RSS: Main: 161439744 08:40:56 INFO - PROCESS | 13715 | 08:40:59 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51978/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:00 INFO - PROCESS | 13715 | RSS: Main: 161517568 08:41:00 INFO - PROCESS | 13715 | 08:41:03 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51978/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:04 INFO - PROCESS | 13715 | RSS: Main: 161910784 08:41:04 INFO - PROCESS | 13715 | 08:41:07 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51978/tests/kraken/driver.html?testName=json-parse-financial) 08:41:07 INFO - PROCESS | 13715 | RSS: Main: 161849344 08:41:07 INFO - PROCESS | 13715 | 08:41:09 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:10 INFO - PROCESS | 13715 | RSS: Main: 161472512 08:41:10 INFO - PROCESS | 13715 | 08:41:11 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51978/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:12 INFO - PROCESS | 13715 | RSS: Main: 161280000 08:41:12 INFO - PROCESS | 13715 | 08:41:14 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:15 INFO - PROCESS | 13715 | RSS: Main: 161726464 08:41:15 INFO - PROCESS | 13715 | 08:41:17 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:41:18 INFO - PROCESS | 13715 | RSS: Main: 162193408 08:41:18 INFO - PROCESS | 13715 | 08:41:20 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:21 INFO - PROCESS | 13715 | RSS: Main: 161935360 08:41:21 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | Cycle 1(1): loaded http://localhost:51978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51978/tests/kraken/driver.html?testName=ai-astar) 08:41:23 INFO - PROCESS | 13715 | RSS: Main: 162279424 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | __start_tp_report 08:41:23 INFO - PROCESS | 13715 | _x_x_mozilla_page_load 08:41:23 INFO - PROCESS | 13715 | _x_x_mozilla_page_load_details 08:41:23 INFO - PROCESS | 13715 | |i|pagename|runs| 08:41:23 INFO - PROCESS | 13715 | |0;ai-astar;110;104;109;109;109;112;110;109;109;110 08:41:23 INFO - PROCESS | 13715 | |1;audio-beat-detection;161;124;160;172;127;153;150;129;185;127 08:41:23 INFO - PROCESS | 13715 | |2;audio-dft;161;163;161;163;162;163;165;164;165;162 08:41:23 INFO - PROCESS | 13715 | |3;audio-fft;75;76;78;180;76;75;74;77;159;75 08:41:23 INFO - PROCESS | 13715 | |4;audio-oscillator;83;84;145;83;84;83;147;83;83;145 08:41:23 INFO - PROCESS | 13715 | |5;imaging-gaussian-blur;118;118;117;116;117;117;119;118;118;117 08:41:23 INFO - PROCESS | 13715 | |6;imaging-darkroom;147;149;146;147;147;150;147;147;146;147 08:41:23 INFO - PROCESS | 13715 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 08:41:23 INFO - PROCESS | 13715 | |8;json-parse-financial;51;51;51;56;58;53;54;52;51;53 08:41:23 INFO - PROCESS | 13715 | |9;json-stringify-tinderbox;59;60;59;60;60;59;60;60;62;59 08:41:23 INFO - PROCESS | 13715 | |10;stanford-crypto-aes;78;75;75;76;77;77;76;77;107;77 08:41:23 INFO - PROCESS | 13715 | |11;stanford-crypto-ccm;116;126;129;118;120;122;135;128;133;127 08:41:23 INFO - PROCESS | 13715 | |12;stanford-crypto-pbkdf2;158;154;158;160;157;157;161;155;156;154 08:41:23 INFO - PROCESS | 13715 | |13;stanford-crypto-sha256-iterative;62;66;61;63;63;60;62;64;60;62 08:41:23 INFO - PROCESS | 13715 | __end_tp_report 08:41:23 INFO - PROCESS | 13715 | __start_cc_report 08:41:23 INFO - PROCESS | 13715 | _x_x_mozilla_cycle_collect,894 08:41:23 INFO - PROCESS | 13715 | __end_cc_report 08:41:23 INFO - PROCESS | 13715 | __startTimestamp1466523683469__endTimestamp 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | ------- Summary: start ------- 08:41:23 INFO - PROCESS | 13715 | Number of tests: 14 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.50 stddev:2.02 (1.8%) stddev-sans-first:2.12 08:41:23 INFO - PROCESS | 13715 | Values: 110.0 104.0 109.0 109.0 109.0 112.0 110.0 109.0 109.0 110.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:156.50 stddev:21.34 (13.6%) stddev-sans-first:22.18 08:41:23 INFO - PROCESS | 13715 | Values: 161.0 124.0 160.0 172.0 127.0 153.0 150.0 129.0 185.0 127.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.45 (0.9%) stddev-sans-first:1.36 08:41:23 INFO - PROCESS | 13715 | Values: 161.0 163.0 161.0 163.0 162.0 163.0 165.0 164.0 165.0 162.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#3] audio-fft Cycles:10 Average:94.50 Median:75.50 stddev:39.85 (52.8%) stddev-sans-first:41.64 08:41:23 INFO - PROCESS | 13715 | Values: 75.0 76.0 78.0 180.0 76.0 75.0 74.0 77.0 159.0 75.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:83.00 stddev:30.14 (36.3%) stddev-sans-first:31.17 08:41:23 INFO - PROCESS | 13715 | Values: 83.0 84.0 145.0 83.0 84.0 83.0 147.0 83.0 83.0 145.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 08:41:23 INFO - PROCESS | 13715 | Values: 118.0 118.0 117.0 116.0 117.0 117.0 119.0 118.0 118.0 117.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.25 (0.9%) stddev-sans-first:1.32 08:41:23 INFO - PROCESS | 13715 | Values: 147.0 149.0 146.0 147.0 147.0 150.0 147.0 147.0 146.0 147.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:41:23 INFO - PROCESS | 13715 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:2.40 (4.5%) stddev-sans-first:2.44 08:41:23 INFO - PROCESS | 13715 | Values: 51.0 51.0 51.0 56.0 58.0 53.0 54.0 52.0 51.0 53.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.93 08:41:23 INFO - PROCESS | 13715 | Values: 59.0 60.0 59.0 60.0 60.0 59.0 60.0 60.0 62.0 59.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:77.00 stddev:9.71 (12.6%) stddev-sans-first:10.28 08:41:23 INFO - PROCESS | 13715 | Values: 78.0 75.0 75.0 76.0 77.0 77.0 76.0 77.0 107.0 77.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:127.50 stddev:6.29 (4.9%) stddev-sans-first:5.68 08:41:23 INFO - PROCESS | 13715 | Values: 116.0 126.0 129.0 118.0 120.0 122.0 135.0 128.0 133.0 127.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:157.50 stddev:2.36 (1.5%) stddev-sans-first:2.47 08:41:23 INFO - PROCESS | 13715 | Values: 158.0 154.0 158.0 160.0 157.0 157.0 161.0 155.0 156.0 154.0 08:41:23 INFO - PROCESS | 13715 | 08:41:23 INFO - PROCESS | 13715 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.83 (2.9%) stddev-sans-first:1.94 08:41:23 INFO - PROCESS | 13715 | Values: 62.0 66.0 61.0 63.0 63.0 60.0 62.0 64.0 60.0 62.0 08:41:23 INFO - PROCESS | 13715 | -------- Summary: end -------- 08:41:23 INFO - PROCESS | 13715 | 08:41:24 INFO - TEST-INFO | 13715: exit 0 08:41:24 INFO - TEST-OK | kraken | took 61088ms 08:41:24 INFO - SUITE-END | took 1171s 08:41:24 INFO - Completed test suite (00:19:32) 08:41:24 INFO - javascript benchmark 08:41:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7850.902822770593, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3414.061133188373, 3450.1202193440668, 3468.774529655572, 3475.3223121491305, 3481.8955431337054, 5865.824025279248, 5882.647041177533, 5923.703814809259, 5988.7604495820115, 5990.9101363479585, 5991.161237426763, 5995.370486098951, 6041.969790151054, 6045.546584006206, 6046.395360463963, 5318.787248510064, 5362.812301569426, 5398.865028374283, 5451.400345961941, 5477.178423236506, 5250.7637156328055, 5265.710385928773, 5474.42518535554, 5482.39693633702, 5519.144532597454, 5331.546818520411, 5336.893262134755, 5372.7045012524295, 5391.272178255944, 5402.945970540283, 5357.142857142858, 5379.919301210485, 5382.111951527993, 5383.084875571162, 5399.379071406799, 5245.8196905696295, 5386.461353864622, 5425.538829199483, 5431.456854314576, 5448.536874365684, 5683.715814209314, 5708.65748055118, 5766.971165144189, 5818.505427038707, 5822.097574875901, 6380.011098279728, 6388.904166437507, 6390.93609063908, 6401.935980640181, 6415.775447859302, 6473.158489396348, 6484.124643173159, 6489.123968264271, 6499.155109835691, 6503.829310724068, 5787.421257874179, 5824.737886795105, 5875.2949646042325, 5907.1434641976675, 5936.495397891142, 6405.29541750407, 6464.353564643592, 6468.870622587522, 6491.7078731457195, 6495.1556297681, 6090.908636370458, 6229.065640153923, 6264.248290205113, 6276.843078922972, 6283.654399008007, 6152.692365381713, 6191.349908259658, 6214.9689251553455, 6336.809895703136, 6346.079818426302, 6320.778772742932, 6331.651759153198, 6334.619922804646, 6335.049742538656, 6338.936610633927, 6116.4879456621975, 6260.248770147611, 6316.9368306317265, 6321.304656487782, 6338.080978258219, 4749.928751068736, 4826.469088400273, 4834.564889159992, 4838.685485443435, 4853.4418541867435, 4267.786610669454, 4308.9353659695125, 4309.159713855831, 4312.072904325585, 4334.393184954109, 5992.400759923973, 6117.847053823601, 6119.571629985859, 6172.598781079216, 6176.938230617726, 6101.816945491642, 6312.337204593543, 6389.297177310492, 6405.167328247298, 6447.9355206447335, 6150.538709596798, 6176.4441200292185, 6200.782972595937, 6217.595856269328, 6223.813285601439, 5365.597580181502, 5408.702521361284, 5437.809676661377, 5526.309211348582, 5557.194206840067, 6670.299618540081, 6689.130413046273, 6694.196696396463, 6696.229933557605, 6737.663116844138, 6438.0, 6504.447121994684, 6516.869662606816, 6521.67391630426, 6526.347365263436, 6420.357964203542, 6520.576162549419, 6521.445677117498, 6610.70251838678, 6674.365935236145, 6314.084457753692, 6321.589096708699, 6322.367763223825, 6334.0, 6341.270753863365, 6431.517636177399, 6446.387593178641, 6449.419552240133, 6471.741130354922, 6474.287828338973, 6023.819285421444, 6110.4980065817745, 6130.887362651087, 6188.752449902134, 6261.373862613702, 6229.719662615284, 6281.497480201664, 6284.74861005573, 6286.937130628635, 6293.874122517615, 5910.497607703222, 6150.292716337678, 6173.969130154321, 6180.6291622502795, 6183.96908015475, 6178.320384757763, 6201.534884883742, 6237.064440333805, 6334.429901308904, 6362.968185159045, 6139.2325959255095, 6180.443760061616, 6181.1655426516845, 6191.0, 6197.721102550306], "value": 5866.25399173656, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.6751689121656, 644.1722386733047, 663.9634820084897, 664.4949838123026, 698.2075344484016, 39471.80264098679, 40988.0, 44119.0, 44244.336334955, 44410.555894441044, 44880.775596121974, 45866.0, 45971.0, 45975.0, 46006.079878402496, 8728.214460698537, 8968.372213945026, 8975.506347150937, 8988.910110898873, 8990.190882820545, 8825.161609647073, 9005.54972251388, 9008.549572521348, 9009.639614415448, 9033.503157326344, 8985.14641109097, 8989.55052247385, 9017.143371379709, 9066.501342426163, 9079.046700096495, 8983.595738191798, 9010.098990100938, 9014.50420226884, 9036.322275829307, 9049.909500904972, 8856.114388561156, 8937.106289371075, 8941.59762810675, 8956.149165829302, 8970.775730606721, 30709.232269193224, 30845.074647760604, 30937.0718878434, 30965.22586935322, 31067.533986990213, 3816.446615240802, 3925.8625948091967, 4000.5199376074765, 4409.559044095597, 4563.201439748064, 33400.49899251513, 33453.33093338144, 33492.16269593255, 33872.83063584691, 34181.48727769085, 4695.483496815347, 4756.31033500144, 4780.37855078841, 4814.374131362935, 4821.903561928777, 309203.0, 309290.0, 311000.0, 311258.99999999773, 312154.0, 38734.80632596819, 64311.678441607495, 64948.0, 64980.35019649837, 65309.0, 38336.61663383386, 41486.0, 41584.58415415868, 41932.0, 41933.0, 17762.200700968486, 17950.640987180184, 18005.369812056517, 18018.279268829363, 18052.368167114088, 15030.473933412279, 15055.171965542, 15087.0, 15114.395424183129, 15161.545153645407, 9333.579988900516, 9355.25157987373, 9359.391639543408, 9396.060393960686, 9424.717258482257, 3517.683408493248, 3590.4973303737497, 3616.276744651028, 3621.040424287566, 3672.2288319453214, 1127.4475507001673, 1137.2494153858413, 1139.6125317391961, 1152.423788105947, 1180.2741314091772, 34061.65938340585, 34238.14404639854, 34345.31309373798, 34395.484067739, 35129.47305790415, 1204.7710934922336, 1230.7476967221698, 1234.3951463782682, 1246.333211731719, 1259.0808709642013, 17651.117444127744, 17929.19318630665, 17971.820281797278, 18023.369182078826, 18309.176087076114, 569049.0, 574047.0, 603655.0, 618205.0, 922109.0, 61339.0, 68013.65993170002, 68093.0, 68266.317336826, 68289.65855170692, 1492.7686208637679, 1495.0506428418032, 1496.0500082447725, 1510.7884896114554, 1512.6445285357931, 34130.65869341275, 35221.82389088038, 35379.82310088536, 35583.288334233686, 35824.64175358213, 58772.4122758767, 59163.0, 59232.0, 59363.1095533576, 59374.40625593689, 509074.0, 510115.0, 510353.0, 511609.0, 518872.0, 49186.0, 49670.50329496659, 50577.49422505728, 50889.0, 51238.48761512486, 53172.73413632907, 54008.839646415276, 54587.72706136603, 54590.45409545854, 55706.44293557013, 45743.77128114338, 46276.305855412866, 47164.0, 47559.52440475551, 47695.28457073216, 44965.77517112393, 45399.319010215535, 46210.768946155054, 46250.7687461574, 47391.28913066238, 45941.31088033749, 46102.0, 46309.0, 46768.53231467642, 46895.29657055215, 38053.61946380501, 38935.0, 38956.0, 40460.79769601133, 40564.79717601511, 30008.69991300059, 30442.695573043988, 30607.846960765055, 30904.536431953988, 31073.223169420944], "value": 20657.655505749393, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.73879802719335, 435.80171022184896, 439.2116151508043, 439.6504778700934, 451.6951058035827, 18679.159437825296, 19575.804241957576, 20270.39188824334, 20640.174393024263, 20674.173033078696, 18739.06304684767, 19150.808491915075, 19624.018799060024, 19634.0, 19825.405237842853, 5076.46697096805, 5371.194320851884, 5377.65045272058, 5383.757730902099, 5392.40683524812, 5425.755840987145, 5453.454654534555, 5472.425395333473, 5585.58108141889, 5873.089671100986, 5924.822255332347, 5952.821415357546, 5959.761609535613, 5974.372690867462, 5998.520118390518, 5482.314710661168, 5488.945110548883, 5501.257330260403, 5921.851953701149, 5935.050391937291, 5306.442823503554, 5316.415194328621, 5335.466453354672, 5347.144456886918, 5347.866303342409, 15113.924430377887, 23242.65136022944, 23669.52660946789, 23773.405664858343, 23898.0, 2468.9753102468926, 2504.7476261869065, 2579.019972410472, 2634.6826586706648, 2862.2415060009116, 10921.290116142425, 11205.383703896283, 11328.207025508218, 11330.433478326133, 13871.861281387159, 2109.725735654355, 2151.053536443975, 2155.665871789875, 2177.4882902517897, 2196.2203417786777, 82274.0, 90383.54808225982, 104459.95540044579, 106675.46662266717, 111706.44146779214, 18932.242710291433, 19153.90423047904, 19517.350362161615, 19983.600327993357, 20872.47818804542, 36300.0, 36335.0, 36662.0, 36723.63276367202, 37079.25841483155, 10921.563137474572, 11012.944935275433, 11030.283031603081, 11051.72370690739, 11292.37891915936, 9162.358634895627, 9210.585523651453, 9267.582958766872, 9310.86033709495, 9769.120779129913, 9769.169620582188, 9941.304108712466, 9984.0, 10001.0, 10088.49557522121, 3667.6646706586826, 3737.383331750231, 3830.8467661293234, 3915.5888631693833, 3938.5667576566557, 942.1285311087217, 1022.8210063239052, 1036.8341065429645, 1053.210092430677, 1118.9888101119047, 19543.60912781765, 19652.508687282647, 19690.40928772139, 19966.0, 20079.899600502195, 1057.5716834681966, 1086.293908959167, 1104.8177050786692, 1121.5009320852305, 1125.426032723317, 11086.223964322582, 11091.72270693239, 11159.94420027911, 11161.888381116247, 11269.0, 502510.0, 505805.0, 510230.0, 511468.0, 522510.0, 81092.59453702693, 88902.55548722215, 99815.0, 100734.0, 102282.48858755658, 1038.444432228769, 1054.7943151085465, 1059.89930956559, 1081.7566047639218, 1084.1976937066513, 18027.909860450614, 18117.275308987493, 18363.449096527125, 18402.907985459988, 18438.35465758692, 43374.78312608417, 43809.34285985777, 44143.0, 44281.33577996268, 44499.55500444954, 58167.709161453924, 58349.416505836096, 59920.0, 61259.0, 61645.0, 9018.864717029119, 9181.035991220826, 9258.0, 9458.763530911783, 9595.712128636153, 12756.170848894792, 13290.534831280858, 13303.401346939218, 13889.72220555563, 13940.372683229481, 11497.367644779282, 11694.181407301407, 11813.586524471602, 11831.881681183078, 11925.403729813648, 11560.190786644855, 11775.705607359885, 11796.233244839059, 11881.0, 12217.266963981834, 11678.182527223353, 11761.647150585497, 11811.881881181078, 11886.465109069939, 12004.75990480168, 9016.549172541216, 9214.723558293263, 9229.169374756304, 9264.11990860867, 9282.118198771106, 10962.177836662122, 11611.767764644828, 11725.648230553097, 11770.52917883275, 11960.162788604714], "value": 10460.937499989284, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1604.8555629993302, 1607.8070631524215, 1855.1188185611836, 1923.403744839099, 1936.1287420660697, 9441.480718560477, 9756.4633945133, 10037.498125093753, 10119.898801011988, 10135.138513226375, 10111.898881011188, 10213.948930255357, 10224.897751022487, 10258.589656413735, 10290.02244786744, 2561.206026131905, 2577.3814284571754, 2579.342267721728, 2587.611858221263, 2596.260065881215, 2547.4140947581973, 2578.419855532509, 2581.4837032593464, 2587.3660953066433, 2590.9870450647813, 2515.8993640254366, 2518.8236823422367, 2581.6385706001174, 2600.8179427440086, 2600.9089681861046, 2493.750624937501, 2517.207079769885, 2520.6723125993685, 2532.670752802133, 2534.8859301331486, 2523.129520315488, 2553.2850801775535, 2555.8083143764106, 2581.3030481770006, 2602.5705758549816, 9923.751906202331, 10010.199184065257, 10048.296619236657, 10057.0, 10061.748456288578, 5895.174675545427, 6008.459238668497, 6026.035834266497, 6073.848153796146, 6149.046897730859, 3626.6373362663785, 3713.702903767719, 3784.810759462016, 3822.3502004658994, 3847.0959324558708, 1287.813267076278, 1317.3018300300855, 1326.6086504481104, 1349.2444231230543, 1360.7414591227634, 13872.098313609584, 13894.305284735723, 13913.513027044004, 13930.0, 13944.372503237277, 4996.375453068366, 5046.899062018739, 5078.339815823919, 5085.593152547787, 5095.439501654815, 10929.508172132273, 10946.945265273622, 10951.069159121405, 10954.671359859218, 10998.06516446095, 5808.82573522795, 5867.589268751147, 5869.236999190163, 5915.852103697442, 5949.762009519571, 4903.289023091703, 5205.7917683293, 5306.044911915815, 5331.466853314715, 5513.751881165357, 4378.540253273424, 4416.470023597189, 4455.866324010285, 4529.954700452953, 4530.818767249273, 1312.0, 1315.7171208190284, 1322.510671051717, 1333.153447560806, 1344.7848344264871, 892.9196372326392, 966.4829316315737, 1052.7841792432532, 1067.3115840283128, 1074.984139987704, 6629.270780214172, 6658.234303055114, 6799.11611490503, 6854.2117656469145, 6968.477364197705, 1056.2131212246925, 1094.43089593411, 1098.319042193845, 1125.3641692443744, 1154.7067284641255, 4692.131955588227, 4844.95155048452, 4924.212126059813, 5015.799368025311, 5035.9928014397265, 12126.818097728365, 12688.429020694091, 12711.491540338468, 12758.425870835648, 12785.872141278654, 12441.75116497665, 12534.435950382254, 12626.747465050648, 12816.295103769382, 12890.097693161577, 9196.356255062215, 9298.442093474414, 9423.62305507772, 9496.0, 9497.525123743786, 6600.405963463311, 6635.170603674541, 6689.464842812466, 6823.93176068233, 6970.686319115551, 11169.106471482099, 11299.887001129884, 11587.942060289644, 11645.941770291094, 11720.941395292968, 11540.653780386601, 11679.824802627798, 11796.0, 11813.173077884809, 11854.881451185378, 7968.601569921597, 8692.130786921258, 8773.517456539952, 8918.554072296229, 8995.280377569648, 9585.712428627152, 9671.419714817133, 9680.85478717834, 9692.951535242279, 9706.272029597667, 8396.580170991549, 8471.788205294917, 8474.91525084766, 8552.486850788973, 8584.141585841366, 8338.24955753985, 8382.329413646772, 8578.056413794353, 8666.956665216634, 8674.522901240493, 7838.451308408585, 7860.174681658572, 7918.2477664621765, 7941.205879412013, 7955.204479551999, 5364.785408583769, 5526.86182845416, 5539.639923404966, 5617.7191140442, 5632.549396048388, 5570.192322113352, 5818.796342128175, 5888.852778680567, 5894.38108998549, 5933.732982015733], "value": 5215.333364122498, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.58037479519714, 353.9964600353996, 356.6487010294859, 356.8162396365872, 359.99460008099874, 5875.353711091777, 5921.615095018826, 5940.910886336708, 5966.164736936832, 5982.611130276529, 5701.77192912283, 5759.4816466518005, 5786.884262314762, 5793.246877905877, 5803.6227645203135, 4469.664775141878, 4472.127935052666, 4491.550844915515, 4500.572445617661, 4510.233260345749, 4482.932756008662, 4499.1901457737595, 4506.369108324837, 4511.70673906195, 4513.390692256553, 4454.554544545552, 4481.193385190664, 4500.527444618317, 4509.368688383629, 4515.983903621692, 4443.711158774686, 4478.507364189936, 4495.730256184639, 4501.347304640809, 4504.864854054351, 3958.5447673517624, 3980.6218409251073, 3985.6612187964056, 3992.2414741199077, 4004.799760012017, 5615.2700148980775, 5646.915296270518, 5673.631213971079, 5702.54379649627, 5721.0, 4994.35073440454, 5118.468256902725, 5136.5890728741615, 5173.0, 5178.818741344073, 6042.909356359658, 6081.087836824512, 6089.421504957022, 6092.958858782314, 6119.87760244797, 4295.806688699016, 4389.858636754435, 4390.078083602447, 4395.670324725626, 4408.515063343029, 6148.784792532285, 6297.6536290504, 6302.968485157545, 6306.653134077624, 6309.432151106376, 4390.648748100144, 4399.472063352418, 4433.866983990485, 4433.869363312335, 4444.666600019981, 4435.911281774346, 4476.149531588988, 4476.798544065525, 4482.350059241392, 4491.550844915548, 5055.747212639353, 5065.569426598707, 5105.7191854448365, 5161.0, 5180.404253510819, 6077.875593015307, 6099.664518451527, 6101.206843110367, 6146.815595532141, 6162.366972752225, 1545.1964978211493, 1547.9458218962282, 1550.8759299256033, 1553.7902383178127, 1566.169929937135, 937.4047479850344, 967.6501280713507, 975.4683697384942, 977.8533220017055, 992.9503524823874, 5098.0, 5325.973370133124, 5333.546648534841, 5354.892902142014, 5406.864828379322, 5504.339479262514, 5520.723963801875, 5573.665580065209, 5576.247206627135, 5617.0, 4920.941997470561, 5258.2112683097075, 5313.574914006947, 5347.91431341777, 5347.946520534822, 2921.583032229367, 2936.3540021195304, 2945.9263518412213, 2969.391274788663, 2971.286891146109, 5686.402927692616, 5700.25896633435, 5712.7714891403875, 5731.312242530923, 5743.425657434307, 5938.524918006549, 6437.9678101610125, 6459.741610335628, 6473.352664733583, 6475.190601174853, 6510.707018184193, 6565.441937435276, 6573.506986975996, 6591.538592298589, 6633.568818026813, 6142.433679411722, 6295.716692748929, 6352.237731472253, 6354.777582784581, 6369.7452101915405, 6076.848078798065, 6252.687365631609, 6281.623102613858, 6295.622262664255, 6295.905561416491, 6459.806205813833, 6483.805485835433, 6499.252585952676, 6600.966995164993, 6610.239822420291, 4455.576720211704, 4481.574250446202, 4487.282034874404, 4511.729296242236, 4518.88702782433, 6313.0, 6322.905156422749, 6352.7612115637, 6390.584612000205, 6455.128012876214, 6158.199434073542, 6207.472364848858, 6207.720652570555, 6211.2857021441305, 6229.190205273286, 5974.761009559569, 6070.3019152798, 6146.231721034871, 6160.0, 6204.286507051746, 6019.0, 6034.78878239277, 6080.452759251689, 6100.908486372797, 6129.816105516842, 6196.628202307876, 6198.504119670325, 6226.25284965807, 6241.594296370721, 6268.122462855113, 5794.855128621818, 6028.969855150872, 6082.36135205797, 6096.969515152396, 6127.111568822585], "value": 4580.21621214675, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.7995801154682, 782.6008735544871, 789.5617932047718, 840.0339609449132, 879.9604017819196, 13981.930090349546, 15059.247037648129, 15107.244637768123, 15259.694806103898, 15395.692086158284, 15113.244337783095, 15292.84707152928, 15295.311710973005, 15298.84701152988, 15307.92346038271, 710.0662628643317, 837.5770236030827, 853.2875049333813, 859.6131740716671, 862.8533149364623, 842.4524059361434, 844.2148801614496, 849.587949844325, 851.1233429567556, 852.5438890193748, 899.4063917814244, 900.5362238447204, 903.7108125399875, 905.3119629081913, 906.4561263242068, 890.4568213389826, 893.3076865429312, 897.6050537763396, 898.5013317608724, 904.0507467159489, 662.3045801907978, 665.1618960110247, 665.8867992441296, 667.2693400726197, 667.7696194812781, 14474.0, 14585.854141458556, 14595.883596878499, 14600.853991460055, 14624.976251662281, 14660.633484162874, 15005.474808381654, 15180.924095379452, 15415.537533874001, 15774.132422716746, 12270.202436841666, 12620.55828046023, 12783.936080319632, 12871.712828717147, 13000.544980925622, 3981.3828856527284, 3984.6812255019527, 4005.819738111792, 4033.052232725307, 4095.4675892133832, 75250.0, 76293.23706762973, 76840.0, 76972.61513692452, 77359.22640773577, 12002.279863208236, 12244.81632775509, 12423.462773489713, 12434.937825310997, 12455.22510069712, 24016.63975040376, 24030.87984560066, 24063.398415039414, 24173.274801755975, 24255.757442425704, 8573.356998225157, 8609.870851937227, 8753.912460875437, 8788.033316335199, 8798.86801697975, 4833.95166048335, 4991.251312303184, 5004.474530174352, 5028.874278143076, 5119.360079990001, 3826.215625796705, 3919.6472317490993, 3932.7640341579595, 3940.0937784309194, 3940.9605903941165, 619.9132121502993, 625.8842114208886, 655.8721049395417, 659.4032400677395, 661.0282884160276, 701.3512500936613, 711.370437163104, 744.0327574153579, 765.456525866641, 775.7812655804395, 10111.595536178618, 10138.188944884392, 10296.07335339823, 10304.948475257726, 10382.221333400024, 629.820501157168, 657.4181849063613, 712.2663656433881, 716.8781307177792, 731.6305265840716, 4795.688280261772, 4988.0, 5010.098182327143, 5029.2958985742025, 5046.671966322251, 70800.2919970804, 71018.64490677514, 72467.55064898673, 72741.0, 124082.37958810148, 86926.1307386918, 105923.47038264759, 107950.0, 111544.0, 113283.0, 96008.51995739977, 96262.51868740612, 97398.0, 98345.50827245817, 100007.0, 9471.0, 9536.85694714566, 9554.0, 9588.424694518351, 9595.328327017321, 48367.0, 53876.75148413989, 54082.0, 56315.436845632656, 57343.42656573381, 54560.0, 67781.0, 69463.0, 70123.69124665743, 77529.8370524454, 13683.315834208448, 13991.0, 14078.366473508922, 14292.285385730464, 14404.495842645458, 13705.177689338672, 14376.640583985483, 14632.634184145481, 14945.476908308592, 15207.163606001775, 13716.314184290944, 13721.931390342985, 13763.174209547458, 14297.857021429652, 14694.485693000694, 12707.809382859079, 12744.10791244604, 13052.086353955132, 13227.735445290848, 13900.096493727875, 11490.885091149315, 11667.883321167019, 11918.344491053076, 12680.6829829255, 14098.577042688736, 11260.7747845041, 11518.0, 11730.824037639271, 11746.0, 11884.762304753684, 11282.717932051764, 11488.655340339803, 11492.770144596894, 11629.53481860716, 11909.285442873455], "value": 7732.112082959852, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 109.0, 109.0, 109.0, 112.0, 110.0, 109.0, 109.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 124.0, 160.0, 172.0, 127.0, 153.0, 150.0, 129.0, 185.0, 127.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 163.0, 162.0, 163.0, 165.0, 164.0, 165.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 180.0, 76.0, 75.0, 74.0, 77.0, 159.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 145.0, 83.0, 84.0, 83.0, 147.0, 83.0, 83.0, 145.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 119.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 146.0, 147.0, 147.0, 150.0, 147.0, 147.0, 146.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 56.0, 58.0, 53.0, 54.0, 52.0, 51.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 62.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 76.0, 77.0, 77.0, 76.0, 77.0, 107.0, 77.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 126.0, 129.0, 118.0, 120.0, 122.0, 135.0, 128.0, 133.0, 127.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 154.0, 158.0, 160.0, 157.0, 157.0, 161.0, 155.0, 156.0, 154.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 61.0, 63.0, 63.0, 60.0, 62.0, 64.0, 60.0, 62.0], "value": 62.3, "unit": "score"}]}]} 08:41:24 INFO - Return code: 0 08:41:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:41:24 ERROR - # TBPL SUCCESS # 08:41:24 INFO - Running post-action listener: _resource_record_post_action 08:41:24 INFO - ##### 08:41:24 INFO - ##### Finished run-tests step (success) 08:41:24 INFO - ##### 08:41:24 INFO - Running post-run listener: _resource_record_post_run 08:41:24 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 270336; Write bytes: 505782272; Read time: 300; Write time: 646452 08:41:24 INFO - TinderboxPrint: CPU usage
13.4% 08:41:24 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 300 08:41:24 INFO - TinderboxPrint: I/O write bytes / time
505,782,272 / 646,452 08:41:24 INFO - TinderboxPrint: CPU idle
8,213.6 (86.6%) 08:41:24 INFO - TinderboxPrint: CPU user
1,214.0 (12.8%) 08:41:24 INFO - TinderboxPrint: Swap in / out
0 / 0 08:41:24 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252526592; Read time: 0; Write time: 428320 08:41:24 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 270336; Write bytes: 252669952; Read time: 300; Write time: 217828 08:41:25 INFO - Running post-run listener: _upload_blobber_files 08:41:25 INFO - Blob upload gear active. 08:41:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:41:25 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 08:41:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:41:25 INFO - (blobuploader) - INFO - Open directory for files ... 08:41:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:41:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:41:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:26 INFO - (blobuploader) - INFO - Done attempting. 08:41:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:41:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:41:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:27 INFO - (blobuploader) - INFO - Done attempting. 08:41:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:41:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:41:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:30 INFO - (blobuploader) - INFO - Done attempting. 08:41:30 INFO - (blobuploader) - INFO - Iteration through files over. 08:41:30 INFO - Return code: 0 08:41:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:41:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:41:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0efea7d3b5319064873f1ffa0cae459982c8d40ddfbfb09cfb78bf44d532e3f5ede76bba6a04f926c3fed2312d6d0ce83b500503b1ffffdaadefb58c852a110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2be7950010be35cb475560c67776dbd9edc9855e72d3fc1dd934e92b116dc22bcf3a0c4f8bba697d4443727334b71ff17429aea67604eff1f7fcbbed9f5554fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c209be02c48bf0ca4a14118a7aa5b4cf11edec035f3dcb47c3911cb307f81ff0d2516a31862df74819a1f78e6eacc40137ae03303712f5f6b9264008d2ef75a"} 08:41:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:41:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:41:30 INFO - Contents: 08:41:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0efea7d3b5319064873f1ffa0cae459982c8d40ddfbfb09cfb78bf44d532e3f5ede76bba6a04f926c3fed2312d6d0ce83b500503b1ffffdaadefb58c852a110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2be7950010be35cb475560c67776dbd9edc9855e72d3fc1dd934e92b116dc22bcf3a0c4f8bba697d4443727334b71ff17429aea67604eff1f7fcbbed9f5554fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c209be02c48bf0ca4a14118a7aa5b4cf11edec035f3dcb47c3911cb307f81ff0d2516a31862df74819a1f78e6eacc40137ae03303712f5f6b9264008d2ef75a"} 08:41:30 INFO - Running post-run listener: copy_logs_to_upload_dir 08:41:30 INFO - Copying logs to upload dir... 08:41:30 INFO - mkdir: /builds/slave/test/build/upload/logs 08:41:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.391334 ========= master_lag: 0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-21 08:41:30.667091) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 08:41:30.670414) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0efea7d3b5319064873f1ffa0cae459982c8d40ddfbfb09cfb78bf44d532e3f5ede76bba6a04f926c3fed2312d6d0ce83b500503b1ffffdaadefb58c852a110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2be7950010be35cb475560c67776dbd9edc9855e72d3fc1dd934e92b116dc22bcf3a0c4f8bba697d4443727334b71ff17429aea67604eff1f7fcbbed9f5554fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c209be02c48bf0ca4a14118a7aa5b4cf11edec035f3dcb47c3911cb307f81ff0d2516a31862df74819a1f78e6eacc40137ae03303712f5f6b9264008d2ef75a"} build_url:https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/YzKs19P2QHSddHfhKvwPrQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c0efea7d3b5319064873f1ffa0cae459982c8d40ddfbfb09cfb78bf44d532e3f5ede76bba6a04f926c3fed2312d6d0ce83b500503b1ffffdaadefb58c852a110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2be7950010be35cb475560c67776dbd9edc9855e72d3fc1dd934e92b116dc22bcf3a0c4f8bba697d4443727334b71ff17429aea67604eff1f7fcbbed9f5554fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c209be02c48bf0ca4a14118a7aa5b4cf11edec035f3dcb47c3911cb307f81ff0d2516a31862df74819a1f78e6eacc40137ae03303712f5f6b9264008d2ef75a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 08:41:30.698513) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:41:30.698855) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1466520933.896185-1441732439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:41:30.749095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 08:41:30.749436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 08:41:30.749751) ========= ========= Total master_lag: 0.26 =========