builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1469618595.09 results: success (0) buildid: 20160726081123 builduid: d55b11d35c3148cb8ff39a91e15f3ac4 revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:15.090487) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:15.090947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:15.091226) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:15.163014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:15.163277) ========= 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-1469618586.344137-1753398946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 04:23:15-- 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% 232M=0s 2016-07-27 04:23:15 (232 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:15.327607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:15.327883) ========= 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-1469618586.344137-1753398946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020211 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:15.380305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 04:23:15.381127) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ebd239b4cbfb8eff833560f72b163275ac4026d3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ebd239b4cbfb8eff833560f72b163275ac4026d3 --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-1469618586.344137-1753398946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 04:23:15,966 truncating revision to first 12 chars 2016-07-27 04:23:15,966 Setting DEBUG logging. 2016-07-27 04:23:15,966 attempt 1/10 2016-07-27 04:23:15,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ebd239b4cbfb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 04:23:17,301 unpacking tar archive at: mozilla-aurora-ebd239b4cbfb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.679582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 04:23:17.076344) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:17.076724) ========= script_repo_revision: ebd239b4cbfb8eff833560f72b163275ac4026d3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:17.077193) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:17.077508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:23:17.088411) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-27 04:23:17.088851) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:17 INFO - MultiFileLogger online at 20160727 04:23:17 in /builds/slave/test 04:23:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:23:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:17 INFO - {'append_to_log': False, 04:23:17 INFO - 'base_work_dir': '/builds/slave/test', 04:23:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:23:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:17 INFO - 'branch': 'Mozilla-Aurora', 04:23:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:17 INFO - 'config_files': ('talos/linux_config.py',), 04:23:17 INFO - 'default_actions': ('clobber', 04:23:17 INFO - 'read-buildbot-config', 04:23:17 INFO - 'download-and-extract', 04:23:17 INFO - 'populate-webroot', 04:23:17 INFO - 'create-virtualenv', 04:23:17 INFO - 'install', 04:23:17 INFO - 'run-tests'), 04:23:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:17 INFO - 'download_minidump_stackwalk': True, 04:23:17 INFO - 'download_symbols': 'ondemand', 04:23:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:17 INFO - 'installer_path': 'installer.exe', 04:23:17 INFO - 'log_level': 'info', 04:23:17 INFO - 'log_name': 'talos', 04:23:17 INFO - 'log_to_console': True, 04:23:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:17 INFO - 'opt_config_files': (), 04:23:17 INFO - 'pip_index': False, 04:23:17 INFO - 'sps_profile': False, 04:23:17 INFO - 'sps_profile_interval': 0, 04:23:17 INFO - 'suite': 'dromaeojs-e10s', 04:23:17 INFO - 'system_bits': '32', 04:23:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:17 INFO - 'title': 'talos-linux64-ix-011', 04:23:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:17 INFO - 'use_talos_json': True, 04:23:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:17 INFO - 'work_dir': 'build'} 04:23:17 INFO - ##### 04:23:17 INFO - ##### Running clobber step. 04:23:17 INFO - ##### 04:23:17 INFO - Running pre-action listener: _resource_record_pre_action 04:23:17 INFO - Running main action method: clobber 04:23:17 INFO - rmtree: /builds/slave/test/build 04:23:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:18 INFO - Running post-action listener: _resource_record_post_action 04:23:18 INFO - ##### 04:23:18 INFO - ##### Finished clobber step (success) 04:23:18 INFO - ##### 04:23:18 INFO - ##### 04:23:18 INFO - ##### Running read-buildbot-config step. 04:23:18 INFO - ##### 04:23:18 INFO - Running pre-action listener: _resource_record_pre_action 04:23:18 INFO - Running main action method: read_buildbot_config 04:23:18 INFO - Using buildbot properties: 04:23:18 INFO - { 04:23:18 INFO - "project": "", 04:23:18 INFO - "product": "firefox", 04:23:18 INFO - "script_repo_revision": "production", 04:23:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:23:18 INFO - "repository": "", 04:23:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:23:18 INFO - "buildid": "20160726081123", 04:23:18 INFO - "pgo_build": "True", 04:23:18 INFO - "basedir": "/builds/slave/test", 04:23:18 INFO - "buildnumber": 409, 04:23:18 INFO - "slavename": "talos-linux64-ix-011", 04:23:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:23:18 INFO - "platform": "ubuntu64_hw", 04:23:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:23:18 INFO - "branch": "mozilla-aurora", 04:23:18 INFO - "repo_path": "releases/mozilla-aurora", 04:23:18 INFO - "revision": "ebd239b4cbfb8eff833560f72b163275ac4026d3", 04:23:18 INFO - "stage_platform": "linux64-pgo", 04:23:18 INFO - "builduid": "d55b11d35c3148cb8ff39a91e15f3ac4", 04:23:18 INFO - "slavebuilddir": "test" 04:23:18 INFO - } 04:23:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:23:18 INFO - Running post-action listener: _resource_record_post_action 04:23:18 INFO - ##### 04:23:18 INFO - ##### Finished read-buildbot-config step (success) 04:23:18 INFO - ##### 04:23:18 INFO - ##### 04:23:18 INFO - ##### Running download-and-extract step. 04:23:18 INFO - ##### 04:23:18 INFO - Running pre-action listener: _resource_record_pre_action 04:23:18 INFO - Running main action method: download_and_extract 04:23:18 INFO - mkdir: /builds/slave/test/build/tests 04:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:18 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:23:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:23:18 INFO - Downloaded 1361 bytes. 04:23:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:23:18 INFO - Using the following test package requirements: 04:23:18 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:23:18 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:18 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:23:18 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:18 INFO - u'jsshell-linux-x86_64.zip'], 04:23:18 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:18 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:23:18 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:23:18 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:23:18 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:18 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:23:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:18 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:18 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:19 INFO - Downloaded 24494733 bytes. 04:23:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:23:21 INFO - Return code: 0 04:23:21 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:21 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:23:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:22 INFO - Downloaded 24494733 bytes. 04:23:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:23:23 INFO - Return code: 0 04:23:23 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')]} 04:23:23 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:23:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:23:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:23:24 INFO - Downloaded 10833369 bytes. 04:23:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:23:24 INFO - Return code: 0 04:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:24 INFO - https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:23:26 INFO - Downloaded 63637001 bytes. 04:23:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:26 INFO - mkdir: /builds/slave/test/properties 04:23:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:26 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:26 INFO - Contents: 04:23:26 INFO - build_url:https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:23:26 INFO - Running post-action listener: _resource_record_post_action 04:23:26 INFO - Running post-action listener: set_extra_try_arguments 04:23:26 INFO - ##### 04:23:26 INFO - ##### Finished download-and-extract step (success) 04:23:26 INFO - ##### 04:23:26 INFO - ##### 04:23:26 INFO - ##### Running populate-webroot step. 04:23:26 INFO - ##### 04:23:26 INFO - Running pre-action listener: _resource_record_pre_action 04:23:26 INFO - Running main action method: populate_webroot 04:23:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:26 INFO - '--tppagecycles', 04:23:26 INFO - '7'], 04:23:26 INFO - 'tests': ['tsvgm']}}, 04:23:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:26 INFO - 'talos_options': ['--disable-e10s'], 04:23:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:26 INFO - 'talos_options': ['--disable-e10s'], 04:23:26 INFO - 'tests': ['damp', 'tps']}, 04:23:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:26 INFO - 'tests': ['damp', 'tps']}, 04:23:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:26 INFO - 'tests': ['dromaeo_dom']}, 04:23:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:26 INFO - 'tests': ['a11yr', 04:23:26 INFO - 'ts_paint', 04:23:26 INFO - 'tpaint', 04:23:26 INFO - 'sessionrestore', 04:23:26 INFO - 'sessionrestore_no_auto_restore', 04:23:26 INFO - 'tabpaint']}, 04:23:26 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:26 INFO - 'ts_paint', 04:23:26 INFO - 'tpaint', 04:23:26 INFO - 'sessionrestore', 04:23:26 INFO - 'sessionrestore_no_auto_restore', 04:23:26 INFO - 'tabpaint']}, 04:23:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:26 INFO - 'ts_paint', 04:23:26 INFO - 'tpaint', 04:23:26 INFO - 'sessionrestore', 04:23:26 INFO - 'sessionrestore_no_auto_restore', 04:23:26 INFO - 'tabpaint']}, 04:23:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:26 INFO - 'ts_paint', 04:23:26 INFO - 'tpaint', 04:23:26 INFO - 'sessionrestore', 04:23:26 INFO - 'sessionrestore_no_auto_restore', 04:23:26 INFO - 'tabpaint']}, 04:23:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:26 INFO - 'tests': ['a11yr', 04:23:26 INFO - 'ts_paint', 04:23:26 INFO - 'tpaint', 04:23:26 INFO - 'sessionrestore', 04:23:26 INFO - 'sessionrestore_no_auto_restore', 04:23:26 INFO - 'tabpaint']}, 04:23:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:26 INFO - 'tests': ['a11yr', 04:23:26 INFO - 'ts_paint', 04:23:26 INFO - 'tpaint', 04:23:26 INFO - 'sessionrestore', 04:23:26 INFO - 'sessionrestore_no_auto_restore', 04:23:26 INFO - 'tabpaint']}, 04:23:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:26 INFO - 'tests': ['tsvgx', 04:23:26 INFO - 'tsvgr_opacity', 04:23:26 INFO - 'tart', 04:23:26 INFO - 'tscrollx', 04:23:26 INFO - 'cart']}, 04:23:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:26 INFO - 'tsvgr_opacity', 04:23:26 INFO - 'tart', 04:23:26 INFO - 'tscrollx', 04:23:26 INFO - 'cart']}, 04:23:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:26 INFO - 'talos_options': ['--disable-e10s'], 04:23:26 INFO - 'tests': ['tp5o']}, 04:23:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:26 INFO - 'tests': ['tp5o']}, 04:23:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:26 INFO - 'talos_options': ['--disable-e10s', 04:23:26 INFO - '--xperf_path', 04:23:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:26 INFO - 'tests': ['tp5n']}, 04:23:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:26 INFO - 'talos_options': ['--xperf_path', 04:23:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:26 INFO - 'tests': ['tp5n']}}, 04:23:26 INFO - 'talos.zip': {'path': '', 04:23:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:26 INFO - Running post-action listener: _resource_record_post_action 04:23:26 INFO - ##### 04:23:26 INFO - ##### Finished populate-webroot step (success) 04:23:26 INFO - ##### 04:23:26 INFO - ##### 04:23:26 INFO - ##### Running create-virtualenv step. 04:23:26 INFO - ##### 04:23:26 INFO - Running pre-action listener: _resource_record_pre_action 04:23:26 INFO - Running main action method: create_virtualenv 04:23:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:26 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 04:23:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:26 INFO - Using real prefix '/usr' 04:23:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:27 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:29 INFO - Installing pip.................done. 04:23:29 INFO - Return code: 0 04:23:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:29 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 0x7f1deb652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, '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-1469618586.344137-1753398946', '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 04:23:29 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 04:23:29 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 04:23:29 INFO - Using env: {'DISPLAY': ':0', 04:23:29 INFO - 'HOME': '/home/cltbld', 04:23:29 INFO - 'LANG': 'en_US.UTF-8', 04:23:29 INFO - 'LANGUAGE': 'en_US:en', 04:23:29 INFO - 'LOGNAME': 'cltbld', 04:23:29 INFO - 'MAIL': '/var/mail/cltbld', 04:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:29 INFO - 'MOZ_NO_REMOTE': '1', 04:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:29 INFO - 'NO_EM_RESTART': '1', 04:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:29 INFO - 'PWD': '/builds/slave/test', 04:23:29 INFO - 'SHELL': '/bin/bash', 04:23:29 INFO - 'SHLVL': '1', 04:23:29 INFO - 'TERM': 'linux', 04:23:29 INFO - 'TMOUT': '86400', 04:23:29 INFO - 'USER': 'cltbld', 04:23:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:29 INFO - '_': '/tools/buildbot/bin/python'} 04:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:29 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 04:23:29 INFO - Cleaning up... 04:23:29 INFO - Return code: 0 04:23:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:29 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 0x7f1deb652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, '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-1469618586.344137-1753398946', '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 04:23:29 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 04:23:29 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 04:23:29 INFO - Using env: {'DISPLAY': ':0', 04:23:29 INFO - 'HOME': '/home/cltbld', 04:23:29 INFO - 'LANG': 'en_US.UTF-8', 04:23:29 INFO - 'LANGUAGE': 'en_US:en', 04:23:29 INFO - 'LOGNAME': 'cltbld', 04:23:29 INFO - 'MAIL': '/var/mail/cltbld', 04:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:29 INFO - 'MOZ_NO_REMOTE': '1', 04:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:29 INFO - 'NO_EM_RESTART': '1', 04:23:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:29 INFO - 'PWD': '/builds/slave/test', 04:23:29 INFO - 'SHELL': '/bin/bash', 04:23:29 INFO - 'SHLVL': '1', 04:23:29 INFO - 'TERM': 'linux', 04:23:29 INFO - 'TMOUT': '86400', 04:23:29 INFO - 'USER': 'cltbld', 04:23:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:29 INFO - '_': '/tools/buildbot/bin/python'} 04:23:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:29 INFO - Downloading/unpacking psutil>=3.1.1 04:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:31 INFO - Installing collected packages: psutil 04:23:31 INFO - Running setup.py install for psutil 04:23:31 INFO - building 'psutil._psutil_linux' extension 04:23:31 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 04:23:31 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 04:23:31 INFO - building 'psutil._psutil_posix' extension 04:23:31 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 04:23:32 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 04:23:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:32 INFO - Successfully installed psutil 04:23:32 INFO - Cleaning up... 04:23:32 INFO - Return code: 0 04:23:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1deb652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, '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-1469618586.344137-1753398946', '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 04:23:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:23:32 INFO - Using env: {'DISPLAY': ':0', 04:23:32 INFO - 'HOME': '/home/cltbld', 04:23:32 INFO - 'LANG': 'en_US.UTF-8', 04:23:32 INFO - 'LANGUAGE': 'en_US:en', 04:23:32 INFO - 'LOGNAME': 'cltbld', 04:23:32 INFO - 'MAIL': '/var/mail/cltbld', 04:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:32 INFO - 'MOZ_NO_REMOTE': '1', 04:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:32 INFO - 'NO_EM_RESTART': '1', 04:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:32 INFO - 'PWD': '/builds/slave/test', 04:23:32 INFO - 'SHELL': '/bin/bash', 04:23:32 INFO - 'SHLVL': '1', 04:23:32 INFO - 'TERM': 'linux', 04:23:32 INFO - 'TMOUT': '86400', 04:23:32 INFO - 'USER': 'cltbld', 04:23:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:32 INFO - '_': '/tools/buildbot/bin/python'} 04:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:23:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:23:34 INFO - Installing collected packages: mozsystemmonitor 04:23:34 INFO - Running setup.py install for mozsystemmonitor 04:23:34 INFO - Successfully installed mozsystemmonitor 04:23:34 INFO - Cleaning up... 04:23:34 INFO - Return code: 0 04:23:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:23:34 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')]} 04:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:34 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')]} 04:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:34 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 0x7f1deb652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, '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-1469618586.344137-1753398946', '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 04:23:34 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 04:23:34 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 04:23:34 INFO - Using env: {'DISPLAY': ':0', 04:23:34 INFO - 'HOME': '/home/cltbld', 04:23:34 INFO - 'LANG': 'en_US.UTF-8', 04:23:34 INFO - 'LANGUAGE': 'en_US:en', 04:23:34 INFO - 'LOGNAME': 'cltbld', 04:23:34 INFO - 'MAIL': '/var/mail/cltbld', 04:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:34 INFO - 'MOZ_NO_REMOTE': '1', 04:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:34 INFO - 'NO_EM_RESTART': '1', 04:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:34 INFO - 'PWD': '/builds/slave/test', 04:23:34 INFO - 'SHELL': '/bin/bash', 04:23:34 INFO - 'SHLVL': '1', 04:23:34 INFO - 'TERM': 'linux', 04:23:34 INFO - 'TMOUT': '86400', 04:23:34 INFO - 'USER': 'cltbld', 04:23:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:34 INFO - '_': '/tools/buildbot/bin/python'} 04:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:34 INFO - Downloading/unpacking jsonschema==2.5.1 04:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:23:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:23:36 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 04:23:36 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 04:23:36 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 04:23:36 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 04:23:36 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 04:23:36 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 04:23:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:23:36 INFO - warning: no files found matching '*.txt' 04:23:36 INFO - no previously-included directories found matching 'build' 04:23:36 INFO - no previously-included directories found matching 'dist' 04:23:36 INFO - no previously-included directories found matching '.git*' 04:23:36 INFO - Installing collected packages: jsonschema, functools32 04:23:37 INFO - Running setup.py install for functools32 04:23:37 INFO - warning: no files found matching '*.txt' 04:23:37 INFO - no previously-included directories found matching 'build' 04:23:37 INFO - no previously-included directories found matching 'dist' 04:23:37 INFO - no previously-included directories found matching '.git*' 04:23:37 INFO - Successfully installed jsonschema functools32 04:23:37 INFO - Cleaning up... 04:23:37 INFO - Return code: 0 04:23:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23: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', '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 0x7f1deb652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, '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-1469618586.344137-1753398946', '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 04:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:23: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 blobuploader==1.2.4 04:23:37 INFO - Using env: {'DISPLAY': ':0', 04:23:37 INFO - 'HOME': '/home/cltbld', 04:23:37 INFO - 'LANG': 'en_US.UTF-8', 04:23:37 INFO - 'LANGUAGE': 'en_US:en', 04:23:37 INFO - 'LOGNAME': 'cltbld', 04:23:37 INFO - 'MAIL': '/var/mail/cltbld', 04:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:37 INFO - 'MOZ_NO_REMOTE': '1', 04:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:37 INFO - 'NO_EM_RESTART': '1', 04:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:37 INFO - 'PWD': '/builds/slave/test', 04:23:37 INFO - 'SHELL': '/bin/bash', 04:23:37 INFO - 'SHLVL': '1', 04:23:37 INFO - 'TERM': 'linux', 04:23:37 INFO - 'TMOUT': '86400', 04:23:37 INFO - 'USER': 'cltbld', 04:23:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:37 INFO - '_': '/tools/buildbot/bin/python'} 04:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:37 INFO - Downloading/unpacking blobuploader==1.2.4 04:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:39 INFO - Downloading blobuploader-1.2.4.tar.gz 04:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:23:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:23:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:40 INFO - Downloading docopt-0.6.1.tar.gz 04:23:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:23:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:23:40 INFO - Running setup.py install for blobuploader 04:23:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:23:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:23:40 INFO - Running setup.py install for requests 04:23:40 INFO - Running setup.py install for docopt 04:23:40 INFO - Successfully installed blobuploader requests docopt 04:23:40 INFO - Cleaning up... 04:23:40 INFO - Return code: 0 04:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:40 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 0x7f1deb652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, '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-1469618586.344137-1753398946', '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 04:23:40 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 04:23:40 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 04:23:40 INFO - Using env: {'DISPLAY': ':0', 04:23:40 INFO - 'HOME': '/home/cltbld', 04:23:40 INFO - 'LANG': 'en_US.UTF-8', 04:23:40 INFO - 'LANGUAGE': 'en_US:en', 04:23:40 INFO - 'LOGNAME': 'cltbld', 04:23:40 INFO - 'MAIL': '/var/mail/cltbld', 04:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:40 INFO - 'MOZ_NO_REMOTE': '1', 04:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:40 INFO - 'NO_EM_RESTART': '1', 04:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:40 INFO - 'PWD': '/builds/slave/test', 04:23:40 INFO - 'SHELL': '/bin/bash', 04:23:40 INFO - 'SHLVL': '1', 04:23:40 INFO - 'TERM': 'linux', 04:23:40 INFO - 'TMOUT': '86400', 04:23:40 INFO - 'USER': 'cltbld', 04:23:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:40 INFO - '_': '/tools/buildbot/bin/python'} 04:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:40 INFO - Running setup.py (path:/tmp/pip-EkFX69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:41 INFO - Running setup.py (path:/tmp/pip-fJ7uTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:41 INFO - Running setup.py (path:/tmp/pip-VY4aKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:41 INFO - Running setup.py (path:/tmp/pip-V1GYIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:41 INFO - Running setup.py (path:/tmp/pip-kWUvqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:41 INFO - Running setup.py (path:/tmp/pip-wOGFpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:41 INFO - Running setup.py (path:/tmp/pip-f8wT8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:41 INFO - Running setup.py (path:/tmp/pip-YrTjrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:41 INFO - Running setup.py (path:/tmp/pip-w84OiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:41 INFO - Running setup.py (path:/tmp/pip-PHd15U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:41 INFO - Running setup.py (path:/tmp/pip-5cOBJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:41 INFO - Running setup.py (path:/tmp/pip-V1Ioj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:41 INFO - Running setup.py (path:/tmp/pip-sIGmzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:41 INFO - Running setup.py (path:/tmp/pip-zzop76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:41 INFO - Running setup.py (path:/tmp/pip-XuXfFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:42 INFO - Running setup.py (path:/tmp/pip-zzw7wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:42 INFO - Running setup.py (path:/tmp/pip-ciA6vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:23:42 INFO - Running setup.py install for manifestparser 04:23:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:23:42 INFO - Running setup.py install for mozcrash 04:23:42 INFO - Running setup.py install for mozdebug 04:23:42 INFO - Running setup.py install for mozdevice 04:23:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:23:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:23:42 INFO - Running setup.py install for mozfile 04:23:42 INFO - Running setup.py install for mozhttpd 04:23:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:23:42 INFO - Running setup.py install for mozinfo 04:23:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:23:42 INFO - Running setup.py install for mozInstall 04:23:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:23:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:23:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:23:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:23:42 INFO - Running setup.py install for mozleak 04:23:43 INFO - Running setup.py install for mozlog 04:23:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:23:43 INFO - Running setup.py install for moznetwork 04:23:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:23:43 INFO - Running setup.py install for mozprocess 04:23:43 INFO - Running setup.py install for mozprofile 04:23:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:23:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:23:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:23:43 INFO - Running setup.py install for mozrunner 04:23:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:23:43 INFO - Running setup.py install for mozscreenshot 04:23:43 INFO - Running setup.py install for moztest 04:23:43 INFO - Running setup.py install for mozversion 04:23:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:23:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:23:43 INFO - Cleaning up... 04:23:43 INFO - Return code: 0 04:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:43 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 0x7f1deb652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, '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-1469618586.344137-1753398946', '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 04:23:43 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 04:23:43 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 04:23:43 INFO - Using env: {'DISPLAY': ':0', 04:23:43 INFO - 'HOME': '/home/cltbld', 04:23:43 INFO - 'LANG': 'en_US.UTF-8', 04:23:43 INFO - 'LANGUAGE': 'en_US:en', 04:23:43 INFO - 'LOGNAME': 'cltbld', 04:23:43 INFO - 'MAIL': '/var/mail/cltbld', 04:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:43 INFO - 'MOZ_NO_REMOTE': '1', 04:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:43 INFO - 'NO_EM_RESTART': '1', 04:23:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:43 INFO - 'PWD': '/builds/slave/test', 04:23:43 INFO - 'SHELL': '/bin/bash', 04:23:43 INFO - 'SHLVL': '1', 04:23:43 INFO - 'TERM': 'linux', 04:23:43 INFO - 'TMOUT': '86400', 04:23:43 INFO - 'USER': 'cltbld', 04:23:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:43 INFO - '_': '/tools/buildbot/bin/python'} 04:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:23:44 INFO - Running setup.py (path:/tmp/pip-9tzVGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:23:44 INFO - Running setup.py (path:/tmp/pip-UuYtd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:23:44 INFO - Running setup.py (path:/tmp/pip-vnrL2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:23:44 INFO - Running setup.py (path:/tmp/pip-F2uQEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:23:44 INFO - Running setup.py (path:/tmp/pip-aYCk5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:23:44 INFO - Running setup.py (path:/tmp/pip-oUQB9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:23:44 INFO - Running setup.py (path:/tmp/pip-qhADwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:23:44 INFO - Running setup.py (path:/tmp/pip-MAov85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:23:44 INFO - Running setup.py (path:/tmp/pip-4trQYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:23:44 INFO - Running setup.py (path:/tmp/pip-BMDtEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:23:44 INFO - Running setup.py (path:/tmp/pip-B8E4fU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:23:44 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)) 04:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:23:44 INFO - Running setup.py (path:/tmp/pip-7NAY2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:23:45 INFO - Running setup.py (path:/tmp/pip-Kpo6qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:23:45 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:23:45 INFO - Running setup.py (path:/tmp/pip-QDIY4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:23:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:45 INFO - Running setup.py (path:/tmp/pip-aPmLww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:23:45 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:23:45 INFO - Running setup.py (path:/tmp/pip-tYNlFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:23:45 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)) 04:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:23:45 INFO - Running setup.py (path:/tmp/pip-hvyaQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:23:45 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)) 04:23:45 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)) 04:23:45 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)) 04:23:45 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)) 04:23:45 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)) 04:23:45 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)) 04:23:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:47 INFO - Downloading blessings-1.6.tar.gz 04:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:23:47 INFO - Installing collected packages: blessings 04:23:47 INFO - Running setup.py install for blessings 04:23:47 INFO - Successfully installed blessings 04:23:47 INFO - Cleaning up... 04:23:47 INFO - Return code: 0 04:23:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:47 INFO - Reading from file tmpfile_stdout 04:23:47 INFO - Current package versions: 04:23:47 INFO - argparse == 1.2.1 04:23:47 INFO - blessings == 1.6 04:23:47 INFO - blobuploader == 1.2.4 04:23:47 INFO - docopt == 0.6.1 04:23:47 INFO - functools32 == 3.2.3-2 04:23:47 INFO - jsonschema == 2.5.1 04:23:47 INFO - manifestparser == 1.1 04:23:47 INFO - mozInstall == 1.12 04:23:47 INFO - mozcrash == 0.17 04:23:47 INFO - mozdebug == 0.1 04:23:47 INFO - mozdevice == 0.48 04:23:47 INFO - mozfile == 1.2 04:23:47 INFO - mozhttpd == 0.7 04:23:47 INFO - mozinfo == 0.9 04:23:47 INFO - mozleak == 0.1 04:23:47 INFO - mozlog == 3.2 04:23:47 INFO - moznetwork == 0.27 04:23:47 INFO - mozprocess == 0.23 04:23:47 INFO - mozprofile == 0.28 04:23:47 INFO - mozrunner == 6.12 04:23:47 INFO - mozscreenshot == 0.1 04:23:47 INFO - mozsystemmonitor == 0.3 04:23:47 INFO - moztest == 0.7 04:23:47 INFO - mozversion == 1.4 04:23:47 INFO - psutil == 3.1.1 04:23:47 INFO - requests == 1.2.3 04:23:47 INFO - wsgiref == 0.1.2 04:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:47 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 0x7f1deb652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, '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-1469618586.344137-1753398946', '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 04:23:47 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 04:23:47 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 04:23:47 INFO - Using env: {'DISPLAY': ':0', 04:23:47 INFO - 'HOME': '/home/cltbld', 04:23:47 INFO - 'LANG': 'en_US.UTF-8', 04:23:47 INFO - 'LANGUAGE': 'en_US:en', 04:23:47 INFO - 'LOGNAME': 'cltbld', 04:23:47 INFO - 'MAIL': '/var/mail/cltbld', 04:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:47 INFO - 'MOZ_NO_REMOTE': '1', 04:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:47 INFO - 'NO_EM_RESTART': '1', 04:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:47 INFO - 'PWD': '/builds/slave/test', 04:23:47 INFO - 'SHELL': '/bin/bash', 04:23:47 INFO - 'SHLVL': '1', 04:23:47 INFO - 'TERM': 'linux', 04:23:47 INFO - 'TMOUT': '86400', 04:23:47 INFO - 'USER': 'cltbld', 04:23:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:47 INFO - '_': '/tools/buildbot/bin/python'} 04:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:47 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)) 04:23:47 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)) 04:23:47 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)) 04:23:47 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)) 04:23:47 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)) 04:23:47 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)) 04:23:47 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)) 04:23:47 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)) 04:23:47 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)) 04:23:47 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)) 04:23:47 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)) 04:23:47 INFO - Cleaning up... 04:23:47 INFO - Return code: 0 04:23:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:47 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 0x7f1deb652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, '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-1469618586.344137-1753398946', '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 04:23:47 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 04:23:47 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 04:23:47 INFO - Using env: {'DISPLAY': ':0', 04:23:47 INFO - 'HOME': '/home/cltbld', 04:23:47 INFO - 'LANG': 'en_US.UTF-8', 04:23:47 INFO - 'LANGUAGE': 'en_US:en', 04:23:47 INFO - 'LOGNAME': 'cltbld', 04:23:47 INFO - 'MAIL': '/var/mail/cltbld', 04:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:47 INFO - 'MOZ_NO_REMOTE': '1', 04:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:47 INFO - 'NO_EM_RESTART': '1', 04:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:47 INFO - 'PWD': '/builds/slave/test', 04:23:47 INFO - 'SHELL': '/bin/bash', 04:23:47 INFO - 'SHLVL': '1', 04:23:47 INFO - 'TERM': 'linux', 04:23:47 INFO - 'TMOUT': '86400', 04:23:47 INFO - 'USER': 'cltbld', 04:23:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:47 INFO - '_': '/tools/buildbot/bin/python'} 04:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:23:48 INFO - Cleaning up... 04:23:48 INFO - Return code: 0 04:23:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:23:48 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')]} 04:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:48 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')]} 04:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:48 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 0x7f1deb652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ec020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, '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-1469618586.344137-1753398946', '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 04:23:48 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 04:23:48 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 04:23:48 INFO - Using env: {'DISPLAY': ':0', 04:23:48 INFO - 'HOME': '/home/cltbld', 04:23:48 INFO - 'LANG': 'en_US.UTF-8', 04:23:48 INFO - 'LANGUAGE': 'en_US:en', 04:23:48 INFO - 'LOGNAME': 'cltbld', 04:23:48 INFO - 'MAIL': '/var/mail/cltbld', 04:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:48 INFO - 'MOZ_NO_REMOTE': '1', 04:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:48 INFO - 'NO_EM_RESTART': '1', 04:23:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:48 INFO - 'PWD': '/builds/slave/test', 04:23:48 INFO - 'SHELL': '/bin/bash', 04:23:48 INFO - 'SHLVL': '1', 04:23:48 INFO - 'TERM': 'linux', 04:23:48 INFO - 'TMOUT': '86400', 04:23:48 INFO - 'USER': 'cltbld', 04:23:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:48 INFO - '_': '/tools/buildbot/bin/python'} 04:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:48 INFO - Downloading/unpacking flake8 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23: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 04:23:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:23:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:23:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 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 04:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:23:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:51 INFO - no previously-included directories found matching 'docs/_build' 04:23:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:23:51 INFO - Running setup.py install for pep8 04:23:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:23:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:23:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:23:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:23:51 INFO - no previously-included directories found matching 'docs/_build' 04:23:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:23:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:23:51 INFO - Cleaning up... 04:23:51 INFO - Return code: 0 04:23:51 INFO - Running post-action listener: _resource_record_post_action 04:23:51 INFO - Running post-action listener: _start_resource_monitoring 04:23:51 INFO - Starting resource monitoring. 04:23:51 INFO - ##### 04:23:51 INFO - ##### Finished create-virtualenv step (success) 04:23:51 INFO - ##### 04:23:51 INFO - ##### 04:23:51 INFO - ##### Running install step. 04:23:51 INFO - ##### 04:23:51 INFO - Running pre-action listener: _resource_record_pre_action 04:23:51 INFO - Running main action method: install 04:23:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:23:51 INFO - Reading from file tmpfile_stdout 04:23:51 INFO - Detecting whether we're running mozinstall >=1.0... 04:23:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:23:51 INFO - Reading from file tmpfile_stdout 04:23:51 INFO - Output received: 04:23:51 INFO - Usage: mozinstall [options] installer 04:23:51 INFO - Options: 04:23:51 INFO - -h, --help show this help message and exit 04:23:51 INFO - -d DEST, --destination=DEST 04:23:51 INFO - Directory to install application into. [default: 04:23:51 INFO - "/builds/slave/test"] 04:23:51 INFO - --app=APP Application being installed. [default: firefox] 04:23:51 INFO - mkdir: /builds/slave/test/build/application 04:23:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:24:07 INFO - Reading from file tmpfile_stdout 04:24:07 INFO - Output received: 04:24:07 INFO - /builds/slave/test/build/application/firefox/firefox 04:24:07 INFO - Running post-action listener: _resource_record_post_action 04:24:07 INFO - ##### 04:24:07 INFO - ##### Finished install step (success) 04:24:07 INFO - ##### 04:24:07 INFO - ##### 04:24:07 INFO - ##### Running run-tests step. 04:24:07 INFO - ##### 04:24:07 INFO - Running pre-action listener: _resource_record_pre_action 04:24:07 INFO - Running main action method: run_tests 04:24:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:07 INFO - Python 2.7.3 04:24:07 INFO - Return code: 0 04:24:07 INFO - grabbing minidump binary from tooltool 04:24:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:07 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 0x297e2e0>, '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 0x28ea140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ea5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:07 INFO - Return code: 0 04:24:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:24:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:24:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:24:08 INFO - Return code: 0 04:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:24:08 INFO - Using env: {'DISPLAY': ':0', 04:24:08 INFO - 'HOME': '/home/cltbld', 04:24:08 INFO - 'LANG': 'en_US.UTF-8', 04:24:08 INFO - 'LANGUAGE': 'en_US:en', 04:24:08 INFO - 'LOGNAME': 'cltbld', 04:24:08 INFO - 'MAIL': '/var/mail/cltbld', 04:24:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:08 INFO - 'MOZ_NO_REMOTE': '1', 04:24:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:08 INFO - 'NO_EM_RESTART': '1', 04:24:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:08 INFO - 'PWD': '/builds/slave/test', 04:24:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:08 INFO - 'SHELL': '/bin/bash', 04:24:08 INFO - 'SHLVL': '1', 04:24:08 INFO - 'TERM': 'linux', 04:24:08 INFO - 'TMOUT': '86400', 04:24:08 INFO - 'USER': 'cltbld', 04:24:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469618586.344137-1753398946', 04:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:08 INFO - '_': '/tools/buildbot/bin/python'} 04:24:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:24:08 INFO - mozversion application_buildid: 20160726081123 04:24:08 INFO - mozversion application_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 04:24:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:24:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:08 INFO - mozversion application_name: Firefox 04:24:08 INFO - mozversion application_remotingname: firefox-dev 04:24:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:24:08 INFO - mozversion application_vendor: Mozilla 04:24:08 INFO - mozversion application_version: 49.0a2 04:24:08 INFO - mozversion platform_buildid: 20160726081123 04:24:08 INFO - mozversion platform_changeset: ebd239b4cbfb8eff833560f72b163275ac4026d3 04:24:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:24:08 INFO - mozversion platform_version: 49.0a2 04:24:08 INFO - using testdate: 1469618648 04:24:08 INFO - actual date: 1469618648 04:24:08 INFO - starting webserver on 'localhost:56095' 04:24:08 INFO - SUITE-START | Running 2 tests 04:24:08 INFO - TEST-START | dromaeo_css 04:24:08 INFO - operating with platform_type : linux_ 04:24:08 INFO - Initialising browser for dromaeo_css test... 04:24:08 INFO - TEST-INFO | started process 15311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbvp6ac/profile http://localhost:56095/getInfo.html) 04:24:14 INFO - PROCESS | 15311 | __metrics Screen width/height:1600/1200 04:24:14 INFO - PROCESS | 15311 | colorDepth:24 04:24:14 INFO - PROCESS | 15311 | Browser inner width/height: 1024/697 04:24:14 INFO - PROCESS | 15311 | __metrics 04:24:15 ERROR - PROCESS | 15311 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:24:16 INFO - TEST-INFO | 15311: exit 0 04:24:16 INFO - Browser initialized. 04:24:16 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:16 INFO - TEST-INFO | started process 15441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbvp6ac/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:27 INFO - PROCESS | 15441 | RSS: Main: 156098560 04:24:27 INFO - PROCESS | 15441 | 04:25:17 INFO - PROCESS | 15441 | 1469618717455 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] 04:27:26 INFO - PROCESS | 15441 | Cycle 1(1): loaded http://localhost:56095/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56095/tests/dromaeo/cssquery-ext.html) 04:27:27 INFO - PROCESS | 15441 | RSS: Main: 160202752 04:27:27 INFO - PROCESS | 15441 | 04:30:29 INFO - PROCESS | 15441 | Cycle 1(1): loaded http://localhost:56095/tests/dromaeo/cssquery-ext.html (next: http://localhost:56095/tests/dromaeo/cssquery-jquery.html) 04:30:29 INFO - PROCESS | 15441 | RSS: Main: 157732864 04:30:29 INFO - PROCESS | 15441 | 04:33:31 INFO - PROCESS | 15441 | Cycle 1(1): loaded http://localhost:56095/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56095/tests/dromaeo/cssquery-mootools.html) 04:33:32 INFO - PROCESS | 15441 | RSS: Main: 156889088 04:33:32 INFO - PROCESS | 15441 | 04:36:33 INFO - PROCESS | 15441 | Cycle 1(1): loaded http://localhost:56095/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56095/tests/dromaeo/cssquery-prototype.html) 04:36:34 INFO - PROCESS | 15441 | RSS: Main: 156344320 04:36:34 INFO - PROCESS | 15441 | 04:39:36 INFO - PROCESS | 15441 | Cycle 1(1): loaded http://localhost:56095/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56095/tests/dromaeo/cssquery-yui.html) 04:39:37 INFO - PROCESS | 15441 | RSS: Main: 158699520 04:39:37 INFO - PROCESS | 15441 | 04:42:39 INFO - PROCESS | 15441 | Cycle 1(1): loaded http://localhost:56095/tests/dromaeo/cssquery-yui.html (next: http://localhost:56095/tests/dromaeo/cssquery-dojo.html) 04:42:40 INFO - PROCESS | 15441 | RSS: Main: 158846976 04:42:40 INFO - PROCESS | 15441 | 04:42:40 INFO - PROCESS | 15441 | __start_tp_report 04:42:40 INFO - PROCESS | 15441 | _x_x_mozilla_page_load 04:42:40 INFO - PROCESS | 15441 | _x_x_mozilla_page_load_details 04:42:40 INFO - PROCESS | 15441 | |i|pagename|runs| 04:42:40 INFO - PROCESS | 15441 | |0;dojo.html;3387.813670248136;3441.3633477806607;3447.3794716950947;3456.3432947739943;3462.463318185682;5697.4017728138515;5727.627704199234;5744.856378590537;5787.189793428918;5790.044642633966;5735.569832262576;5759.654420734749;5776.740046697898;5786.479216870481;5801.129830525423;5146.5625421839095;5202.947970520303;5248.6588371755715;5261.158214685651;5272.499112584298;5132.461091585367;5305.734713264322;5309.681419114865;5323.387810401795;5333.093374126388;5132.820351287705;5241.79032838686;5251.0023095611905;5284.2073688946775;5304.177852432879;5256.448072952342;5258.211268309746;5268.4994925482015;5283.63014588979;5287.894242115136;5243.318368612094;5282.2076688496645;5337.946620533823;5347.41178470368;5351.7056561889085;5493.615446918718;5549.334079910396;5583.664980101207;5607.579431542651;5711.343195532525;6114.0217565189805;6123.418275263843;6134.9079763803575;6139.938600613981;6158.076288556752;6160.537959653044;6180.567360284782;6191.690415479253;6197.597156184834;6203.7828675996125;5665.688387138705;5742.770289188427;5762.3373312069225;5776.220210271602;5812.854678633068;6346.746130154742;6370.948793449122;6390.392912673288;6417.647029413427;6449.5485316027425;6022.45797878193;6164.321924588292;6171.660558669317;6174;6178.227721534809;6133.723982420713;6194.4115309045565;6218.751249949952;6228.657423841732;6246.562740608114;6199.256089269316;6203.596766210182;6204.689765511796;6208.937910620926;6226.844328891814;5984.8803023940145;6022.247219097613;6042.969785151046;6171.660558669227;6206.968965155235;4678.555537223959;4688.976555117202;4690.718556886598;4696.7416792076765;4709.95290047102;4176.14389050244;4181.623653871166;4188.099558594917;4197.895052623648;4212.473440819897;5900.586958912921;5906.645601263938;5907.586468947218;5916.7337469813965;5988.311344195473;6071.2714474263375;6136.386361363828;6140.3552626974415;6194.628322300677;6213;5984.880302393928;5993.0710739835395;5995.333867268888;6022.939770602238;6045.1234570987845;5197.922031169535;5322.787088516416;5350.491703288181;5379.704116273564;5389.622726409114;6483.157189565326;6554.606723596599;6577.835554111186;6582.703778329891;6591.472682185414;6027.487663548647;6319.873602528016;6320.905186422116;6339.587926784744;6351;6330.082138089859;6340.556161068681;6357.872842543031;6468.223813142453;6479.773207937699;6125.571210015256;6132.969335153296;6137.508999280136;6138.048602466625;6143.846403839761;6082.239720034996;6126.181801871033;6222.657753823583;6239.344868788893;6240;6041.78853740117;6115.057807493917;6115.9156198811215;6132.6664570199355;6142.191841058572;6035.637861728311;6095.1771510845465;6096.847578810565;6111.052786818051;6114.57197996136;5791.420857914175;5840.678762668094;5844.47399734026;5926.911096333472;5998.9100163496705;6030.336662967158;6047.9395206047375;6065.939340606537;6082.665453400105;6104.481119104926;5923.437273459014;5930.584859059824;5933.376995415592;5954.612950158225;5956.672383018976 04:42:40 INFO - PROCESS | 15441 | |1;ext.html;603.9003564411872;654.7381047580968;662.4402379988911;662.8707402056601;663.9834004149895;46950;48391.27413088798;48453.757731211335;48536.757316213414;52341.73829130849;49657;50131.74934125334;50230;50410;50604.74697626516;8937.329700272474;9098.681546145886;9117.772055698595;9154.633814647406;9197.264218862474;9007.864882026775;9047.321450891177;9095.226905713022;9107.863382049274;9129.543522823833;9126.726198214032;9149.039350868163;9174.678886238982;9182.540872956359;9197.356185067049;9039.186473217409;9156.725298241063;9166.40418372807;9186.356955013152;9187.586558604846;9017.504037277948;9042.502662353569;9062.864057039149;9065.728028159167;9093.63625454981;46372.53627463716;46552.30171547429;46798.53201467976;47023.76488117572;47163.5283647166;3864.4976153099915;3945.5315935635404;4013.8795836124964;4279.914401711948;4526.909461810746;34924;34981;35612.28775424503;35697;37290.62709372926;4664.813407463697;4721.763911804431;4753.405824271966;4757.333973243749;4833.782479788418;383726;389591;392343;392598;393807.0309648462;38174.42738358927;67328;67540;67598.3240167592;67783;39766.602333976865;41413.37879931804;41474.79262603668;41594.58405415968;41818.790906045884;16949;17103.23035463407;17127.314907403812;17152.828471715373;17191.57021074483;14142.929285353508;14332.283385830875;14375.568732938029;14400.135991840523;14454.349554270084;9310.95344523273;9341.626334946663;9357;9399.953000234955;9436.95281523588;3547.3614749345365;3629.491871138043;3634.9091272717865;3641.8725344612812;3653.5615726113037;1037.2687255484866;1124.942553999238;1127.8421021057059;1136.1654416344836;1220.6155061155707;31675.683243167736;33993.130377828966;34312;34442.82778586091;34661.48007779886;1130.4121856634504;1215.173681896319;1230.4954968462887;1253.8934190593902;1270.326726834779;17058.829411705974;17375.826241737675;17446.825531744773;17536.386226482013;17801.198946047458;595783;600165;602695;602712;603716;62906.68546657329;63019;63026.68486657629;63212.367876321565;63473.68263158655;1516.564050153297;1536.1474381718253;1545.4436402894949;1545.7217700813962;1565.2721484509757;31999.520007200375;32034.03897883067;32355.35289294248;32537.837310813295;32740.34519309648;56184;56295.43704562902;56313;56563.43436565582;57036.144457832335;515959;518330;522084;522419;525273;47040.52959470498;48275.75862120667;48371;48737.5126248733;49063.264051038546;51358.48641513537;54501.454985449636;54894.72552637211;55338.72330638321;56070.71964640151;45154.322685159095;45341;46024.539754602025;46965.76517117392;47154.764226178646;44440.7777961121;44652;45241;46218.07563848772;49272.50727492679;46181.76909115433;46450.535494644624;46618.13527458999;47297.527024729316;47344.52655473539;38326.42510362291;39472.605273946894;39658.603413966644;40150.01168857634;40373.798131009156;31234.531482028244;31579.84210078935;31652.634660131003;31771;31862.203444913135 04:42:40 INFO - PROCESS | 15441 | |2;jquery.html;429.77007301093903;431.73232595790614;438.7463540970292;442.3696232868162;444.7509394738946;18995.145218465168;19752.209911603535;20662.48343791406;20717.792822071773;20724.689129663067;18711.906440467814;19350.12924418401;19901.601967960632;19930.70103948442;19941.202351905944;5798.362180160179;6003.8198854034445;6032.758689652409;6035.547333949971;6040.637561746309;5711.628744131639;5864.149698293745;5957.821265362046;5959.255093113361;5964.552658550626;5902.055671092626;5904.7047647617665;5911.674857882815;5912.9113063304085;5921.259842519685;5713.8571535711735;5813.7383817728305;5846.064629659277;5876.177335173079;5898.233229680157;5255.842324730264;5278.1291086970605;5283.339582552181;5291.3650361956425;5318.9202161967605;17265.741013884803;18545.907270463696;22342.66486002711;23239;23441.41396465085;2577.484503099369;2596.337933826881;2658.1493921944984;2819;2961.9703802962126;14467.927660361736;14777;14851.331690073865;14864.554063378117;15218.847811521853;2079.7712251652306;2107.6627739561595;2145.1633862793524;2180.356794745554;2201.1745595401726;82455;84312.57843710804;84956.57521712413;85206;85369.14630853674;11285;11343.829842552368;11455.942720286344;12029.639110826514;12208.694782630328;15769.763453548207;15790;15883.126428046568;15911;15964.962277451928;8329.167083291622;8373.371997100241;8427.367947403969;8624.611892464854;8638.09300023501;8595.742127736177;8732.214100730966;8776.692815751418;8806.515641639644;8963.865542016874;4817.855464336076;4865.9026819463415;4894;4897.338859253955;4952.702837829742;2055.825254853354;2114.8519603627597;2138.967915481269;2152.763196048433;2152.9246476373564;967.2310513142069;1049.6483677967967;1075.349413604758;1085.699473600262;1105.8894110588876;18916.71624925627;19408.514787130436;19660.410187694393;19700.90149549243;19879.403617891487;1050.0077426831572;1084.8210045342587;1086.239632257423;1166.859976802789;1190.8511436070492;10601.25791194609;10806.567737290421;10919.290246133976;11030.28303160292;11043.39261340634;503632;508167;510323;515235;523004;93174;94188.52905735427;94313;95789;96302.51848740711;1027.9331843430152;1030.3354336453096;1073.8603981482356;1093.038126448736;1107.8227483602584;17124;17145.91427042857;17239.65520689604;17409.216585253947;17582.120893954994;38060.61939380682;41392.37911431391;42356;42702;44749.10501789881;58345.416545835695;60239.397606023376;60278;60352.39647603643;60878.69560652169;8408.831823363376;8603.913960860562;8660.740177794676;8729.956350218208;8969.641214351353;7516.323530882247;9082.046385129466;9179.714839922282;11105.38920359388;11972.940135299268;11003.449827508432;11211.887881121085;11408.600698975495;11414.828777568177;11435.59975400857;10543.789124217627;10701;10778.353298802096;10920.890791092304;11050.171237157085;10918.399488027917;11282.887171128184;11288.774224515299;11447.25592836463;11589.072874170215;8974.282057435259;9179.127982841619;9187.908120918706;9268.675596354095;9504.382215155993;10553.208509361675;10709.732256693333;10741.731456713645;10998.725031874266;11182.440877955907 04:42:40 INFO - PROCESS | 15441 | |3;mootools.html;1575.0549670197884;1590.3797518967601;1797.5506123469133;1880.2291060665113;1907.923683052678;8626.22363987241;9250.491222982733;9278.953605231982;9884.851727224088;9915.950420247907;9328.207102396305;9617.807643847118;9669.37149085309;9684.854727179098;9705.514724263794;2440.463098118411;2455.0670745116877;2460.1512478194995;2474.8020158387285;2480.231128350217;2445.4742230420457;2529.519391315644;2531.556977528934;2535.150724507292;2544.3511904464335;2472.0359059966627;2487.253823852846;2518.4207632244593;2525.1666949906485;2541.1487151804076;2305.3890718959487;2326.7440581536016;2348.870812105342;2380.143148466551;2395.341281147681;2446.033816642434;2446.2294377271282;2449.889754961031;2462.335169504224;2505.5991041433285;9675.854862177073;9718.271129665303;9728.951355243249;9754.073363030571;9793.069658382443;5690.40250773667;5879.235699359098;5902.409759024106;5906.852328691817;5912.408759124053;3655.214128962259;3822.197338558906;3850.2299540091813;3920.5295364556437;3950.3679411294343;1204.4640135139866;1245.7882160032816;1253.6301790971686;2347.612643913752;2359.8112151027876;13734.175949442966;13773.517926872611;13854.307284635828;13921.373538190806;13995.86004139966;5017.297578339036;5065.9746701266995;5089.134847076006;5107.770150343244;5172.172452407597;10876.401797901191;10913.399763012952;10955;10967.012968832843;11002.724931876606;5702.54379649627;5813.82558523245;5822.097574875901;5830.183774271605;5932.2881254248905;4860.125177468019;5326.707031113248;5426.321709786277;5431.37539182999;5453.481919217747;4227.492700875914;4262.147570485915;4297.376880352332;4302.139572085595;4430.047539778963;1230.7046308885804;1271.4024408527978;1274.4265080713717;1276.910616256853;1288.845338559379;869.1352104655908;988.604558176735;1013.5591017907234;1054.8291396549823;1067.3329169269207;6481.351864813481;6490.772822951174;6509.544331896816;6569.441597464173;6572.474202063823;453.4626467635862;461.6099396010366;467.2010861426998;470.98116075357285;473.07985967293973;4259.87220383389;4469.374287599739;4530.954690453119;4534.161180181677;4570.520095389937;12035.75928481443;12293.323867187211;12316.753664926831;12373.93813030929;12409;11609.825852612217;12050.096242781827;12154.756904861853;12291.815622765665;12314.261144331369;9102.81663383756;9175.495347755805;9224;9294.86057709135;9310.53447327631;6248.4688801452385;6346.873062538631;6441.67791610427;6455.870882582416;6505.772297969737;11030.834537482106;11352.432378380883;11431.314121152758;11483.712907177387;11551.826722599335;11466.885331146581;11487.138464615355;11586.76826463483;11629.825552616549;11645.88354116448;7775.688972441039;8320;8425.915740842758;8649.437786543855;8789.472631642122;9548.092931171528;9561.139497445263;9568.282378821756;9578.521073946136;9605.567749451431;8170.673173073011;8344;8408.369372297224;8425.4944703318;8444.324454043784;7893.250141236574;7910.841783164189;8154;8251.051129120227;8264.21489958453;7683.615819209129;7727.652255648622;7732;7738.458307918391;7755.72854950074;5310.654807437504;5346.724908130888;5370.892582148257;5388.595855310789;5401.297831282065;5379.2469054333205;5389.541888939327;5429.945700542944;5475.67145971243;5484.808031718871 04:42:40 INFO - PROCESS | 15441 | |4;prototype.html;326.409199349178;356.83050550988276;359.8776416018554;362.6174386022745;363.17740318179347;5680.602357834953;5784.1902133701215;5788;5827.155062515938;5850.853728656785;5696.458836410545;5707.828765137042;5714.657120572769;5714.885702285952;5797.681127537984;4099.692523060782;4404.98685302379;4530.75080870552;4535.365048893141;4543.5456454354635;4426.092651006552;4448.621867141297;4473.66447516436;4485.080558485519;4519.4124763780665;4434.445694288214;4445.911081778362;4446.7554284514335;4462.286034234523;4498.595126438619;4336.392904993303;4463;4463.285874260119;4471.642268618519;4494.438195225597;3859.903502412434;3898.161895192519;3924.1955399143108;3945.368741001426;3953.2884080865433;5411.83764487066;5456.863578410532;5501.257330260443;5521.4478552144465;5547;4931.975340123312;5130.153144867844;5136.897262054738;5142.460041695643;5151.227315902607;5920.875033743575;5924.58527903047;5940.970295148497;5948.940510594882;5968.135295058353;4300.88177073963;4302.41917341158;4328.935065974013;4329.935050974238;4403.4495688039;5970.701464926737;6174.567780255384;6195.597286176384;6237.660877171061;6264.4362007419095;4419.9337009944875;4442.067165895133;4451.844185453494;4462.866114016585;4488.753118578445;4461.13007963444;4526.751028693454;4529.5243999380245;4534.161180181677;4546.340780586796;5047.747612619428;5134.974325128351;5140.278006867667;5143.537081662594;5151.742412879341;5920.555958303058;5988.700564971734;6002.199340197923;6018.097285407224;6035.939640603626;1570.9371625135095;1582.754673025683;1587.5078725595104;1589.5549246211078;1589.6105454163574;992.6153016541883;1003.3795420396153;1014.5586669798661;1017.5777052523268;1019.4087429291142;5661.575381846378;5854.238948936696;5874.706264686749;5881.294244690579;5897.616654917417;6147.538934579924;6148.1699970503405;6176.197094377792;6220.502359811204;6244.625322480666;5789.681567513827;5876.206712093813;5888.087346461305;5888.381719919433;5895.970520147458;3299.835008249578;3307.6692330767214;3324.2852786650988;3334.483155110962;3337.4826901830256;6265.686715664198;6404.647744374104;6467.935320646828;6495.6752162391695;6552.705128269239;6349.238091429058;6363.618182908947;6372.203474565679;6381.266154392211;6395.040743888454;6268.686565671789;6449.903251451232;6482.384173503509;6536.607803531803;6596.175478065242;6193.659348735863;6194.451387153212;6213.099100630474;6237.28271248794;6298.874022519615;6169.84575385601;6191.535634827316;6204.193454850841;6211.81364559064;6219.689015549114;6197.946349120751;6498.595519657568;6523.151990241428;6528.445082167879;6556.2788093310655;4330.761808100585;4334.696571239983;4350.1734670412525;4362.585554372329;4374.496932852635;6118.388161184024;6130.877382452415;6212.63322069144;6236.906446403398;6284.654344011124;6013.849653758516;6013.9097913532205;6071.301800292847;6081.331053584014;6113.633182009094;5998.310194327533;6077.544184186292;6091.939080609137;6117.724702388492;6159.846003849761;5693.28833895763;5790.85522861915;5965.105234214902;5967.91048134287;5971.880562388815;6044.546659000504;6072.939270607238;6084.847878803065;6091.786787462417;6092.603980741238;5946.702664866652;5956.612820166675;5964.403559644001;5983.875724118049;5996.940030599638 04:42:40 INFO - PROCESS | 15441 | |5;yui.html;779.3842864137329;804.9275565199134;855.5294587976612;889.1330952321487;911.7766147293912;17967.730484042735;18345.90827045866;18569.164387602574;18602.627947441044;18640.627187456244;16037.198140093007;16054.75917861233;16084.919575402108;16118.435854745087;16122.677546449064;738.8226825561853;870.8780770692108;890.4301247201796;892.7232557907037;897.6274845938927;872.9170728780756;875.312879389676;877.1316396767219;877.4209022045451;886.4371124336028;930.8976012638605;932.5104320231865;932.8246409523981;934.2619330728717;934.6681927915594;921.6267411698273;922.4880191493752;923.7829110159107;927.8283517549241;928.7817362919709;676.9187697476285;682.474494639125;682.8600136971909;682.9863402731967;684.5584597934354;16590.585235369093;16651.084190369525;16707;16711.247993840305;16737.497875063767;14976.400943962228;15407.152606606633;15531.922340388226;15641.452549160838;15790;12908.54820081302;12917.741645167043;13076.215427074407;13199.472021119143;13402.865971340358;4067.51189857219;4150.626443620058;4152.688548358855;4154.667626589866;4262;70065;71801.6409917947;71810.28189718089;83373.16626833714;83465.16534834696;12766.29785361814;12968.416421261067;12990.480380784662;13047.543335983384;13416.932915335556;21357.46606334854;21850.672239916414;23495.295141145794;23559;23582.882085589463;9232.90767092334;9277.90722092784;9397.57710903011;9463.290253230898;9719.319647624598;5141.100307446182;5199.792008319625;5204.661696989683;5259.658122222043;5263.289455923401;3985.4221137934837;4118.670506359544;4125.401816736557;4126.855560055384;4132.33882578786;726.4079774983477;728.970841166358;739.593223726948;745.6048294403975;746.3133916796452;719.9208087110413;732.5677850068486;759.6809340077181;802.5866678660494;825.9628316725762;10617.522211500502;10782.083522900484;10819.098991109717;10860.728481788019;10988.835167472495;752.9308382097435;757.7916073079947;774.996379688305;795.4710117771733;824.9670013199525;4928.531789479994;4947.356843610308;4984.2025275955675;4986.750662466862;5008.223725322581;110649.44675276573;113059.43470282597;115730;117678;118682;59716.40283597195;82663;87581.56209218912;93624.53187734018;94491;86702.56648716716;88504.9999999987;88758;90705;90740;9880.308378413729;9907.256955728206;9972.102510774064;10001.649942251986;10065.295429320171;51820.481795181564;52288;52873.20690189573;53647.92704145817;54153;66227;67294.99057514043;76597.61701191458;76822;77190.6140469294;12516.624501264976;13063.608091757262;13158.802617960548;13367.799483007957;13547.923609586702;14491;15126.092434453967;15976.760348595013;16344.918275408547;16444.506664800076;15281.312340944462;15302.85228607881;15389.76915346293;15435.459758908384;16140.466655667693;14142.717145657234;14884.330205141012;14914.328855201325;15816.762748559011;15962.840371596136;14646.926765366105;14802.77795833085;14811.629709257355;15070.0204486708;15302;11463.713407164554;11782.705432363917;11861.940690296493;11901.523939042341;12156.817647735113;11889.28664280146;12017.519299227934;12044.75910481768;12068.456919438471;12160.695982600506 04:42:40 INFO - PROCESS | 15441 | __end_tp_report 04:42:40 INFO - PROCESS | 15441 | __start_cc_report 04:42:40 INFO - PROCESS | 15441 | _x_x_mozilla_cycle_collect,338 04:42:40 INFO - PROCESS | 15441 | __end_cc_report 04:42:40 INFO - PROCESS | 15441 | __startTimestamp1469619760041__endTimestamp 04:42:40 INFO - PROCESS | 15441 | 04:42:40 INFO - PROCESS | 15441 | ------- Summary: start ------- 04:42:40 INFO - PROCESS | 15441 | Number of tests: 6 04:42:40 INFO - PROCESS | 15441 | 04:42:40 INFO - PROCESS | 15441 | [#0] dojo.html Cycles:165 Average:5755.06 Median:5995.33 stddev:655.99 (10.9%) stddev-sans-first:631.17 04:42:40 INFO - PROCESS | 15441 | Values: 3387.8 3441.4 3447.4 3456.3 3462.5 5697.4 5727.6 5744.9 5787.2 5790.0 5735.6 5759.7 5776.7 5786.5 5801.1 5146.6 5202.9 5248.7 5261.2 5272.5 5132.5 5305.7 5309.7 5323.4 5333.1 5132.8 5241.8 5251.0 5284.2 5304.2 5256.4 5258.2 5268.5 5283.6 5287.9 5243.3 5282.2 5337.9 5347.4 5351.7 5493.6 5549.3 5583.7 5607.6 5711.3 6114.0 6123.4 6134.9 6139.9 6158.1 6160.5 6180.6 6191.7 6197.6 6203.8 5665.7 5742.8 5762.3 5776.2 5812.9 6346.7 6370.9 6390.4 6417.6 6449.5 6022.5 6164.3 6171.7 6174.0 6178.2 6133.7 6194.4 6218.8 6228.7 6246.6 6199.3 6203.6 6204.7 6208.9 6226.8 5984.9 6022.2 6043.0 6171.7 6207.0 4678.6 4689.0 4690.7 4696.7 4710.0 4176.1 4181.6 4188.1 4197.9 4212.5 5900.6 5906.6 5907.6 5916.7 5988.3 6071.3 6136.4 6140.4 6194.6 6213.0 5984.9 5993.1 5995.3 6022.9 6045.1 5197.9 5322.8 5350.5 5379.7 5389.6 6483.2 6554.6 6577.8 6582.7 6591.5 6027.5 6319.9 6320.9 6339.6 6351.0 6330.1 6340.6 6357.9 6468.2 6479.8 6125.6 6133.0 6137.5 6138.0 6143.8 6082.2 6126.2 6222.7 6239.3 6240.0 6041.8 6115.1 6115.9 6132.7 6142.2 6035.6 6095.2 6096.8 6111.1 6114.6 5791.4 5840.7 5844.5 5926.9 5998.9 6030.3 6047.9 6065.9 6082.7 6104.5 5923.4 5930.6 5933.4 5954.6 5956.7 04:42:40 INFO - PROCESS | 15441 | 04:42:40 INFO - PROCESS | 15441 | [#1] ext.html Cycles:180 Average:67116.11 Median:46957.88 stddev:135964.15 (289.5%) stddev-sans-first:136253.85 04:42:40 INFO - PROCESS | 15441 | Values: 603.9 654.7 662.4 662.9 664.0 46950.0 48391.3 48453.8 48536.8 52341.7 49657.0 50131.7 50230.0 50410.0 50604.7 8937.3 9098.7 9117.8 9154.6 9197.3 9007.9 9047.3 9095.2 9107.9 9129.5 9126.7 9149.0 9174.7 9182.5 9197.4 9039.2 9156.7 9166.4 9186.4 9187.6 9017.5 9042.5 9062.9 9065.7 9093.6 46372.5 46552.3 46798.5 47023.8 47163.5 3864.5 3945.5 4013.9 4279.9 4526.9 34924.0 34981.0 35612.3 35697.0 37290.6 4664.8 4721.8 4753.4 4757.3 4833.8 383726.0 389591.0 392343.0 392598.0 393807.0 38174.4 67328.0 67540.0 67598.3 67783.0 39766.6 41413.4 41474.8 41594.6 41818.8 16949.0 17103.2 17127.3 17152.8 17191.6 14142.9 14332.3 14375.6 14400.1 14454.3 9311.0 9341.6 9357.0 9400.0 9437.0 3547.4 3629.5 3634.9 3641.9 3653.6 1037.3 1124.9 1127.8 1136.2 1220.6 31675.7 33993.1 34312.0 34442.8 34661.5 1130.4 1215.2 1230.5 1253.9 1270.3 17058.8 17375.8 17446.8 17536.4 17801.2 595783.0 600165.0 602695.0 602712.0 603716.0 62906.7 63019.0 63026.7 63212.4 63473.7 1516.6 1536.1 1545.4 1545.7 1565.3 31999.5 32034.0 32355.4 32537.8 32740.3 56184.0 56295.4 56313.0 56563.4 57036.1 515959.0 518330.0 522084.0 522419.0 525273.0 47040.5 48275.8 48371.0 48737.5 49063.3 51358.5 54501.5 54894.7 55338.7 56070.7 45154.3 45341.0 46024.5 46965.8 47154.8 44440.8 44652.0 45241.0 46218.1 49272.5 46181.8 46450.5 46618.1 47297.5 47344.5 38326.4 39472.6 39658.6 40150.0 40373.8 31234.5 31579.8 31652.6 31771.0 31862.2 04:42:40 INFO - PROCESS | 15441 | 04:42:40 INFO - PROCESS | 15441 | [#2] jquery.html Cycles:180 Average:29931.31 Median:13009.45 stddev:84436.19 (649.0%) stddev-sans-first:84644.00 04:42:40 INFO - PROCESS | 15441 | Values: 429.8 431.7 438.7 442.4 444.8 18995.1 19752.2 20662.5 20717.8 20724.7 18711.9 19350.1 19901.6 19930.7 19941.2 5798.4 6003.8 6032.8 6035.5 6040.6 5711.6 5864.1 5957.8 5959.3 5964.6 5902.1 5904.7 5911.7 5912.9 5921.3 5713.9 5813.7 5846.1 5876.2 5898.2 5255.8 5278.1 5283.3 5291.4 5318.9 17265.7 18545.9 22342.7 23239.0 23441.4 2577.5 2596.3 2658.1 2819.0 2962.0 14467.9 14777.0 14851.3 14864.6 15218.8 2079.8 2107.7 2145.2 2180.4 2201.2 82455.0 84312.6 84956.6 85206.0 85369.1 11285.0 11343.8 11455.9 12029.6 12208.7 15769.8 15790.0 15883.1 15911.0 15965.0 8329.2 8373.4 8427.4 8624.6 8638.1 8595.7 8732.2 8776.7 8806.5 8963.9 4817.9 4865.9 4894.0 4897.3 4952.7 2055.8 2114.9 2139.0 2152.8 2152.9 967.2 1049.6 1075.3 1085.7 1105.9 18916.7 19408.5 19660.4 19700.9 19879.4 1050.0 1084.8 1086.2 1166.9 1190.9 10601.3 10806.6 10919.3 11030.3 11043.4 503632.0 508167.0 510323.0 515235.0 523004.0 93174.0 94188.5 94313.0 95789.0 96302.5 1027.9 1030.3 1073.9 1093.0 1107.8 17124.0 17145.9 17239.7 17409.2 17582.1 38060.6 41392.4 42356.0 42702.0 44749.1 58345.4 60239.4 60278.0 60352.4 60878.7 8408.8 8603.9 8660.7 8730.0 8969.6 7516.3 9082.0 9179.7 11105.4 11972.9 11003.4 11211.9 11408.6 11414.8 11435.6 10543.8 10701.0 10778.4 10920.9 11050.2 10918.4 11282.9 11288.8 11447.3 11589.1 8974.3 9179.1 9187.9 9268.7 9504.4 10553.2 10709.7 10741.7 10998.7 11182.4 04:42:40 INFO - PROCESS | 15441 | 04:42:40 INFO - PROCESS | 15441 | [#3] mootools.html Cycles:180 Average:6362.96 Median:469.09 stddev:3694.78 (787.6%) stddev-sans-first:3687.63 04:42:40 INFO - PROCESS | 15441 | Values: 1575.1 1590.4 1797.6 1880.2 1907.9 8626.2 9250.5 9279.0 9884.9 9916.0 9328.2 9617.8 9669.4 9684.9 9705.5 2440.5 2455.1 2460.2 2474.8 2480.2 2445.5 2529.5 2531.6 2535.2 2544.4 2472.0 2487.3 2518.4 2525.2 2541.1 2305.4 2326.7 2348.9 2380.1 2395.3 2446.0 2446.2 2449.9 2462.3 2505.6 9675.9 9718.3 9729.0 9754.1 9793.1 5690.4 5879.2 5902.4 5906.9 5912.4 3655.2 3822.2 3850.2 3920.5 3950.4 1204.5 1245.8 1253.6 2347.6 2359.8 13734.2 13773.5 13854.3 13921.4 13995.9 5017.3 5066.0 5089.1 5107.8 5172.2 10876.4 10913.4 10955.0 10967.0 11002.7 5702.5 5813.8 5822.1 5830.2 5932.3 4860.1 5326.7 5426.3 5431.4 5453.5 4227.5 4262.1 4297.4 4302.1 4430.0 1230.7 1271.4 1274.4 1276.9 1288.8 869.1 988.6 1013.6 1054.8 1067.3 6481.4 6490.8 6509.5 6569.4 6572.5 453.5 461.6 467.2 471.0 473.1 4259.9 4469.4 4531.0 4534.2 4570.5 12035.8 12293.3 12316.8 12373.9 12409.0 11609.8 12050.1 12154.8 12291.8 12314.3 9102.8 9175.5 9224.0 9294.9 9310.5 6248.5 6346.9 6441.7 6455.9 6505.8 11030.8 11352.4 11431.3 11483.7 11551.8 11466.9 11487.1 11586.8 11629.8 11645.9 7775.7 8320.0 8425.9 8649.4 8789.5 9548.1 9561.1 9568.3 9578.5 9605.6 8170.7 8344.0 8408.4 8425.5 8444.3 7893.3 7910.8 8154.0 8251.1 8264.2 7683.6 7727.7 7732.0 7738.5 7755.7 5310.7 5346.7 5370.9 5388.6 5401.3 5379.2 5389.5 5429.9 5475.7 5484.8 04:42:40 INFO - PROCESS | 15441 | 04:42:40 INFO - PROCESS | 15441 | [#4] prototype.html Cycles:180 Average:5091.24 Median:5812.42 stddev:1503.45 (25.9%) stddev-sans-first:1464.51 04:42:40 INFO - PROCESS | 15441 | Values: 326.4 356.8 359.9 362.6 363.2 5680.6 5784.2 5788.0 5827.2 5850.9 5696.5 5707.8 5714.7 5714.9 5797.7 4099.7 4405.0 4530.8 4535.4 4543.5 4426.1 4448.6 4473.7 4485.1 4519.4 4434.4 4445.9 4446.8 4462.3 4498.6 4336.4 4463.0 4463.3 4471.6 4494.4 3859.9 3898.2 3924.2 3945.4 3953.3 5411.8 5456.9 5501.3 5521.4 5547.0 4932.0 5130.2 5136.9 5142.5 5151.2 5920.9 5924.6 5941.0 5948.9 5968.1 4300.9 4302.4 4328.9 4329.9 4403.4 5970.7 6174.6 6195.6 6237.7 6264.4 4419.9 4442.1 4451.8 4462.9 4488.8 4461.1 4526.8 4529.5 4534.2 4546.3 5047.7 5135.0 5140.3 5143.5 5151.7 5920.6 5988.7 6002.2 6018.1 6035.9 1570.9 1582.8 1587.5 1589.6 1589.6 992.6 1003.4 1014.6 1017.6 1019.4 5661.6 5854.2 5874.7 5881.3 5897.6 6147.5 6148.2 6176.2 6220.5 6244.6 5789.7 5876.2 5888.1 5888.4 5896.0 3299.8 3307.7 3324.3 3334.5 3337.5 6265.7 6404.6 6467.9 6495.7 6552.7 6349.2 6363.6 6372.2 6381.3 6395.0 6268.7 6449.9 6482.4 6536.6 6596.2 6193.7 6194.5 6213.1 6237.3 6298.9 6169.8 6191.5 6204.2 6211.8 6219.7 6197.9 6498.6 6523.2 6528.4 6556.3 4330.8 4334.7 4350.2 4362.6 4374.5 6118.4 6130.9 6212.6 6236.9 6284.7 6013.8 6013.9 6071.3 6081.3 6113.6 5998.3 6077.5 6091.9 6117.7 6159.8 5693.3 5790.9 5965.1 5967.9 5971.9 6044.5 6072.9 6084.8 6091.8 6092.6 5946.7 5956.6 5964.4 5983.9 5996.9 04:42:40 INFO - PROCESS | 15441 | 04:42:40 INFO - PROCESS | 15441 | [#5] yui.html Cycles:180 Average:21100.41 Median:4208.33 stddev:28979.61 (688.6%) stddev-sans-first:29020.73 04:42:40 INFO - PROCESS | 15441 | Values: 779.4 804.9 855.5 889.1 911.8 17967.7 18345.9 18569.2 18602.6 18640.6 16037.2 16054.8 16084.9 16118.4 16122.7 738.8 870.9 890.4 892.7 897.6 872.9 875.3 877.1 877.4 886.4 930.9 932.5 932.8 934.3 934.7 921.6 922.5 923.8 927.8 928.8 676.9 682.5 682.9 683.0 684.6 16590.6 16651.1 16707.0 16711.2 16737.5 14976.4 15407.2 15531.9 15641.5 15790.0 12908.5 12917.7 13076.2 13199.5 13402.9 4067.5 4150.6 4152.7 4154.7 4262.0 70065.0 71801.6 71810.3 83373.2 83465.2 12766.3 12968.4 12990.5 13047.5 13416.9 21357.5 21850.7 23495.3 23559.0 23582.9 9232.9 9277.9 9397.6 9463.3 9719.3 5141.1 5199.8 5204.7 5259.7 5263.3 3985.4 4118.7 4125.4 4126.9 4132.3 726.4 729.0 739.6 745.6 746.3 719.9 732.6 759.7 802.6 826.0 10617.5 10782.1 10819.1 10860.7 10988.8 752.9 757.8 775.0 795.5 825.0 4928.5 4947.4 4984.2 4986.8 5008.2 110649.4 113059.4 115730.0 117678.0 118682.0 59716.4 82663.0 87581.6 93624.5 94491.0 86702.6 88505.0 88758.0 90705.0 90740.0 9880.3 9907.3 9972.1 10001.6 10065.3 51820.5 52288.0 52873.2 53647.9 54153.0 66227.0 67295.0 76597.6 76822.0 77190.6 12516.6 13063.6 13158.8 13367.8 13547.9 14491.0 15126.1 15976.8 16344.9 16444.5 15281.3 15302.9 15389.8 15435.5 16140.5 14142.7 14884.3 14914.3 15816.8 15962.8 14646.9 14802.8 14811.6 15070.0 15302.0 11463.7 11782.7 11861.9 11901.5 12156.8 11889.3 12017.5 12044.8 12068.5 12160.7 04:42:40 INFO - PROCESS | 15441 | -------- Summary: end -------- 04:42:40 INFO - PROCESS | 15441 | 04:42:40 INFO - TEST-INFO | 15441: exit 0 04:42:40 INFO - TEST-OK | dromaeo_css | took 1111961ms 04:42:40 INFO - TEST-START | kraken 04:42:40 INFO - operating with platform_type : linux_ 04:42:40 INFO - Initialising browser for kraken test... 04:42:40 INFO - TEST-INFO | started process 15687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ9dfaT/profile http://localhost:56095/getInfo.html) 04:42:46 INFO - PROCESS | 15687 | __metrics Screen width/height:1600/1200 04:42:46 INFO - PROCESS | 15687 | colorDepth:24 04:42:46 INFO - PROCESS | 15687 | Browser inner width/height: 1024/697 04:42:46 INFO - PROCESS | 15687 | __metrics 04:42:47 ERROR - PROCESS | 15687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:42:47 INFO - TEST-INFO | 15687: exit 0 04:42:47 INFO - Browser initialized. 04:42:47 INFO - Running cycle 1/1 for kraken test... 04:42:47 INFO - TEST-INFO | started process 15818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ9dfaT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:59 INFO - PROCESS | 15818 | RSS: Main: 156037120 04:42:59 INFO - PROCESS | 15818 | 04:43:02 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56095/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:03 INFO - PROCESS | 15818 | RSS: Main: 161292288 04:43:03 INFO - PROCESS | 15818 | 04:43:05 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56095/tests/kraken/driver.html?testName=audio-dft) 04:43:06 INFO - PROCESS | 15818 | RSS: Main: 160583680 04:43:06 INFO - PROCESS | 15818 | 04:43:09 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56095/tests/kraken/driver.html?testName=audio-fft) 04:43:09 INFO - PROCESS | 15818 | RSS: Main: 161665024 04:43:09 INFO - PROCESS | 15818 | 04:43:12 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56095/tests/kraken/driver.html?testName=audio-oscillator) 04:43:12 INFO - PROCESS | 15818 | RSS: Main: 160673792 04:43:12 INFO - PROCESS | 15818 | 04:43:14 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56095/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:15 INFO - PROCESS | 15818 | RSS: Main: 161267712 04:43:15 INFO - PROCESS | 15818 | 04:43:18 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56095/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:19 INFO - PROCESS | 15818 | RSS: Main: 160808960 04:43:19 INFO - PROCESS | 15818 | 04:43:22 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56095/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:23 INFO - PROCESS | 15818 | RSS: Main: 161579008 04:43:23 INFO - PROCESS | 15818 | 04:43:25 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56095/tests/kraken/driver.html?testName=json-parse-financial) 04:43:26 INFO - PROCESS | 15818 | RSS: Main: 160714752 04:43:26 INFO - PROCESS | 15818 | 04:43:28 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56095/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:28 INFO - PROCESS | 15818 | RSS: Main: 160456704 04:43:28 INFO - PROCESS | 15818 | 04:43:30 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56095/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:31 INFO - PROCESS | 15818 | RSS: Main: 160890880 04:43:31 INFO - PROCESS | 15818 | 04:43:33 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56095/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:33 INFO - PROCESS | 15818 | RSS: Main: 161300480 04:43:33 INFO - PROCESS | 15818 | 04:43:36 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:36 INFO - PROCESS | 15818 | RSS: Main: 161005568 04:43:36 INFO - PROCESS | 15818 | 04:43:39 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:43:40 INFO - PROCESS | 15818 | RSS: Main: 160927744 04:43:40 INFO - PROCESS | 15818 | 04:43:41 INFO - PROCESS | 15818 | Cycle 1(1): loaded http://localhost:56095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56095/tests/kraken/driver.html?testName=ai-astar) 04:43:42 INFO - PROCESS | 15818 | RSS: Main: 161734656 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | __start_tp_report 04:43:42 INFO - PROCESS | 15818 | _x_x_mozilla_page_load 04:43:42 INFO - PROCESS | 15818 | _x_x_mozilla_page_load_details 04:43:42 INFO - PROCESS | 15818 | |i|pagename|runs| 04:43:42 INFO - PROCESS | 15818 | |0;ai-astar;109;103;110;111;111;112;109;110;111;111 04:43:42 INFO - PROCESS | 15818 | |1;audio-beat-detection;158;124;152;184;128;156;150;127;182;129 04:43:42 INFO - PROCESS | 15818 | |2;audio-dft;163;162;163;162;162;164;165;165;162;162 04:43:42 INFO - PROCESS | 15818 | |3;audio-fft;76;75;88;177;76;76;75;75;164;76 04:43:42 INFO - PROCESS | 15818 | |4;audio-oscillator;84;85;152;85;85;84;139;84;84;151 04:43:42 INFO - PROCESS | 15818 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;117;118;118 04:43:42 INFO - PROCESS | 15818 | |6;imaging-darkroom;151;148;146;147;152;148;147;147;148;147 04:43:42 INFO - PROCESS | 15818 | |7;imaging-desaturate;95;96;95;95;95;96;96;96;95;96 04:43:42 INFO - PROCESS | 15818 | |8;json-parse-financial;50;51;50;50;51;56;52;52;50;54 04:43:42 INFO - PROCESS | 15818 | |9;json-stringify-tinderbox;61;61;60;61;64;61;61;61;61;61 04:43:42 INFO - PROCESS | 15818 | |10;stanford-crypto-aes;76;77;83;77;77;82;82;84;99;76 04:43:42 INFO - PROCESS | 15818 | |11;stanford-crypto-ccm;125;132;119;124;133;122;136;119;128;120 04:43:42 INFO - PROCESS | 15818 | |12;stanford-crypto-pbkdf2;156;153;155;153;162;153;158;155;159;151 04:43:42 INFO - PROCESS | 15818 | |13;stanford-crypto-sha256-iterative;71;66;61;62;62;62;62;60;60;64 04:43:42 INFO - PROCESS | 15818 | __end_tp_report 04:43:42 INFO - PROCESS | 15818 | __start_cc_report 04:43:42 INFO - PROCESS | 15818 | _x_x_mozilla_cycle_collect,888 04:43:42 INFO - PROCESS | 15818 | __end_cc_report 04:43:42 INFO - PROCESS | 15818 | __startTimestamp1469619822154__endTimestamp 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | ------- Summary: start ------- 04:43:42 INFO - PROCESS | 15818 | Number of tests: 14 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:2.54 (2.3%) stddev-sans-first:2.68 04:43:42 INFO - PROCESS | 15818 | Values: 109.0 103.0 110.0 111.0 111.0 112.0 109.0 110.0 111.0 111.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.00 stddev:22.12 (14.4%) stddev-sans-first:23.22 04:43:42 INFO - PROCESS | 15818 | Values: 158.0 124.0 152.0 184.0 128.0 156.0 150.0 127.0 182.0 129.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 04:43:42 INFO - PROCESS | 15818 | Values: 163.0 162.0 163.0 162.0 162.0 164.0 165.0 165.0 162.0 162.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#3] audio-fft Cycles:10 Average:95.80 Median:76.00 stddev:39.68 (52.2%) stddev-sans-first:41.44 04:43:42 INFO - PROCESS | 15818 | Values: 76.0 75.0 88.0 177.0 76.0 76.0 75.0 75.0 164.0 76.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:84.00 stddev:30.58 (36.4%) stddev-sans-first:31.63 04:43:42 INFO - PROCESS | 15818 | Values: 84.0 85.0 152.0 85.0 85.0 84.0 139.0 84.0 84.0 151.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:43:42 INFO - PROCESS | 15818 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.91 (1.3%) stddev-sans-first:1.72 04:43:42 INFO - PROCESS | 15818 | Values: 151.0 148.0 146.0 147.0 152.0 148.0 147.0 147.0 148.0 147.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:43:42 INFO - PROCESS | 15818 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.50 stddev:2.01 (3.9%) stddev-sans-first:2.05 04:43:42 INFO - PROCESS | 15818 | Values: 50.0 51.0 50.0 50.0 51.0 56.0 52.0 52.0 50.0 54.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:1.03 (1.7%) stddev-sans-first:1.09 04:43:42 INFO - PROCESS | 15818 | Values: 61.0 61.0 60.0 61.0 64.0 61.0 61.0 61.0 61.0 61.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:6.96 (8.5%) stddev-sans-first:7.11 04:43:42 INFO - PROCESS | 15818 | Values: 76.0 77.0 83.0 77.0 77.0 82.0 82.0 84.0 99.0 76.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.50 stddev:6.18 (4.9%) stddev-sans-first:6.55 04:43:42 INFO - PROCESS | 15818 | Values: 125.0 132.0 119.0 124.0 133.0 122.0 136.0 119.0 128.0 120.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:155.50 stddev:3.34 (2.1%) stddev-sans-first:3.54 04:43:42 INFO - PROCESS | 15818 | Values: 156.0 153.0 155.0 153.0 162.0 153.0 158.0 155.0 159.0 151.0 04:43:42 INFO - PROCESS | 15818 | 04:43:42 INFO - PROCESS | 15818 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:62.00 stddev:3.33 (5.4%) stddev-sans-first:1.90 04:43:42 INFO - PROCESS | 15818 | Values: 71.0 66.0 61.0 62.0 62.0 62.0 62.0 60.0 60.0 64.0 04:43:42 INFO - PROCESS | 15818 | -------- Summary: end -------- 04:43:42 INFO - PROCESS | 15818 | 04:43:43 INFO - TEST-INFO | 15818: exit 0 04:43:43 INFO - TEST-OK | kraken | took 62354ms 04:43:43 INFO - SUITE-END | took 1174s 04:43:43 INFO - Completed test suite (00:19:34) 04:43:43 INFO - javascript benchmark 04:43:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7728.05122751748, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3387.813670248136, 3441.3633477806607, 3447.3794716950947, 3456.3432947739943, 3462.463318185682, 5697.4017728138515, 5727.627704199234, 5744.856378590537, 5787.189793428918, 5790.044642633966, 5735.569832262576, 5759.654420734749, 5776.740046697898, 5786.479216870481, 5801.129830525423, 5146.5625421839095, 5202.947970520303, 5248.6588371755715, 5261.158214685651, 5272.499112584298, 5132.461091585367, 5305.734713264322, 5309.681419114865, 5323.387810401795, 5333.093374126388, 5132.820351287705, 5241.79032838686, 5251.0023095611905, 5284.2073688946775, 5304.177852432879, 5256.448072952342, 5258.211268309746, 5268.4994925482015, 5283.63014588979, 5287.894242115136, 5243.318368612094, 5282.2076688496645, 5337.946620533823, 5347.41178470368, 5351.7056561889085, 5493.615446918718, 5549.334079910396, 5583.664980101207, 5607.579431542651, 5711.343195532525, 6114.0217565189805, 6123.418275263843, 6134.9079763803575, 6139.938600613981, 6158.076288556752, 6160.537959653044, 6180.567360284782, 6191.690415479253, 6197.597156184834, 6203.7828675996125, 5665.688387138705, 5742.770289188427, 5762.3373312069225, 5776.220210271602, 5812.854678633068, 6346.746130154742, 6370.948793449122, 6390.392912673288, 6417.647029413427, 6449.5485316027425, 6022.45797878193, 6164.321924588292, 6171.660558669317, 6174.0, 6178.227721534809, 6133.723982420713, 6194.4115309045565, 6218.751249949952, 6228.657423841732, 6246.562740608114, 6199.256089269316, 6203.596766210182, 6204.689765511796, 6208.937910620926, 6226.844328891814, 5984.8803023940145, 6022.247219097613, 6042.969785151046, 6171.660558669227, 6206.968965155235, 4678.555537223959, 4688.976555117202, 4690.718556886598, 4696.7416792076765, 4709.95290047102, 4176.14389050244, 4181.623653871166, 4188.099558594917, 4197.895052623648, 4212.473440819897, 5900.586958912921, 5906.645601263938, 5907.586468947218, 5916.7337469813965, 5988.311344195473, 6071.2714474263375, 6136.386361363828, 6140.3552626974415, 6194.628322300677, 6213.0, 5984.880302393928, 5993.0710739835395, 5995.333867268888, 6022.939770602238, 6045.1234570987845, 5197.922031169535, 5322.787088516416, 5350.491703288181, 5379.704116273564, 5389.622726409114, 6483.157189565326, 6554.606723596599, 6577.835554111186, 6582.703778329891, 6591.472682185414, 6027.487663548647, 6319.873602528016, 6320.905186422116, 6339.587926784744, 6351.0, 6330.082138089859, 6340.556161068681, 6357.872842543031, 6468.223813142453, 6479.773207937699, 6125.571210015256, 6132.969335153296, 6137.508999280136, 6138.048602466625, 6143.846403839761, 6082.239720034996, 6126.181801871033, 6222.657753823583, 6239.344868788893, 6240.0, 6041.78853740117, 6115.057807493917, 6115.9156198811215, 6132.6664570199355, 6142.191841058572, 6035.637861728311, 6095.1771510845465, 6096.847578810565, 6111.052786818051, 6114.57197996136, 5791.420857914175, 5840.678762668094, 5844.47399734026, 5926.911096333472, 5998.9100163496705, 6030.336662967158, 6047.9395206047375, 6065.939340606537, 6082.665453400105, 6104.481119104926, 5923.437273459014, 5930.584859059824, 5933.376995415592, 5954.612950158225, 5956.672383018976], "value": 5711.233287682628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.9003564411872, 654.7381047580968, 662.4402379988911, 662.8707402056601, 663.9834004149895, 46950.0, 48391.27413088798, 48453.757731211335, 48536.757316213414, 52341.73829130849, 49657.0, 50131.74934125334, 50230.0, 50410.0, 50604.74697626516, 8937.329700272474, 9098.681546145886, 9117.772055698595, 9154.633814647406, 9197.264218862474, 9007.864882026775, 9047.321450891177, 9095.226905713022, 9107.863382049274, 9129.543522823833, 9126.726198214032, 9149.039350868163, 9174.678886238982, 9182.540872956359, 9197.356185067049, 9039.186473217409, 9156.725298241063, 9166.40418372807, 9186.356955013152, 9187.586558604846, 9017.504037277948, 9042.502662353569, 9062.864057039149, 9065.728028159167, 9093.63625454981, 46372.53627463716, 46552.30171547429, 46798.53201467976, 47023.76488117572, 47163.5283647166, 3864.4976153099915, 3945.5315935635404, 4013.8795836124964, 4279.914401711948, 4526.909461810746, 34924.0, 34981.0, 35612.28775424503, 35697.0, 37290.62709372926, 4664.813407463697, 4721.763911804431, 4753.405824271966, 4757.333973243749, 4833.782479788418, 383726.0, 389591.0, 392343.0, 392598.0, 393807.0309648462, 38174.42738358927, 67328.0, 67540.0, 67598.3240167592, 67783.0, 39766.602333976865, 41413.37879931804, 41474.79262603668, 41594.58405415968, 41818.790906045884, 16949.0, 17103.23035463407, 17127.314907403812, 17152.828471715373, 17191.57021074483, 14142.929285353508, 14332.283385830875, 14375.568732938029, 14400.135991840523, 14454.349554270084, 9310.95344523273, 9341.626334946663, 9357.0, 9399.953000234955, 9436.95281523588, 3547.3614749345365, 3629.491871138043, 3634.9091272717865, 3641.8725344612812, 3653.5615726113037, 1037.2687255484866, 1124.942553999238, 1127.8421021057059, 1136.1654416344836, 1220.6155061155707, 31675.683243167736, 33993.130377828966, 34312.0, 34442.82778586091, 34661.48007779886, 1130.4121856634504, 1215.173681896319, 1230.4954968462887, 1253.8934190593902, 1270.326726834779, 17058.829411705974, 17375.826241737675, 17446.825531744773, 17536.386226482013, 17801.198946047458, 595783.0, 600165.0, 602695.0, 602712.0, 603716.0, 62906.68546657329, 63019.0, 63026.68486657629, 63212.367876321565, 63473.68263158655, 1516.564050153297, 1536.1474381718253, 1545.4436402894949, 1545.7217700813962, 1565.2721484509757, 31999.520007200375, 32034.03897883067, 32355.35289294248, 32537.837310813295, 32740.34519309648, 56184.0, 56295.43704562902, 56313.0, 56563.43436565582, 57036.144457832335, 515959.0, 518330.0, 522084.0, 522419.0, 525273.0, 47040.52959470498, 48275.75862120667, 48371.0, 48737.5126248733, 49063.264051038546, 51358.48641513537, 54501.454985449636, 54894.72552637211, 55338.72330638321, 56070.71964640151, 45154.322685159095, 45341.0, 46024.539754602025, 46965.76517117392, 47154.764226178646, 44440.7777961121, 44652.0, 45241.0, 46218.07563848772, 49272.50727492679, 46181.76909115433, 46450.535494644624, 46618.13527458999, 47297.527024729316, 47344.52655473539, 38326.42510362291, 39472.605273946894, 39658.603413966644, 40150.01168857634, 40373.798131009156, 31234.531482028244, 31579.84210078935, 31652.634660131003, 31771.0, 31862.203444913135], "value": 21004.41779187852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.77007301093903, 431.73232595790614, 438.7463540970292, 442.3696232868162, 444.7509394738946, 18995.145218465168, 19752.209911603535, 20662.48343791406, 20717.792822071773, 20724.689129663067, 18711.906440467814, 19350.12924418401, 19901.601967960632, 19930.70103948442, 19941.202351905944, 5798.362180160179, 6003.8198854034445, 6032.758689652409, 6035.547333949971, 6040.637561746309, 5711.628744131639, 5864.149698293745, 5957.821265362046, 5959.255093113361, 5964.552658550626, 5902.055671092626, 5904.7047647617665, 5911.674857882815, 5912.9113063304085, 5921.259842519685, 5713.8571535711735, 5813.7383817728305, 5846.064629659277, 5876.177335173079, 5898.233229680157, 5255.842324730264, 5278.1291086970605, 5283.339582552181, 5291.3650361956425, 5318.9202161967605, 17265.741013884803, 18545.907270463696, 22342.66486002711, 23239.0, 23441.41396465085, 2577.484503099369, 2596.337933826881, 2658.1493921944984, 2819.0, 2961.9703802962126, 14467.927660361736, 14777.0, 14851.331690073865, 14864.554063378117, 15218.847811521853, 2079.7712251652306, 2107.6627739561595, 2145.1633862793524, 2180.356794745554, 2201.1745595401726, 82455.0, 84312.57843710804, 84956.57521712413, 85206.0, 85369.14630853674, 11285.0, 11343.829842552368, 11455.942720286344, 12029.639110826514, 12208.694782630328, 15769.763453548207, 15790.0, 15883.126428046568, 15911.0, 15964.962277451928, 8329.167083291622, 8373.371997100241, 8427.367947403969, 8624.611892464854, 8638.09300023501, 8595.742127736177, 8732.214100730966, 8776.692815751418, 8806.515641639644, 8963.865542016874, 4817.855464336076, 4865.9026819463415, 4894.0, 4897.338859253955, 4952.702837829742, 2055.825254853354, 2114.8519603627597, 2138.967915481269, 2152.763196048433, 2152.9246476373564, 967.2310513142069, 1049.6483677967967, 1075.349413604758, 1085.699473600262, 1105.8894110588876, 18916.71624925627, 19408.514787130436, 19660.410187694393, 19700.90149549243, 19879.403617891487, 1050.0077426831572, 1084.8210045342587, 1086.239632257423, 1166.859976802789, 1190.8511436070492, 10601.25791194609, 10806.567737290421, 10919.290246133976, 11030.28303160292, 11043.39261340634, 503632.0, 508167.0, 510323.0, 515235.0, 523004.0, 93174.0, 94188.52905735427, 94313.0, 95789.0, 96302.51848740711, 1027.9331843430152, 1030.3354336453096, 1073.8603981482356, 1093.038126448736, 1107.8227483602584, 17124.0, 17145.91427042857, 17239.65520689604, 17409.216585253947, 17582.120893954994, 38060.61939380682, 41392.37911431391, 42356.0, 42702.0, 44749.10501789881, 58345.416545835695, 60239.397606023376, 60278.0, 60352.39647603643, 60878.69560652169, 8408.831823363376, 8603.913960860562, 8660.740177794676, 8729.956350218208, 8969.641214351353, 7516.323530882247, 9082.046385129466, 9179.714839922282, 11105.38920359388, 11972.940135299268, 11003.449827508432, 11211.887881121085, 11408.600698975495, 11414.828777568177, 11435.59975400857, 10543.789124217627, 10701.0, 10778.353298802096, 10920.890791092304, 11050.171237157085, 10918.399488027917, 11282.887171128184, 11288.774224515299, 11447.25592836463, 11589.072874170215, 8974.282057435259, 9179.127982841619, 9187.908120918706, 9268.675596354095, 9504.382215155993, 10553.208509361675, 10709.732256693333, 10741.731456713645, 10998.725031874266, 11182.440877955907], "value": 9504.285453551638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1575.0549670197884, 1590.3797518967601, 1797.5506123469133, 1880.2291060665113, 1907.923683052678, 8626.22363987241, 9250.491222982733, 9278.953605231982, 9884.851727224088, 9915.950420247907, 9328.207102396305, 9617.807643847118, 9669.37149085309, 9684.854727179098, 9705.514724263794, 2440.463098118411, 2455.0670745116877, 2460.1512478194995, 2474.8020158387285, 2480.231128350217, 2445.4742230420457, 2529.519391315644, 2531.556977528934, 2535.150724507292, 2544.3511904464335, 2472.0359059966627, 2487.253823852846, 2518.4207632244593, 2525.1666949906485, 2541.1487151804076, 2305.3890718959487, 2326.7440581536016, 2348.870812105342, 2380.143148466551, 2395.341281147681, 2446.033816642434, 2446.2294377271282, 2449.889754961031, 2462.335169504224, 2505.5991041433285, 9675.854862177073, 9718.271129665303, 9728.951355243249, 9754.073363030571, 9793.069658382443, 5690.40250773667, 5879.235699359098, 5902.409759024106, 5906.852328691817, 5912.408759124053, 3655.214128962259, 3822.197338558906, 3850.2299540091813, 3920.5295364556437, 3950.3679411294343, 1204.4640135139866, 1245.7882160032816, 1253.6301790971686, 2347.612643913752, 2359.8112151027876, 13734.175949442966, 13773.517926872611, 13854.307284635828, 13921.373538190806, 13995.86004139966, 5017.297578339036, 5065.9746701266995, 5089.134847076006, 5107.770150343244, 5172.172452407597, 10876.401797901191, 10913.399763012952, 10955.0, 10967.012968832843, 11002.724931876606, 5702.54379649627, 5813.82558523245, 5822.097574875901, 5830.183774271605, 5932.2881254248905, 4860.125177468019, 5326.707031113248, 5426.321709786277, 5431.37539182999, 5453.481919217747, 4227.492700875914, 4262.147570485915, 4297.376880352332, 4302.139572085595, 4430.047539778963, 1230.7046308885804, 1271.4024408527978, 1274.4265080713717, 1276.910616256853, 1288.845338559379, 869.1352104655908, 988.604558176735, 1013.5591017907234, 1054.8291396549823, 1067.3329169269207, 6481.351864813481, 6490.772822951174, 6509.544331896816, 6569.441597464173, 6572.474202063823, 453.4626467635862, 461.6099396010366, 467.2010861426998, 470.98116075357285, 473.07985967293973, 4259.87220383389, 4469.374287599739, 4530.954690453119, 4534.161180181677, 4570.520095389937, 12035.75928481443, 12293.323867187211, 12316.753664926831, 12373.93813030929, 12409.0, 11609.825852612217, 12050.096242781827, 12154.756904861853, 12291.815622765665, 12314.261144331369, 9102.81663383756, 9175.495347755805, 9224.0, 9294.86057709135, 9310.53447327631, 6248.4688801452385, 6346.873062538631, 6441.67791610427, 6455.870882582416, 6505.772297969737, 11030.834537482106, 11352.432378380883, 11431.314121152758, 11483.712907177387, 11551.826722599335, 11466.885331146581, 11487.138464615355, 11586.76826463483, 11629.825552616549, 11645.88354116448, 7775.688972441039, 8320.0, 8425.915740842758, 8649.437786543855, 8789.472631642122, 9548.092931171528, 9561.139497445263, 9568.282378821756, 9578.521073946136, 9605.567749451431, 8170.673173073011, 8344.0, 8408.369372297224, 8425.4944703318, 8444.324454043784, 7893.250141236574, 7910.841783164189, 8154.0, 8251.051129120227, 8264.21489958453, 7683.615819209129, 7727.652255648622, 7732.0, 7738.458307918391, 7755.72854950074, 5310.654807437504, 5346.724908130888, 5370.892582148257, 5388.595855310789, 5401.297831282065, 5379.2469054333205, 5389.541888939327, 5429.945700542944, 5475.67145971243, 5484.808031718871], "value": 4984.844887729619, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.409199349178, 356.83050550988276, 359.8776416018554, 362.6174386022745, 363.17740318179347, 5680.602357834953, 5784.1902133701215, 5788.0, 5827.155062515938, 5850.853728656785, 5696.458836410545, 5707.828765137042, 5714.657120572769, 5714.885702285952, 5797.681127537984, 4099.692523060782, 4404.98685302379, 4530.75080870552, 4535.365048893141, 4543.5456454354635, 4426.092651006552, 4448.621867141297, 4473.66447516436, 4485.080558485519, 4519.4124763780665, 4434.445694288214, 4445.911081778362, 4446.7554284514335, 4462.286034234523, 4498.595126438619, 4336.392904993303, 4463.0, 4463.285874260119, 4471.642268618519, 4494.438195225597, 3859.903502412434, 3898.161895192519, 3924.1955399143108, 3945.368741001426, 3953.2884080865433, 5411.83764487066, 5456.863578410532, 5501.257330260443, 5521.4478552144465, 5547.0, 4931.975340123312, 5130.153144867844, 5136.897262054738, 5142.460041695643, 5151.227315902607, 5920.875033743575, 5924.58527903047, 5940.970295148497, 5948.940510594882, 5968.135295058353, 4300.88177073963, 4302.41917341158, 4328.935065974013, 4329.935050974238, 4403.4495688039, 5970.701464926737, 6174.567780255384, 6195.597286176384, 6237.660877171061, 6264.4362007419095, 4419.9337009944875, 4442.067165895133, 4451.844185453494, 4462.866114016585, 4488.753118578445, 4461.13007963444, 4526.751028693454, 4529.5243999380245, 4534.161180181677, 4546.340780586796, 5047.747612619428, 5134.974325128351, 5140.278006867667, 5143.537081662594, 5151.742412879341, 5920.555958303058, 5988.700564971734, 6002.199340197923, 6018.097285407224, 6035.939640603626, 1570.9371625135095, 1582.754673025683, 1587.5078725595104, 1589.5549246211078, 1589.6105454163574, 992.6153016541883, 1003.3795420396153, 1014.5586669798661, 1017.5777052523268, 1019.4087429291142, 5661.575381846378, 5854.238948936696, 5874.706264686749, 5881.294244690579, 5897.616654917417, 6147.538934579924, 6148.1699970503405, 6176.197094377792, 6220.502359811204, 6244.625322480666, 5789.681567513827, 5876.206712093813, 5888.087346461305, 5888.381719919433, 5895.970520147458, 3299.835008249578, 3307.6692330767214, 3324.2852786650988, 3334.483155110962, 3337.4826901830256, 6265.686715664198, 6404.647744374104, 6467.935320646828, 6495.6752162391695, 6552.705128269239, 6349.238091429058, 6363.618182908947, 6372.203474565679, 6381.266154392211, 6395.040743888454, 6268.686565671789, 6449.903251451232, 6482.384173503509, 6536.607803531803, 6596.175478065242, 6193.659348735863, 6194.451387153212, 6213.099100630474, 6237.28271248794, 6298.874022519615, 6169.84575385601, 6191.535634827316, 6204.193454850841, 6211.81364559064, 6219.689015549114, 6197.946349120751, 6498.595519657568, 6523.151990241428, 6528.445082167879, 6556.2788093310655, 4330.761808100585, 4334.696571239983, 4350.1734670412525, 4362.585554372329, 4374.496932852635, 6118.388161184024, 6130.877382452415, 6212.63322069144, 6236.906446403398, 6284.654344011124, 6013.849653758516, 6013.9097913532205, 6071.301800292847, 6081.331053584014, 6113.633182009094, 5998.310194327533, 6077.544184186292, 6091.939080609137, 6117.724702388492, 6159.846003849761, 5693.28833895763, 5790.85522861915, 5965.105234214902, 5967.91048134287, 5971.880562388815, 6044.546659000504, 6072.939270607238, 6084.847878803065, 6091.786787462417, 6092.603980741238, 5946.702664866652, 5956.612820166675, 5964.403559644001, 5983.875724118049, 5996.940030599638], "value": 4609.956748395009, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.3842864137329, 804.9275565199134, 855.5294587976612, 889.1330952321487, 911.7766147293912, 17967.730484042735, 18345.90827045866, 18569.164387602574, 18602.627947441044, 18640.627187456244, 16037.198140093007, 16054.75917861233, 16084.919575402108, 16118.435854745087, 16122.677546449064, 738.8226825561853, 870.8780770692108, 890.4301247201796, 892.7232557907037, 897.6274845938927, 872.9170728780756, 875.312879389676, 877.1316396767219, 877.4209022045451, 886.4371124336028, 930.8976012638605, 932.5104320231865, 932.8246409523981, 934.2619330728717, 934.6681927915594, 921.6267411698273, 922.4880191493752, 923.7829110159107, 927.8283517549241, 928.7817362919709, 676.9187697476285, 682.474494639125, 682.8600136971909, 682.9863402731967, 684.5584597934354, 16590.585235369093, 16651.084190369525, 16707.0, 16711.247993840305, 16737.497875063767, 14976.400943962228, 15407.152606606633, 15531.922340388226, 15641.452549160838, 15790.0, 12908.54820081302, 12917.741645167043, 13076.215427074407, 13199.472021119143, 13402.865971340358, 4067.51189857219, 4150.626443620058, 4152.688548358855, 4154.667626589866, 4262.0, 70065.0, 71801.6409917947, 71810.28189718089, 83373.16626833714, 83465.16534834696, 12766.29785361814, 12968.416421261067, 12990.480380784662, 13047.543335983384, 13416.932915335556, 21357.46606334854, 21850.672239916414, 23495.295141145794, 23559.0, 23582.882085589463, 9232.90767092334, 9277.90722092784, 9397.57710903011, 9463.290253230898, 9719.319647624598, 5141.100307446182, 5199.792008319625, 5204.661696989683, 5259.658122222043, 5263.289455923401, 3985.4221137934837, 4118.670506359544, 4125.401816736557, 4126.855560055384, 4132.33882578786, 726.4079774983477, 728.970841166358, 739.593223726948, 745.6048294403975, 746.3133916796452, 719.9208087110413, 732.5677850068486, 759.6809340077181, 802.5866678660494, 825.9628316725762, 10617.522211500502, 10782.083522900484, 10819.098991109717, 10860.728481788019, 10988.835167472495, 752.9308382097435, 757.7916073079947, 774.996379688305, 795.4710117771733, 824.9670013199525, 4928.531789479994, 4947.356843610308, 4984.2025275955675, 4986.750662466862, 5008.223725322581, 110649.44675276573, 113059.43470282597, 115730.0, 117678.0, 118682.0, 59716.40283597195, 82663.0, 87581.56209218912, 93624.53187734018, 94491.0, 86702.56648716716, 88504.9999999987, 88758.0, 90705.0, 90740.0, 9880.308378413729, 9907.256955728206, 9972.102510774064, 10001.649942251986, 10065.295429320171, 51820.481795181564, 52288.0, 52873.20690189573, 53647.92704145817, 54153.0, 66227.0, 67294.99057514043, 76597.61701191458, 76822.0, 77190.6140469294, 12516.624501264976, 13063.608091757262, 13158.802617960548, 13367.799483007957, 13547.923609586702, 14491.0, 15126.092434453967, 15976.760348595013, 16344.918275408547, 16444.506664800076, 15281.312340944462, 15302.85228607881, 15389.76915346293, 15435.459758908384, 16140.466655667693, 14142.717145657234, 14884.330205141012, 14914.328855201325, 15816.762748559011, 15962.840371596136, 14646.926765366105, 14802.77795833085, 14811.629709257355, 15070.0204486708, 15302.0, 11463.713407164554, 11782.705432363917, 11861.940690296493, 11901.523939042341, 12156.817647735113, 11889.28664280146, 12017.519299227934, 12044.75910481768, 12068.456919438471, 12160.695982600506], "value": 8129.642757469198, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 103.0, 110.0, 111.0, 111.0, 112.0, 109.0, 110.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 152.0, 184.0, 128.0, 156.0, 150.0, 127.0, 182.0, 129.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 162.0, 164.0, 165.0, 165.0, 162.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 88.0, 177.0, 76.0, 76.0, 75.0, 75.0, 164.0, 76.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 152.0, 85.0, 85.0, 84.0, 139.0, 84.0, 84.0, 151.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 146.0, 147.0, 152.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 50.0, 51.0, 56.0, 52.0, 52.0, 50.0, 54.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 64.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 83.0, 77.0, 77.0, 82.0, 82.0, 84.0, 99.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 132.0, 119.0, 124.0, 133.0, 122.0, 136.0, 119.0, 128.0, 120.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 155.0, 153.0, 162.0, 153.0, 158.0, 155.0, 159.0, 151.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 61.0, 62.0, 62.0, 62.0, 62.0, 60.0, 60.0, 64.0], "value": 63.0, "unit": "score"}]}]} 04:43:43 INFO - Return code: 0 04:43:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:43:43 ERROR - # TBPL SUCCESS # 04:43:43 INFO - Running post-action listener: _resource_record_post_action 04:43:43 INFO - ##### 04:43:43 INFO - ##### Finished run-tests step (success) 04:43:43 INFO - ##### 04:43:43 INFO - Running post-run listener: _resource_record_post_run 04:43:43 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 509657088; Read time: 0; Write time: 922420 04:43:43 INFO - TinderboxPrint: CPU usage
13.4% 04:43:43 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:43:43 INFO - TinderboxPrint: I/O write bytes / time
509,657,088 / 922,420 04:43:43 INFO - TinderboxPrint: CPU idle
8,234.9 (86.6%) 04:43:43 INFO - TinderboxPrint: CPU user
1,212.4 (12.7%) 04:43:43 INFO - TinderboxPrint: Swap in / out
0 / 0 04:43:43 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 260235264; Read time: 0; Write time: 516436 04:43:43 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 249421824; Read time: 0; Write time: 405984 04:43:44 INFO - Running post-run listener: _upload_blobber_files 04:43:44 INFO - Blob upload gear active. 04:43:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:43:44 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 04:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:43:44 INFO - (blobuploader) - INFO - Open directory for files ... 04:43:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:43:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:43:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:45 INFO - (blobuploader) - INFO - Done attempting. 04:43:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:43:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:43:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:46 INFO - (blobuploader) - INFO - Done attempting. 04:43:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:43:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:59 INFO - (blobuploader) - INFO - Done attempting. 04:43:59 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:59 INFO - Return code: 0 04:43:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/194d89ac33e64207173a6a256e8d2ae067833e747f73ed5528f52b105b430e12db40f2f444e37047f3761b900f666e7f6a7123bf1bcf217a259745f8234e4986", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f2d34dac875fc12b3a198ad9e6b3b9a2929c5f6f60efd2db46fea172e058d4fe8776a7c696571c4264e0d25559e2eec7dff6c78f30f337bb1517555cfb16302", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c0225cba19cbed397d0111b725acc183c294a9b936a1c8c9c58aaaafae34960f0476576d8fd8f4365c6982c1586f849eea5bb42071336fd04efbfa86f6eb73c"} 04:43:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:59 INFO - Contents: 04:43:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/194d89ac33e64207173a6a256e8d2ae067833e747f73ed5528f52b105b430e12db40f2f444e37047f3761b900f666e7f6a7123bf1bcf217a259745f8234e4986", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f2d34dac875fc12b3a198ad9e6b3b9a2929c5f6f60efd2db46fea172e058d4fe8776a7c696571c4264e0d25559e2eec7dff6c78f30f337bb1517555cfb16302", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c0225cba19cbed397d0111b725acc183c294a9b936a1c8c9c58aaaafae34960f0476576d8fd8f4365c6982c1586f849eea5bb42071336fd04efbfa86f6eb73c"} 04:43:59 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:59 INFO - Copying logs to upload dir... 04:43:59 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.189825 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-27 04:43:59.298981) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:43:59.304384) ========= 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-1469618586.344137-1753398946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/194d89ac33e64207173a6a256e8d2ae067833e747f73ed5528f52b105b430e12db40f2f444e37047f3761b900f666e7f6a7123bf1bcf217a259745f8234e4986", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f2d34dac875fc12b3a198ad9e6b3b9a2929c5f6f60efd2db46fea172e058d4fe8776a7c696571c4264e0d25559e2eec7dff6c78f30f337bb1517555cfb16302", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c0225cba19cbed397d0111b725acc183c294a9b936a1c8c9c58aaaafae34960f0476576d8fd8f4365c6982c1586f849eea5bb42071336fd04efbfa86f6eb73c"} build_url:https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011484 build_url: 'https://queue.taskcluster.net/v1/task/aA36r4ZWRri9h5F4NshaRA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/194d89ac33e64207173a6a256e8d2ae067833e747f73ed5528f52b105b430e12db40f2f444e37047f3761b900f666e7f6a7123bf1bcf217a259745f8234e4986", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f2d34dac875fc12b3a198ad9e6b3b9a2929c5f6f60efd2db46fea172e058d4fe8776a7c696571c4264e0d25559e2eec7dff6c78f30f337bb1517555cfb16302", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c0225cba19cbed397d0111b725acc183c294a9b936a1c8c9c58aaaafae34960f0476576d8fd8f4365c6982c1586f849eea5bb42071336fd04efbfa86f6eb73c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 04:43:59.330157) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:43:59.330492) ========= 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-1469618586.344137-1753398946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:43:59.382429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:43:59.382738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:43:59.383059) ========= ========= Total master_lag: 0.14 =========