builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1465179037.02 results: success (0) buildid: 20160605163003 builduid: 40dec010446b4dbe8612b8205283e671 revision: e54065dbe41dc0192f5d1710ad1ba5855f573545 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.025137) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.025548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.025968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.044530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.044808) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 19:10:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 81.7M=0s 2016-06-05 19:10:37 (81.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138703 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.196912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.197216) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017469 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:37.245987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-05 19:10:37.246297) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e54065dbe41dc0192f5d1710ad1ba5855f573545 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e54065dbe41dc0192f5d1710ad1ba5855f573545 --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=5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 19:10:37,562 truncating revision to first 12 chars 2016-06-05 19:10:37,562 Setting DEBUG logging. 2016-06-05 19:10:37,562 attempt 1/10 2016-06-05 19:10:37,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e54065dbe41d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 19:10:38,834 unpacking tar archive at: mozilla-inbound-e54065dbe41d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.603927 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-05 19:10:38.863158) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:38.863446) ========= script_repo_revision: e54065dbe41dc0192f5d1710ad1ba5855f573545 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:38.863852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:38.864125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 19:10:38.881151) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-06-05 19:10:38.881409) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:10:39 INFO - MultiFileLogger online at 20160605 19:10:39 in /builds/slave/test 19:10:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:10:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:10:39 INFO - {'append_to_log': False, 19:10:39 INFO - 'base_work_dir': '/builds/slave/test', 19:10:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:10:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:10:39 INFO - 'branch': 'Mozilla-Inbound', 19:10:39 INFO - 'buildbot_json_path': 'buildprops.json', 19:10:39 INFO - 'config_files': ('talos/linux_config.py',), 19:10:39 INFO - 'default_actions': ('clobber', 19:10:39 INFO - 'read-buildbot-config', 19:10:39 INFO - 'download-and-extract', 19:10:39 INFO - 'populate-webroot', 19:10:39 INFO - 'create-virtualenv', 19:10:39 INFO - 'install', 19:10:39 INFO - 'run-tests'), 19:10:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:10:39 INFO - 'download_minidump_stackwalk': True, 19:10:39 INFO - 'download_symbols': 'ondemand', 19:10:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:10:39 INFO - 'tooltool.py': '/tools/tooltool.py', 19:10:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:10:39 INFO - '/tools/misc-python/virtualenv.py')}, 19:10:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:10:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:10:39 INFO - 'installer_path': 'installer.exe', 19:10:39 INFO - 'log_level': 'info', 19:10:39 INFO - 'log_name': 'talos', 19:10:39 INFO - 'log_to_console': True, 19:10:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:10:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:10:39 INFO - 'opt_config_files': (), 19:10:39 INFO - 'pip_index': False, 19:10:39 INFO - 'sps_profile': False, 19:10:39 INFO - 'sps_profile_interval': 0, 19:10:39 INFO - 'suite': 'dromaeojs', 19:10:39 INFO - 'system_bits': '32', 19:10:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:10:39 INFO - 'title': 'talos-linux64-ix-011', 19:10:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:10:39 INFO - 'use_talos_json': True, 19:10:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:10:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:10:39 INFO - 'work_dir': 'build'} 19:10:39 INFO - ##### 19:10:39 INFO - ##### Running clobber step. 19:10:39 INFO - ##### 19:10:39 INFO - Running pre-action listener: _resource_record_pre_action 19:10:39 INFO - Running main action method: clobber 19:10:39 INFO - rmtree: /builds/slave/test/build 19:10:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:10:39 INFO - Running post-action listener: _resource_record_post_action 19:10:39 INFO - ##### 19:10:39 INFO - ##### Finished clobber step (success) 19:10:39 INFO - ##### 19:10:39 INFO - ##### 19:10:39 INFO - ##### Running read-buildbot-config step. 19:10:39 INFO - ##### 19:10:39 INFO - Running pre-action listener: _resource_record_pre_action 19:10:39 INFO - Running main action method: read_buildbot_config 19:10:39 INFO - Using buildbot properties: 19:10:39 INFO - { 19:10:39 INFO - "project": "", 19:10:39 INFO - "product": "firefox", 19:10:39 INFO - "script_repo_revision": "production", 19:10:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:10:39 INFO - "repository": "", 19:10:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:10:39 INFO - "buildid": "20160605163003", 19:10:39 INFO - "pgo_build": "True", 19:10:39 INFO - "basedir": "/builds/slave/test", 19:10:39 INFO - "buildnumber": 1896, 19:10:39 INFO - "slavename": "talos-linux64-ix-011", 19:10:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:10:39 INFO - "platform": "ubuntu64_hw", 19:10:39 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:10:39 INFO - "branch": "mozilla-inbound", 19:10:39 INFO - "repo_path": "integration/mozilla-inbound", 19:10:39 INFO - "revision": "e54065dbe41dc0192f5d1710ad1ba5855f573545", 19:10:39 INFO - "stage_platform": "linux64-pgo", 19:10:39 INFO - "builduid": "40dec010446b4dbe8612b8205283e671", 19:10:39 INFO - "slavebuilddir": "test" 19:10:39 INFO - } 19:10:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:10:39 INFO - Running post-action listener: _resource_record_post_action 19:10:39 INFO - ##### 19:10:39 INFO - ##### Finished read-buildbot-config step (success) 19:10:39 INFO - ##### 19:10:39 INFO - ##### 19:10:39 INFO - ##### Running download-and-extract step. 19:10:39 INFO - ##### 19:10:39 INFO - Running pre-action listener: _resource_record_pre_action 19:10:39 INFO - Running main action method: download_and_extract 19:10:39 INFO - mkdir: /builds/slave/test/build/tests 19:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:39 INFO - https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:10:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:10:42 INFO - Downloaded 1361 bytes. 19:10:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:10:42 INFO - Using the following test package requirements: 19:10:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:10:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:10:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'jsshell-linux-x86_64.zip'], 19:10:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:10:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:10:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:10:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:10:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:10:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:10:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:10:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:42 INFO - https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:10:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:11:09 INFO - Downloaded 24443848 bytes. 19:11:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:11:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:11:10 INFO - Return code: 0 19:11:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:10 INFO - https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:11:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:11:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:11:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:11:12 INFO - Downloaded 24443848 bytes. 19:11:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:11:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:11:13 INFO - Return code: 0 19:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:13 INFO - https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:11:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:11:31 INFO - Downloaded 10833369 bytes. 19:11:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:11:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:11:31 INFO - Return code: 0 19:11: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')]} 19:11:31 INFO - https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:11:33 INFO - Downloaded 59192519 bytes. 19:11:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:11:33 INFO - mkdir: /builds/slave/test/properties 19:11:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:11:33 INFO - Writing to file /builds/slave/test/properties/build_url 19:11:33 INFO - Contents: 19:11:33 INFO - build_url:https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:11:35 INFO - Running post-action listener: _resource_record_post_action 19:11:35 INFO - Running post-action listener: set_extra_try_arguments 19:11:35 INFO - ##### 19:11:35 INFO - ##### Finished download-and-extract step (success) 19:11:35 INFO - ##### 19:11:35 INFO - ##### 19:11:35 INFO - ##### Running populate-webroot step. 19:11:35 INFO - ##### 19:11:35 INFO - Running pre-action listener: _resource_record_pre_action 19:11:35 INFO - Running main action method: populate_webroot 19:11:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:35 INFO - '--tppagecycles', 19:11:35 INFO - '7'], 19:11:35 INFO - 'tests': ['tsvgm']}}, 19:11:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:11:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:11:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:11:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:11:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:35 INFO - 'talos_options': ['--disable-e10s'], 19:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:35 INFO - 'talos_options': ['--disable-e10s'], 19:11:35 INFO - 'tests': ['damp', 'tps']}, 19:11:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:35 INFO - 'tests': ['damp', 'tps']}, 19:11:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:11:35 INFO - 'tests': ['dromaeo_dom']}, 19:11:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:11:35 INFO - 'tests': ['a11yr', 19:11:35 INFO - 'ts_paint', 19:11:35 INFO - 'tpaint', 19:11:35 INFO - 'sessionrestore', 19:11:35 INFO - 'sessionrestore_no_auto_restore', 19:11:35 INFO - 'tabpaint']}, 19:11:35 INFO - 'other-e10s': {'tests': ['a11yr', 19:11:35 INFO - 'ts_paint', 19:11:35 INFO - 'tpaint', 19:11:35 INFO - 'sessionrestore', 19:11:35 INFO - 'sessionrestore_no_auto_restore', 19:11:35 INFO - 'tabpaint']}, 19:11:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:11:35 INFO - 'ts_paint', 19:11:35 INFO - 'tpaint', 19:11:35 INFO - 'sessionrestore', 19:11:35 INFO - 'sessionrestore_no_auto_restore', 19:11:35 INFO - 'tabpaint']}, 19:11:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:11:35 INFO - 'ts_paint', 19:11:35 INFO - 'tpaint', 19:11:35 INFO - 'sessionrestore', 19:11:35 INFO - 'sessionrestore_no_auto_restore', 19:11:35 INFO - 'tabpaint']}, 19:11:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:11:35 INFO - 'tests': ['a11yr', 19:11:35 INFO - 'ts_paint', 19:11:35 INFO - 'tpaint', 19:11:35 INFO - 'sessionrestore', 19:11:35 INFO - 'sessionrestore_no_auto_restore', 19:11:35 INFO - 'tabpaint']}, 19:11:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:11:35 INFO - 'tests': ['a11yr', 19:11:35 INFO - 'ts_paint', 19:11:35 INFO - 'tpaint', 19:11:35 INFO - 'sessionrestore', 19:11:35 INFO - 'sessionrestore_no_auto_restore', 19:11:35 INFO - 'tabpaint']}, 19:11:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:11:35 INFO - 'tests': ['tsvgx', 19:11:35 INFO - 'tsvgr_opacity', 19:11:35 INFO - 'tart', 19:11:35 INFO - 'tscrollx', 19:11:35 INFO - 'cart']}, 19:11:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:11:35 INFO - 'tsvgr_opacity', 19:11:35 INFO - 'tart', 19:11:35 INFO - 'tscrollx', 19:11:35 INFO - 'cart']}, 19:11:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:35 INFO - 'talos_options': ['--disable-e10s'], 19:11:35 INFO - 'tests': ['tp5o']}, 19:11:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:35 INFO - 'tests': ['tp5o']}, 19:11:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:35 INFO - 'talos_options': ['--disable-e10s', 19:11:35 INFO - '--xperf_path', 19:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:35 INFO - 'tests': ['tp5n']}, 19:11:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:35 INFO - 'talos_options': ['--xperf_path', 19:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:35 INFO - 'tests': ['tp5n']}}, 19:11:35 INFO - 'talos.zip': {'path': '', 19:11:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:35 INFO - Running post-action listener: _resource_record_post_action 19:11:35 INFO - ##### 19:11:35 INFO - ##### Finished populate-webroot step (success) 19:11:35 INFO - ##### 19:11:35 INFO - ##### 19:11:35 INFO - ##### Running create-virtualenv step. 19:11:35 INFO - ##### 19:11:35 INFO - Running pre-action listener: _resource_record_pre_action 19:11:35 INFO - Running main action method: create_virtualenv 19:11:35 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:11:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:35 INFO - Using real prefix '/usr' 19:11:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:35 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:37 INFO - Installing pip.................done. 19:11:37 INFO - Return code: 0 19:11:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd376839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:11:37 INFO - Using env: {'DISPLAY': ':0', 19:11:37 INFO - 'HOME': '/home/cltbld', 19:11:37 INFO - 'LANG': 'en_US.UTF-8', 19:11:37 INFO - 'LANGUAGE': 'en_US:en', 19:11:37 INFO - 'LOGNAME': 'cltbld', 19:11:37 INFO - 'MAIL': '/var/mail/cltbld', 19:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:37 INFO - 'MOZ_NO_REMOTE': '1', 19:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:37 INFO - 'NO_EM_RESTART': '1', 19:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:37 INFO - 'PWD': '/builds/slave/test', 19:11:37 INFO - 'SHELL': '/bin/bash', 19:11:37 INFO - 'SHLVL': '1', 19:11:37 INFO - 'TERM': 'linux', 19:11:37 INFO - 'TMOUT': '86400', 19:11:37 INFO - 'USER': 'cltbld', 19:11:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:37 INFO - '_': '/tools/buildbot/bin/python'} 19:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:11:38 INFO - Cleaning up... 19:11:38 INFO - Return code: 0 19:11:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:38 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 0x7fd376839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:11:38 INFO - Using env: {'DISPLAY': ':0', 19:11:38 INFO - 'HOME': '/home/cltbld', 19:11:38 INFO - 'LANG': 'en_US.UTF-8', 19:11:38 INFO - 'LANGUAGE': 'en_US:en', 19:11:38 INFO - 'LOGNAME': 'cltbld', 19:11:38 INFO - 'MAIL': '/var/mail/cltbld', 19:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:38 INFO - 'MOZ_NO_REMOTE': '1', 19:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:38 INFO - 'NO_EM_RESTART': '1', 19:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:38 INFO - 'PWD': '/builds/slave/test', 19:11:38 INFO - 'SHELL': '/bin/bash', 19:11:38 INFO - 'SHLVL': '1', 19:11:38 INFO - 'TERM': 'linux', 19:11:38 INFO - 'TMOUT': '86400', 19:11:38 INFO - 'USER': 'cltbld', 19:11:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:38 INFO - '_': '/tools/buildbot/bin/python'} 19:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:38 INFO - Downloading/unpacking psutil>=3.1.1 19:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:40 INFO - Installing collected packages: psutil 19:11:40 INFO - Running setup.py install for psutil 19:11:40 INFO - building 'psutil._psutil_linux' extension 19:11:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:11:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:11:40 INFO - building 'psutil._psutil_posix' extension 19:11:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:11:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:40 INFO - Successfully installed psutil 19:11:40 INFO - Cleaning up... 19:11:40 INFO - Return code: 0 19:11:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd376839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:11:40 INFO - Using env: {'DISPLAY': ':0', 19:11:40 INFO - 'HOME': '/home/cltbld', 19:11:40 INFO - 'LANG': 'en_US.UTF-8', 19:11:40 INFO - 'LANGUAGE': 'en_US:en', 19:11:40 INFO - 'LOGNAME': 'cltbld', 19:11:40 INFO - 'MAIL': '/var/mail/cltbld', 19:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:40 INFO - 'MOZ_NO_REMOTE': '1', 19:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:40 INFO - 'NO_EM_RESTART': '1', 19:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:40 INFO - 'PWD': '/builds/slave/test', 19:11:40 INFO - 'SHELL': '/bin/bash', 19:11:40 INFO - 'SHLVL': '1', 19:11:40 INFO - 'TERM': 'linux', 19:11:40 INFO - 'TMOUT': '86400', 19:11:40 INFO - 'USER': 'cltbld', 19:11:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:40 INFO - '_': '/tools/buildbot/bin/python'} 19:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:11:42 INFO - Installing collected packages: mozsystemmonitor 19:11:42 INFO - Running setup.py install for mozsystemmonitor 19:11:43 INFO - Successfully installed mozsystemmonitor 19:11:43 INFO - Cleaning up... 19:11:43 INFO - Return code: 0 19:11:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:43 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 0x7fd376839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:11:43 INFO - Using env: {'DISPLAY': ':0', 19:11:43 INFO - 'HOME': '/home/cltbld', 19:11:43 INFO - 'LANG': 'en_US.UTF-8', 19:11:43 INFO - 'LANGUAGE': 'en_US:en', 19:11:43 INFO - 'LOGNAME': 'cltbld', 19:11:43 INFO - 'MAIL': '/var/mail/cltbld', 19:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:43 INFO - 'MOZ_NO_REMOTE': '1', 19:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:43 INFO - 'NO_EM_RESTART': '1', 19:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:43 INFO - 'PWD': '/builds/slave/test', 19:11:43 INFO - 'SHELL': '/bin/bash', 19:11:43 INFO - 'SHLVL': '1', 19:11:43 INFO - 'TERM': 'linux', 19:11:43 INFO - 'TMOUT': '86400', 19:11:43 INFO - 'USER': 'cltbld', 19:11:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:43 INFO - '_': '/tools/buildbot/bin/python'} 19:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:43 INFO - Downloading/unpacking jsonschema==2.5.1 19:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:45 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:45 INFO - warning: no files found matching '*.txt' 19:11:45 INFO - no previously-included directories found matching 'build' 19:11:45 INFO - no previously-included directories found matching 'dist' 19:11:45 INFO - no previously-included directories found matching '.git*' 19:11:45 INFO - Installing collected packages: jsonschema, functools32 19:11:45 INFO - Running setup.py install for functools32 19:11:45 INFO - warning: no files found matching '*.txt' 19:11:45 INFO - no previously-included directories found matching 'build' 19:11:45 INFO - no previously-included directories found matching 'dist' 19:11:45 INFO - no previously-included directories found matching '.git*' 19:11:45 INFO - Successfully installed jsonschema functools32 19:11:45 INFO - Cleaning up... 19:11:45 INFO - Return code: 0 19:11:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:45 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 0x7fd376839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:11:45 INFO - Using env: {'DISPLAY': ':0', 19:11:45 INFO - 'HOME': '/home/cltbld', 19:11:45 INFO - 'LANG': 'en_US.UTF-8', 19:11:45 INFO - 'LANGUAGE': 'en_US:en', 19:11:45 INFO - 'LOGNAME': 'cltbld', 19:11:45 INFO - 'MAIL': '/var/mail/cltbld', 19:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:45 INFO - 'MOZ_NO_REMOTE': '1', 19:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:45 INFO - 'NO_EM_RESTART': '1', 19:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:45 INFO - 'PWD': '/builds/slave/test', 19:11:45 INFO - 'SHELL': '/bin/bash', 19:11:45 INFO - 'SHLVL': '1', 19:11:45 INFO - 'TERM': 'linux', 19:11:45 INFO - 'TMOUT': '86400', 19:11:45 INFO - 'USER': 'cltbld', 19:11:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:45 INFO - '_': '/tools/buildbot/bin/python'} 19:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:45 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:47 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:11:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:48 INFO - Downloading docopt-0.6.1.tar.gz 19:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:48 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:48 INFO - Running setup.py install for blobuploader 19:11:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:11:48 INFO - Running setup.py install for requests 19:11:49 INFO - Running setup.py install for docopt 19:11:49 INFO - Successfully installed blobuploader requests docopt 19:11:49 INFO - Cleaning up... 19:11:49 INFO - Return code: 0 19:11:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:49 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 0x7fd376839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:11:49 INFO - Using env: {'DISPLAY': ':0', 19:11:49 INFO - 'HOME': '/home/cltbld', 19:11:49 INFO - 'LANG': 'en_US.UTF-8', 19:11:49 INFO - 'LANGUAGE': 'en_US:en', 19:11:49 INFO - 'LOGNAME': 'cltbld', 19:11:49 INFO - 'MAIL': '/var/mail/cltbld', 19:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:49 INFO - 'MOZ_NO_REMOTE': '1', 19:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:49 INFO - 'NO_EM_RESTART': '1', 19:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:49 INFO - 'PWD': '/builds/slave/test', 19:11:49 INFO - 'SHELL': '/bin/bash', 19:11:49 INFO - 'SHLVL': '1', 19:11:49 INFO - 'TERM': 'linux', 19:11:49 INFO - 'TMOUT': '86400', 19:11:49 INFO - 'USER': 'cltbld', 19:11:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:49 INFO - '_': '/tools/buildbot/bin/python'} 19:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:50 INFO - Running setup.py (path:/tmp/pip-Fob8sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:50 INFO - Running setup.py (path:/tmp/pip-e5Avry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:50 INFO - Running setup.py (path:/tmp/pip-HRmI1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:50 INFO - Running setup.py (path:/tmp/pip-z8xfVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:50 INFO - Running setup.py (path:/tmp/pip-Xuh3Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:50 INFO - Running setup.py (path:/tmp/pip-kjMZCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:50 INFO - Running setup.py (path:/tmp/pip-er59jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:50 INFO - Running setup.py (path:/tmp/pip-KghtBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:50 INFO - Running setup.py (path:/tmp/pip-ceyr0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:50 INFO - Running setup.py (path:/tmp/pip-CrxT1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:50 INFO - Running setup.py (path:/tmp/pip-e5TAGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:50 INFO - Running setup.py (path:/tmp/pip-QWlyjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:50 INFO - Running setup.py (path:/tmp/pip-irKH8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:51 INFO - Running setup.py (path:/tmp/pip-gCOf3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:51 INFO - Running setup.py (path:/tmp/pip-CMDGuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:51 INFO - Running setup.py (path:/tmp/pip-K5wBjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:51 INFO - Running setup.py (path:/tmp/pip-NL6d8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:51 INFO - Running setup.py install for manifestparser 19:11:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozcrash 19:11:51 INFO - Running setup.py install for mozdebug 19:11:51 INFO - Running setup.py install for mozdevice 19:11:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozfile 19:11:51 INFO - Running setup.py install for mozhttpd 19:11:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:51 INFO - Running setup.py install for mozinfo 19:11:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for mozInstall 19:11:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for mozleak 19:11:52 INFO - Running setup.py install for mozlog 19:11:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for moznetwork 19:11:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for mozprocess 19:11:52 INFO - Running setup.py install for mozprofile 19:11:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for mozrunner 19:11:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:52 INFO - Running setup.py install for mozscreenshot 19:11:52 INFO - Running setup.py install for moztest 19:11:53 INFO - Running setup.py install for mozversion 19:11:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:53 INFO - Cleaning up... 19:11:53 INFO - Return code: 0 19:11:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:53 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 0x7fd376839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:11:53 INFO - Using env: {'DISPLAY': ':0', 19:11:53 INFO - 'HOME': '/home/cltbld', 19:11:53 INFO - 'LANG': 'en_US.UTF-8', 19:11:53 INFO - 'LANGUAGE': 'en_US:en', 19:11:53 INFO - 'LOGNAME': 'cltbld', 19:11:53 INFO - 'MAIL': '/var/mail/cltbld', 19:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:53 INFO - 'MOZ_NO_REMOTE': '1', 19:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:53 INFO - 'NO_EM_RESTART': '1', 19:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:53 INFO - 'PWD': '/builds/slave/test', 19:11:53 INFO - 'SHELL': '/bin/bash', 19:11:53 INFO - 'SHLVL': '1', 19:11:53 INFO - 'TERM': 'linux', 19:11:53 INFO - 'TMOUT': '86400', 19:11:53 INFO - 'USER': 'cltbld', 19:11:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:53 INFO - '_': '/tools/buildbot/bin/python'} 19:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:53 INFO - Running setup.py (path:/tmp/pip-rtP7ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:53 INFO - Running setup.py (path:/tmp/pip-j_Bjoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:53 INFO - Running setup.py (path:/tmp/pip-VRV3k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:53 INFO - Running setup.py (path:/tmp/pip-Wlvlq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:53 INFO - Running setup.py (path:/tmp/pip-74wY0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:53 INFO - Running setup.py (path:/tmp/pip-5eZ1A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:53 INFO - Running setup.py (path:/tmp/pip-chX52J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:53 INFO - Running setup.py (path:/tmp/pip-jjBn_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:54 INFO - Running setup.py (path:/tmp/pip-ZW3fZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:54 INFO - Running setup.py (path:/tmp/pip-la9VUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:54 INFO - Running setup.py (path:/tmp/pip-F70CPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:54 INFO - Running setup.py (path:/tmp/pip-UErwh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:54 INFO - Running setup.py (path:/tmp/pip-_69Wpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:54 INFO - Running setup.py (path:/tmp/pip-iafy2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:54 INFO - Running setup.py (path:/tmp/pip-95PFmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:54 INFO - Running setup.py (path:/tmp/pip-2Zl51b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:54 INFO - Running setup.py (path:/tmp/pip-pvWYfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:11:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:56 INFO - Downloading blessings-1.6.tar.gz 19:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:56 INFO - Installing collected packages: blessings 19:11:56 INFO - Running setup.py install for blessings 19:11:56 INFO - Successfully installed blessings 19:11:56 INFO - Cleaning up... 19:11:56 INFO - Return code: 0 19:11:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:57 INFO - Reading from file tmpfile_stdout 19:11:57 INFO - Current package versions: 19:11:57 INFO - argparse == 1.2.1 19:11:57 INFO - blessings == 1.6 19:11:57 INFO - blobuploader == 1.2.4 19:11:57 INFO - docopt == 0.6.1 19:11:57 INFO - functools32 == 3.2.3-2 19:11:57 INFO - jsonschema == 2.5.1 19:11:57 INFO - manifestparser == 1.1 19:11:57 INFO - mozInstall == 1.12 19:11:57 INFO - mozcrash == 0.17 19:11:57 INFO - mozdebug == 0.1 19:11:57 INFO - mozdevice == 0.48 19:11:57 INFO - mozfile == 1.2 19:11:57 INFO - mozhttpd == 0.7 19:11:57 INFO - mozinfo == 0.9 19:11:57 INFO - mozleak == 0.1 19:11:57 INFO - mozlog == 3.2 19:11:57 INFO - moznetwork == 0.27 19:11:57 INFO - mozprocess == 0.22 19:11:57 INFO - mozprofile == 0.28 19:11:57 INFO - mozrunner == 6.11 19:11:57 INFO - mozscreenshot == 0.1 19:11:57 INFO - mozsystemmonitor == 0.3 19:11:57 INFO - moztest == 0.7 19:11:57 INFO - mozversion == 1.4 19:11:57 INFO - psutil == 3.1.1 19:11:57 INFO - requests == 1.2.3 19:11:57 INFO - wsgiref == 0.1.2 19:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:57 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 0x7fd376839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:11:57 INFO - Using env: {'DISPLAY': ':0', 19:11:57 INFO - 'HOME': '/home/cltbld', 19:11:57 INFO - 'LANG': 'en_US.UTF-8', 19:11:57 INFO - 'LANGUAGE': 'en_US:en', 19:11:57 INFO - 'LOGNAME': 'cltbld', 19:11:57 INFO - 'MAIL': '/var/mail/cltbld', 19:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:57 INFO - 'MOZ_NO_REMOTE': '1', 19:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:57 INFO - 'NO_EM_RESTART': '1', 19:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:57 INFO - 'PWD': '/builds/slave/test', 19:11:57 INFO - 'SHELL': '/bin/bash', 19:11:57 INFO - 'SHLVL': '1', 19:11:57 INFO - 'TERM': 'linux', 19:11:57 INFO - 'TMOUT': '86400', 19:11:57 INFO - 'USER': 'cltbld', 19:11:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:57 INFO - '_': '/tools/buildbot/bin/python'} 19:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:11:57 INFO - Cleaning up... 19:11:57 INFO - Return code: 0 19:11:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd376839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:11:57 INFO - Using env: {'DISPLAY': ':0', 19:11:57 INFO - 'HOME': '/home/cltbld', 19:11:57 INFO - 'LANG': 'en_US.UTF-8', 19:11:57 INFO - 'LANGUAGE': 'en_US:en', 19:11:57 INFO - 'LOGNAME': 'cltbld', 19:11:57 INFO - 'MAIL': '/var/mail/cltbld', 19:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:57 INFO - 'MOZ_NO_REMOTE': '1', 19:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:57 INFO - 'NO_EM_RESTART': '1', 19:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:57 INFO - 'PWD': '/builds/slave/test', 19:11:57 INFO - 'SHELL': '/bin/bash', 19:11:57 INFO - 'SHLVL': '1', 19:11:57 INFO - 'TERM': 'linux', 19:11:57 INFO - 'TMOUT': '86400', 19:11:57 INFO - 'USER': 'cltbld', 19:11:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:57 INFO - '_': '/tools/buildbot/bin/python'} 19:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:11:57 INFO - Cleaning up... 19:11:57 INFO - Return code: 0 19:11:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd376839f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, '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': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:11:57 INFO - Using env: {'DISPLAY': ':0', 19:11:57 INFO - 'HOME': '/home/cltbld', 19:11:57 INFO - 'LANG': 'en_US.UTF-8', 19:11:57 INFO - 'LANGUAGE': 'en_US:en', 19:11:57 INFO - 'LOGNAME': 'cltbld', 19:11:57 INFO - 'MAIL': '/var/mail/cltbld', 19:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:57 INFO - 'MOZ_NO_REMOTE': '1', 19:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:57 INFO - 'NO_EM_RESTART': '1', 19:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:57 INFO - 'PWD': '/builds/slave/test', 19:11:57 INFO - 'SHELL': '/bin/bash', 19:11:57 INFO - 'SHLVL': '1', 19:11:57 INFO - 'TERM': 'linux', 19:11:57 INFO - 'TMOUT': '86400', 19:11:57 INFO - 'USER': 'cltbld', 19:11:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:57 INFO - '_': '/tools/buildbot/bin/python'} 19:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:57 INFO - Downloading/unpacking flake8 19:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:11:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:11:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:12:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:12:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:12:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:12:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:12:00 INFO - no previously-included directories found matching 'docs/_build' 19:12:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:12:00 INFO - Running setup.py install for pep8 19:12:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:12:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:12:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:12:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:12:00 INFO - no previously-included directories found matching 'docs/_build' 19:12:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:12:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:12:00 INFO - Cleaning up... 19:12:00 INFO - Return code: 0 19:12:00 INFO - Running post-action listener: _resource_record_post_action 19:12:00 INFO - Running post-action listener: _start_resource_monitoring 19:12:00 INFO - Starting resource monitoring. 19:12:00 INFO - ##### 19:12:00 INFO - ##### Finished create-virtualenv step (success) 19:12:00 INFO - ##### 19:12:00 INFO - ##### 19:12:00 INFO - ##### Running install step. 19:12:00 INFO - ##### 19:12:00 INFO - Running pre-action listener: _resource_record_pre_action 19:12:00 INFO - Running main action method: install 19:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:00 INFO - Reading from file tmpfile_stdout 19:12:00 INFO - Detecting whether we're running mozinstall >=1.0... 19:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:12:00 INFO - Reading from file tmpfile_stdout 19:12:00 INFO - Output received: 19:12:00 INFO - Usage: mozinstall [options] installer 19:12:00 INFO - Options: 19:12:00 INFO - -h, --help show this help message and exit 19:12:00 INFO - -d DEST, --destination=DEST 19:12:00 INFO - Directory to install application into. [default: 19:12:00 INFO - "/builds/slave/test"] 19:12:00 INFO - --app=APP Application being installed. [default: firefox] 19:12:00 INFO - mkdir: /builds/slave/test/build/application 19:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:12:17 INFO - Reading from file tmpfile_stdout 19:12:17 INFO - Output received: 19:12:17 INFO - /builds/slave/test/build/application/firefox/firefox 19:12:17 INFO - Running post-action listener: _resource_record_post_action 19:12:17 INFO - ##### 19:12:17 INFO - ##### Finished install step (success) 19:12:17 INFO - ##### 19:12:17 INFO - ##### 19:12:17 INFO - ##### Running run-tests step. 19:12:17 INFO - ##### 19:12:17 INFO - Running pre-action listener: _resource_record_pre_action 19:12:17 INFO - Running main action method: run_tests 19:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:12:17 INFO - Python 2.7.3 19:12:17 INFO - Return code: 0 19:12:17 INFO - grabbing minidump binary from tooltool 19:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:12:17 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 0x1cea1c0>, '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 0x1ceb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ceb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:12:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:12:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:12:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:12:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:12:17 INFO - Return code: 0 19:12:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:12:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:12:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:12:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:12:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:12:18 INFO - Return code: 0 19:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:12:18 INFO - Using env: {'DISPLAY': ':0', 19:12:18 INFO - 'HOME': '/home/cltbld', 19:12:18 INFO - 'LANG': 'en_US.UTF-8', 19:12:18 INFO - 'LANGUAGE': 'en_US:en', 19:12:18 INFO - 'LOGNAME': 'cltbld', 19:12:18 INFO - 'MAIL': '/var/mail/cltbld', 19:12:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:12:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:18 INFO - 'MOZ_NO_REMOTE': '1', 19:12:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:12:18 INFO - 'NO_EM_RESTART': '1', 19:12:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:18 INFO - 'PWD': '/builds/slave/test', 19:12:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:12:18 INFO - 'SHELL': '/bin/bash', 19:12:18 INFO - 'SHLVL': '1', 19:12:18 INFO - 'TERM': 'linux', 19:12:18 INFO - 'TMOUT': '86400', 19:12:18 INFO - 'USER': 'cltbld', 19:12:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127', 19:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:18 INFO - '_': '/tools/buildbot/bin/python'} 19:12:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:12:18 INFO - mozversion application_buildid: 20160605163003 19:12:18 INFO - mozversion application_changeset: e54065dbe41dc0192f5d1710ad1ba5855f573545 19:12:18 INFO - mozversion application_display_name: Nightly 19:12:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:12:18 INFO - mozversion application_name: Firefox 19:12:18 INFO - mozversion application_remotingname: firefox 19:12:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:12:18 INFO - mozversion application_vendor: Mozilla 19:12:18 INFO - mozversion application_version: 49.0a1 19:12:18 INFO - mozversion platform_buildid: 20160605163003 19:12:18 INFO - mozversion platform_changeset: e54065dbe41dc0192f5d1710ad1ba5855f573545 19:12:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:12:18 INFO - mozversion platform_version: 49.0a1 19:12:18 INFO - using testdate: 1465179138 19:12:18 INFO - actual date: 1465179138 19:12:18 INFO - starting webserver on 'localhost:38200' 19:12:18 INFO - SUITE-START | Running 2 tests 19:12:18 INFO - TEST-START | dromaeo_css 19:12:18 INFO - operating with platform_type : linux_ 19:12:18 INFO - Initialising browser for dromaeo_css test... 19:12:18 INFO - TEST-INFO | started process 31045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLbEaaO/profile http://localhost:38200/getInfo.html) 19:12:24 INFO - PROCESS | 31045 | __metrics Screen width/height:1600/1200 19:12:24 INFO - PROCESS | 31045 | colorDepth:24 19:12:24 INFO - PROCESS | 31045 | Browser inner width/height: 1024/697 19:12:24 INFO - PROCESS | 31045 | __metrics 19:12:26 ERROR - PROCESS | 31045 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:12:26 INFO - PROCESS | 31045 | console.error: PushService: 19:12:26 INFO - PROCESS | 31045 | stateChangeProcessEnqueue: Error transitioning state 19:12:26 INFO - PROCESS | 31045 | UnknownError 19:12:27 INFO - TEST-INFO | 31045: exit 0 19:12:27 INFO - Browser initialized. 19:12:27 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:27 INFO - TEST-INFO | started process 31130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLbEaaO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:39 INFO - PROCESS | 31130 | RSS: Main: 156303360 19:12:39 INFO - PROCESS | 31130 | 19:13:30 INFO - PROCESS | 31130 | 1465179210804 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:15:39 INFO - PROCESS | 31130 | Cycle 1(1): loaded http://localhost:38200/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38200/tests/dromaeo/cssquery-ext.html) 19:15:40 INFO - PROCESS | 31130 | RSS: Main: 245288960 19:15:40 INFO - PROCESS | 31130 | 19:18:42 INFO - PROCESS | 31130 | Cycle 1(1): loaded http://localhost:38200/tests/dromaeo/cssquery-ext.html (next: http://localhost:38200/tests/dromaeo/cssquery-jquery.html) 19:18:43 INFO - PROCESS | 31130 | RSS: Main: 244154368 19:18:43 INFO - PROCESS | 31130 | 19:21:45 INFO - PROCESS | 31130 | Cycle 1(1): loaded http://localhost:38200/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38200/tests/dromaeo/cssquery-mootools.html) 19:21:45 INFO - PROCESS | 31130 | RSS: Main: 249417728 19:21:45 INFO - PROCESS | 31130 | 19:24:47 INFO - PROCESS | 31130 | Cycle 1(1): loaded http://localhost:38200/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38200/tests/dromaeo/cssquery-prototype.html) 19:24:48 INFO - PROCESS | 31130 | RSS: Main: 243982336 19:24:48 INFO - PROCESS | 31130 | 19:27:51 INFO - PROCESS | 31130 | Cycle 1(1): loaded http://localhost:38200/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38200/tests/dromaeo/cssquery-yui.html) 19:27:51 INFO - PROCESS | 31130 | RSS: Main: 208023552 19:27:51 INFO - PROCESS | 31130 | 19:30:54 INFO - PROCESS | 31130 | Cycle 1(1): loaded http://localhost:38200/tests/dromaeo/cssquery-yui.html (next: http://localhost:38200/tests/dromaeo/cssquery-dojo.html) 19:30:54 INFO - PROCESS | 31130 | RSS: Main: 272297984 19:30:54 INFO - PROCESS | 31130 | 19:30:54 INFO - PROCESS | 31130 | __start_tp_report 19:30:54 INFO - PROCESS | 31130 | _x_x_mozilla_page_load 19:30:54 INFO - PROCESS | 31130 | _x_x_mozilla_page_load_details 19:30:54 INFO - PROCESS | 31130 | |i|pagename|runs| 19:30:54 INFO - PROCESS | 31130 | |0;dojo.html;3158;3161.7944833585802;3187.0438868339493;3201.871925122995;3221.0658908916416;5269.920951185735;5358.4641535846395;5444.156155795853;5538.9169162462595;5555.111182210847;5414.052540805363;5418.83743487696;5424.240606315119;5427.918581221275;5429.647072940256;4856.368672072635;4961.751912404366;4963.826266080688;4976.4774698656665;5100.846974590768;4997.250412438127;5028.7988480460735;5052.494750524955;5057.544820966113;5069.74651267437;4750.287456881478;4762.738049407281;4892.3884514435695;4952.059108769322;4971.0803501352;4892.241702536077;4897.583705385046;4910.558049775502;4974.452810190876;4995.825146119869;4904.386951631046;4937.185364414903;4938.283948827436;4953.925691114636;4993.275974983607;5266.578673706094;5314.92027619586;5350.438203988564;5414.864628384283;5442.619016668835;5820.767169313222;5867.823965281048;5871.911921321183;5874.73563689635;5876.559258055663;5871.001929671923;5910.645361278294;5914.8817023659285;5925.081612350093;5928.377520360344;5289.418164001957;5428.728563571845;5461.153521204259;5464.836054918359;5529.4470552944385;6017.428344307284;6029.537288842169;6039.254161030247;6043.481283581734;6094.908576371358;5823.650580965071;5826.796062137805;5829.213056237354;5830.2129212555765;5830.650160990354;5667.8866422672145;5801.796937107181;5846.503047240947;5854.2096816930025;5893.6463812171405;5834.708264586754;5852;5853;5858.648481091148;5874.647521148745;5679.630823996427;5833.329167145747;5857.355690874;5875.823725288248;5876.471117599436;4357.433533640607;4358.150160718629;4360.302351623725;4378.912421751547;4385.3641222022625;3907.5115610548683;3915.197384536163;3919.8236079376497;3945.585713500041;3954.2486927483687;5371.57027437804;5426.186072089218;5463.72681365938;5506.614536982453;5518.420565840609;5815.534757219412;5854.912176317359;5857.326407463111;5907.645541267538;5923.437273459014;5545.528630066489;5563.388027316992;5566.805161819398;5572.331320241597;5572.359178694502;4939.135651261086;4998.4251811042195;5055.241713742895;5061.949380506221;5106.565941894906;6061.121137435047;6141.731496609813;6144.709610981744;6144.9553575892205;6145.016797312409;5920.319163296276;5920.940790592039;5924.6445213285615;5924.822255332347;5965.552583556164;5902.38025007368;5979.820605381846;6017.368176341596;6126.019836826086;6140.785072522441;5753.942460575341;5755.971220143872;5767.625104368202;5768.884622307614;5808.82573522795;5813.360530341574;5861.736221869941;5863.706814659165;5865.296164460292;5867.266591676041;5601.29983752031;5688.3742788294085;5717.17101020358;5733.627314224729;5763.625364351304;5766.279215098113;5766.740496677576;5767.884642307046;5771.509421699203;5772.1341798728845;5678.4605462480995;5687.43125687428;5687.77248910039;5688.0330343840815;5691.573132015033;5632;5715.714214289185;5742.684152371493;5754.712264386848;5862.794802181903;5656.406077361818;5669.489745922887;5669.971650141888;5671.347795003462;5707.372189059117 19:30:54 INFO - PROCESS | 31130 | |1;ext.html;597.7847974729096;612.2255346986062;640.3372509452715;641.4771960851908;651.7458191305394;31323;31917.840410797944;34961.475577866324;43071.138577228434;44277.55722442774;43428.34857477133;43704.781476092656;43982.78008609961;44009.7799511002;44021.55978440223;8524.872126918086;8785.64857405703;8788.428752131123;8789.165029322236;8793.296536277114;8601.569921503931;8757.7810554736;8787.209151176392;8793.384463087586;8797.648094076229;8834.646614135427;8846.336524760636;8863.290936725047;8864.335174861879;8877;8765.912340876605;8811.77970550735;8815.735527934108;8816.338774591866;8816.735497935073;8626.266767324785;8721.912780872173;8735.519546424945;8747.737567872973;8747.868781968276;40393.192136157406;40656.18687626231;40798.79600602008;40901.59098409038;40914.18171636551;3422.178677117499;3544.0608238816735;3565.3938830398633;3582.874599389009;3927.7643341399607;31125.533117003262;31507.21231969196;31806.522902156485;31991.200219994455;33107.172320691934;4044.50856375516;4067.5174152063114;4088.5298190708154;4096.262672718909;4277.358396240589;204935;204938;205654;205777;205890.9705451478;56634;56648;56912.71543642255;57121.714391428606;57208.42791572114;55887.72056139775;59768.70115649394;60800.391996080354;60815;67092;16613.91693041551;16732.749008764637;16762.99422034682;16771.91614041922;16779.496615101565;11633.185677002697;11807.173497855068;12652.936735316449;12683.809742853864;12699.174553653984;17106.315747369965;17308.576799248116;17454.825451745575;18123.72814407785;18144.637107257782;6387.137736405619;6686.09737685416;6722.697478613474;6727.461803055744;6831.351021652935;993.2500961773959;1129.3336931210624;1134.6425875849081;1145.8674365308477;1158.5771193514474;31927;32414.67585324164;32714.34571308608;32750.508742368882;33297.50053749196;1092.082650573522;1097.434821067151;1103.7957977774138;1116.8268918317674;1214.9514019439123;17227.913860430617;17386.65226695459;17399;17455.65088698219;17514.29942802299;516058;516490;518524;520154;521962;59397;59484.40515594875;59519.70240148772;59566;59573;1263.7030297879992;1357.4434481862388;1359.789232668938;1373.6565858535366;1394.2571785268415;32340.514892277104;33286;33440.832795835864;33816.13096426472;34059.14852128716;45642.54357456383;45921.31118033299;46161.53838461573;46187.76906115448;46301.305480418494;411495;413344;414710;414758;416533;33843.66156338405;35273.47089793604;43213.13573728571;45957.31064034109;46872.29691554698;48865.755671221414;49322.260166098255;49445.752771235915;49891;50369.49630503648;39239.12717531489;40419.1916161681;41471.7926410366;42281.78859105685;42531;40748;40806.90205465765;41263.587364125975;41354.37968430416;42338.788306058275;41291;41479.170416592104;41863.37204941867;41925;43736.56263437325;39229.215415692095;40727;42581;43811.780941095094;44321.55678443174;32835;34025;34044.489332659534;34087.147821304665;34407.65592344045 19:30:54 INFO - PROCESS | 31130 | |2;jquery.html;398.2850782844793;407.23643169058;410.7904968466085;416.7582801974855;421.759597029693;13805.930970345134;19076.713849292253;19495.512612184666;19887.602247955034;19909.60180796383;13922.860771392283;18465;18474.076296185205;18546.721799173025;19361.806381936178;5673.26247587813;5825.621334613258;5850.707464626773;5865.296164460249;5901.704914754267;5727.885442291152;5773.48038676519;5818.0981947797945;5818.912716309259;5826.300843898738;4148.087420767426;6124.510039196876;6395.072714456401;6432.388923052303;6570.770023049195;6455;6504.0569117477935;6518.120053792748;6540.803775886731;6545.738170473175;5649.830505084854;5755.740991655385;5769.105788602773;5786.68173250471;5794.246747922785;23058.65412018821;23200.65199022016;23967.28098157058;24182.879085604636;24217.152399665927;2166.263470420049;2309.480366917447;2353.423411264234;2382.5949588569983;2464.088287333698;10009.59961601535;10261.846072308921;10376.740581485448;10681.893181068168;13352.198868067948;1795.3895675470403;1918.396422423179;1934.41000494849;1973.5362189885366;2022.6763717805227;80759;80824.95875206216;81126;83003.5849820753;83004.58497707473;11404.771904561861;11462.942685286687;11761.941190294165;11773.764524709457;12310.734996695386;16036.67926641484;16168.595785105466;16224.67550649004;16250.75623865643;16273.918630407008;8284.875726864102;8339.624716887754;8436.578171091543;8559.186877246651;8591.140885911358;8127.431079824474;8174.3460523158;8269.467120974483;8455.32357411418;8460.153984601491;4355.542668019875;4616.976915115471;4764.094821983812;4874.293227481995;4922.680025798311;1889.7165425186058;2030.9743579492263;2038.8674736142104;2053.620080285152;2079.719237902894;912.981740365189;984.532347135105;1045.3466583385384;1078.2344535379968;1116.547798141754;18926.62146757057;19621.901890490743;19703.704444433344;19803.702944455843;19855;958.2190514730472;982.8378317577519;1036.1451802263164;1059.6979860739652;1112.57165991094;10741.40922249268;11168.497417616065;11196.832047519294;11218.775624487627;11219.1585631078;458918;459623;469278.1650550947;473640;475134;92586.68533286722;94856;94949.52525237329;97391.51304243434;104348.52166261706;493.29705170132416;502.22406382139684;508.280782692486;509.3683832048234;511.3148381169251;10854.782904342026;11364.204505684524;11449.59926402572;11555.480003400035;11940.104492163297;43028.78485607552;43326.56673433226;44202;44248;44760.552394475635;61032;61215.69392153011;61371.38628613835;62344.68827655833;62362.376376235654;8426.283765879969;8780.604872780612;8794.29645628361;8956.79083323743;8989.05614910425;9624;10784.892151078702;12697.365131743562;13405.798913016508;13869.791953120914;11876.168668193144;12172.75654486923;12216.38918054076;12437.191582547106;12718.236905785683;12077.57728479499;12156.452959617016;12250.14249002597;12456.065795065226;12654.177478463871;12197.75604487923;12349.444275007467;12358.814617780561;12384.256944583354;12464.626061218178;8998.955005224932;9069.77325566866;9132.771680708036;9174.53207486799;9403.106704863027;11198.10415166801;11958.940205299266;12133.696657583278;12212.816807747713;12223.20549164337 19:30:54 INFO - PROCESS | 31130 | |3;mootools.html;1349.763791336517;1501.1968596800707;1553.3243039277916;1706.2748331958921;1864.8414884734805;8553.230209281164;8858.512781797006;8904.332175086862;9123.042080581543;9214.493202873839;8822.77943051424;9038.954805225982;9048.321375896801;9051.094890510945;9055.592498337573;2085.384811480617;2335.94160145996;2366.041753089997;2398.2805158452484;2403.3150552092657;2379.8096152307776;2380.833341666084;2383.3207535852284;2389.8924548395275;2392.820538459614;2329.569029729497;2381.8094552435764;2384.201292566992;2386.3556839653284;2386.451116243265;2055.7738648748627;2276.5902137615303;2331.4870728439714;2333.3933177373833;2368.0409434179187;2332.603457412244;2339.7309309429465;2340.754220806808;2359.398353419867;2402.5555272274687;8968.775780605472;9024.413413128192;9027.909720902773;9036.277097832157;9064.410813297114;5244.108501554745;5399.9730001350135;5405.18922161675;5407.891842163174;5414.810481633124;3196.9200769980703;3276;3360.395128876801;3410.2667926395698;3434.9141271468166;1037.5370727274508;1042.3381152967845;1086.4459125845797;1103.8564986551778;1114.0363585498567;12595;12640.178388404724;12641.93679031599;12684.112112152154;12693.301868397235;4532.410786597721;4669.066186762661;4673.322368256584;4747.8100875965265;4834.734089625034;10676.89323106759;10678.09236214915;10680.092192163598;10689.412082335391;10693.198010149114;4735.763211839394;5311.044012077863;5321.042212401728;5322.893542129135;5326.094563924142;4730.739809310452;4871.391076115486;4877.975610121926;4911.7298548580175;4915.0415668944215;4068.4100805383055;4109.650679692199;4114.6091121343425;4197.76912269822;4294.463192100988;1283.4866053578457;1296.695276609996;1298.805179223124;1311.0363882546321;1314.2968511846116;821.2977903892206;897.4749771383683;916.0701887584107;921.5300196899495;931.3527098666361;5766.971165144148;5792.304923409133;5810.41895810424;5929.169916211734;6014.127951447016;439.6131404364203;446.62260389970425;448.8092560661706;998.4159266828987;1027.106417416852;3745.3632882410056;3747.1756213633503;3835.558910725302;3861.2084522673345;3887.8833634990997;11166.106711463064;11333.093352531778;11424.771504570028;11438.94280528592;11439.142064345207;10972.286801357886;11216.943915280372;11360.488778004845;11364.715882103013;11418.885811141949;8399.11809260031;8442.57787110642;8443.95778021106;8531.872021919677;8563.57182140878;5509.449055094618;5568.721563921868;5579.414161512983;5626.549876009991;5766.538676905921;10213.62116114315;10357.482125893826;10557.260991730813;10585.206109541969;10609.469526523488;10546.841797372892;10646.84029739539;10649.733756656145;10669.733256668645;10685.679429617125;6315.494760419064;6734.528582999143;6813.625250611264;6847.349501797321;6913.032175495535;8885.822283554422;8899.466032038099;8980.550972451481;8993.865092023494;9004.774880628036;7738.535687858746;8026.598670066356;8026.678932842621;8032.959835200787;8124.268815806606;7756.534607923542;7875.291223789886;7890.723824666109;7948.364130869632;8011.078725946358;6550.541462097607;6680.83297917556;6693;6776.28848970851;6777.559458635173;4724.881877953078;4759.857204283877;4784.114938736345;4824.517548245148;4881.731504767272;4973.726445045412;5047.343845300087;5060.1903695408555;5111.46329635383;5204.843854684365 19:30:54 INFO - PROCESS | 31130 | |4;prototype.html;335.28082263544695;338.9068006298268;342.7378055787323;344.42652982783665;348.39031694534566;5211.921821172686;5216.191490319002;5274.472552744728;5295.338082739658;5323.095073837448;5172.6379153459275;5192.5067118623765;5228.241904923784;5236.764345604447;5236.947630523694;4058.0463591056077;4132.338825787874;4138.3378659414575;4165.250254954107;4198;4115.609017143366;4166.520850102247;4171.124063946575;4175.227582897159;4185.665146788265;4132.648724858391;4144.316187829005;4144.44050053242;4153.1070819773895;4193.888619515816;3963.9801800990954;3977.125032492847;4096.1193343431005;4103.692223083251;4111.794410279504;3625.329314076904;3644.6173151818944;3650.7079433645245;3651.214988777399;3658.981705091484;4835.371401717789;5067.39191297043;5073.594112471031;5079.466656001141;5089.549478398676;4504.977475112603;4686.367340409035;4691.997121842024;4697.78859951303;4697.812087516495;5364.758585863646;5385.0037743017665;5426.8371948841595;5442.6462279951675;5494.890102197934;3921.0981474260793;3930.5849894038124;3990.201959608061;4004.5594984551676;4013.6588389986887;5624.878192603103;5629.6340737852315;5656.115381155599;5660.716964151776;5666.46168613981;4070.2876996526084;4077.5728495027097;4082.81627326771;4089.427480152781;4094.2220978014084;4106.691998100155;4115.156392939441;4135.834566617302;4136.255474014706;4145.0880806222585;4400.669949753781;4590.311453282035;4628.4445866496235;4674.504158669193;4701.64737644678;5489.780408783684;5510.760078982197;5552.861178470571;5566.721663916788;5573;1401.439424230316;1406.4374250299961;1407.1486750515994;1417.794874356809;1419.9421431033945;917.3991035871514;959.1463597398321;963.0995019656643;976.2531663277598;977.8973207813219;5225.869353266199;5244.501772331622;5255.766299322772;5276.182191760283;5288.444713305047;5424.321959755031;5564.8330550083565;5574.327701689477;5589.329280486287;5595.944040559623;5111.900941297639;5253.632245742838;5270.49930256625;5281.471852814688;5323.973380133075;2933.765298776093;2946.1897978056204;2958.467475854367;2961.6890226526334;2981.5825784390204;5778.739956701875;5818.854528636818;5823.79616713413;5827.184194212814;5827.35899051104;5582.54853738031;5672.631278966936;5707.372189059283;5714.485696287271;5741.88516229673;5758.971205143947;5765.711714414262;5795.478406943395;5821.155932389865;5844.26946631671;5301.5493683037375;5563.7496312666835;5591.412901645269;5597.468240517144;5600.971995139998;5482.972585137049;5483.232347471437;5535.972320138535;5538.196961440649;5539.418361072029;5756.704741433312;5761.48146666802;5796.391378905154;5802.680852552981;5843.065109582446;3903.6096390360735;3960.7821569813937;3965.6827453804203;3973.980130099447;4005.799710014546;5531.419200983839;5584.329880414376;5594.552435805207;5608.831735047955;5622.606417550732;5440.129579267298;5480.945190548044;5517.144842549411;5540.778368865362;5543.861403464784;5249.737513124405;5444.183372494158;5455.618106732491;5462.371827239759;5467.20725494809;5315.3090098286975;5335.1060373566825;5338.145896656516;5354.286628278914;5365.248865158959;5317.760700768397;5374.964710077681;5387.622866399314;5479.452054794648;5515.393306736176;5349.438308977501;5358.973205134105;5360.544353729821;5362.785488580413;5387.973060134675 19:30:54 INFO - PROCESS | 31130 | |5;yui.html;669.9162604674416;672.7779832655224;746.6080307838384;776.5767656627138;806.4234072638062;14555.490557830479;14842.851571484282;15007.39970401184;15195.772063419057;15227.238638068107;13918.791218131712;14088.36602352894;14109.223992680398;14139.434422623082;14140.71718565628;687.3435868745336;795.0181525815613;816.5957850863831;835.578033093287;837.4054421360842;835.9122292159327;840.6763396092488;840.9285210757063;841.2302742990157;841.88634534338;872.1235158665532;873;874.204473928725;875.2778957360172;876.2332958661171;710.406810313389;842.0442797424905;859.9484030958131;865.5326123893121;872.1235158665564;636.8821767972939;638.2022471910112;638.9233292004943;638.9265234498046;639.338284875152;14999.1750453725;15019.399224031025;15027.699446011127;15038.924805375904;15041.172735499544;13046.282454465001;13392.06255562111;13429.932850335686;13513.86486135136;13523.120997135155;12548.874511254953;12636.2418254905;12749.10756247063;12947.935260323638;12974.545890893867;4401.9119617607785;4433.290673492258;4489.955100448987;4507.481639611454;4510.368548403226;71993.28006719919;73297.63351183264;73603;73733.63133184353;73758.26241737568;10796.406197659204;10933;10969.122470202365;10979.1765617579;11123.777524449628;20801.791982079987;20819.959002049836;20829.479263018547;20831.479213019797;20840;7736.7678969631;7893.329067029252;7899.5260284381975;8113.229243221885;8276.965379327585;4655.301704744248;4658.3711198988385;4715.95284047162;4722.480527142012;4761.309610106515;3258.4297747894025;3355.597328320617;3363.983180084084;3373.1061268763797;3374.4263475209273;549.72239019295;550.8430097422215;554.2226011778495;559.3204256827973;575.7495489462013;546.160491743047;560.7112337146373;565.7397597105295;586.8567910551435;602.9035354343284;7459.291367320096;7553.773386798405;7662.885056724153;7699.576523291161;7985.800354991172;476.9332293478916;530.2549917366107;545.3319683387818;581.8574449259959;618.7617767159676;3915.960840391617;3929.587393323717;3981.144054028398;4015.9799201003807;4066.3087275163293;109216;110963.44518277358;111169.44415278034;112142;113955;93587.53206233925;97421;98198;98621.50689246651;99825.0174982496;84535.577322113;85229;85349.14650853536;85810.14189858147;86473.56763216143;7754.302112809874;7951.721689740832;7961.363090952826;8175.223353781381;8218.383621228551;48823.755881220364;48906.75546622244;48963.75518122529;49330.30022748237;52219.47780522146;51449.48550514597;69684.65157674179;77035.2296477028;78108;79348.20651793409;9927.40435573868;10030.64892728751;10040.799184016132;10049.899501004897;10393.792124157626;11804.645860624196;11947;12010.699732506757;12190.817137742764;12576.937115314366;10615.575376984834;10684.25210235276;10704.197185210984;11233.941734815447;11572.421378931189;10748.742764019644;10908.290961087503;11061.5022323994;11205.495752691311;11258.324500529994;10765.730856728644;10776.622818201326;11109.388983605979;11213.831792522955;11432.428378581204;9520.333576649567;9611.951940240255;9748.499429535083;9931.801363972825;9984.900150998688;8175.836483270183;8289.875651865106;8900.821983560421;9179.238174133074;9377.1091746284 19:30:54 INFO - PROCESS | 31130 | __end_tp_report 19:30:54 INFO - PROCESS | 31130 | __start_cc_report 19:30:54 INFO - PROCESS | 31130 | _x_x_mozilla_cycle_collect,1018 19:30:54 INFO - PROCESS | 31130 | __end_cc_report 19:30:54 INFO - PROCESS | 31130 | __startTimestamp1465180254658__endTimestamp 19:30:54 INFO - PROCESS | 31130 | 19:30:54 INFO - PROCESS | 31130 | ------- Summary: start ------- 19:30:54 INFO - PROCESS | 31130 | Number of tests: 6 19:30:54 INFO - PROCESS | 31130 | 19:30:54 INFO - PROCESS | 31130 | [#0] dojo.html Cycles:165 Average:5431.59 Median:5678.46 stddev:636.37 (11.2%) stddev-sans-first:612.81 19:30:54 INFO - PROCESS | 31130 | Values: 3158.0 3161.8 3187.0 3201.9 3221.1 5269.9 5358.5 5444.2 5538.9 5555.1 5414.1 5418.8 5424.2 5427.9 5429.6 4856.4 4961.8 4963.8 4976.5 5100.8 4997.3 5028.8 5052.5 5057.5 5069.7 4750.3 4762.7 4892.4 4952.1 4971.1 4892.2 4897.6 4910.6 4974.5 4995.8 4904.4 4937.2 4938.3 4953.9 4993.3 5266.6 5314.9 5350.4 5414.9 5442.6 5820.8 5867.8 5871.9 5874.7 5876.6 5871.0 5910.6 5914.9 5925.1 5928.4 5289.4 5428.7 5461.2 5464.8 5529.4 6017.4 6029.5 6039.3 6043.5 6094.9 5823.7 5826.8 5829.2 5830.2 5830.7 5667.9 5801.8 5846.5 5854.2 5893.6 5834.7 5852.0 5853.0 5858.6 5874.6 5679.6 5833.3 5857.4 5875.8 5876.5 4357.4 4358.2 4360.3 4378.9 4385.4 3907.5 3915.2 3919.8 3945.6 3954.2 5371.6 5426.2 5463.7 5506.6 5518.4 5815.5 5854.9 5857.3 5907.6 5923.4 5545.5 5563.4 5566.8 5572.3 5572.4 4939.1 4998.4 5055.2 5061.9 5106.6 6061.1 6141.7 6144.7 6145.0 6145.0 5920.3 5920.9 5924.6 5924.8 5965.6 5902.4 5979.8 6017.4 6126.0 6140.8 5753.9 5756.0 5767.6 5768.9 5808.8 5813.4 5861.7 5863.7 5865.3 5867.3 5601.3 5688.4 5717.2 5733.6 5763.6 5766.3 5766.7 5767.9 5771.5 5772.1 5678.5 5687.4 5687.8 5688.0 5691.6 5632.0 5715.7 5742.7 5754.7 5862.8 5656.4 5669.5 5670.0 5671.3 5707.4 19:30:54 INFO - PROCESS | 31130 | 19:30:54 INFO - PROCESS | 31130 | [#1] ext.html Cycles:180 Average:55523.92 Median:414734.00 stddev:106536.88 (25.7%) stddev-sans-first:106755.92 19:30:54 INFO - PROCESS | 31130 | Values: 597.8 612.2 640.3 641.5 651.7 31323.0 31917.8 34961.5 43071.1 44277.6 43428.3 43704.8 43982.8 44009.8 44021.6 8524.9 8785.6 8788.4 8789.2 8793.3 8601.6 8757.8 8787.2 8793.4 8797.6 8834.6 8846.3 8863.3 8864.3 8877.0 8765.9 8811.8 8815.7 8816.3 8816.7 8626.3 8721.9 8735.5 8747.7 8747.9 40393.2 40656.2 40798.8 40901.6 40914.2 3422.2 3544.1 3565.4 3582.9 3927.8 31125.5 31507.2 31806.5 31991.2 33107.2 4044.5 4067.5 4088.5 4096.3 4277.4 204935.0 204938.0 205654.0 205777.0 205891.0 56634.0 56648.0 56912.7 57121.7 57208.4 55887.7 59768.7 60800.4 60815.0 67092.0 16613.9 16732.7 16763.0 16771.9 16779.5 11633.2 11807.2 12652.9 12683.8 12699.2 17106.3 17308.6 17454.8 18123.7 18144.6 6387.1 6686.1 6722.7 6727.5 6831.4 993.3 1129.3 1134.6 1145.9 1158.6 31927.0 32414.7 32714.3 32750.5 33297.5 1092.1 1097.4 1103.8 1116.8 1215.0 17227.9 17386.7 17399.0 17455.7 17514.3 516058.0 516490.0 518524.0 520154.0 521962.0 59397.0 59484.4 59519.7 59566.0 59573.0 1263.7 1357.4 1359.8 1373.7 1394.3 32340.5 33286.0 33440.8 33816.1 34059.1 45642.5 45921.3 46161.5 46187.8 46301.3 411495.0 413344.0 414710.0 414758.0 416533.0 33843.7 35273.5 43213.1 45957.3 46872.3 48865.8 49322.3 49445.8 49891.0 50369.5 39239.1 40419.2 41471.8 42281.8 42531.0 40748.0 40806.9 41263.6 41354.4 42338.8 41291.0 41479.2 41863.4 41925.0 43736.6 39229.2 40727.0 42581.0 43811.8 44321.6 32835.0 34025.0 34044.5 34087.1 34407.7 19:30:54 INFO - PROCESS | 31130 | 19:30:54 INFO - PROCESS | 31130 | [#2] jquery.html Cycles:180 Average:28661.48 Median:1431.19 stddev:77372.79 (5406.2%) stddev-sans-first:77560.74 19:30:54 INFO - PROCESS | 31130 | Values: 398.3 407.2 410.8 416.8 421.8 13805.9 19076.7 19495.5 19887.6 19909.6 13922.9 18465.0 18474.1 18546.7 19361.8 5673.3 5825.6 5850.7 5865.3 5901.7 5727.9 5773.5 5818.1 5818.9 5826.3 4148.1 6124.5 6395.1 6432.4 6570.8 6455.0 6504.1 6518.1 6540.8 6545.7 5649.8 5755.7 5769.1 5786.7 5794.2 23058.7 23200.7 23967.3 24182.9 24217.2 2166.3 2309.5 2353.4 2382.6 2464.1 10009.6 10261.8 10376.7 10681.9 13352.2 1795.4 1918.4 1934.4 1973.5 2022.7 80759.0 80825.0 81126.0 83003.6 83004.6 11404.8 11462.9 11761.9 11773.8 12310.7 16036.7 16168.6 16224.7 16250.8 16273.9 8284.9 8339.6 8436.6 8559.2 8591.1 8127.4 8174.3 8269.5 8455.3 8460.2 4355.5 4617.0 4764.1 4874.3 4922.7 1889.7 2031.0 2038.9 2053.6 2079.7 913.0 984.5 1045.3 1078.2 1116.5 18926.6 19621.9 19703.7 19803.7 19855.0 958.2 982.8 1036.1 1059.7 1112.6 10741.4 11168.5 11196.8 11218.8 11219.2 458918.0 459623.0 469278.2 473640.0 475134.0 92586.7 94856.0 94949.5 97391.5 104348.5 493.3 502.2 508.3 509.4 511.3 10854.8 11364.2 11449.6 11555.5 11940.1 43028.8 43326.6 44202.0 44248.0 44760.6 61032.0 61215.7 61371.4 62344.7 62362.4 8426.3 8780.6 8794.3 8956.8 8989.1 9624.0 10784.9 12697.4 13405.8 13869.8 11876.2 12172.8 12216.4 12437.2 12718.2 12077.6 12156.5 12250.1 12456.1 12654.2 12197.8 12349.4 12358.8 12384.3 12464.6 8999.0 9069.8 9132.8 9174.5 9403.1 11198.1 11958.9 12133.7 12212.8 12223.2 19:30:54 INFO - PROCESS | 31130 | 19:30:54 INFO - PROCESS | 31130 | [#3] mootools.html Cycles:180 Average:5855.37 Median:4671.19 stddev:3436.79 (73.6%) stddev-sans-first:3429.76 19:30:54 INFO - PROCESS | 31130 | Values: 1349.8 1501.2 1553.3 1706.3 1864.8 8553.2 8858.5 8904.3 9123.0 9214.5 8822.8 9039.0 9048.3 9051.1 9055.6 2085.4 2335.9 2366.0 2398.3 2403.3 2379.8 2380.8 2383.3 2389.9 2392.8 2329.6 2381.8 2384.2 2386.4 2386.5 2055.8 2276.6 2331.5 2333.4 2368.0 2332.6 2339.7 2340.8 2359.4 2402.6 8968.8 9024.4 9027.9 9036.3 9064.4 5244.1 5400.0 5405.2 5407.9 5414.8 3196.9 3276.0 3360.4 3410.3 3434.9 1037.5 1042.3 1086.4 1103.9 1114.0 12595.0 12640.2 12641.9 12684.1 12693.3 4532.4 4669.1 4673.3 4747.8 4834.7 10676.9 10678.1 10680.1 10689.4 10693.2 4735.8 5311.0 5321.0 5322.9 5326.1 4730.7 4871.4 4878.0 4911.7 4915.0 4068.4 4109.7 4114.6 4197.8 4294.5 1283.5 1296.7 1298.8 1311.0 1314.3 821.3 897.5 916.1 921.5 931.4 5767.0 5792.3 5810.4 5929.2 6014.1 439.6 446.6 448.8 998.4 1027.1 3745.4 3747.2 3835.6 3861.2 3887.9 11166.1 11333.1 11424.8 11438.9 11439.1 10972.3 11216.9 11360.5 11364.7 11418.9 8399.1 8442.6 8444.0 8531.9 8563.6 5509.4 5568.7 5579.4 5626.5 5766.5 10213.6 10357.5 10557.3 10585.2 10609.5 10546.8 10646.8 10649.7 10669.7 10685.7 6315.5 6734.5 6813.6 6847.3 6913.0 8885.8 8899.5 8980.6 8993.9 9004.8 7738.5 8026.6 8026.7 8033.0 8124.3 7756.5 7875.3 7890.7 7948.4 8011.1 6550.5 6680.8 6693.0 6776.3 6777.6 4724.9 4759.9 4784.1 4824.5 4881.7 4973.7 5047.3 5060.2 5111.5 5204.8 19:30:54 INFO - PROCESS | 31130 | 19:30:54 INFO - PROCESS | 31130 | [#4] prototype.html Cycles:180 Average:4615.42 Median:5278.83 stddev:1340.55 (25.4%) stddev-sans-first:1305.25 19:30:54 INFO - PROCESS | 31130 | Values: 335.3 338.9 342.7 344.4 348.4 5211.9 5216.2 5274.5 5295.3 5323.1 5172.6 5192.5 5228.2 5236.8 5236.9 4058.0 4132.3 4138.3 4165.3 4198.0 4115.6 4166.5 4171.1 4175.2 4185.7 4132.6 4144.3 4144.4 4153.1 4193.9 3964.0 3977.1 4096.1 4103.7 4111.8 3625.3 3644.6 3650.7 3651.2 3659.0 4835.4 5067.4 5073.6 5079.5 5089.5 4505.0 4686.4 4692.0 4697.8 4697.8 5364.8 5385.0 5426.8 5442.6 5494.9 3921.1 3930.6 3990.2 4004.6 4013.7 5624.9 5629.6 5656.1 5660.7 5666.5 4070.3 4077.6 4082.8 4089.4 4094.2 4106.7 4115.2 4135.8 4136.3 4145.1 4400.7 4590.3 4628.4 4674.5 4701.6 5489.8 5510.8 5552.9 5566.7 5573.0 1401.4 1406.4 1407.1 1417.8 1419.9 917.4 959.1 963.1 976.3 977.9 5225.9 5244.5 5255.8 5276.2 5288.4 5424.3 5564.8 5574.3 5589.3 5595.9 5111.9 5253.6 5270.5 5281.5 5324.0 2933.8 2946.2 2958.5 2961.7 2981.6 5778.7 5818.9 5823.8 5827.2 5827.4 5582.5 5672.6 5707.4 5714.5 5741.9 5759.0 5765.7 5795.5 5821.2 5844.3 5301.5 5563.7 5591.4 5597.5 5601.0 5483.0 5483.2 5536.0 5538.2 5539.4 5756.7 5761.5 5796.4 5802.7 5843.1 3903.6 3960.8 3965.7 3974.0 4005.8 5531.4 5584.3 5594.6 5608.8 5622.6 5440.1 5480.9 5517.1 5540.8 5543.9 5249.7 5444.2 5455.6 5462.4 5467.2 5315.3 5335.1 5338.1 5354.3 5365.2 5317.8 5375.0 5387.6 5479.5 5515.4 5349.4 5359.0 5360.5 5362.8 5388.0 19:30:54 INFO - PROCESS | 31130 | 19:30:54 INFO - PROCESS | 31130 | [#5] yui.html Cycles:180 Average:19747.61 Median:26374.87 stddev:29336.82 (111.2%) stddev-sans-first:29384.14 19:30:54 INFO - PROCESS | 31130 | Values: 669.9 672.8 746.6 776.6 806.4 14555.5 14842.9 15007.4 15195.8 15227.2 13918.8 14088.4 14109.2 14139.4 14140.7 687.3 795.0 816.6 835.6 837.4 835.9 840.7 840.9 841.2 841.9 872.1 873.0 874.2 875.3 876.2 710.4 842.0 859.9 865.5 872.1 636.9 638.2 638.9 638.9 639.3 14999.2 15019.4 15027.7 15038.9 15041.2 13046.3 13392.1 13429.9 13513.9 13523.1 12548.9 12636.2 12749.1 12947.9 12974.5 4401.9 4433.3 4490.0 4507.5 4510.4 71993.3 73297.6 73603.0 73733.6 73758.3 10796.4 10933.0 10969.1 10979.2 11123.8 20801.8 20820.0 20829.5 20831.5 20840.0 7736.8 7893.3 7899.5 8113.2 8277.0 4655.3 4658.4 4716.0 4722.5 4761.3 3258.4 3355.6 3364.0 3373.1 3374.4 549.7 550.8 554.2 559.3 575.7 546.2 560.7 565.7 586.9 602.9 7459.3 7553.8 7662.9 7699.6 7985.8 476.9 530.3 545.3 581.9 618.8 3916.0 3929.6 3981.1 4016.0 4066.3 109216.0 110963.4 111169.4 112142.0 113955.0 93587.5 97421.0 98198.0 98621.5 99825.0 84535.6 85229.0 85349.1 85810.1 86473.6 7754.3 7951.7 7961.4 8175.2 8218.4 48823.8 48906.8 48963.8 49330.3 52219.5 51449.5 69684.7 77035.2 78108.0 79348.2 9927.4 10030.6 10040.8 10049.9 10393.8 11804.6 11947.0 12010.7 12190.8 12576.9 10615.6 10684.3 10704.2 11233.9 11572.4 10748.7 10908.3 11061.5 11205.5 11258.3 10765.7 10776.6 11109.4 11213.8 11432.4 9520.3 9612.0 9748.5 9931.8 9984.9 8175.8 8289.9 8900.8 9179.2 9377.1 19:30:54 INFO - PROCESS | 31130 | -------- Summary: end -------- 19:30:54 INFO - PROCESS | 31130 | 19:30:55 INFO - TEST-INFO | 31130: exit 0 19:30:55 INFO - TEST-OK | dromaeo_css | took 1116713ms 19:30:55 INFO - TEST-START | kraken 19:30:55 INFO - operating with platform_type : linux_ 19:30:55 INFO - Initialising browser for kraken test... 19:30:55 INFO - TEST-INFO | started process 31316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZoPTcd/profile http://localhost:38200/getInfo.html) 19:31:00 INFO - PROCESS | 31316 | __metrics Screen width/height:1600/1200 19:31:00 INFO - PROCESS | 31316 | colorDepth:24 19:31:00 INFO - PROCESS | 31316 | Browser inner width/height: 1024/697 19:31:00 INFO - PROCESS | 31316 | __metrics 19:31:02 ERROR - PROCESS | 31316 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:31:03 INFO - PROCESS | 31316 | console.error: PushService: 19:31:03 INFO - PROCESS | 31316 | stateChangeProcessEnqueue: Error transitioning state 19:31:03 INFO - PROCESS | 31316 | UnknownError 19:31:03 INFO - TEST-INFO | 31316: exit 0 19:31:03 INFO - Browser initialized. 19:31:03 INFO - Running cycle 1/1 for kraken test... 19:31:03 INFO - TEST-INFO | started process 31396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZoPTcd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:15 INFO - PROCESS | 31396 | RSS: Main: 160059392 19:31:15 INFO - PROCESS | 31396 | 19:31:18 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38200/tests/kraken/driver.html?testName=audio-beat-detection) 19:31:18 INFO - PROCESS | 31396 | RSS: Main: 218157056 19:31:18 INFO - PROCESS | 31396 | 19:31:21 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38200/tests/kraken/driver.html?testName=audio-dft) 19:31:22 INFO - PROCESS | 31396 | RSS: Main: 205950976 19:31:22 INFO - PROCESS | 31396 | 19:31:25 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38200/tests/kraken/driver.html?testName=audio-fft) 19:31:26 INFO - PROCESS | 31396 | RSS: Main: 272465920 19:31:26 INFO - PROCESS | 31396 | 19:31:28 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38200/tests/kraken/driver.html?testName=audio-oscillator) 19:31:28 INFO - PROCESS | 31396 | RSS: Main: 182972416 19:31:28 INFO - PROCESS | 31396 | 19:31:30 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38200/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:31:31 INFO - PROCESS | 31396 | RSS: Main: 186761216 19:31:31 INFO - PROCESS | 31396 | 19:31:34 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38200/tests/kraken/driver.html?testName=imaging-darkroom) 19:31:35 INFO - PROCESS | 31396 | RSS: Main: 221380608 19:31:35 INFO - PROCESS | 31396 | 19:31:38 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38200/tests/kraken/driver.html?testName=imaging-desaturate) 19:31:38 INFO - PROCESS | 31396 | RSS: Main: 223825920 19:31:38 INFO - PROCESS | 31396 | 19:31:41 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38200/tests/kraken/driver.html?testName=json-parse-financial) 19:31:42 INFO - PROCESS | 31396 | RSS: Main: 223846400 19:31:42 INFO - PROCESS | 31396 | 19:31:43 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38200/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:44 INFO - PROCESS | 31396 | RSS: Main: 209489920 19:31:44 INFO - PROCESS | 31396 | 19:31:46 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38200/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:46 INFO - PROCESS | 31396 | RSS: Main: 213368832 19:31:46 INFO - PROCESS | 31396 | 19:31:48 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38200/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:49 INFO - PROCESS | 31396 | RSS: Main: 216014848 19:31:49 INFO - PROCESS | 31396 | 19:31:52 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:52 INFO - PROCESS | 31396 | RSS: Main: 223137792 19:31:52 INFO - PROCESS | 31396 | 19:31:55 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:56 INFO - PROCESS | 31396 | RSS: Main: 222711808 19:31:56 INFO - PROCESS | 31396 | 19:31:57 INFO - PROCESS | 31396 | Cycle 1(1): loaded http://localhost:38200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38200/tests/kraken/driver.html?testName=ai-astar) 19:31:58 INFO - PROCESS | 31396 | RSS: Main: 265256960 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | __start_tp_report 19:31:58 INFO - PROCESS | 31396 | _x_x_mozilla_page_load 19:31:58 INFO - PROCESS | 31396 | _x_x_mozilla_page_load_details 19:31:58 INFO - PROCESS | 31396 | |i|pagename|runs| 19:31:58 INFO - PROCESS | 31396 | |0;ai-astar;114;109;111;111;112;111;112;110;111;110 19:31:58 INFO - PROCESS | 31396 | |1;audio-beat-detection;155;127;132;152;127;153;155;126;185;126 19:31:58 INFO - PROCESS | 31396 | |2;audio-dft;159;159;160;161;159;160;161;160;160;160 19:31:58 INFO - PROCESS | 31396 | |3;audio-fft;75;76;75;120;75;76;73;75;103;75 19:31:58 INFO - PROCESS | 31396 | |4;audio-oscillator;84;86;116;85;85;85;121;85;84;128 19:31:58 INFO - PROCESS | 31396 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 19:31:58 INFO - PROCESS | 31396 | |6;imaging-darkroom;146;145;146;146;145;145;146;145;146;146 19:31:58 INFO - PROCESS | 31396 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 19:31:58 INFO - PROCESS | 31396 | |8;json-parse-financial;65;53;56;54;54;57;53;53;53;55 19:31:58 INFO - PROCESS | 31396 | |9;json-stringify-tinderbox;61;60;60;61;60;61;60;60;61;62 19:31:58 INFO - PROCESS | 31396 | |10;stanford-crypto-aes;82;85;86;80;84;80;81;84;115;86 19:31:58 INFO - PROCESS | 31396 | |11;stanford-crypto-ccm;142;125;127;121;128;128;126;128;131;130 19:31:58 INFO - PROCESS | 31396 | |12;stanford-crypto-pbkdf2;162;162;164;160;161;161;162;162;168;159 19:31:58 INFO - PROCESS | 31396 | |13;stanford-crypto-sha256-iterative;67;65;65;63;65;63;63;63;62;61 19:31:58 INFO - PROCESS | 31396 | __end_tp_report 19:31:58 INFO - PROCESS | 31396 | __start_cc_report 19:31:58 INFO - PROCESS | 31396 | _x_x_mozilla_cycle_collect,1624 19:31:58 INFO - PROCESS | 31396 | __end_cc_report 19:31:58 INFO - PROCESS | 31396 | __startTimestamp1465180318039__endTimestamp 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | ------- Summary: start ------- 19:31:58 INFO - PROCESS | 31396 | Number of tests: 14 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:1.37 (1.2%) stddev-sans-first:0.97 19:31:58 INFO - PROCESS | 31396 | Values: 114.0 109.0 111.0 111.0 112.0 111.0 112.0 110.0 111.0 110.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:152.50 stddev:19.54 (12.8%) stddev-sans-first:20.30 19:31:58 INFO - PROCESS | 31396 | Values: 155.0 127.0 132.0 152.0 127.0 153.0 155.0 126.0 185.0 126.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 19:31:58 INFO - PROCESS | 31396 | Values: 159.0 159.0 160.0 161.0 159.0 160.0 161.0 160.0 160.0 160.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:15.92 (21.2%) stddev-sans-first:16.67 19:31:58 INFO - PROCESS | 31396 | Values: 75.0 76.0 75.0 120.0 75.0 76.0 73.0 75.0 103.0 75.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:18.02 (21.2%) stddev-sans-first:18.59 19:31:58 INFO - PROCESS | 31396 | Values: 84.0 86.0 116.0 85.0 85.0 85.0 121.0 85.0 84.0 128.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:31:58 INFO - PROCESS | 31396 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:31:58 INFO - PROCESS | 31396 | Values: 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:31:58 INFO - PROCESS | 31396 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.50 stddev:3.68 (6.8%) stddev-sans-first:1.48 19:31:58 INFO - PROCESS | 31396 | Values: 65.0 53.0 56.0 54.0 54.0 57.0 53.0 53.0 53.0 55.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 19:31:58 INFO - PROCESS | 31396 | Values: 61.0 60.0 60.0 61.0 60.0 61.0 60.0 60.0 61.0 62.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:84.00 stddev:10.34 (12.3%) stddev-sans-first:10.85 19:31:58 INFO - PROCESS | 31396 | Values: 82.0 85.0 86.0 80.0 84.0 80.0 81.0 84.0 115.0 86.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.00 stddev:5.46 (4.3%) stddev-sans-first:2.93 19:31:58 INFO - PROCESS | 31396 | Values: 142.0 125.0 127.0 121.0 128.0 128.0 126.0 128.0 131.0 130.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.00 stddev:2.47 (1.5%) stddev-sans-first:2.62 19:31:58 INFO - PROCESS | 31396 | Values: 162.0 162.0 164.0 160.0 161.0 161.0 162.0 162.0 168.0 159.0 19:31:58 INFO - PROCESS | 31396 | 19:31:58 INFO - PROCESS | 31396 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.77 (2.8%) stddev-sans-first:1.41 19:31:58 INFO - PROCESS | 31396 | Values: 67.0 65.0 65.0 63.0 65.0 63.0 63.0 63.0 62.0 61.0 19:31:58 INFO - PROCESS | 31396 | -------- Summary: end -------- 19:31:58 INFO - PROCESS | 31396 | 19:31:59 INFO - TEST-INFO | 31396: exit 0 19:31:59 INFO - TEST-OK | kraken | took 63621ms 19:31:59 INFO - SUITE-END | took 1180s 19:31:59 INFO - Completed test suite (00:19:40) 19:31:59 INFO - javascript benchmark 19:31:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3158.0, 3161.7944833585802, 3187.0438868339493, 3201.871925122995, 3221.0658908916416, 5269.920951185735, 5358.4641535846395, 5444.156155795853, 5538.9169162462595, 5555.111182210847, 5414.052540805363, 5418.83743487696, 5424.240606315119, 5427.918581221275, 5429.647072940256, 4856.368672072635, 4961.751912404366, 4963.826266080688, 4976.4774698656665, 5100.846974590768, 4997.250412438127, 5028.7988480460735, 5052.494750524955, 5057.544820966113, 5069.74651267437, 4750.287456881478, 4762.738049407281, 4892.3884514435695, 4952.059108769322, 4971.0803501352, 4892.241702536077, 4897.583705385046, 4910.558049775502, 4974.452810190876, 4995.825146119869, 4904.386951631046, 4937.185364414903, 4938.283948827436, 4953.925691114636, 4993.275974983607, 5266.578673706094, 5314.92027619586, 5350.438203988564, 5414.864628384283, 5442.619016668835, 5820.767169313222, 5867.823965281048, 5871.911921321183, 5874.73563689635, 5876.559258055663, 5871.001929671923, 5910.645361278294, 5914.8817023659285, 5925.081612350093, 5928.377520360344, 5289.418164001957, 5428.728563571845, 5461.153521204259, 5464.836054918359, 5529.4470552944385, 6017.428344307284, 6029.537288842169, 6039.254161030247, 6043.481283581734, 6094.908576371358, 5823.650580965071, 5826.796062137805, 5829.213056237354, 5830.2129212555765, 5830.650160990354, 5667.8866422672145, 5801.796937107181, 5846.503047240947, 5854.2096816930025, 5893.6463812171405, 5834.708264586754, 5852.0, 5853.0, 5858.648481091148, 5874.647521148745, 5679.630823996427, 5833.329167145747, 5857.355690874, 5875.823725288248, 5876.471117599436, 4357.433533640607, 4358.150160718629, 4360.302351623725, 4378.912421751547, 4385.3641222022625, 3907.5115610548683, 3915.197384536163, 3919.8236079376497, 3945.585713500041, 3954.2486927483687, 5371.57027437804, 5426.186072089218, 5463.72681365938, 5506.614536982453, 5518.420565840609, 5815.534757219412, 5854.912176317359, 5857.326407463111, 5907.645541267538, 5923.437273459014, 5545.528630066489, 5563.388027316992, 5566.805161819398, 5572.331320241597, 5572.359178694502, 4939.135651261086, 4998.4251811042195, 5055.241713742895, 5061.949380506221, 5106.565941894906, 6061.121137435047, 6141.731496609813, 6144.709610981744, 6144.9553575892205, 6145.016797312409, 5920.319163296276, 5920.940790592039, 5924.6445213285615, 5924.822255332347, 5965.552583556164, 5902.38025007368, 5979.820605381846, 6017.368176341596, 6126.019836826086, 6140.785072522441, 5753.942460575341, 5755.971220143872, 5767.625104368202, 5768.884622307614, 5808.82573522795, 5813.360530341574, 5861.736221869941, 5863.706814659165, 5865.296164460292, 5867.266591676041, 5601.29983752031, 5688.3742788294085, 5717.17101020358, 5733.627314224729, 5763.625364351304, 5766.279215098113, 5766.740496677576, 5767.884642307046, 5771.509421699203, 5772.1341798728845, 5678.4605462480995, 5687.43125687428, 5687.77248910039, 5688.0330343840815, 5691.573132015033, 5632.0, 5715.714214289185, 5742.684152371493, 5754.712264386848, 5862.794802181903, 5656.406077361818, 5669.489745922887, 5669.971650141888, 5671.347795003462, 5707.372189059117], "value": 5387.609075964344, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.7847974729096, 612.2255346986062, 640.3372509452715, 641.4771960851908, 651.7458191305394, 31323.0, 31917.840410797944, 34961.475577866324, 43071.138577228434, 44277.55722442774, 43428.34857477133, 43704.781476092656, 43982.78008609961, 44009.7799511002, 44021.55978440223, 8524.872126918086, 8785.64857405703, 8788.428752131123, 8789.165029322236, 8793.296536277114, 8601.569921503931, 8757.7810554736, 8787.209151176392, 8793.384463087586, 8797.648094076229, 8834.646614135427, 8846.336524760636, 8863.290936725047, 8864.335174861879, 8877.0, 8765.912340876605, 8811.77970550735, 8815.735527934108, 8816.338774591866, 8816.735497935073, 8626.266767324785, 8721.912780872173, 8735.519546424945, 8747.737567872973, 8747.868781968276, 40393.192136157406, 40656.18687626231, 40798.79600602008, 40901.59098409038, 40914.18171636551, 3422.178677117499, 3544.0608238816735, 3565.3938830398633, 3582.874599389009, 3927.7643341399607, 31125.533117003262, 31507.21231969196, 31806.522902156485, 31991.200219994455, 33107.172320691934, 4044.50856375516, 4067.5174152063114, 4088.5298190708154, 4096.262672718909, 4277.358396240589, 204935.0, 204938.0, 205654.0, 205777.0, 205890.9705451478, 56634.0, 56648.0, 56912.71543642255, 57121.714391428606, 57208.42791572114, 55887.72056139775, 59768.70115649394, 60800.391996080354, 60815.0, 67092.0, 16613.91693041551, 16732.749008764637, 16762.99422034682, 16771.91614041922, 16779.496615101565, 11633.185677002697, 11807.173497855068, 12652.936735316449, 12683.809742853864, 12699.174553653984, 17106.315747369965, 17308.576799248116, 17454.825451745575, 18123.72814407785, 18144.637107257782, 6387.137736405619, 6686.09737685416, 6722.697478613474, 6727.461803055744, 6831.351021652935, 993.2500961773959, 1129.3336931210624, 1134.6425875849081, 1145.8674365308477, 1158.5771193514474, 31927.0, 32414.67585324164, 32714.34571308608, 32750.508742368882, 33297.50053749196, 1092.082650573522, 1097.434821067151, 1103.7957977774138, 1116.8268918317674, 1214.9514019439123, 17227.913860430617, 17386.65226695459, 17399.0, 17455.65088698219, 17514.29942802299, 516058.0, 516490.0, 518524.0, 520154.0, 521962.0, 59397.0, 59484.40515594875, 59519.70240148772, 59566.0, 59573.0, 1263.7030297879992, 1357.4434481862388, 1359.789232668938, 1373.6565858535366, 1394.2571785268415, 32340.514892277104, 33286.0, 33440.832795835864, 33816.13096426472, 34059.14852128716, 45642.54357456383, 45921.31118033299, 46161.53838461573, 46187.76906115448, 46301.305480418494, 411495.0, 413344.0, 414710.0, 414758.0, 416533.0, 33843.66156338405, 35273.47089793604, 43213.13573728571, 45957.31064034109, 46872.29691554698, 48865.755671221414, 49322.260166098255, 49445.752771235915, 49891.0, 50369.49630503648, 39239.12717531489, 40419.1916161681, 41471.7926410366, 42281.78859105685, 42531.0, 40748.0, 40806.90205465765, 41263.587364125975, 41354.37968430416, 42338.788306058275, 41291.0, 41479.170416592104, 41863.37204941867, 41925.0, 43736.56263437325, 39229.215415692095, 40727.0, 42581.0, 43811.780941095094, 44321.55678443174, 32835.0, 34025.0, 34044.489332659534, 34087.147821304665, 34407.65592344045], "value": 20005.200794930515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.2850782844793, 407.23643169058, 410.7904968466085, 416.7582801974855, 421.759597029693, 13805.930970345134, 19076.713849292253, 19495.512612184666, 19887.602247955034, 19909.60180796383, 13922.860771392283, 18465.0, 18474.076296185205, 18546.721799173025, 19361.806381936178, 5673.26247587813, 5825.621334613258, 5850.707464626773, 5865.296164460249, 5901.704914754267, 5727.885442291152, 5773.48038676519, 5818.0981947797945, 5818.912716309259, 5826.300843898738, 4148.087420767426, 6124.510039196876, 6395.072714456401, 6432.388923052303, 6570.770023049195, 6455.0, 6504.0569117477935, 6518.120053792748, 6540.803775886731, 6545.738170473175, 5649.830505084854, 5755.740991655385, 5769.105788602773, 5786.68173250471, 5794.246747922785, 23058.65412018821, 23200.65199022016, 23967.28098157058, 24182.879085604636, 24217.152399665927, 2166.263470420049, 2309.480366917447, 2353.423411264234, 2382.5949588569983, 2464.088287333698, 10009.59961601535, 10261.846072308921, 10376.740581485448, 10681.893181068168, 13352.198868067948, 1795.3895675470403, 1918.396422423179, 1934.41000494849, 1973.5362189885366, 2022.6763717805227, 80759.0, 80824.95875206216, 81126.0, 83003.5849820753, 83004.58497707473, 11404.771904561861, 11462.942685286687, 11761.941190294165, 11773.764524709457, 12310.734996695386, 16036.67926641484, 16168.595785105466, 16224.67550649004, 16250.75623865643, 16273.918630407008, 8284.875726864102, 8339.624716887754, 8436.578171091543, 8559.186877246651, 8591.140885911358, 8127.431079824474, 8174.3460523158, 8269.467120974483, 8455.32357411418, 8460.153984601491, 4355.542668019875, 4616.976915115471, 4764.094821983812, 4874.293227481995, 4922.680025798311, 1889.7165425186058, 2030.9743579492263, 2038.8674736142104, 2053.620080285152, 2079.719237902894, 912.981740365189, 984.532347135105, 1045.3466583385384, 1078.2344535379968, 1116.547798141754, 18926.62146757057, 19621.901890490743, 19703.704444433344, 19803.702944455843, 19855.0, 958.2190514730472, 982.8378317577519, 1036.1451802263164, 1059.6979860739652, 1112.57165991094, 10741.40922249268, 11168.497417616065, 11196.832047519294, 11218.775624487627, 11219.1585631078, 458918.0, 459623.0, 469278.1650550947, 473640.0, 475134.0, 92586.68533286722, 94856.0, 94949.52525237329, 97391.51304243434, 104348.52166261706, 493.29705170132416, 502.22406382139684, 508.280782692486, 509.3683832048234, 511.3148381169251, 10854.782904342026, 11364.204505684524, 11449.59926402572, 11555.480003400035, 11940.104492163297, 43028.78485607552, 43326.56673433226, 44202.0, 44248.0, 44760.552394475635, 61032.0, 61215.69392153011, 61371.38628613835, 62344.68827655833, 62362.376376235654, 8426.283765879969, 8780.604872780612, 8794.29645628361, 8956.79083323743, 8989.05614910425, 9624.0, 10784.892151078702, 12697.365131743562, 13405.798913016508, 13869.791953120914, 11876.168668193144, 12172.75654486923, 12216.38918054076, 12437.191582547106, 12718.236905785683, 12077.57728479499, 12156.452959617016, 12250.14249002597, 12456.065795065226, 12654.177478463871, 12197.75604487923, 12349.444275007467, 12358.814617780561, 12384.256944583354, 12464.626061218178, 8998.955005224932, 9069.77325566866, 9132.771680708036, 9174.53207486799, 9403.106704863027, 11198.10415166801, 11958.940205299266, 12133.696657583278, 12212.816807747713, 12223.20549164337], "value": 9165.141375921909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.763791336517, 1501.1968596800707, 1553.3243039277916, 1706.2748331958921, 1864.8414884734805, 8553.230209281164, 8858.512781797006, 8904.332175086862, 9123.042080581543, 9214.493202873839, 8822.77943051424, 9038.954805225982, 9048.321375896801, 9051.094890510945, 9055.592498337573, 2085.384811480617, 2335.94160145996, 2366.041753089997, 2398.2805158452484, 2403.3150552092657, 2379.8096152307776, 2380.833341666084, 2383.3207535852284, 2389.8924548395275, 2392.820538459614, 2329.569029729497, 2381.8094552435764, 2384.201292566992, 2386.3556839653284, 2386.451116243265, 2055.7738648748627, 2276.5902137615303, 2331.4870728439714, 2333.3933177373833, 2368.0409434179187, 2332.603457412244, 2339.7309309429465, 2340.754220806808, 2359.398353419867, 2402.5555272274687, 8968.775780605472, 9024.413413128192, 9027.909720902773, 9036.277097832157, 9064.410813297114, 5244.108501554745, 5399.9730001350135, 5405.18922161675, 5407.891842163174, 5414.810481633124, 3196.9200769980703, 3276.0, 3360.395128876801, 3410.2667926395698, 3434.9141271468166, 1037.5370727274508, 1042.3381152967845, 1086.4459125845797, 1103.8564986551778, 1114.0363585498567, 12595.0, 12640.178388404724, 12641.93679031599, 12684.112112152154, 12693.301868397235, 4532.410786597721, 4669.066186762661, 4673.322368256584, 4747.8100875965265, 4834.734089625034, 10676.89323106759, 10678.09236214915, 10680.092192163598, 10689.412082335391, 10693.198010149114, 4735.763211839394, 5311.044012077863, 5321.042212401728, 5322.893542129135, 5326.094563924142, 4730.739809310452, 4871.391076115486, 4877.975610121926, 4911.7298548580175, 4915.0415668944215, 4068.4100805383055, 4109.650679692199, 4114.6091121343425, 4197.76912269822, 4294.463192100988, 1283.4866053578457, 1296.695276609996, 1298.805179223124, 1311.0363882546321, 1314.2968511846116, 821.2977903892206, 897.4749771383683, 916.0701887584107, 921.5300196899495, 931.3527098666361, 5766.971165144148, 5792.304923409133, 5810.41895810424, 5929.169916211734, 6014.127951447016, 439.6131404364203, 446.62260389970425, 448.8092560661706, 998.4159266828987, 1027.106417416852, 3745.3632882410056, 3747.1756213633503, 3835.558910725302, 3861.2084522673345, 3887.8833634990997, 11166.106711463064, 11333.093352531778, 11424.771504570028, 11438.94280528592, 11439.142064345207, 10972.286801357886, 11216.943915280372, 11360.488778004845, 11364.715882103013, 11418.885811141949, 8399.11809260031, 8442.57787110642, 8443.95778021106, 8531.872021919677, 8563.57182140878, 5509.449055094618, 5568.721563921868, 5579.414161512983, 5626.549876009991, 5766.538676905921, 10213.62116114315, 10357.482125893826, 10557.260991730813, 10585.206109541969, 10609.469526523488, 10546.841797372892, 10646.84029739539, 10649.733756656145, 10669.733256668645, 10685.679429617125, 6315.494760419064, 6734.528582999143, 6813.625250611264, 6847.349501797321, 6913.032175495535, 8885.822283554422, 8899.466032038099, 8980.550972451481, 8993.865092023494, 9004.774880628036, 7738.535687858746, 8026.598670066356, 8026.678932842621, 8032.959835200787, 8124.268815806606, 7756.534607923542, 7875.291223789886, 7890.723824666109, 7948.364130869632, 8011.078725946358, 6550.541462097607, 6680.83297917556, 6693.0, 6776.28848970851, 6777.559458635173, 4724.881877953078, 4759.857204283877, 4784.114938736345, 4824.517548245148, 4881.731504767272, 4973.726445045412, 5047.343845300087, 5060.1903695408555, 5111.46329635383, 5204.843854684365], "value": 4608.630051785909, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.28082263544695, 338.9068006298268, 342.7378055787323, 344.42652982783665, 348.39031694534566, 5211.921821172686, 5216.191490319002, 5274.472552744728, 5295.338082739658, 5323.095073837448, 5172.6379153459275, 5192.5067118623765, 5228.241904923784, 5236.764345604447, 5236.947630523694, 4058.0463591056077, 4132.338825787874, 4138.3378659414575, 4165.250254954107, 4198.0, 4115.609017143366, 4166.520850102247, 4171.124063946575, 4175.227582897159, 4185.665146788265, 4132.648724858391, 4144.316187829005, 4144.44050053242, 4153.1070819773895, 4193.888619515816, 3963.9801800990954, 3977.125032492847, 4096.1193343431005, 4103.692223083251, 4111.794410279504, 3625.329314076904, 3644.6173151818944, 3650.7079433645245, 3651.214988777399, 3658.981705091484, 4835.371401717789, 5067.39191297043, 5073.594112471031, 5079.466656001141, 5089.549478398676, 4504.977475112603, 4686.367340409035, 4691.997121842024, 4697.78859951303, 4697.812087516495, 5364.758585863646, 5385.0037743017665, 5426.8371948841595, 5442.6462279951675, 5494.890102197934, 3921.0981474260793, 3930.5849894038124, 3990.201959608061, 4004.5594984551676, 4013.6588389986887, 5624.878192603103, 5629.6340737852315, 5656.115381155599, 5660.716964151776, 5666.46168613981, 4070.2876996526084, 4077.5728495027097, 4082.81627326771, 4089.427480152781, 4094.2220978014084, 4106.691998100155, 4115.156392939441, 4135.834566617302, 4136.255474014706, 4145.0880806222585, 4400.669949753781, 4590.311453282035, 4628.4445866496235, 4674.504158669193, 4701.64737644678, 5489.780408783684, 5510.760078982197, 5552.861178470571, 5566.721663916788, 5573.0, 1401.439424230316, 1406.4374250299961, 1407.1486750515994, 1417.794874356809, 1419.9421431033945, 917.3991035871514, 959.1463597398321, 963.0995019656643, 976.2531663277598, 977.8973207813219, 5225.869353266199, 5244.501772331622, 5255.766299322772, 5276.182191760283, 5288.444713305047, 5424.321959755031, 5564.8330550083565, 5574.327701689477, 5589.329280486287, 5595.944040559623, 5111.900941297639, 5253.632245742838, 5270.49930256625, 5281.471852814688, 5323.973380133075, 2933.765298776093, 2946.1897978056204, 2958.467475854367, 2961.6890226526334, 2981.5825784390204, 5778.739956701875, 5818.854528636818, 5823.79616713413, 5827.184194212814, 5827.35899051104, 5582.54853738031, 5672.631278966936, 5707.372189059283, 5714.485696287271, 5741.88516229673, 5758.971205143947, 5765.711714414262, 5795.478406943395, 5821.155932389865, 5844.26946631671, 5301.5493683037375, 5563.7496312666835, 5591.412901645269, 5597.468240517144, 5600.971995139998, 5482.972585137049, 5483.232347471437, 5535.972320138535, 5538.196961440649, 5539.418361072029, 5756.704741433312, 5761.48146666802, 5796.391378905154, 5802.680852552981, 5843.065109582446, 3903.6096390360735, 3960.7821569813937, 3965.6827453804203, 3973.980130099447, 4005.799710014546, 5531.419200983839, 5584.329880414376, 5594.552435805207, 5608.831735047955, 5622.606417550732, 5440.129579267298, 5480.945190548044, 5517.144842549411, 5540.778368865362, 5543.861403464784, 5249.737513124405, 5444.183372494158, 5455.618106732491, 5462.371827239759, 5467.20725494809, 5315.3090098286975, 5335.1060373566825, 5338.145896656516, 5354.286628278914, 5365.248865158959, 5317.760700768397, 5374.964710077681, 5387.622866399314, 5479.452054794648, 5515.393306736176, 5349.438308977501, 5358.973205134105, 5360.544353729821, 5362.785488580413, 5387.973060134675], "value": 4193.303671622603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.9162604674416, 672.7779832655224, 746.6080307838384, 776.5767656627138, 806.4234072638062, 14555.490557830479, 14842.851571484282, 15007.39970401184, 15195.772063419057, 15227.238638068107, 13918.791218131712, 14088.36602352894, 14109.223992680398, 14139.434422623082, 14140.71718565628, 687.3435868745336, 795.0181525815613, 816.5957850863831, 835.578033093287, 837.4054421360842, 835.9122292159327, 840.6763396092488, 840.9285210757063, 841.2302742990157, 841.88634534338, 872.1235158665532, 873.0, 874.204473928725, 875.2778957360172, 876.2332958661171, 710.406810313389, 842.0442797424905, 859.9484030958131, 865.5326123893121, 872.1235158665564, 636.8821767972939, 638.2022471910112, 638.9233292004943, 638.9265234498046, 639.338284875152, 14999.1750453725, 15019.399224031025, 15027.699446011127, 15038.924805375904, 15041.172735499544, 13046.282454465001, 13392.06255562111, 13429.932850335686, 13513.86486135136, 13523.120997135155, 12548.874511254953, 12636.2418254905, 12749.10756247063, 12947.935260323638, 12974.545890893867, 4401.9119617607785, 4433.290673492258, 4489.955100448987, 4507.481639611454, 4510.368548403226, 71993.28006719919, 73297.63351183264, 73603.0, 73733.63133184353, 73758.26241737568, 10796.406197659204, 10933.0, 10969.122470202365, 10979.1765617579, 11123.777524449628, 20801.791982079987, 20819.959002049836, 20829.479263018547, 20831.479213019797, 20840.0, 7736.7678969631, 7893.329067029252, 7899.5260284381975, 8113.229243221885, 8276.965379327585, 4655.301704744248, 4658.3711198988385, 4715.95284047162, 4722.480527142012, 4761.309610106515, 3258.4297747894025, 3355.597328320617, 3363.983180084084, 3373.1061268763797, 3374.4263475209273, 549.72239019295, 550.8430097422215, 554.2226011778495, 559.3204256827973, 575.7495489462013, 546.160491743047, 560.7112337146373, 565.7397597105295, 586.8567910551435, 602.9035354343284, 7459.291367320096, 7553.773386798405, 7662.885056724153, 7699.576523291161, 7985.800354991172, 476.9332293478916, 530.2549917366107, 545.3319683387818, 581.8574449259959, 618.7617767159676, 3915.960840391617, 3929.587393323717, 3981.144054028398, 4015.9799201003807, 4066.3087275163293, 109216.0, 110963.44518277358, 111169.44415278034, 112142.0, 113955.0, 93587.53206233925, 97421.0, 98198.0, 98621.50689246651, 99825.0174982496, 84535.577322113, 85229.0, 85349.14650853536, 85810.14189858147, 86473.56763216143, 7754.302112809874, 7951.721689740832, 7961.363090952826, 8175.223353781381, 8218.383621228551, 48823.755881220364, 48906.75546622244, 48963.75518122529, 49330.30022748237, 52219.47780522146, 51449.48550514597, 69684.65157674179, 77035.2296477028, 78108.0, 79348.20651793409, 9927.40435573868, 10030.64892728751, 10040.799184016132, 10049.899501004897, 10393.792124157626, 11804.645860624196, 11947.0, 12010.699732506757, 12190.817137742764, 12576.937115314366, 10615.575376984834, 10684.25210235276, 10704.197185210984, 11233.941734815447, 11572.421378931189, 10748.742764019644, 10908.290961087503, 11061.5022323994, 11205.495752691311, 11258.324500529994, 10765.730856728644, 10776.622818201326, 11109.388983605979, 11213.831792522955, 11432.428378581204, 9520.333576649567, 9611.951940240255, 9748.499429535083, 9931.801363972825, 9984.900150998688, 8175.836483270183, 8289.875651865106, 8900.821983560421, 9179.238174133074, 9377.1091746284], "value": 6972.975350068955, "unit": "score"}], "name": "dromaeo_css", "value": 7145.702447318985, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 111.0, 111.0, 112.0, 111.0, 112.0, 110.0, 111.0, 110.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 132.0, 152.0, 127.0, 153.0, 155.0, 126.0, 185.0, 126.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 161.0, 159.0, 160.0, 161.0, 160.0, 160.0, 160.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 120.0, 75.0, 76.0, 73.0, 75.0, 103.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 116.0, 85.0, 85.0, 85.0, 121.0, 85.0, 84.0, 128.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 53.0, 56.0, 54.0, 54.0, 57.0, 53.0, 53.0, 53.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 60.0, 61.0, 60.0, 60.0, 61.0, 62.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 86.0, 80.0, 84.0, 80.0, 81.0, 84.0, 115.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 125.0, 127.0, 121.0, 128.0, 128.0, 126.0, 128.0, 131.0, 130.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 160.0, 161.0, 161.0, 162.0, 162.0, 168.0, 159.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 63.0, 65.0, 63.0, 63.0, 63.0, 62.0, 61.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1506.9999999999998, "alertThreshold": 2.0}]} 19:31:59 INFO - Return code: 0 19:31:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:31:59 ERROR - # TBPL SUCCESS # 19:31:59 INFO - Running post-action listener: _resource_record_post_action 19:31:59 INFO - ##### 19:31:59 INFO - ##### Finished run-tests step (success) 19:31:59 INFO - ##### 19:31:59 INFO - Running post-run listener: _resource_record_post_run 19:31:59 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390082560; Read time: 16; Write time: 482120 19:31:59 INFO - TinderboxPrint: CPU usage
13.2% 19:31:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:31:59 INFO - TinderboxPrint: I/O write bytes / time
390,082,560 / 482,120 19:31:59 INFO - TinderboxPrint: CPU idle
8,303.3 (86.8%) 19:31:59 INFO - TinderboxPrint: CPU user
1,205.7 (12.6%) 19:31:59 INFO - TinderboxPrint: Swap in / out
0 / 0 19:31:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99213312; Read time: 0; Write time: 114596 19:31:59 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290869248; Read time: 16; Write time: 367524 19:32:00 INFO - Running post-run listener: _upload_blobber_files 19:32:00 INFO - Blob upload gear active. 19:32:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:32:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:32:00 INFO - (blobuploader) - INFO - Open directory for files ... 19:32:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:32:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:32:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:01 INFO - (blobuploader) - INFO - Done attempting. 19:32:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:32:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:32:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:01 INFO - (blobuploader) - INFO - Done attempting. 19:32:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:32:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:05 INFO - (blobuploader) - INFO - Done attempting. 19:32:05 INFO - (blobuploader) - INFO - Iteration through files over. 19:32:05 INFO - Return code: 0 19:32:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:32:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:32:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b9db5d40bd2dbccf71d3ee8d613a40a7abc070487844956568735838f43afe2b0c0ba7aa7ab67cbba434ed6f6af923aef0aa80bc5b2a435a4abce66cce8244d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4cb20e48bce9c0dce143e9440542617ba931e2cead194fb0017e6a6e537957327ab25f9141b4f1d20aa112c473b796c3af45461cbef9c7a4294ba0937a43d3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a2136e8dbc67f38ad5475e6eb18541cfedc29258a14ae7b80f4cd8fc97cbdc31b0f6a3de14aec4b1625949c4a35707fc897cca1db4537858e0d2e8979396b73"} 19:32:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:32:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:32:05 INFO - Contents: 19:32:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b9db5d40bd2dbccf71d3ee8d613a40a7abc070487844956568735838f43afe2b0c0ba7aa7ab67cbba434ed6f6af923aef0aa80bc5b2a435a4abce66cce8244d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4cb20e48bce9c0dce143e9440542617ba931e2cead194fb0017e6a6e537957327ab25f9141b4f1d20aa112c473b796c3af45461cbef9c7a4294ba0937a43d3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a2136e8dbc67f38ad5475e6eb18541cfedc29258a14ae7b80f4cd8fc97cbdc31b0f6a3de14aec4b1625949c4a35707fc897cca1db4537858e0d2e8979396b73"} 19:32:05 INFO - Running post-run listener: copy_logs_to_upload_dir 19:32:05 INFO - Copying logs to upload dir... 19:32:05 INFO - mkdir: /builds/slave/test/build/upload/logs 19:32:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.604417 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-06-05 19:32:05.500051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 19:32:05.503051) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b9db5d40bd2dbccf71d3ee8d613a40a7abc070487844956568735838f43afe2b0c0ba7aa7ab67cbba434ed6f6af923aef0aa80bc5b2a435a4abce66cce8244d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4cb20e48bce9c0dce143e9440542617ba931e2cead194fb0017e6a6e537957327ab25f9141b4f1d20aa112c473b796c3af45461cbef9c7a4294ba0937a43d3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a2136e8dbc67f38ad5475e6eb18541cfedc29258a14ae7b80f4cd8fc97cbdc31b0f6a3de14aec4b1625949c4a35707fc897cca1db4537858e0d2e8979396b73"} build_url:https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/WYW6B_w2T2aNyGUZQXFGaw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b9db5d40bd2dbccf71d3ee8d613a40a7abc070487844956568735838f43afe2b0c0ba7aa7ab67cbba434ed6f6af923aef0aa80bc5b2a435a4abce66cce8244d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4cb20e48bce9c0dce143e9440542617ba931e2cead194fb0017e6a6e537957327ab25f9141b4f1d20aa112c473b796c3af45461cbef9c7a4294ba0937a43d3b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8a2136e8dbc67f38ad5475e6eb18541cfedc29258a14ae7b80f4cd8fc97cbdc31b0f6a3de14aec4b1625949c4a35707fc897cca1db4537858e0d2e8979396b73"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 19:32:05.527618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:32:05.527928) ========= 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=5cf47e208febbcd81da23b2e0000026f-1465173148.272518-327730127 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 19:32:05.611114) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 19:32:05.611395) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 19:32:05.611650) ========= ========= Total master_lag: 0.16 =========