builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1470220256.74 results: success (0) buildid: 20160803004014 builduid: 42b6f8d5249f44eb99235f2724a0838a revision: a68e8e0562b46bbe62c47363948517d2f6e92242 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:56.739619) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:56.740204) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:56.740530) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:56.755307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:56.755585) ========= 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=62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 03:30:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.3M=0s 2016-08-03 03:30:57 (34.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:56.928884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:56.929161) ========= 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=62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020249 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:56.977768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:56.978077) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a68e8e0562b46bbe62c47363948517d2f6e92242 --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 a68e8e0562b46bbe62c47363948517d2f6e92242 --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=62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 03:30:57,239 truncating revision to first 12 chars 2016-08-03 03:30:57,239 Setting DEBUG logging. 2016-08-03 03:30:57,239 attempt 1/10 2016-08-03 03:30:57,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a68e8e0562b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 03:30:57,569 unpacking tar archive at: mozilla-aurora-a68e8e0562b4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669994 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:57.663131) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:57.663481) ========= script_repo_revision: a68e8e0562b46bbe62c47363948517d2f6e92242 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:57.663932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:57.664238) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 03:30:57.679701) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-08-03 03:30:57.680016) ========= /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=62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:58 INFO - MultiFileLogger online at 20160803 03:30:58 in /builds/slave/test 03:30:58 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 03:30:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:58 INFO - {'append_to_log': False, 03:30:58 INFO - 'base_work_dir': '/builds/slave/test', 03:30:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:30:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:58 INFO - 'branch': 'Mozilla-Aurora', 03:30:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:58 INFO - 'config_files': ('talos/linux_config.py',), 03:30:58 INFO - 'default_actions': ('clobber', 03:30:58 INFO - 'read-buildbot-config', 03:30:58 INFO - 'download-and-extract', 03:30:58 INFO - 'populate-webroot', 03:30:58 INFO - 'create-virtualenv', 03:30:58 INFO - 'install', 03:30:58 INFO - 'run-tests'), 03:30:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:58 INFO - 'download_minidump_stackwalk': True, 03:30:58 INFO - 'download_symbols': 'ondemand', 03:30:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:58 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:58 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:58 INFO - 'installer_path': 'installer.exe', 03:30:58 INFO - 'log_level': 'info', 03:30:58 INFO - 'log_name': 'talos', 03:30:58 INFO - 'log_to_console': True, 03:30:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:58 INFO - 'opt_config_files': (), 03:30:58 INFO - 'pip_index': False, 03:30:58 INFO - 'sps_profile': False, 03:30:58 INFO - 'sps_profile_interval': 0, 03:30:58 INFO - 'suite': 'dromaeojs-e10s', 03:30:58 INFO - 'system_bits': '32', 03:30:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:58 INFO - 'title': 'talos-linux64-ix-018', 03:30:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:58 INFO - 'use_talos_json': True, 03:30:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:58 INFO - 'work_dir': 'build'} 03:30:58 INFO - [mozharness: 2016-08-03 10:30:58.033420Z] Running clobber step. 03:30:58 INFO - Running pre-action listener: _resource_record_pre_action 03:30:58 INFO - Running main action method: clobber 03:30:58 INFO - rmtree: /builds/slave/test/build 03:30:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:59 INFO - Running post-action listener: _resource_record_post_action 03:30:59 INFO - [mozharness: 2016-08-03 10:30:59.004521Z] Finished clobber step (success) 03:30:59 INFO - [mozharness: 2016-08-03 10:30:59.004640Z] Running read-buildbot-config step. 03:30:59 INFO - Running pre-action listener: _resource_record_pre_action 03:30:59 INFO - Running main action method: read_buildbot_config 03:30:59 INFO - Using buildbot properties: 03:30:59 INFO - { 03:30:59 INFO - "project": "", 03:30:59 INFO - "product": "firefox", 03:30:59 INFO - "script_repo_revision": "production", 03:30:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:30:59 INFO - "repository": "", 03:30:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:30:59 INFO - "buildid": "20160803004014", 03:30:59 INFO - "stage_platform": "linux64-pgo", 03:30:59 INFO - "basedir": "/builds/slave/test", 03:30:59 INFO - "nightly_build": "True", 03:30:59 INFO - "buildnumber": 491, 03:30:59 INFO - "slavename": "talos-linux64-ix-018", 03:30:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:30:59 INFO - "platform": "ubuntu64_hw", 03:30:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:30:59 INFO - "branch": "mozilla-aurora", 03:30:59 INFO - "repo_path": "releases/mozilla-aurora", 03:30:59 INFO - "revision": "a68e8e0562b46bbe62c47363948517d2f6e92242", 03:30:59 INFO - "pgo_build": "True", 03:30:59 INFO - "builduid": "42b6f8d5249f44eb99235f2724a0838a", 03:30:59 INFO - "slavebuilddir": "test" 03:30:59 INFO - } 03:30:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:30:59 INFO - Running post-action listener: _resource_record_post_action 03:30:59 INFO - [mozharness: 2016-08-03 10:30:59.007132Z] Finished read-buildbot-config step (success) 03:30:59 INFO - [mozharness: 2016-08-03 10:30:59.007221Z] Running download-and-extract step. 03:30:59 INFO - Running pre-action listener: _resource_record_pre_action 03:30:59 INFO - Running main action method: download_and_extract 03:30:59 INFO - mkdir: /builds/slave/test/build/tests 03:30:59 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')]} 03:30:59 INFO - https://queue.taskcluster.net/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:30:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:30:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:30:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:30:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:31:00 INFO - Downloaded 1361 bytes. 03:31:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:31:00 INFO - Using the following test package requirements: 03:31:00 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:00 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:00 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:00 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:00 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:31:00 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:00 INFO - u'jsshell-linux-x86_64.zip'], 03:31:00 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:00 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:00 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:00 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:00 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:31:00 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:00 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:31:00 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:00 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:00 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:00 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:00 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:00 INFO - https://queue.taskcluster.net/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:31:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:31:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:31:30 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:31:30 INFO - Running command: ['nslookup', u'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 03:31:30 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 03:31:30 INFO - Server: 10.26.75.40 03:31:30 INFO - Address: 10.26.75.40#53 03:31:30 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 03:31:30 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 03:31:30 INFO - Address: 10.26.48.46 03:31:30 INFO - Return code: 0 03:31:30 INFO - retry: attempt #1 caught exception: 03:31:30 INFO - retry: Failed, sleeping 30 seconds before retrying 03:32:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:32:23 INFO - Downloaded 21765408 bytes. 03:32:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:24 INFO - Return code: 0 03:32:24 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:32: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')]} 03:32:24 INFO - https://queue.taskcluster.net/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:32:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:32:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:32:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:25 INFO - Downloaded 21765408 bytes. 03:32:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:26 INFO - Return code: 0 03:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:26 INFO - https://queue.taskcluster.net/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:32:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:32:27 INFO - Downloaded 14413723 bytes. 03:32:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:32:27 INFO - Return code: 0 03:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:27 INFO - https://queue.taskcluster.net/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:32:30 INFO - Downloaded 63743700 bytes. 03:32:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:30 INFO - mkdir: /builds/slave/test/properties 03:32:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:30 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:30 INFO - Contents: 03:32:30 INFO - build_url:https://queue.taskcluster.net/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:32:30 INFO - Running post-action listener: _resource_record_post_action 03:32:30 INFO - Running post-action listener: set_extra_try_arguments 03:32:30 INFO - [mozharness: 2016-08-03 10:32:30.781861Z] Finished download-and-extract step (success) 03:32:30 INFO - [mozharness: 2016-08-03 10:32:30.782096Z] Running populate-webroot step. 03:32:30 INFO - Running pre-action listener: _resource_record_pre_action 03:32:30 INFO - Running main action method: populate_webroot 03:32:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:30 INFO - '--tppagecycles', 03:32:30 INFO - '7'], 03:32:30 INFO - 'tests': ['tsvgm']}}, 03:32:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:32:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:30 INFO - 'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:30 INFO - 'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['damp', 'tps']}, 03:32:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:30 INFO - 'tests': ['damp', 'tps']}, 03:32:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['dromaeo_dom']}, 03:32:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['basic_compositor_video']}, 03:32:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:32:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['a11yr', 03:32:30 INFO - 'ts_paint', 03:32:30 INFO - 'tpaint', 03:32:30 INFO - 'sessionrestore', 03:32:30 INFO - 'sessionrestore_no_auto_restore', 03:32:30 INFO - 'tabpaint']}, 03:32:30 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:30 INFO - 'ts_paint', 03:32:30 INFO - 'tpaint', 03:32:30 INFO - 'sessionrestore', 03:32:30 INFO - 'sessionrestore_no_auto_restore', 03:32:30 INFO - 'tabpaint']}, 03:32:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:32:30 INFO - 'ts_paint', 03:32:30 INFO - 'tpaint', 03:32:30 INFO - 'sessionrestore', 03:32:30 INFO - 'sessionrestore_no_auto_restore', 03:32:30 INFO - 'tabpaint']}, 03:32:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:32:30 INFO - 'ts_paint', 03:32:30 INFO - 'tpaint', 03:32:30 INFO - 'sessionrestore', 03:32:30 INFO - 'sessionrestore_no_auto_restore', 03:32:30 INFO - 'tabpaint']}, 03:32:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['a11yr', 03:32:30 INFO - 'ts_paint', 03:32:30 INFO - 'tpaint', 03:32:30 INFO - 'sessionrestore', 03:32:30 INFO - 'sessionrestore_no_auto_restore', 03:32:30 INFO - 'tabpaint']}, 03:32:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['a11yr', 03:32:30 INFO - 'ts_paint', 03:32:30 INFO - 'tpaint', 03:32:30 INFO - 'sessionrestore', 03:32:30 INFO - 'sessionrestore_no_auto_restore', 03:32:30 INFO - 'tabpaint']}, 03:32:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['tsvgx', 03:32:30 INFO - 'tsvgr_opacity', 03:32:30 INFO - 'tart', 03:32:30 INFO - 'tscrollx', 03:32:30 INFO - 'cart']}, 03:32:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:30 INFO - 'tsvgr_opacity', 03:32:30 INFO - 'tart', 03:32:30 INFO - 'tscrollx', 03:32:30 INFO - 'cart']}, 03:32:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:30 INFO - 'talos_options': ['--disable-e10s'], 03:32:30 INFO - 'tests': ['tp5o']}, 03:32:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:30 INFO - 'tests': ['tp5o']}, 03:32:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:30 INFO - 'talos_options': ['--disable-e10s', 03:32:30 INFO - '--xperf_path', 03:32:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:30 INFO - 'tests': ['tp5n']}, 03:32:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:30 INFO - 'talos_options': ['--xperf_path', 03:32:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:30 INFO - 'tests': ['tp5n']}}, 03:32:30 INFO - 'talos.zip': {'path': '', 03:32:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:30 INFO - Running post-action listener: _resource_record_post_action 03:32:30 INFO - [mozharness: 2016-08-03 10:32:30.801985Z] Finished populate-webroot step (success) 03:32:30 INFO - [mozharness: 2016-08-03 10:32:30.802079Z] Running create-virtualenv step. 03:32:30 INFO - Running pre-action listener: _resource_record_pre_action 03:32:30 INFO - Running main action method: create_virtualenv 03:32:30 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:30 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 03:32:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:30 INFO - Using real prefix '/usr' 03:32:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:33 INFO - Installing pip.................done. 03:32:33 INFO - Return code: 0 03:32:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32:33 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')]} 03:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:33 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')]} 03:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:33 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 0x130a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1539400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, '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': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', '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 03:32:33 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 03:32:33 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 03:32:33 INFO - Using env: {'DISPLAY': ':0', 03:32:33 INFO - 'HOME': '/home/cltbld', 03:32:33 INFO - 'LANG': 'en_US.UTF-8', 03:32:33 INFO - 'LANGUAGE': 'en_US:en', 03:32:33 INFO - 'LOGNAME': 'cltbld', 03:32:33 INFO - 'MAIL': '/var/mail/cltbld', 03:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:33 INFO - 'MOZ_NO_REMOTE': '1', 03:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:33 INFO - 'NO_EM_RESTART': '1', 03:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:33 INFO - 'PWD': '/builds/slave/test', 03:32:33 INFO - 'SHELL': '/bin/bash', 03:32:33 INFO - 'SHLVL': '1', 03:32:33 INFO - 'TERM': 'linux', 03:32:33 INFO - 'TMOUT': '86400', 03:32:33 INFO - 'USER': 'cltbld', 03:32:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:33 INFO - '_': '/tools/buildbot/bin/python'} 03:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:33 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 03:32:33 INFO - Cleaning up... 03:32:33 INFO - Return code: 0 03:32:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:32:33 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')]} 03:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:33 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')]} 03:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:33 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 0x130a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1539400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, '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': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', '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 03:32:33 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 03:32:33 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 03:32:33 INFO - Using env: {'DISPLAY': ':0', 03:32:33 INFO - 'HOME': '/home/cltbld', 03:32:33 INFO - 'LANG': 'en_US.UTF-8', 03:32:33 INFO - 'LANGUAGE': 'en_US:en', 03:32:33 INFO - 'LOGNAME': 'cltbld', 03:32:33 INFO - 'MAIL': '/var/mail/cltbld', 03:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:33 INFO - 'MOZ_NO_REMOTE': '1', 03:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:33 INFO - 'NO_EM_RESTART': '1', 03:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:33 INFO - 'PWD': '/builds/slave/test', 03:32:33 INFO - 'SHELL': '/bin/bash', 03:32:33 INFO - 'SHLVL': '1', 03:32:33 INFO - 'TERM': 'linux', 03:32:33 INFO - 'TMOUT': '86400', 03:32:33 INFO - 'USER': 'cltbld', 03:32:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:33 INFO - '_': '/tools/buildbot/bin/python'} 03:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:33 INFO - Downloading/unpacking psutil>=3.1.1 03:32:33 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 03:32:33 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 03:32:33 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 03:32:33 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 03:32:33 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 03:32:33 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 03:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:35 INFO - Installing collected packages: psutil 03:32:35 INFO - Running setup.py install for psutil 03:32:35 INFO - building 'psutil._psutil_linux' extension 03:32:35 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 03:32:36 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 03:32:36 INFO - building 'psutil._psutil_posix' extension 03:32:36 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 03:32:36 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 03:32:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:36 INFO - Successfully installed psutil 03:32:36 INFO - Cleaning up... 03:32:36 INFO - Return code: 0 03:32:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:32:36 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')]} 03:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:36 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')]} 03:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:36 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 0x130a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1539400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, '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': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', '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 03:32:36 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 03:32:36 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 03:32:36 INFO - Using env: {'DISPLAY': ':0', 03:32:36 INFO - 'HOME': '/home/cltbld', 03:32:36 INFO - 'LANG': 'en_US.UTF-8', 03:32:36 INFO - 'LANGUAGE': 'en_US:en', 03:32:36 INFO - 'LOGNAME': 'cltbld', 03:32:36 INFO - 'MAIL': '/var/mail/cltbld', 03:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:36 INFO - 'MOZ_NO_REMOTE': '1', 03:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:36 INFO - 'NO_EM_RESTART': '1', 03:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:36 INFO - 'PWD': '/builds/slave/test', 03:32:36 INFO - 'SHELL': '/bin/bash', 03:32:36 INFO - 'SHLVL': '1', 03:32:36 INFO - 'TERM': 'linux', 03:32:36 INFO - 'TMOUT': '86400', 03:32:36 INFO - 'USER': 'cltbld', 03:32:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:36 INFO - '_': '/tools/buildbot/bin/python'} 03:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:32:38 INFO - Installing collected packages: mozsystemmonitor 03:32:38 INFO - Running setup.py install for mozsystemmonitor 03:32:38 INFO - Successfully installed mozsystemmonitor 03:32:38 INFO - Cleaning up... 03:32:38 INFO - Return code: 0 03:32:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x130a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1539400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, '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': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', '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 03:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:32:38 INFO - Using env: {'DISPLAY': ':0', 03:32:38 INFO - 'HOME': '/home/cltbld', 03:32:38 INFO - 'LANG': 'en_US.UTF-8', 03:32:38 INFO - 'LANGUAGE': 'en_US:en', 03:32:38 INFO - 'LOGNAME': 'cltbld', 03:32:38 INFO - 'MAIL': '/var/mail/cltbld', 03:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:38 INFO - 'MOZ_NO_REMOTE': '1', 03:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:38 INFO - 'NO_EM_RESTART': '1', 03:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:38 INFO - 'PWD': '/builds/slave/test', 03:32:38 INFO - 'SHELL': '/bin/bash', 03:32:38 INFO - 'SHLVL': '1', 03:32:38 INFO - 'TERM': 'linux', 03:32:38 INFO - 'TMOUT': '86400', 03:32:38 INFO - 'USER': 'cltbld', 03:32:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:38 INFO - '_': '/tools/buildbot/bin/python'} 03:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:38 INFO - Downloading/unpacking jsonschema==2.5.1 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:32:40 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 03:32:40 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 03:32:40 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 03:32:40 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 03:32:40 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 03:32:40 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 03:32:40 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:40 INFO - warning: no files found matching '*.txt' 03:32:40 INFO - no previously-included directories found matching 'build' 03:32:40 INFO - no previously-included directories found matching 'dist' 03:32:40 INFO - no previously-included directories found matching '.git*' 03:32:40 INFO - Installing collected packages: jsonschema, functools32 03:32:40 INFO - Running setup.py install for functools32 03:32:41 INFO - warning: no files found matching '*.txt' 03:32:41 INFO - no previously-included directories found matching 'build' 03:32:41 INFO - no previously-included directories found matching 'dist' 03:32:41 INFO - no previously-included directories found matching '.git*' 03:32:41 INFO - Successfully installed jsonschema functools32 03:32:41 INFO - Cleaning up... 03:32:41 INFO - Return code: 0 03:32:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:41 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1539400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, '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': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', '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 03:32:41 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:32:41 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 functools32==3.2.3-2 03:32:41 INFO - Using env: {'DISPLAY': ':0', 03:32:41 INFO - 'HOME': '/home/cltbld', 03:32:41 INFO - 'LANG': 'en_US.UTF-8', 03:32:41 INFO - 'LANGUAGE': 'en_US:en', 03:32:41 INFO - 'LOGNAME': 'cltbld', 03:32:41 INFO - 'MAIL': '/var/mail/cltbld', 03:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:41 INFO - 'MOZ_NO_REMOTE': '1', 03:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:41 INFO - 'NO_EM_RESTART': '1', 03:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:41 INFO - 'PWD': '/builds/slave/test', 03:32:41 INFO - 'SHELL': '/bin/bash', 03:32:41 INFO - 'SHLVL': '1', 03:32:41 INFO - 'TERM': 'linux', 03:32:41 INFO - 'TMOUT': '86400', 03:32:41 INFO - 'USER': 'cltbld', 03:32:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:41 INFO - '_': '/tools/buildbot/bin/python'} 03:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:32:41 INFO - Cleaning up... 03:32:41 INFO - Return code: 0 03:32:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:41 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 0x130a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1539400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, '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': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', '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 03:32:41 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 03:32:41 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 03:32:41 INFO - Using env: {'DISPLAY': ':0', 03:32:41 INFO - 'HOME': '/home/cltbld', 03:32:41 INFO - 'LANG': 'en_US.UTF-8', 03:32:41 INFO - 'LANGUAGE': 'en_US:en', 03:32:41 INFO - 'LOGNAME': 'cltbld', 03:32:41 INFO - 'MAIL': '/var/mail/cltbld', 03:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:41 INFO - 'MOZ_NO_REMOTE': '1', 03:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:41 INFO - 'NO_EM_RESTART': '1', 03:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:41 INFO - 'PWD': '/builds/slave/test', 03:32:41 INFO - 'SHELL': '/bin/bash', 03:32:41 INFO - 'SHLVL': '1', 03:32:41 INFO - 'TERM': 'linux', 03:32:41 INFO - 'TMOUT': '86400', 03:32:41 INFO - 'USER': 'cltbld', 03:32:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:41 INFO - '_': '/tools/buildbot/bin/python'} 03:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:41 INFO - Downloading/unpacking blobuploader==1.2.4 03:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:44 INFO - Downloading docopt-0.6.1.tar.gz 03:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:44 INFO - Running setup.py install for blobuploader 03:32:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:44 INFO - Running setup.py install for requests 03:32:44 INFO - Running setup.py install for docopt 03:32:44 INFO - Successfully installed blobuploader requests docopt 03:32:44 INFO - Cleaning up... 03:32:44 INFO - Return code: 0 03:32:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:44 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 0x130a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1539400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, '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': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', '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 03:32:44 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 03:32:44 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 03:32:44 INFO - Using env: {'DISPLAY': ':0', 03:32:44 INFO - 'HOME': '/home/cltbld', 03:32:44 INFO - 'LANG': 'en_US.UTF-8', 03:32:44 INFO - 'LANGUAGE': 'en_US:en', 03:32:44 INFO - 'LOGNAME': 'cltbld', 03:32:44 INFO - 'MAIL': '/var/mail/cltbld', 03:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:44 INFO - 'MOZ_NO_REMOTE': '1', 03:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:44 INFO - 'NO_EM_RESTART': '1', 03:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:44 INFO - 'PWD': '/builds/slave/test', 03:32:44 INFO - 'SHELL': '/bin/bash', 03:32:44 INFO - 'SHLVL': '1', 03:32:44 INFO - 'TERM': 'linux', 03:32:44 INFO - 'TMOUT': '86400', 03:32:44 INFO - 'USER': 'cltbld', 03:32:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:44 INFO - '_': '/tools/buildbot/bin/python'} 03:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:45 INFO - Running setup.py (path:/tmp/pip-fpAB9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:45 INFO - Running setup.py (path:/tmp/pip-EHp72R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:45 INFO - Running setup.py (path:/tmp/pip-b0yI3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:45 INFO - Running setup.py (path:/tmp/pip-sNqgNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:45 INFO - Running setup.py (path:/tmp/pip-ejlQka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:45 INFO - Running setup.py (path:/tmp/pip-Rzds8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:45 INFO - Running setup.py (path:/tmp/pip-ppw4d4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:45 INFO - Running setup.py (path:/tmp/pip-yBpVxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:45 INFO - Running setup.py (path:/tmp/pip-tUMVXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:45 INFO - Running setup.py (path:/tmp/pip-yadDZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:45 INFO - Running setup.py (path:/tmp/pip-wBcnRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:45 INFO - Running setup.py (path:/tmp/pip-WuHYfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:45 INFO - Running setup.py (path:/tmp/pip-bIXJEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:45 INFO - Running setup.py (path:/tmp/pip-OUUwsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:46 INFO - Running setup.py (path:/tmp/pip-zkQLpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:46 INFO - Running setup.py (path:/tmp/pip-8r9RWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:46 INFO - Running setup.py (path:/tmp/pip-wYvDsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:46 INFO - Running setup.py install for manifestparser 03:32:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:46 INFO - Running setup.py install for mozcrash 03:32:46 INFO - Running setup.py install for mozdebug 03:32:46 INFO - Running setup.py install for mozdevice 03:32:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:46 INFO - Running setup.py install for mozfile 03:32:46 INFO - Running setup.py install for mozhttpd 03:32:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:46 INFO - Running setup.py install for mozinfo 03:32:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:46 INFO - Running setup.py install for mozInstall 03:32:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Running setup.py install for mozleak 03:32:47 INFO - Running setup.py install for mozlog 03:32:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Running setup.py install for moznetwork 03:32:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Running setup.py install for mozprocess 03:32:47 INFO - Running setup.py install for mozprofile 03:32:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Running setup.py install for mozrunner 03:32:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:47 INFO - Running setup.py install for mozscreenshot 03:32:47 INFO - Running setup.py install for moztest 03:32:47 INFO - Running setup.py install for mozversion 03:32:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:48 INFO - Cleaning up... 03:32:48 INFO - Return code: 0 03:32:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:48 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 0x130a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1539400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, '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': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', '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 03:32:48 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 03:32:48 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 03:32:48 INFO - Using env: {'DISPLAY': ':0', 03:32:48 INFO - 'HOME': '/home/cltbld', 03:32:48 INFO - 'LANG': 'en_US.UTF-8', 03:32:48 INFO - 'LANGUAGE': 'en_US:en', 03:32:48 INFO - 'LOGNAME': 'cltbld', 03:32:48 INFO - 'MAIL': '/var/mail/cltbld', 03:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:48 INFO - 'MOZ_NO_REMOTE': '1', 03:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:48 INFO - 'NO_EM_RESTART': '1', 03:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:48 INFO - 'PWD': '/builds/slave/test', 03:32:48 INFO - 'SHELL': '/bin/bash', 03:32:48 INFO - 'SHLVL': '1', 03:32:48 INFO - 'TERM': 'linux', 03:32:48 INFO - 'TMOUT': '86400', 03:32:48 INFO - 'USER': 'cltbld', 03:32:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:48 INFO - '_': '/tools/buildbot/bin/python'} 03:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:48 INFO - Running setup.py (path:/tmp/pip-urNesy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:48 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)) 03:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:48 INFO - Running setup.py (path:/tmp/pip-WHHM92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:48 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)) 03:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:48 INFO - Running setup.py (path:/tmp/pip-msXTlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:48 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)) 03:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:48 INFO - Running setup.py (path:/tmp/pip-xTjdUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:48 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)) 03:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:48 INFO - Running setup.py (path:/tmp/pip-WynWAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:48 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)) 03:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:48 INFO - Running setup.py (path:/tmp/pip-o9ZiC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:48 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)) 03:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:48 INFO - Running setup.py (path:/tmp/pip-JHrhcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:48 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)) 03:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:48 INFO - Running setup.py (path:/tmp/pip-e1xRtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:48 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)) 03:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:48 INFO - Running setup.py (path:/tmp/pip-Nme1gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:48 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)) 03:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:48 INFO - Running setup.py (path:/tmp/pip-wlr4qB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 03:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:49 INFO - Running setup.py (path:/tmp/pip-AAftyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:49 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)) 03:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:49 INFO - Running setup.py (path:/tmp/pip-98Syaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:49 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)) 03:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:49 INFO - Running setup.py (path:/tmp/pip-k6hEIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:49 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)) 03:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:49 INFO - Running setup.py (path:/tmp/pip-ASLfR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:49 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)) 03:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:49 INFO - Running setup.py (path:/tmp/pip-XxQGgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:49 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)) 03:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:49 INFO - Running setup.py (path:/tmp/pip-fNMOYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:49 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)) 03:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:49 INFO - Running setup.py (path:/tmp/pip-fIHp9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:49 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)) 03:32:49 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)) 03:32:49 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)) 03:32:49 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)) 03:32:49 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)) 03:32:49 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)) 03:32:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:51 INFO - Downloading blessings-1.6.tar.gz 03:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:51 INFO - Installing collected packages: blessings 03:32:51 INFO - Running setup.py install for blessings 03:32:51 INFO - Successfully installed blessings 03:32:51 INFO - Cleaning up... 03:32:51 INFO - Return code: 0 03:32:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:51 INFO - Reading from file tmpfile_stdout 03:32:51 INFO - Current package versions: 03:32:51 INFO - argparse == 1.2.1 03:32:51 INFO - blessings == 1.6 03:32:51 INFO - blobuploader == 1.2.4 03:32:51 INFO - docopt == 0.6.1 03:32:51 INFO - functools32 == 3.2.3-2 03:32:51 INFO - jsonschema == 2.5.1 03:32:51 INFO - manifestparser == 1.1 03:32:51 INFO - mozInstall == 1.12 03:32:51 INFO - mozcrash == 0.17 03:32:51 INFO - mozdebug == 0.1 03:32:51 INFO - mozdevice == 0.48 03:32:51 INFO - mozfile == 1.2 03:32:51 INFO - mozhttpd == 0.7 03:32:51 INFO - mozinfo == 0.9 03:32:51 INFO - mozleak == 0.1 03:32:51 INFO - mozlog == 3.3 03:32:51 INFO - moznetwork == 0.27 03:32:51 INFO - mozprocess == 0.23 03:32:51 INFO - mozprofile == 0.28 03:32:51 INFO - mozrunner == 6.12 03:32:51 INFO - mozscreenshot == 0.1 03:32:51 INFO - mozsystemmonitor == 0.3 03:32:51 INFO - moztest == 0.7 03:32:51 INFO - mozversion == 1.4 03:32:51 INFO - psutil == 3.1.1 03:32:51 INFO - requests == 1.2.3 03:32:51 INFO - wsgiref == 0.1.2 03:32:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:51 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 0x130a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1539400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, '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': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', '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 03:32:51 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 03:32:51 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 03:32:51 INFO - Using env: {'DISPLAY': ':0', 03:32:51 INFO - 'HOME': '/home/cltbld', 03:32:51 INFO - 'LANG': 'en_US.UTF-8', 03:32:51 INFO - 'LANGUAGE': 'en_US:en', 03:32:51 INFO - 'LOGNAME': 'cltbld', 03:32:51 INFO - 'MAIL': '/var/mail/cltbld', 03:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:51 INFO - 'MOZ_NO_REMOTE': '1', 03:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:51 INFO - 'NO_EM_RESTART': '1', 03:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:51 INFO - 'PWD': '/builds/slave/test', 03:32:51 INFO - 'SHELL': '/bin/bash', 03:32:51 INFO - 'SHLVL': '1', 03:32:51 INFO - 'TERM': 'linux', 03:32:51 INFO - 'TMOUT': '86400', 03:32:51 INFO - 'USER': 'cltbld', 03:32:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:51 INFO - '_': '/tools/buildbot/bin/python'} 03:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:52 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)) 03:32:52 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)) 03:32:52 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)) 03:32:52 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)) 03:32:52 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)) 03:32:52 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)) 03:32:52 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)) 03:32:52 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)) 03:32:52 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)) 03:32:52 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)) 03:32:52 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)) 03:32:52 INFO - Cleaning up... 03:32:52 INFO - Return code: 0 03:32:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x130a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1539400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, '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': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', '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 03:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:32:52 INFO - Using env: {'DISPLAY': ':0', 03:32:52 INFO - 'HOME': '/home/cltbld', 03:32:52 INFO - 'LANG': 'en_US.UTF-8', 03:32:52 INFO - 'LANGUAGE': 'en_US:en', 03:32:52 INFO - 'LOGNAME': 'cltbld', 03:32:52 INFO - 'MAIL': '/var/mail/cltbld', 03:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:52 INFO - 'MOZ_NO_REMOTE': '1', 03:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:52 INFO - 'NO_EM_RESTART': '1', 03:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:52 INFO - 'PWD': '/builds/slave/test', 03:32:52 INFO - 'SHELL': '/bin/bash', 03:32:52 INFO - 'SHLVL': '1', 03:32:52 INFO - 'TERM': 'linux', 03:32:52 INFO - 'TMOUT': '86400', 03:32:52 INFO - 'USER': 'cltbld', 03:32:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:52 INFO - '_': '/tools/buildbot/bin/python'} 03:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:32:52 INFO - Cleaning up... 03:32:52 INFO - Return code: 0 03:32:52 INFO - Running post-action listener: _resource_record_post_action 03:32:52 INFO - Running post-action listener: _start_resource_monitoring 03:32:52 INFO - Starting resource monitoring. 03:32:52 INFO - [mozharness: 2016-08-03 10:32:52.346228Z] Finished create-virtualenv step (success) 03:32:52 INFO - [mozharness: 2016-08-03 10:32:52.346660Z] Running install step. 03:32:52 INFO - Running pre-action listener: _resource_record_pre_action 03:32:52 INFO - Running main action method: install 03:32:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:52 INFO - Reading from file tmpfile_stdout 03:32:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:52 INFO - Reading from file tmpfile_stdout 03:32:52 INFO - Output received: 03:32:52 INFO - Usage: mozinstall [options] installer 03:32:52 INFO - Options: 03:32:52 INFO - -h, --help show this help message and exit 03:32:52 INFO - -d DEST, --destination=DEST 03:32:52 INFO - Directory to install application into. [default: 03:32:52 INFO - "/builds/slave/test"] 03:32:52 INFO - --app=APP Application being installed. [default: firefox] 03:32:52 INFO - mkdir: /builds/slave/test/build/application 03:32:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:08 INFO - Reading from file tmpfile_stdout 03:33:08 INFO - Output received: 03:33:08 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:08 INFO - Running post-action listener: _resource_record_post_action 03:33:08 INFO - [mozharness: 2016-08-03 10:33:08.660950Z] Finished install step (success) 03:33:08 INFO - [mozharness: 2016-08-03 10:33:08.661230Z] Running run-tests step. 03:33:08 INFO - Running pre-action listener: _resource_record_pre_action 03:33:08 INFO - Running main action method: run_tests 03:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:08 INFO - Python 2.7.3 03:33:08 INFO - Return code: 0 03:33:08 INFO - grabbing minidump binary from tooltool 03:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:08 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 0x15c8570>, '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 0x15c9470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15c9900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:08 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 03:33:08 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 03:33:08 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 03:33:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:08 INFO - Return code: 0 03:33:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33: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/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 03:33: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/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 03:33:08 INFO - Using env: {'DISPLAY': ':0', 03:33:08 INFO - 'HOME': '/home/cltbld', 03:33:08 INFO - 'LANG': 'en_US.UTF-8', 03:33:08 INFO - 'LANGUAGE': 'en_US:en', 03:33:08 INFO - 'LOGNAME': 'cltbld', 03:33:08 INFO - 'MAIL': '/var/mail/cltbld', 03:33:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:08 INFO - 'MOZ_NO_REMOTE': '1', 03:33:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:08 INFO - 'NO_EM_RESTART': '1', 03:33:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:08 INFO - 'PWD': '/builds/slave/test', 03:33:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:08 INFO - 'SHELL': '/bin/bash', 03:33:08 INFO - 'SHLVL': '1', 03:33:08 INFO - 'TERM': 'linux', 03:33:08 INFO - 'TMOUT': '86400', 03:33:08 INFO - 'USER': 'cltbld', 03:33:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884', 03:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:08 INFO - '_': '/tools/buildbot/bin/python'} 03:33: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/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 03:33:08 INFO - mozversion application_buildid: 20160803004014 03:33:08 INFO - mozversion application_changeset: a68e8e0562b46bbe62c47363948517d2f6e92242 03:33:08 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:33:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:08 INFO - mozversion application_name: Firefox 03:33:08 INFO - mozversion application_remotingname: firefox-dev 03:33:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:08 INFO - mozversion application_vendor: Mozilla 03:33:08 INFO - mozversion application_version: 50.0a2 03:33:08 INFO - mozversion platform_buildid: 20160803004014 03:33:08 INFO - mozversion platform_changeset: a68e8e0562b46bbe62c47363948517d2f6e92242 03:33:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:08 INFO - mozversion platform_version: 50.0a2 03:33:08 INFO - using testdate: 1470220388 03:33:08 INFO - actual date: 1470220388 03:33:08 INFO - starting webserver on 'localhost:59386' 03:33:08 INFO - SUITE-START | Running 2 tests 03:33:08 INFO - TEST-START | dromaeo_css 03:33:08 INFO - operating with platform_type : linux_ 03:33:08 INFO - Initialising browser for dromaeo_css test... 03:33:08 INFO - TEST-INFO | started process 7045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD826dM/profile http://localhost:59386/getInfo.html) 03:33:13 INFO - PROCESS | 7045 | __metrics Screen width/height:1600/1200 03:33:13 INFO - PROCESS | 7045 | colorDepth:24 03:33:13 INFO - PROCESS | 7045 | Browser inner width/height: 1024/697 03:33:13 INFO - PROCESS | 7045 | __metrics 03:33:13 ERROR - PROCESS | 7045 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:33:14 INFO - TEST-INFO | 7045: exit 0 03:33:14 INFO - Browser initialized. 03:33:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:14 INFO - TEST-INFO | started process 7169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD826dM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:26 INFO - PROCESS | 7169 | RSS: Main: 152694784 03:33:26 INFO - PROCESS | 7169 | 03:34:15 INFO - PROCESS | 7169 | 1470220455875 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] 03:36:24 INFO - PROCESS | 7169 | Cycle 1(1): loaded http://localhost:59386/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59386/tests/dromaeo/cssquery-ext.html) 03:36:25 INFO - PROCESS | 7169 | RSS: Main: 158642176 03:36:25 INFO - PROCESS | 7169 | 03:39:27 INFO - PROCESS | 7169 | Cycle 1(1): loaded http://localhost:59386/tests/dromaeo/cssquery-ext.html (next: http://localhost:59386/tests/dromaeo/cssquery-jquery.html) 03:39:27 INFO - PROCESS | 7169 | RSS: Main: 153292800 03:39:27 INFO - PROCESS | 7169 | 03:42:29 INFO - PROCESS | 7169 | Cycle 1(1): loaded http://localhost:59386/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59386/tests/dromaeo/cssquery-mootools.html) 03:42:30 INFO - PROCESS | 7169 | RSS: Main: 153378816 03:42:30 INFO - PROCESS | 7169 | 03:45:32 INFO - PROCESS | 7169 | Cycle 1(1): loaded http://localhost:59386/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59386/tests/dromaeo/cssquery-prototype.html) 03:45:32 INFO - PROCESS | 7169 | RSS: Main: 151736320 03:45:32 INFO - PROCESS | 7169 | 03:48:35 INFO - PROCESS | 7169 | Cycle 1(1): loaded http://localhost:59386/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59386/tests/dromaeo/cssquery-yui.html) 03:48:35 INFO - PROCESS | 7169 | RSS: Main: 155066368 03:48:35 INFO - PROCESS | 7169 | 03:51:38 INFO - PROCESS | 7169 | Cycle 1(1): loaded http://localhost:59386/tests/dromaeo/cssquery-yui.html (next: http://localhost:59386/tests/dromaeo/cssquery-dojo.html) 03:51:38 INFO - PROCESS | 7169 | RSS: Main: 154681344 03:51:38 INFO - PROCESS | 7169 | 03:51:38 INFO - PROCESS | 7169 | __start_tp_report 03:51:38 INFO - PROCESS | 7169 | _x_x_mozilla_page_load 03:51:38 INFO - PROCESS | 7169 | _x_x_mozilla_page_load_details 03:51:38 INFO - PROCESS | 7169 | |i|pagename|runs| 03:51:38 INFO - PROCESS | 7169 | |0;dojo.html;3321.2693207494353;3339.7662163648547;3345.1637090727318;3361.932761344775;3369.39350916835;5703.058995265781;5773.509251713599;5780.47975682188;5790.33411157717;5798.362180160179;5734.827955161341;5756.884862302752;5770.3364113127;5776.711164441782;5782.045962416196;5182.792688292473;5216.60875434344;5243.265942767996;5266.210068489719;5271.367435907678;5048.040872234282;5049.949500505003;5086.237064440326;5154.536091751742;5192.792288308482;5129.153689641204;5142.562882155022;5149.124648809711;5224.39919409269;5284.920726189091;5177.611679124081;5203.375594928614;5218.660787048868;5236.450172731866;5242.580593552507;4996.90006199874;5054.014467178901;5105.693658380509;5135.64050516464;5212.8957420851375;5625.296837895263;5679.2333035040565;5691.857703557444;5693.3452652945025;5711.971440142815;6120.846978825521;6148.415900489446;6156.78451254204;6175.382461753788;6202.565820392574;5931.258592675916;6109.083637454373;6191.535634827361;6198.81403557894;6210.099535567318;5767.509761670263;5803.506701930341;5818.069108942549;5830.650160990354;5838.299404071496;6302.275238347557;6303.558750887394;6321.715522801485;6324.272708638566;6326.46225070865;5845.269341332333;6027.7287522061615;6038.245219347582;6072.05883088122;6086.056661217518;6080.878382432326;6221.222347206599;6230.59501132425;6235.251769787564;6240.375962403814;6160.753569857246;6201.255849298113;6210.254769427607;6213.96893015532;6214;5984.3417224105315;6135.263289243823;6194.287656919422;6205.410486003822;6216.564840461125;4758.714477131314;4763.356946812136;4765;4780;4782.402199725035;4218.093109981307;4225.7887105644595;4237.745735255895;4245.448091748115;4249.5113061997645;5822.155787410802;5922;5992.64044157352;6021;6106.969465152734;6146.969265153645;6248.781292654735;6283.937160628427;6285.214348206474;6287.874242515216;6066.211392518944;6079.665618390943;6086.360932102154;6087.269527656621;6094.116353128771;5236.554892834076;5318.202269659505;5379;5385.219143224211;5390.54180394663;6458.38645328693;6599.934000660028;6608;6610.6694665267505;6612.801615951529;6242.094896240111;6295.96852015737;6314.0528920661345;6315.936840631535;6327.96836015817;6107.053406721965;6310.558260921692;6344.429001389897;6484.740610375532;6528.086067950396;6118.251671986735;6122.877542449215;6127.892078906909;6140.013486850464;6140.412224875342;6180.845478863064;6186.319504854372;6226.003839385677;6228.439440450381;6228.844278893064;5750.25246717924;5904.822855314347;5926.1999630049395;6041.124037014696;6051.062085376773;6008.819735407945;6016.067509536029;6017.398260173947;6032.849178770566;6070.575059745775;5928.199693041557;5939.9605069113595;5961.731722072431;5969.611975221596;5988.820335389945;5881.5000724937145;5937.376575459687;5954.315253745702;5977.970110149421;5993.730282137227;5927.436893495111;5927.496162826208;5935.643861368331;5953.613015154001;5955.642661440327 03:51:38 INFO - PROCESS | 7169 | |1;ext.html;595.6426144313413;637.3976592120446;651.4137276451196;662.6686656671665;702.8524009957908;41145.17709645805;45891.31163032549;45931.31103033453;46078.539214607925;46242.53757462424;47240;48071.51928480714;48103.75948120263;48153;48265.27602085972;9124.90875091249;9232.53837308132;9247.121523455295;9268.490233037213;9281.164695177433;9247.398919070272;9276.953615231949;9290.535473226346;9324.393914395543;9335.019822918597;9384.906150938506;9403.905960940405;9418.058194180596;9418.293627977895;9451.621935122586;9323.86014209784;9385.718428447157;9402.482863442508;9404.106609872051;9411.152996230372;9167.08329167078;9238.58426370815;9284.025177356416;9299.90700093004;9303.534823258879;44081.55918440839;44422.55577444217;44492.77753611244;44603.77698111521;44671;3156.621205455337;3624.2932628137523;3625;3648.908777280563;3709.647583479565;32561.185970350693;33031.17422064468;33534.49698254528;33573.328533429194;33864.246274564386;4426.513083560806;4510.075434535912;4534.7052441591195;4577.22187228172;4597.563231493003;336623;337803;338680;338772;339545.30227348953;38495.80752096278;38529.6147038526;38533.22933541313;38653.806730966164;38761.61238387637;37850.810745946095;39635.40546891799;39803.20393592112;39953;40048;19947.501312467015;20005.199792008156;20068.498287542927;20166.09252583637;20243.39269821908;13594.45622175102;13607.863921360859;13664.65838354049;13680.657983550293;13735.519256826163;20899.268525601834;20906.686399704016;21078.894605526875;21098.683519747217;21187.894060529597;7490.85018299631;7589.354904833041;7623.275788800055;7641.579713115832;7703.422243331773;1019.3170575714141;1021.9437930913722;1092.3609688332415;1103.9448027598587;1164.2199726183478;33806.29549636023;34100;34574.48138277877;34922.650773492445;35000.82499587486;1157.6628993512506;1158.7381521018306;1184.4314728930162;1196.1208511743862;1260.9684757880943;17795.555111122067;17885.195166217552;17936.372226971995;17958.820411795976;18145.364912228008;577766;579333;585632;586759;590355;64303.35696643067;64896.35103648998;65024.34975650278;65038.34961650323;65217.67391163014;1440.1934916446824;1451.9927400363142;1453.4258967707697;1483.3028476615973;1490.284663361571;32180.35639287248;32839.50740738843;33218.83390583032;33248;33675.15812104717;56216;56358.43641563532;56617.43382566122;56628.7168564171;56894;484754;484846;486551;487851;489068;30988.22529436782;31462.842685786425;31514.212144696565;31585.368292634477;31669;52302.47697522976;52317.7384113077;52828.73585632047;52993.470065298854;53296.46703532915;44096.11807763891;44118.77940610405;44654.55345446634;44750;45576.544234558554;43520.56479435165;43633.78183109191;44413.55586444094;45432.772836135606;45596.77201613971;40268.79865600653;41010.38484422676;43037.56962430335;43455;45192.096158077315;33683.663163369034;34353.61793816576;34737.65262347445;34932.12669683278;35276.29447411089;29481.852590737766;29629.555556666237;30211.244718882204;30281.394372112874;30545.23636909006 03:51:38 INFO - PROCESS | 7169 | |2;jquery.html;425.45966622389585;428.79203586260667;429.8380878951425;435.6493023116391;438.76306794331083;18876.528086797836;19822.306219282327;20619.690704639404;20637.587248255026;20835.16659333625;19645.803541964575;19725;19729.11218995145;19926.800731992713;20061.899690501563;5950.464458198772;6189.195404597396;6195.070739389105;6196.566240363154;6204;5995.820125396245;6016.578839481238;6026.8794624107495;6061.12113743507;6069.57512974092;5857.7364018619055;5946;5962.25471816023;6018.187544681456;6037.637741735488;6009.939900600982;6022.608530445551;6038.064100064497;6051.455369016788;6067.817965461043;5291.021161085173;5430.891382172374;5437.293151890269;5450.672959622435;5470.124780035176;21824;22762.317130486113;24147.275581732578;24526.264212073667;24657.260282191564;2493.7880280176205;2498.2380373985925;2609.5302845487804;2638.5514462541414;2982.7166419190144;10091.394516329045;10307.79384412315;10334.328268662513;10627.256092073481;11328.093752499863;1975.8715683480527;2010.6280338137492;2068.2244158440585;2100.9159633614636;2141.453929248047;81275;83902;84204.57897710473;92521;95416.52291738566;11473.942630286796;11755.001649719568;11917.582884598998;12035.39823008846;12054.095942804324;16774;16887.493375198763;16893.23980420884;16923.57691057709;16991.660166796595;8910.420822646507;9034.774130646787;9152.084791520794;9155.725328240163;9302.813943721088;8716.215540601377;8746.475211487332;8759.562021898879;8907.866382004275;8944.821103577891;5018.89962200754;5113.488651134857;5141.640085194075;5154.484551544815;5278.392984806796;2091.2889617530113;2144.6997420361163;2148.6776983452605;2162.5943136960786;2173.8152257058327;1060.151878497199;1066.8826429092794;1088.3850624397348;1094.7865166292656;1109.9611513596985;20951;21040.78959210419;21390.572188556143;21400.78599214019;21500.89249553742;1016.6645007147623;1033.9844902326472;1042.6402891002592;1051.558345494894;1095.9287646302964;10682.62610808618;11780.281267953973;11861.169718119821;11965.641030769091;11998.820017699742;531774;537154;539399;540033;540111;104210.47894760477;104617.47691261495;105447;106839.46580267049;108475.45762271139;1028.6451174344838;1056.292284169593;1074.6507385099874;1083.0577397663926;1089.7330154112135;16165;18379.54051148732;18427.26290948401;18832.811671883104;18837;31032.68967310298;34582;43770;43833.34249986317;45164.32253516265;60182.69908650429;63580;64199.35800641934;64403.67798160979;65094.02358964524;9131.406458580172;9344.112309330603;9378.015308392793;9405.858912116188;9547.093026162504;10993.505292261707;14356.353964071433;14379.928100359431;14459.204743738774;14905.180215088274;5935.436133567304;12334.568290110163;12665.493380265054;12811.551595694105;12941.28822914711;11847;12116.21244619097;12123.575674851338;12310.692232694255;12874.16317939331;12728;12847.229166250056;13043.869561304266;13063.673408164872;13121.540746074223;9253.72238832836;9276.72169834879;9294.814103718023;9543.379680320757;9617.807643847224;12474.875251247735;12659.240445573296;12692.36538173106;12735.936320318338;12866.29235392025 03:51:38 INFO - PROCESS | 7169 | |3;mootools.html;1536.97694534582;1556.4941394046934;1724.5688577855535;1804.7653805005364;1845.2250054976907;8331;8692.17424344687;8943.865842012376;9472.66845660402;9483.478408687528;9053.049429809875;9309.767255818608;9374;9406.811863762738;9410.529473526314;2503.8748062596933;2513.1329691256487;2528.317354314334;2535.1887396033276;2537.086648806428;2482.8137889658256;2536.3912660961328;2547.1594373856674;2550.2604244768995;2554.978008796487;2411.5056413435204;2450.240425468102;2524.406764410371;2529.7849682776987;2541.3011421859046;2500.1374525788574;2503.9749602503925;2506.6114752213434;2507.6489291499206;2508.159766478223;2399.4841109161616;2413.855168689884;2415.058127330325;2437.5003124359464;2469.802415806731;9349.579268932914;9515.429074255568;9539.236861051098;9546.761330966712;9566.378185417925;5468.7265636718;5562.137868630369;5584.664920104807;5600.299962504687;5609.747561359708;3638.945415818765;3721.5720192177973;3742.719296052807;3768.5477742670782;3790.033541446941;1264.0330147437219;1264.7217612125319;1265.7721610110177;1329.9601011969658;1348.7167694784107;12254.693632659255;12511.56209532662;12532.498700052078;12917.354132293347;12961.805572916319;4771.475137734847;4794.808207671654;4839.225723884161;4859.465458799529;4929.630277729185;10229.693109206735;10241.334313269614;10275.332103413255;10314.948425257826;10357.223208259411;5654.688992105392;5687.317521897398;5694.6583205007;5697.344805347355;5699.971500142473;4686.906261874811;5111.948880511147;5212.270282160501;5226.97386513065;5313;3993.520777506718;4064.20747954152;4091.3249313863475;4098.815553300109;4165.770882601486;1183.7869183547043;1188.3167178872184;1192.4335940428227;1197.455157903152;1217.8721234270452;934.6448349627099;1043.087298613713;1044.5404022230193;1045.6131231444415;1053.7839742852698;6267.561270711098;6293;6299.559030867887;6332.68336583169;6488.675566221765;1005.406809982114;1016.2276669731058;1037.9429131397847;1072.8176210044312;1095.5453486802887;4113.876583702494;4294.377315289328;4294.742315461082;4296.548862369469;4364.148990946735;11496.42517874103;11885.049196064294;11904.345261010554;11919.3444360561;11946.641600751991;11563.710907227218;11576.305421674726;11656.53373865036;11692.966299965019;11737.530498780125;8727.258183054384;8730.126987301346;8834.955825220834;8871.955640221886;8898.86651700225;5982.162497250475;6079.848003799941;6096.847578810565;6167.352427995175;6251.843703907439;10303.330283531546;10648.787024259316;10673.412962286839;10762.838557421801;10825.783484330426;10444.373337599465;10643.361398316125;10764.677059687909;10836.512356943798;10964.56141754321;6920.826979325557;7117.217106118426;7394.223606521453;7553.509021913558;7735.9613201933635;8694.82610347802;8710.956445217733;8731.607077681647;8744.344174187088;8744.91255087441;7543.0948286206;7750.7674769756995;7871.252231038042;7948.483348582324;8086;7523.285287897641;7546.924530754842;7584.355329797029;7627.656755446129;7648.158702542604;7066.752663656747;7123.358897699232;7140.393066589398;7151.141862976476;7161.283871612797;5223.164293712987;5332.226827110125;5336.866578335573;5351.090314646442;5514.696691681996;5154.226865969985;5236.711980840938;5312.229726689531;5332.09354409759;5375.569954403716 03:51:38 INFO - PROCESS | 7169 | |4;prototype.html;345.3955577738957;353.38334606112306;355.4756733817619;356.0457972633342;358.1529682301358;5630.211770352154;5692.943070569293;5833.9999999999945;5857.297124345079;5879.147523609074;5670.914936275949;5739.655620662753;5745.482906538411;5750.607141786345;5752.28096487939;4472.329150627415;4477.507474177838;4504.0766642838225;4514.345419914111;4519.322101684741;4443.22243607369;4483.618892394151;4485.506594274627;4517.819287228507;4528.864134075983;4450.198964186445;4451.799669014886;4455.598996090352;4464.732116073046;4482.9551704482865;4472.1055788842195;4474.217012022916;4489;4554.8861278467975;4564.520725323827;3791.8104094795426;3906.1211227473877;3907.5115610548683;3909.2376986487648;3924.783317171686;5553.888922221573;5618.550515958714;5645.2096706461125;5652.74562644682;5659.189059500962;5083.237514372837;5129.153689641204;5136.537711605936;5170.93995730878;5180.430152683201;5999.910001349983;6035.78874739382;6036.63780173191;6045.879082418327;6052.606580572248;4309.418228539138;4325.6106950374615;4326.459192600925;4331.935020974688;4338.284183109783;6053.303870054912;6226.159468471789;6285.9057114143325;6322.873542529123;6368.172137622079;4358.65130789536;4375.824967001285;4395.516493185747;4397.824087036547;4398.538153493837;4451.910961780746;4457.8439754608435;4470.262406702857;4488.4613846338;4505.842295519641;5018.322526458955;5116;5153.3815942087185;5188.92216616751;5191.273221748958;5775.5668324875805;6081.939180608226;6086.804427675417;6090.786822461193;6165.815025549241;1483.4288798812536;1523.6343277613514;1530.0972426268554;1536.5390382885314;1537.531053028837;960.9903900961041;967.1682353176262;985.3938080928042;1002.5588740953957;1004.4626125023077;5207.0887594670785;5228.607854410934;5235.795766973617;5273.973630131824;5305.31030965972;5412.512873841294;5458.089668616032;5459.908018396257;5505.724713764296;5549.361823390281;4976.701397916064;5195.610019391047;5259.133007782182;5285.867853303698;5291.603129765283;2917.3727648555664;2918.7810914181523;2922.4511009165176;2925.7074292570574;2944.1451885312545;5580.776768929279;5598.944010559923;5651.378348381675;5666.914996275059;5702.572307076985;5154.716490593053;5448.645838020516;5469.687275053959;5516.255305533701;5564.8330550083565;5528.55771538276;5620.859478512988;5649.378568357477;5659.745311460912;5680.784494047325;5240.925610249966;5436.238926550207;5448.046591846491;5480.369757477941;5493.807716730055;5342.465753424626;5382.7619647480515;5395.947790180877;5398;5415.918761218506;5607.775529070882;5642.774289028557;5651.773929042956;5661;5688.151350811086;3784.508013958278;4015.7188996769946;4033.3143365628503;4039.3537034074407;4044.3529035355377;5422.295101636762;5467.824417750203;5512.972435137799;6093.512518998381;6282.210059526246;6115.724792384264;6144.78493252734;6145.938540614537;6161.199044124235;6171.321154673072;6072.753081359925;6141.539384546088;6176.969115154575;6181.629102253879;6242.2209670243765;6058.666773327509;6103.755849765959;6137.7851775187655;6144.2319710036245;6144.754209831735;6231.3145553988115;6240.313565507699;6267.561270711007;6279.748810047547;6302.401271879165;5785.971070144622;5959.331387211588;6082.513398927987;6092.573519853745;6102.359252278447 03:51:38 INFO - PROCESS | 7169 | |5;yui.html;798.6805277888843;811.1847593168868;837.5058715357937;851.884995525604;883.1168831168832;14817.481388151404;15404.69190616187;15878.956798725856;15893;15961.68076638468;13594.18434893907;13756.58730238092;13775;13803.102798318103;13803.44786208553;851.3019324154196;873.3319010956624;885.3094586222757;887.1660638999352;889.968851090212;878.2534845381407;890.5013192612125;890.8351954888367;890.9420887642315;897.5287973813735;927.638221093774;929.6420877961999;931.6320053578833;932.324065052838;933.7907409904157;926.0970553710146;927.1655510040983;927.3832901120746;927.9721608351726;928.4986107501941;682.8941514065327;683.1392445518633;686.2828344380134;686.5297271369078;687.1342108942769;13889.930550347284;13907.79138312926;14021.929890350584;14026.92986535071;14034.649133771636;15512.301946412439;15594.532164035098;15700.450484232997;15724.842751572567;15753.212339382984;12818.102732808708;12887.484500619965;12911.160774549624;12943.417546210349;13452.730945381038;3878.1661942682176;3879.515060617423;3887.4946256986696;3893.4354518594646;3997.020729921159;86436.56781716114;87809.12190878074;87853.56073219657;88441;89782;11256.916051214832;11382.203245772716;11429.657110286538;11551.0181634562;11573.88426115745;21512.892435538037;21664.35006949794;21678.132874684838;21678.24126155577;21749.67375489369;8766;8848.823023539622;8894.688685896092;8907.331950103768;9081.909180908238;4576.633869290449;4661.324108004388;4846.80612775492;5084.56781173597;5166.354205724285;3567.910802229965;3666.8716594919583;3682.4844521766972;3686.2811751708696;3789.8673546425744;741.1513816679872;743.0303453992484;753.6570860258569;755.5579985708422;761.4403413491079;706.2196273118233;720.7081132141491;727.5634619228526;823.8393513264856;827.2265431821146;9844.212463002943;10442.947785261025;10666.626668066581;10713.197424356782;10899.618513351994;755.9924400756032;761.067692077201;807.2492581898773;822.6750433578703;846.9364797640078;5069.138246498104;5310.309659744285;5336.946630533723;5406.378266499403;5425.321834770653;131113;131189;132307;134929.32535337456;135643;113280;116925;118311;118777;118811;98575;98813.50593246988;104217.47891260647;104245;104389.99999999849;9669.468179250209;10049.844267909284;10280.22898282617;10299.948500257451;10306.33008854422;59881.40118598758;60059;60191.39808601858;60330.396696032476;63191;82010;88416.1158388408;90871.0912890889;91880.54059729658;93244.53377733068;11864.22882512634;11991.280523168638;12216.572419965258;12419.130660853654;12528.060395470195;14370.640733981734;14381.640458988191;14392.928035359757;14665.193414362313;14707.92646036763;13382.93308533451;13536.390862411019;13694.246816424793;13701.314934253447;13714.24571648529;12782.936085319514;12934;13369.26469044173;13474.19154850712;14448.855511444752;13458.596242112751;13695.383707733376;13882.375293112036;14004.719905602034;14219.573412797632;10458.947705261426;10715.839262411226;10734.355938643706;10762.40806755636;10797.352158870179;9830.803383932138;11301.71745706364;11433.714157146138;11476.713082172679;11637 03:51:38 INFO - PROCESS | 7169 | __end_tp_report 03:51:38 INFO - PROCESS | 7169 | __start_cc_report 03:51:38 INFO - PROCESS | 7169 | _x_x_mozilla_cycle_collect,309 03:51:38 INFO - PROCESS | 7169 | __end_cc_report 03:51:38 INFO - PROCESS | 7169 | __startTimestamp1470221498281__endTimestamp 03:51:38 INFO - PROCESS | 7169 | 03:51:38 INFO - PROCESS | 7169 | ------- Summary: start ------- 03:51:38 INFO - PROCESS | 7169 | Number of tests: 6 03:51:38 INFO - PROCESS | 7169 | 03:51:38 INFO - PROCESS | 7169 | [#0] dojo.html Cycles:165 Average:5740.04 Median:5961.73 stddev:667.74 (11.2%) stddev-sans-first:642.26 03:51:38 INFO - PROCESS | 7169 | Values: 3321.3 3339.8 3345.2 3361.9 3369.4 5703.1 5773.5 5780.5 5790.3 5798.4 5734.8 5756.9 5770.3 5776.7 5782.0 5182.8 5216.6 5243.3 5266.2 5271.4 5048.0 5049.9 5086.2 5154.5 5192.8 5129.2 5142.6 5149.1 5224.4 5284.9 5177.6 5203.4 5218.7 5236.5 5242.6 4996.9 5054.0 5105.7 5135.6 5212.9 5625.3 5679.2 5691.9 5693.3 5712.0 6120.8 6148.4 6156.8 6175.4 6202.6 5931.3 6109.1 6191.5 6198.8 6210.1 5767.5 5803.5 5818.1 5830.7 5838.3 6302.3 6303.6 6321.7 6324.3 6326.5 5845.3 6027.7 6038.2 6072.1 6086.1 6080.9 6221.2 6230.6 6235.3 6240.4 6160.8 6201.3 6210.3 6214.0 6214.0 5984.3 6135.3 6194.3 6205.4 6216.6 4758.7 4763.4 4765.0 4780.0 4782.4 4218.1 4225.8 4237.7 4245.4 4249.5 5822.2 5922.0 5992.6 6021.0 6107.0 6147.0 6248.8 6283.9 6285.2 6287.9 6066.2 6079.7 6086.4 6087.3 6094.1 5236.6 5318.2 5379.0 5385.2 5390.5 6458.4 6599.9 6608.0 6610.7 6612.8 6242.1 6296.0 6314.1 6315.9 6328.0 6107.1 6310.6 6344.4 6484.7 6528.1 6118.3 6122.9 6127.9 6140.0 6140.4 6180.8 6186.3 6226.0 6228.4 6228.8 5750.3 5904.8 5926.2 6041.1 6051.1 6008.8 6016.1 6017.4 6032.8 6070.6 5928.2 5940.0 5961.7 5969.6 5988.8 5881.5 5937.4 5954.3 5978.0 5993.7 5927.4 5927.5 5935.6 5953.6 5955.6 03:51:38 INFO - PROCESS | 7169 | 03:51:38 INFO - PROCESS | 7169 | [#1] ext.html Cycles:180 Average:62961.62 Median:43577.17 stddev:127642.07 (292.9%) stddev-sans-first:127914.25 03:51:38 INFO - PROCESS | 7169 | Values: 595.6 637.4 651.4 662.7 702.9 41145.2 45891.3 45931.3 46078.5 46242.5 47240.0 48071.5 48103.8 48153.0 48265.3 9124.9 9232.5 9247.1 9268.5 9281.2 9247.4 9277.0 9290.5 9324.4 9335.0 9384.9 9403.9 9418.1 9418.3 9451.6 9323.9 9385.7 9402.5 9404.1 9411.2 9167.1 9238.6 9284.0 9299.9 9303.5 44081.6 44422.6 44492.8 44603.8 44671.0 3156.6 3624.3 3625.0 3648.9 3709.6 32561.2 33031.2 33534.5 33573.3 33864.2 4426.5 4510.1 4534.7 4577.2 4597.6 336623.0 337803.0 338680.0 338772.0 339545.3 38495.8 38529.6 38533.2 38653.8 38761.6 37850.8 39635.4 39803.2 39953.0 40048.0 19947.5 20005.2 20068.5 20166.1 20243.4 13594.5 13607.9 13664.7 13680.7 13735.5 20899.3 20906.7 21078.9 21098.7 21187.9 7490.9 7589.4 7623.3 7641.6 7703.4 1019.3 1021.9 1092.4 1103.9 1164.2 33806.3 34100.0 34574.5 34922.7 35000.8 1157.7 1158.7 1184.4 1196.1 1261.0 17795.6 17885.2 17936.4 17958.8 18145.4 577766.0 579333.0 585632.0 586759.0 590355.0 64303.4 64896.4 65024.3 65038.3 65217.7 1440.2 1452.0 1453.4 1483.3 1490.3 32180.4 32839.5 33218.8 33248.0 33675.2 56216.0 56358.4 56617.4 56628.7 56894.0 484754.0 484846.0 486551.0 487851.0 489068.0 30988.2 31462.8 31514.2 31585.4 31669.0 52302.5 52317.7 52828.7 52993.5 53296.5 44096.1 44118.8 44654.6 44750.0 45576.5 43520.6 43633.8 44413.6 45432.8 45596.8 40268.8 41010.4 43037.6 43455.0 45192.1 33683.7 34353.6 34737.7 34932.1 35276.3 29481.9 29629.6 30211.2 30281.4 30545.2 03:51:38 INFO - PROCESS | 7169 | 03:51:38 INFO - PROCESS | 7169 | [#2] jquery.html Cycles:180 Average:31474.64 Median:11824.79 stddev:88781.64 (750.8%) stddev-sans-first:89000.08 03:51:38 INFO - PROCESS | 7169 | Values: 425.5 428.8 429.8 435.6 438.8 18876.5 19822.3 20619.7 20637.6 20835.2 19645.8 19725.0 19729.1 19926.8 20061.9 5950.5 6189.2 6195.1 6196.6 6204.0 5995.8 6016.6 6026.9 6061.1 6069.6 5857.7 5946.0 5962.3 6018.2 6037.6 6009.9 6022.6 6038.1 6051.5 6067.8 5291.0 5430.9 5437.3 5450.7 5470.1 21824.0 22762.3 24147.3 24526.3 24657.3 2493.8 2498.2 2609.5 2638.6 2982.7 10091.4 10307.8 10334.3 10627.3 11328.1 1975.9 2010.6 2068.2 2100.9 2141.5 81275.0 83902.0 84204.6 92521.0 95416.5 11473.9 11755.0 11917.6 12035.4 12054.1 16774.0 16887.5 16893.2 16923.6 16991.7 8910.4 9034.8 9152.1 9155.7 9302.8 8716.2 8746.5 8759.6 8907.9 8944.8 5018.9 5113.5 5141.6 5154.5 5278.4 2091.3 2144.7 2148.7 2162.6 2173.8 1060.2 1066.9 1088.4 1094.8 1110.0 20951.0 21040.8 21390.6 21400.8 21500.9 1016.7 1034.0 1042.6 1051.6 1095.9 10682.6 11780.3 11861.2 11965.6 11998.8 531774.0 537154.0 539399.0 540033.0 540111.0 104210.5 104617.5 105447.0 106839.5 108475.5 1028.6 1056.3 1074.7 1083.1 1089.7 16165.0 18379.5 18427.3 18832.8 18837.0 31032.7 34582.0 43770.0 43833.3 45164.3 60182.7 63580.0 64199.4 64403.7 65094.0 9131.4 9344.1 9378.0 9405.9 9547.1 10993.5 14356.4 14379.9 14459.2 14905.2 5935.4 12334.6 12665.5 12811.6 12941.3 11847.0 12116.2 12123.6 12310.7 12874.2 12728.0 12847.2 13043.9 13063.7 13121.5 9253.7 9276.7 9294.8 9543.4 9617.8 12474.9 12659.2 12692.4 12735.9 12866.3 03:51:38 INFO - PROCESS | 7169 | 03:51:38 INFO - PROCESS | 7169 | [#3] mootools.html Cycles:180 Average:6058.75 Median:4294.56 stddev:3420.73 (79.7%) stddev-sans-first:3413.44 03:51:38 INFO - PROCESS | 7169 | Values: 1537.0 1556.5 1724.6 1804.8 1845.2 8331.0 8692.2 8943.9 9472.7 9483.5 9053.0 9309.8 9374.0 9406.8 9410.5 2503.9 2513.1 2528.3 2535.2 2537.1 2482.8 2536.4 2547.2 2550.3 2555.0 2411.5 2450.2 2524.4 2529.8 2541.3 2500.1 2504.0 2506.6 2507.6 2508.2 2399.5 2413.9 2415.1 2437.5 2469.8 9349.6 9515.4 9539.2 9546.8 9566.4 5468.7 5562.1 5584.7 5600.3 5609.7 3638.9 3721.6 3742.7 3768.5 3790.0 1264.0 1264.7 1265.8 1330.0 1348.7 12254.7 12511.6 12532.5 12917.4 12961.8 4771.5 4794.8 4839.2 4859.5 4929.6 10229.7 10241.3 10275.3 10314.9 10357.2 5654.7 5687.3 5694.7 5697.3 5700.0 4686.9 5111.9 5212.3 5227.0 5313.0 3993.5 4064.2 4091.3 4098.8 4165.8 1183.8 1188.3 1192.4 1197.5 1217.9 934.6 1043.1 1044.5 1045.6 1053.8 6267.6 6293.0 6299.6 6332.7 6488.7 1005.4 1016.2 1037.9 1072.8 1095.5 4113.9 4294.4 4294.7 4296.5 4364.1 11496.4 11885.0 11904.3 11919.3 11946.6 11563.7 11576.3 11656.5 11693.0 11737.5 8727.3 8730.1 8835.0 8872.0 8898.9 5982.2 6079.8 6096.8 6167.4 6251.8 10303.3 10648.8 10673.4 10762.8 10825.8 10444.4 10643.4 10764.7 10836.5 10964.6 6920.8 7117.2 7394.2 7553.5 7736.0 8694.8 8711.0 8731.6 8744.3 8744.9 7543.1 7750.8 7871.3 7948.5 8086.0 7523.3 7546.9 7584.4 7627.7 7648.2 7066.8 7123.4 7140.4 7151.1 7161.3 5223.2 5332.2 5336.9 5351.1 5514.7 5154.2 5236.7 5312.2 5332.1 5375.6 03:51:38 INFO - PROCESS | 7169 | 03:51:38 INFO - PROCESS | 7169 | [#4] prototype.html Cycles:180 Average:4891.08 Median:5429.27 stddev:1426.27 (26.3%) stddev-sans-first:1388.87 03:51:38 INFO - PROCESS | 7169 | Values: 345.4 353.4 355.5 356.0 358.2 5630.2 5692.9 5834.0 5857.3 5879.1 5670.9 5739.7 5745.5 5750.6 5752.3 4472.3 4477.5 4504.1 4514.3 4519.3 4443.2 4483.6 4485.5 4517.8 4528.9 4450.2 4451.8 4455.6 4464.7 4483.0 4472.1 4474.2 4489.0 4554.9 4564.5 3791.8 3906.1 3907.5 3909.2 3924.8 5553.9 5618.6 5645.2 5652.7 5659.2 5083.2 5129.2 5136.5 5170.9 5180.4 5999.9 6035.8 6036.6 6045.9 6052.6 4309.4 4325.6 4326.5 4331.9 4338.3 6053.3 6226.2 6285.9 6322.9 6368.2 4358.7 4375.8 4395.5 4397.8 4398.5 4451.9 4457.8 4470.3 4488.5 4505.8 5018.3 5116.0 5153.4 5188.9 5191.3 5775.6 6081.9 6086.8 6090.8 6165.8 1483.4 1523.6 1530.1 1536.5 1537.5 961.0 967.2 985.4 1002.6 1004.5 5207.1 5228.6 5235.8 5274.0 5305.3 5412.5 5458.1 5459.9 5505.7 5549.4 4976.7 5195.6 5259.1 5285.9 5291.6 2917.4 2918.8 2922.5 2925.7 2944.1 5580.8 5598.9 5651.4 5666.9 5702.6 5154.7 5448.6 5469.7 5516.3 5564.8 5528.6 5620.9 5649.4 5659.7 5680.8 5240.9 5436.2 5448.0 5480.4 5493.8 5342.5 5382.8 5395.9 5398.0 5415.9 5607.8 5642.8 5651.8 5661.0 5688.2 3784.5 4015.7 4033.3 4039.4 4044.4 5422.3 5467.8 5513.0 6093.5 6282.2 6115.7 6144.8 6145.9 6161.2 6171.3 6072.8 6141.5 6177.0 6181.6 6242.2 6058.7 6103.8 6137.8 6144.2 6144.8 6231.3 6240.3 6267.6 6279.7 6302.4 5786.0 5959.3 6082.5 6092.6 6102.4 03:51:38 INFO - PROCESS | 7169 | 03:51:38 INFO - PROCESS | 7169 | [#5] yui.html Cycles:180 Average:23322.38 Median:3617.39 stddev:35413.40 (979.0%) stddev-sans-first:35472.36 03:51:38 INFO - PROCESS | 7169 | Values: 798.7 811.2 837.5 851.9 883.1 14817.5 15404.7 15879.0 15893.0 15961.7 13594.2 13756.6 13775.0 13803.1 13803.4 851.3 873.3 885.3 887.2 890.0 878.3 890.5 890.8 890.9 897.5 927.6 929.6 931.6 932.3 933.8 926.1 927.2 927.4 928.0 928.5 682.9 683.1 686.3 686.5 687.1 13889.9 13907.8 14021.9 14026.9 14034.6 15512.3 15594.5 15700.5 15724.8 15753.2 12818.1 12887.5 12911.2 12943.4 13452.7 3878.2 3879.5 3887.5 3893.4 3997.0 86436.6 87809.1 87853.6 88441.0 89782.0 11256.9 11382.2 11429.7 11551.0 11573.9 21512.9 21664.4 21678.1 21678.2 21749.7 8766.0 8848.8 8894.7 8907.3 9081.9 4576.6 4661.3 4846.8 5084.6 5166.4 3567.9 3666.9 3682.5 3686.3 3789.9 741.2 743.0 753.7 755.6 761.4 706.2 720.7 727.6 823.8 827.2 9844.2 10442.9 10666.6 10713.2 10899.6 756.0 761.1 807.2 822.7 846.9 5069.1 5310.3 5336.9 5406.4 5425.3 131113.0 131189.0 132307.0 134929.3 135643.0 113280.0 116925.0 118311.0 118777.0 118811.0 98575.0 98813.5 104217.5 104245.0 104390.0 9669.5 10049.8 10280.2 10299.9 10306.3 59881.4 60059.0 60191.4 60330.4 63191.0 82010.0 88416.1 90871.1 91880.5 93244.5 11864.2 11991.3 12216.6 12419.1 12528.1 14370.6 14381.6 14392.9 14665.2 14707.9 13382.9 13536.4 13694.2 13701.3 13714.2 12782.9 12934.0 13369.3 13474.2 14448.9 13458.6 13695.4 13882.4 14004.7 14219.6 10458.9 10715.8 10734.4 10762.4 10797.4 9830.8 11301.7 11433.7 11476.7 11637.0 03:51:38 INFO - PROCESS | 7169 | -------- Summary: end -------- 03:51:38 INFO - PROCESS | 7169 | 03:51:38 INFO - TEST-INFO | 7169: exit 0 03:51:38 INFO - TEST-OK | dromaeo_css | took 1110042ms 03:51:38 INFO - TEST-START | kraken 03:51:38 INFO - operating with platform_type : linux_ 03:51:38 INFO - Initialising browser for kraken test... 03:51:38 INFO - TEST-INFO | started process 7429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFG23N9/profile http://localhost:59386/getInfo.html) 03:51:43 INFO - PROCESS | 7429 | __metrics Screen width/height:1600/1200 03:51:43 INFO - PROCESS | 7429 | colorDepth:24 03:51:43 INFO - PROCESS | 7429 | Browser inner width/height: 1024/697 03:51:43 INFO - PROCESS | 7429 | __metrics 03:51:43 ERROR - PROCESS | 7429 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 03:51:44 INFO - TEST-INFO | 7429: exit 0 03:51:44 INFO - Browser initialized. 03:51:44 INFO - Running cycle 1/1 for kraken test... 03:51:44 INFO - TEST-INFO | started process 7554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFG23N9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:56 INFO - PROCESS | 7554 | RSS: Main: 152514560 03:51:56 INFO - PROCESS | 7554 | 03:51:58 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59386/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:59 INFO - PROCESS | 7554 | RSS: Main: 157966336 03:51:59 INFO - PROCESS | 7554 | 03:52:02 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59386/tests/kraken/driver.html?testName=audio-dft) 03:52:02 INFO - PROCESS | 7554 | RSS: Main: 156651520 03:52:02 INFO - PROCESS | 7554 | 03:52:05 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59386/tests/kraken/driver.html?testName=audio-fft) 03:52:06 INFO - PROCESS | 7554 | RSS: Main: 157519872 03:52:06 INFO - PROCESS | 7554 | 03:52:08 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59386/tests/kraken/driver.html?testName=audio-oscillator) 03:52:09 INFO - PROCESS | 7554 | RSS: Main: 157028352 03:52:09 INFO - PROCESS | 7554 | 03:52:11 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59386/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:11 INFO - PROCESS | 7554 | RSS: Main: 156712960 03:52:11 INFO - PROCESS | 7554 | 03:52:14 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59386/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:15 INFO - PROCESS | 7554 | RSS: Main: 157831168 03:52:15 INFO - PROCESS | 7554 | 03:52:18 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59386/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:19 INFO - PROCESS | 7554 | RSS: Main: 156016640 03:52:19 INFO - PROCESS | 7554 | 03:52:22 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59386/tests/kraken/driver.html?testName=json-parse-financial) 03:52:23 INFO - PROCESS | 7554 | RSS: Main: 157691904 03:52:23 INFO - PROCESS | 7554 | 03:52:24 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59386/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:25 INFO - PROCESS | 7554 | RSS: Main: 156676096 03:52:25 INFO - PROCESS | 7554 | 03:52:26 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59386/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:27 INFO - PROCESS | 7554 | RSS: Main: 157327360 03:52:27 INFO - PROCESS | 7554 | 03:52:29 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59386/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:30 INFO - PROCESS | 7554 | RSS: Main: 157380608 03:52:30 INFO - PROCESS | 7554 | 03:52:32 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:33 INFO - PROCESS | 7554 | RSS: Main: 158167040 03:52:33 INFO - PROCESS | 7554 | 03:52:36 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:36 INFO - PROCESS | 7554 | RSS: Main: 158441472 03:52:36 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | Cycle 1(1): loaded http://localhost:59386/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59386/tests/kraken/driver.html?testName=ai-astar) 03:52:38 INFO - PROCESS | 7554 | RSS: Main: 158982144 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | __start_tp_report 03:52:38 INFO - PROCESS | 7554 | _x_x_mozilla_page_load 03:52:38 INFO - PROCESS | 7554 | _x_x_mozilla_page_load_details 03:52:38 INFO - PROCESS | 7554 | |i|pagename|runs| 03:52:38 INFO - PROCESS | 7554 | |0;ai-astar;101;111;105;109;110;111;110;110;112;111 03:52:38 INFO - PROCESS | 7554 | |1;audio-beat-detection;144;116;140;170;117;147;143;118;181;121 03:52:38 INFO - PROCESS | 7554 | |2;audio-dft;163;163;160;162;162;162;162;162;161;161 03:52:38 INFO - PROCESS | 7554 | |3;audio-fft;75;74;77;173;77;77;75;74;164;76 03:52:38 INFO - PROCESS | 7554 | |4;audio-oscillator;84;83;146;84;86;83;131;86;83;130 03:52:38 INFO - PROCESS | 7554 | |5;imaging-gaussian-blur;118;118;118;117;117;117;118;118;117;118 03:52:38 INFO - PROCESS | 7554 | |6;imaging-darkroom;147;148;148;147;147;149;150;148;148;147 03:52:38 INFO - PROCESS | 7554 | |7;imaging-desaturate;95;95;96;95;95;94;95;96;95;95 03:52:38 INFO - PROCESS | 7554 | |8;json-parse-financial;51;51;51;55;52;51;58;59;52;54 03:52:38 INFO - PROCESS | 7554 | |9;json-stringify-tinderbox;64;65;61;61;63;61;61;61;61;61 03:52:38 INFO - PROCESS | 7554 | |10;stanford-crypto-aes;73;75;74;74;82;75;72;72;73;80 03:52:38 INFO - PROCESS | 7554 | |11;stanford-crypto-ccm;129;128;126;126;119;121;120;133;152;130 03:52:38 INFO - PROCESS | 7554 | |12;stanford-crypto-pbkdf2;156;151;153;151;161;150;159;154;152;154 03:52:38 INFO - PROCESS | 7554 | |13;stanford-crypto-sha256-iterative;64;63;61;61;61;63;61;67;60;60 03:52:38 INFO - PROCESS | 7554 | __end_tp_report 03:52:38 INFO - PROCESS | 7554 | __start_cc_report 03:52:38 INFO - PROCESS | 7554 | _x_x_mozilla_cycle_collect,874 03:52:38 INFO - PROCESS | 7554 | __end_cc_report 03:52:38 INFO - PROCESS | 7554 | __startTimestamp1470221558628__endTimestamp 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | ------- Summary: start ------- 03:52:38 INFO - PROCESS | 7554 | Number of tests: 14 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.40 (3.1%) stddev-sans-first:2.03 03:52:38 INFO - PROCESS | 7554 | Values: 101.0 111.0 105.0 109.0 110.0 111.0 110.0 110.0 112.0 111.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:143.50 stddev:22.62 (15.8%) stddev-sans-first:23.94 03:52:38 INFO - PROCESS | 7554 | Values: 144.0 116.0 140.0 170.0 117.0 147.0 143.0 118.0 181.0 121.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 03:52:38 INFO - PROCESS | 7554 | Values: 163.0 163.0 160.0 162.0 162.0 162.0 162.0 162.0 161.0 161.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.50 stddev:39.23 (52.0%) stddev-sans-first:40.99 03:52:38 INFO - PROCESS | 7554 | Values: 75.0 74.0 77.0 173.0 77.0 77.0 75.0 74.0 164.0 76.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#4] audio-oscillator Cycles:10 Average:99.60 Median:83.50 stddev:25.27 (30.3%) stddev-sans-first:26.16 03:52:38 INFO - PROCESS | 7554 | Values: 84.0 83.0 146.0 84.0 86.0 83.0 131.0 86.0 83.0 130.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:52:38 INFO - PROCESS | 7554 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 03:52:38 INFO - PROCESS | 7554 | Values: 147.0 148.0 148.0 147.0 147.0 149.0 150.0 148.0 148.0 147.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:52:38 INFO - PROCESS | 7554 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:3.03 (5.7%) stddev-sans-first:3.08 03:52:38 INFO - PROCESS | 7554 | Values: 51.0 51.0 51.0 55.0 52.0 51.0 58.0 59.0 52.0 54.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:61.00 stddev:1.52 (2.5%) stddev-sans-first:1.41 03:52:38 INFO - PROCESS | 7554 | Values: 64.0 65.0 61.0 61.0 63.0 61.0 61.0 61.0 61.0 61.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.50 stddev:3.37 (4.5%) stddev-sans-first:3.49 03:52:38 INFO - PROCESS | 7554 | Values: 73.0 75.0 74.0 74.0 82.0 75.0 72.0 72.0 73.0 80.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:128.50 stddev:9.47 (7.4%) stddev-sans-first:10.04 03:52:38 INFO - PROCESS | 7554 | Values: 129.0 128.0 126.0 126.0 119.0 121.0 120.0 133.0 152.0 130.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.10 Median:154.00 stddev:3.60 (2.3%) stddev-sans-first:3.76 03:52:38 INFO - PROCESS | 7554 | Values: 156.0 151.0 153.0 151.0 161.0 150.0 159.0 154.0 152.0 154.0 03:52:38 INFO - PROCESS | 7554 | 03:52:38 INFO - PROCESS | 7554 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:2.18 (3.5%) stddev-sans-first:2.20 03:52:38 INFO - PROCESS | 7554 | Values: 64.0 63.0 61.0 61.0 61.0 63.0 61.0 67.0 60.0 60.0 03:52:38 INFO - PROCESS | 7554 | -------- Summary: end -------- 03:52:38 INFO - PROCESS | 7554 | 03:52:39 INFO - TEST-INFO | 7554: exit 0 03:52:39 INFO - TEST-OK | kraken | took 60558ms 03:52:39 INFO - SUITE-END | took 1170s 03:52:39 INFO - Completed test suite (00:19:30) 03:52:39 INFO - javascript benchmark 03:52:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7668.918628332351, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.2693207494353, 3339.7662163648547, 3345.1637090727318, 3361.932761344775, 3369.39350916835, 5703.058995265781, 5773.509251713599, 5780.47975682188, 5790.33411157717, 5798.362180160179, 5734.827955161341, 5756.884862302752, 5770.3364113127, 5776.711164441782, 5782.045962416196, 5182.792688292473, 5216.60875434344, 5243.265942767996, 5266.210068489719, 5271.367435907678, 5048.040872234282, 5049.949500505003, 5086.237064440326, 5154.536091751742, 5192.792288308482, 5129.153689641204, 5142.562882155022, 5149.124648809711, 5224.39919409269, 5284.920726189091, 5177.611679124081, 5203.375594928614, 5218.660787048868, 5236.450172731866, 5242.580593552507, 4996.90006199874, 5054.014467178901, 5105.693658380509, 5135.64050516464, 5212.8957420851375, 5625.296837895263, 5679.2333035040565, 5691.857703557444, 5693.3452652945025, 5711.971440142815, 6120.846978825521, 6148.415900489446, 6156.78451254204, 6175.382461753788, 6202.565820392574, 5931.258592675916, 6109.083637454373, 6191.535634827361, 6198.81403557894, 6210.099535567318, 5767.509761670263, 5803.506701930341, 5818.069108942549, 5830.650160990354, 5838.299404071496, 6302.275238347557, 6303.558750887394, 6321.715522801485, 6324.272708638566, 6326.46225070865, 5845.269341332333, 6027.7287522061615, 6038.245219347582, 6072.05883088122, 6086.056661217518, 6080.878382432326, 6221.222347206599, 6230.59501132425, 6235.251769787564, 6240.375962403814, 6160.753569857246, 6201.255849298113, 6210.254769427607, 6213.96893015532, 6214.0, 5984.3417224105315, 6135.263289243823, 6194.287656919422, 6205.410486003822, 6216.564840461125, 4758.714477131314, 4763.356946812136, 4765.0, 4780.0, 4782.402199725035, 4218.093109981307, 4225.7887105644595, 4237.745735255895, 4245.448091748115, 4249.5113061997645, 5822.155787410802, 5922.0, 5992.64044157352, 6021.0, 6106.969465152734, 6146.969265153645, 6248.781292654735, 6283.937160628427, 6285.214348206474, 6287.874242515216, 6066.211392518944, 6079.665618390943, 6086.360932102154, 6087.269527656621, 6094.116353128771, 5236.554892834076, 5318.202269659505, 5379.0, 5385.219143224211, 5390.54180394663, 6458.38645328693, 6599.934000660028, 6608.0, 6610.6694665267505, 6612.801615951529, 6242.094896240111, 6295.96852015737, 6314.0528920661345, 6315.936840631535, 6327.96836015817, 6107.053406721965, 6310.558260921692, 6344.429001389897, 6484.740610375532, 6528.086067950396, 6118.251671986735, 6122.877542449215, 6127.892078906909, 6140.013486850464, 6140.412224875342, 6180.845478863064, 6186.319504854372, 6226.003839385677, 6228.439440450381, 6228.844278893064, 5750.25246717924, 5904.822855314347, 5926.1999630049395, 6041.124037014696, 6051.062085376773, 6008.819735407945, 6016.067509536029, 6017.398260173947, 6032.849178770566, 6070.575059745775, 5928.199693041557, 5939.9605069113595, 5961.731722072431, 5969.611975221596, 5988.820335389945, 5881.5000724937145, 5937.376575459687, 5954.315253745702, 5977.970110149421, 5993.730282137227, 5927.436893495111, 5927.496162826208, 5935.643861368331, 5953.613015154001, 5955.642661440327], "value": 5694.325848702696, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.6426144313413, 637.3976592120446, 651.4137276451196, 662.6686656671665, 702.8524009957908, 41145.17709645805, 45891.31163032549, 45931.31103033453, 46078.539214607925, 46242.53757462424, 47240.0, 48071.51928480714, 48103.75948120263, 48153.0, 48265.27602085972, 9124.90875091249, 9232.53837308132, 9247.121523455295, 9268.490233037213, 9281.164695177433, 9247.398919070272, 9276.953615231949, 9290.535473226346, 9324.393914395543, 9335.019822918597, 9384.906150938506, 9403.905960940405, 9418.058194180596, 9418.293627977895, 9451.621935122586, 9323.86014209784, 9385.718428447157, 9402.482863442508, 9404.106609872051, 9411.152996230372, 9167.08329167078, 9238.58426370815, 9284.025177356416, 9299.90700093004, 9303.534823258879, 44081.55918440839, 44422.55577444217, 44492.77753611244, 44603.77698111521, 44671.0, 3156.621205455337, 3624.2932628137523, 3625.0, 3648.908777280563, 3709.647583479565, 32561.185970350693, 33031.17422064468, 33534.49698254528, 33573.328533429194, 33864.246274564386, 4426.513083560806, 4510.075434535912, 4534.7052441591195, 4577.22187228172, 4597.563231493003, 336623.0, 337803.0, 338680.0, 338772.0, 339545.30227348953, 38495.80752096278, 38529.6147038526, 38533.22933541313, 38653.806730966164, 38761.61238387637, 37850.810745946095, 39635.40546891799, 39803.20393592112, 39953.0, 40048.0, 19947.501312467015, 20005.199792008156, 20068.498287542927, 20166.09252583637, 20243.39269821908, 13594.45622175102, 13607.863921360859, 13664.65838354049, 13680.657983550293, 13735.519256826163, 20899.268525601834, 20906.686399704016, 21078.894605526875, 21098.683519747217, 21187.894060529597, 7490.85018299631, 7589.354904833041, 7623.275788800055, 7641.579713115832, 7703.422243331773, 1019.3170575714141, 1021.9437930913722, 1092.3609688332415, 1103.9448027598587, 1164.2199726183478, 33806.29549636023, 34100.0, 34574.48138277877, 34922.650773492445, 35000.82499587486, 1157.6628993512506, 1158.7381521018306, 1184.4314728930162, 1196.1208511743862, 1260.9684757880943, 17795.555111122067, 17885.195166217552, 17936.372226971995, 17958.820411795976, 18145.364912228008, 577766.0, 579333.0, 585632.0, 586759.0, 590355.0, 64303.35696643067, 64896.35103648998, 65024.34975650278, 65038.34961650323, 65217.67391163014, 1440.1934916446824, 1451.9927400363142, 1453.4258967707697, 1483.3028476615973, 1490.284663361571, 32180.35639287248, 32839.50740738843, 33218.83390583032, 33248.0, 33675.15812104717, 56216.0, 56358.43641563532, 56617.43382566122, 56628.7168564171, 56894.0, 484754.0, 484846.0, 486551.0, 487851.0, 489068.0, 30988.22529436782, 31462.842685786425, 31514.212144696565, 31585.368292634477, 31669.0, 52302.47697522976, 52317.7384113077, 52828.73585632047, 52993.470065298854, 53296.46703532915, 44096.11807763891, 44118.77940610405, 44654.55345446634, 44750.0, 45576.544234558554, 43520.56479435165, 43633.78183109191, 44413.55586444094, 45432.772836135606, 45596.77201613971, 40268.79865600653, 41010.38484422676, 43037.56962430335, 43455.0, 45192.096158077315, 33683.663163369034, 34353.61793816576, 34737.65262347445, 34932.12669683278, 35276.29447411089, 29481.852590737766, 29629.555556666237, 30211.244718882204, 30281.394372112874, 30545.23636909006], "value": 20859.660931981543, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.45966622389585, 428.79203586260667, 429.8380878951425, 435.6493023116391, 438.76306794331083, 18876.528086797836, 19822.306219282327, 20619.690704639404, 20637.587248255026, 20835.16659333625, 19645.803541964575, 19725.0, 19729.11218995145, 19926.800731992713, 20061.899690501563, 5950.464458198772, 6189.195404597396, 6195.070739389105, 6196.566240363154, 6204.0, 5995.820125396245, 6016.578839481238, 6026.8794624107495, 6061.12113743507, 6069.57512974092, 5857.7364018619055, 5946.0, 5962.25471816023, 6018.187544681456, 6037.637741735488, 6009.939900600982, 6022.608530445551, 6038.064100064497, 6051.455369016788, 6067.817965461043, 5291.021161085173, 5430.891382172374, 5437.293151890269, 5450.672959622435, 5470.124780035176, 21824.0, 22762.317130486113, 24147.275581732578, 24526.264212073667, 24657.260282191564, 2493.7880280176205, 2498.2380373985925, 2609.5302845487804, 2638.5514462541414, 2982.7166419190144, 10091.394516329045, 10307.79384412315, 10334.328268662513, 10627.256092073481, 11328.093752499863, 1975.8715683480527, 2010.6280338137492, 2068.2244158440585, 2100.9159633614636, 2141.453929248047, 81275.0, 83902.0, 84204.57897710473, 92521.0, 95416.52291738566, 11473.942630286796, 11755.001649719568, 11917.582884598998, 12035.39823008846, 12054.095942804324, 16774.0, 16887.493375198763, 16893.23980420884, 16923.57691057709, 16991.660166796595, 8910.420822646507, 9034.774130646787, 9152.084791520794, 9155.725328240163, 9302.813943721088, 8716.215540601377, 8746.475211487332, 8759.562021898879, 8907.866382004275, 8944.821103577891, 5018.89962200754, 5113.488651134857, 5141.640085194075, 5154.484551544815, 5278.392984806796, 2091.2889617530113, 2144.6997420361163, 2148.6776983452605, 2162.5943136960786, 2173.8152257058327, 1060.151878497199, 1066.8826429092794, 1088.3850624397348, 1094.7865166292656, 1109.9611513596985, 20951.0, 21040.78959210419, 21390.572188556143, 21400.78599214019, 21500.89249553742, 1016.6645007147623, 1033.9844902326472, 1042.6402891002592, 1051.558345494894, 1095.9287646302964, 10682.62610808618, 11780.281267953973, 11861.169718119821, 11965.641030769091, 11998.820017699742, 531774.0, 537154.0, 539399.0, 540033.0, 540111.0, 104210.47894760477, 104617.47691261495, 105447.0, 106839.46580267049, 108475.45762271139, 1028.6451174344838, 1056.292284169593, 1074.6507385099874, 1083.0577397663926, 1089.7330154112135, 16165.0, 18379.54051148732, 18427.26290948401, 18832.811671883104, 18837.0, 31032.68967310298, 34582.0, 43770.0, 43833.34249986317, 45164.32253516265, 60182.69908650429, 63580.0, 64199.35800641934, 64403.67798160979, 65094.02358964524, 9131.406458580172, 9344.112309330603, 9378.015308392793, 9405.858912116188, 9547.093026162504, 10993.505292261707, 14356.353964071433, 14379.928100359431, 14459.204743738774, 14905.180215088274, 5935.436133567304, 12334.568290110163, 12665.493380265054, 12811.551595694105, 12941.28822914711, 11847.0, 12116.21244619097, 12123.575674851338, 12310.692232694255, 12874.16317939331, 12728.0, 12847.229166250056, 13043.869561304266, 13063.673408164872, 13121.540746074223, 9253.72238832836, 9276.72169834879, 9294.814103718023, 9543.379680320757, 9617.807643847224, 12474.875251247735, 12659.240445573296, 12692.36538173106, 12735.936320318338, 12866.29235392025], "value": 9845.395482385533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.97694534582, 1556.4941394046934, 1724.5688577855535, 1804.7653805005364, 1845.2250054976907, 8331.0, 8692.17424344687, 8943.865842012376, 9472.66845660402, 9483.478408687528, 9053.049429809875, 9309.767255818608, 9374.0, 9406.811863762738, 9410.529473526314, 2503.8748062596933, 2513.1329691256487, 2528.317354314334, 2535.1887396033276, 2537.086648806428, 2482.8137889658256, 2536.3912660961328, 2547.1594373856674, 2550.2604244768995, 2554.978008796487, 2411.5056413435204, 2450.240425468102, 2524.406764410371, 2529.7849682776987, 2541.3011421859046, 2500.1374525788574, 2503.9749602503925, 2506.6114752213434, 2507.6489291499206, 2508.159766478223, 2399.4841109161616, 2413.855168689884, 2415.058127330325, 2437.5003124359464, 2469.802415806731, 9349.579268932914, 9515.429074255568, 9539.236861051098, 9546.761330966712, 9566.378185417925, 5468.7265636718, 5562.137868630369, 5584.664920104807, 5600.299962504687, 5609.747561359708, 3638.945415818765, 3721.5720192177973, 3742.719296052807, 3768.5477742670782, 3790.033541446941, 1264.0330147437219, 1264.7217612125319, 1265.7721610110177, 1329.9601011969658, 1348.7167694784107, 12254.693632659255, 12511.56209532662, 12532.498700052078, 12917.354132293347, 12961.805572916319, 4771.475137734847, 4794.808207671654, 4839.225723884161, 4859.465458799529, 4929.630277729185, 10229.693109206735, 10241.334313269614, 10275.332103413255, 10314.948425257826, 10357.223208259411, 5654.688992105392, 5687.317521897398, 5694.6583205007, 5697.344805347355, 5699.971500142473, 4686.906261874811, 5111.948880511147, 5212.270282160501, 5226.97386513065, 5313.0, 3993.520777506718, 4064.20747954152, 4091.3249313863475, 4098.815553300109, 4165.770882601486, 1183.7869183547043, 1188.3167178872184, 1192.4335940428227, 1197.455157903152, 1217.8721234270452, 934.6448349627099, 1043.087298613713, 1044.5404022230193, 1045.6131231444415, 1053.7839742852698, 6267.561270711098, 6293.0, 6299.559030867887, 6332.68336583169, 6488.675566221765, 1005.406809982114, 1016.2276669731058, 1037.9429131397847, 1072.8176210044312, 1095.5453486802887, 4113.876583702494, 4294.377315289328, 4294.742315461082, 4296.548862369469, 4364.148990946735, 11496.42517874103, 11885.049196064294, 11904.345261010554, 11919.3444360561, 11946.641600751991, 11563.710907227218, 11576.305421674726, 11656.53373865036, 11692.966299965019, 11737.530498780125, 8727.258183054384, 8730.126987301346, 8834.955825220834, 8871.955640221886, 8898.86651700225, 5982.162497250475, 6079.848003799941, 6096.847578810565, 6167.352427995175, 6251.843703907439, 10303.330283531546, 10648.787024259316, 10673.412962286839, 10762.838557421801, 10825.783484330426, 10444.373337599465, 10643.361398316125, 10764.677059687909, 10836.512356943798, 10964.56141754321, 6920.826979325557, 7117.217106118426, 7394.223606521453, 7553.509021913558, 7735.9613201933635, 8694.82610347802, 8710.956445217733, 8731.607077681647, 8744.344174187088, 8744.91255087441, 7543.0948286206, 7750.7674769756995, 7871.252231038042, 7948.483348582324, 8086.0, 7523.285287897641, 7546.924530754842, 7584.355329797029, 7627.656755446129, 7648.158702542604, 7066.752663656747, 7123.358897699232, 7140.393066589398, 7151.141862976476, 7161.283871612797, 5223.164293712987, 5332.226827110125, 5336.866578335573, 5351.090314646442, 5514.696691681996, 5154.226865969985, 5236.711980840938, 5312.229726689531, 5332.09354409759, 5375.569954403716], "value": 4876.766045957333, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.3955577738957, 353.38334606112306, 355.4756733817619, 356.0457972633342, 358.1529682301358, 5630.211770352154, 5692.943070569293, 5833.9999999999945, 5857.297124345079, 5879.147523609074, 5670.914936275949, 5739.655620662753, 5745.482906538411, 5750.607141786345, 5752.28096487939, 4472.329150627415, 4477.507474177838, 4504.0766642838225, 4514.345419914111, 4519.322101684741, 4443.22243607369, 4483.618892394151, 4485.506594274627, 4517.819287228507, 4528.864134075983, 4450.198964186445, 4451.799669014886, 4455.598996090352, 4464.732116073046, 4482.9551704482865, 4472.1055788842195, 4474.217012022916, 4489.0, 4554.8861278467975, 4564.520725323827, 3791.8104094795426, 3906.1211227473877, 3907.5115610548683, 3909.2376986487648, 3924.783317171686, 5553.888922221573, 5618.550515958714, 5645.2096706461125, 5652.74562644682, 5659.189059500962, 5083.237514372837, 5129.153689641204, 5136.537711605936, 5170.93995730878, 5180.430152683201, 5999.910001349983, 6035.78874739382, 6036.63780173191, 6045.879082418327, 6052.606580572248, 4309.418228539138, 4325.6106950374615, 4326.459192600925, 4331.935020974688, 4338.284183109783, 6053.303870054912, 6226.159468471789, 6285.9057114143325, 6322.873542529123, 6368.172137622079, 4358.65130789536, 4375.824967001285, 4395.516493185747, 4397.824087036547, 4398.538153493837, 4451.910961780746, 4457.8439754608435, 4470.262406702857, 4488.4613846338, 4505.842295519641, 5018.322526458955, 5116.0, 5153.3815942087185, 5188.92216616751, 5191.273221748958, 5775.5668324875805, 6081.939180608226, 6086.804427675417, 6090.786822461193, 6165.815025549241, 1483.4288798812536, 1523.6343277613514, 1530.0972426268554, 1536.5390382885314, 1537.531053028837, 960.9903900961041, 967.1682353176262, 985.3938080928042, 1002.5588740953957, 1004.4626125023077, 5207.0887594670785, 5228.607854410934, 5235.795766973617, 5273.973630131824, 5305.31030965972, 5412.512873841294, 5458.089668616032, 5459.908018396257, 5505.724713764296, 5549.361823390281, 4976.701397916064, 5195.610019391047, 5259.133007782182, 5285.867853303698, 5291.603129765283, 2917.3727648555664, 2918.7810914181523, 2922.4511009165176, 2925.7074292570574, 2944.1451885312545, 5580.776768929279, 5598.944010559923, 5651.378348381675, 5666.914996275059, 5702.572307076985, 5154.716490593053, 5448.645838020516, 5469.687275053959, 5516.255305533701, 5564.8330550083565, 5528.55771538276, 5620.859478512988, 5649.378568357477, 5659.745311460912, 5680.784494047325, 5240.925610249966, 5436.238926550207, 5448.046591846491, 5480.369757477941, 5493.807716730055, 5342.465753424626, 5382.7619647480515, 5395.947790180877, 5398.0, 5415.918761218506, 5607.775529070882, 5642.774289028557, 5651.773929042956, 5661.0, 5688.151350811086, 3784.508013958278, 4015.7188996769946, 4033.3143365628503, 4039.3537034074407, 4044.3529035355377, 5422.295101636762, 5467.824417750203, 5512.972435137799, 6093.512518998381, 6282.210059526246, 6115.724792384264, 6144.78493252734, 6145.938540614537, 6161.199044124235, 6171.321154673072, 6072.753081359925, 6141.539384546088, 6176.969115154575, 6181.629102253879, 6242.2209670243765, 6058.666773327509, 6103.755849765959, 6137.7851775187655, 6144.2319710036245, 6144.754209831735, 6231.3145553988115, 6240.313565507699, 6267.561270711007, 6279.748810047547, 6302.401271879165, 5785.971070144622, 5959.331387211588, 6082.513398927987, 6092.573519853745, 6102.359252278447], "value": 4437.868623149852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.6805277888843, 811.1847593168868, 837.5058715357937, 851.884995525604, 883.1168831168832, 14817.481388151404, 15404.69190616187, 15878.956798725856, 15893.0, 15961.68076638468, 13594.18434893907, 13756.58730238092, 13775.0, 13803.102798318103, 13803.44786208553, 851.3019324154196, 873.3319010956624, 885.3094586222757, 887.1660638999352, 889.968851090212, 878.2534845381407, 890.5013192612125, 890.8351954888367, 890.9420887642315, 897.5287973813735, 927.638221093774, 929.6420877961999, 931.6320053578833, 932.324065052838, 933.7907409904157, 926.0970553710146, 927.1655510040983, 927.3832901120746, 927.9721608351726, 928.4986107501941, 682.8941514065327, 683.1392445518633, 686.2828344380134, 686.5297271369078, 687.1342108942769, 13889.930550347284, 13907.79138312926, 14021.929890350584, 14026.92986535071, 14034.649133771636, 15512.301946412439, 15594.532164035098, 15700.450484232997, 15724.842751572567, 15753.212339382984, 12818.102732808708, 12887.484500619965, 12911.160774549624, 12943.417546210349, 13452.730945381038, 3878.1661942682176, 3879.515060617423, 3887.4946256986696, 3893.4354518594646, 3997.020729921159, 86436.56781716114, 87809.12190878074, 87853.56073219657, 88441.0, 89782.0, 11256.916051214832, 11382.203245772716, 11429.657110286538, 11551.0181634562, 11573.88426115745, 21512.892435538037, 21664.35006949794, 21678.132874684838, 21678.24126155577, 21749.67375489369, 8766.0, 8848.823023539622, 8894.688685896092, 8907.331950103768, 9081.909180908238, 4576.633869290449, 4661.324108004388, 4846.80612775492, 5084.56781173597, 5166.354205724285, 3567.910802229965, 3666.8716594919583, 3682.4844521766972, 3686.2811751708696, 3789.8673546425744, 741.1513816679872, 743.0303453992484, 753.6570860258569, 755.5579985708422, 761.4403413491079, 706.2196273118233, 720.7081132141491, 727.5634619228526, 823.8393513264856, 827.2265431821146, 9844.212463002943, 10442.947785261025, 10666.626668066581, 10713.197424356782, 10899.618513351994, 755.9924400756032, 761.067692077201, 807.2492581898773, 822.6750433578703, 846.9364797640078, 5069.138246498104, 5310.309659744285, 5336.946630533723, 5406.378266499403, 5425.321834770653, 131113.0, 131189.0, 132307.0, 134929.32535337456, 135643.0, 113280.0, 116925.0, 118311.0, 118777.0, 118811.0, 98575.0, 98813.50593246988, 104217.47891260647, 104245.0, 104389.99999999849, 9669.468179250209, 10049.844267909284, 10280.22898282617, 10299.948500257451, 10306.33008854422, 59881.40118598758, 60059.0, 60191.39808601858, 60330.396696032476, 63191.0, 82010.0, 88416.1158388408, 90871.0912890889, 91880.54059729658, 93244.53377733068, 11864.22882512634, 11991.280523168638, 12216.572419965258, 12419.130660853654, 12528.060395470195, 14370.640733981734, 14381.640458988191, 14392.928035359757, 14665.193414362313, 14707.92646036763, 13382.93308533451, 13536.390862411019, 13694.246816424793, 13701.314934253447, 13714.24571648529, 12782.936085319514, 12934.0, 13369.26469044173, 13474.19154850712, 14448.855511444752, 13458.596242112751, 13695.383707733376, 13882.375293112036, 14004.719905602034, 14219.573412797632, 10458.947705261426, 10715.839262411226, 10734.355938643706, 10762.40806755636, 10797.352158870179, 9830.803383932138, 11301.71745706364, 11433.714157146138, 11476.713082172679, 11637.0], "value": 8036.61805923462, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 109.0, 110.0, 111.0, 110.0, 110.0, 112.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 140.0, 170.0, 117.0, 147.0, 143.0, 118.0, 181.0, 121.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 160.0, 162.0, 162.0, 162.0, 162.0, 162.0, 161.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 77.0, 173.0, 77.0, 77.0, 75.0, 74.0, 164.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 146.0, 84.0, 86.0, 83.0, 131.0, 86.0, 83.0, 130.0], "value": 99.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 149.0, 150.0, 148.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 55.0, 52.0, 51.0, 58.0, 59.0, 52.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 61.0, 61.0, 63.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 74.0, 82.0, 75.0, 72.0, 72.0, 73.0, 80.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 126.0, 126.0, 119.0, 121.0, 120.0, 133.0, 152.0, 130.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 151.0, 153.0, 151.0, 161.0, 150.0, 159.0, 154.0, 152.0, 154.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 61.0, 61.0, 61.0, 63.0, 61.0, 67.0, 60.0, 60.0], "value": 62.1, "unit": "score"}]}]} 03:52:39 INFO - Return code: 0 03:52:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:52:39 ERROR - # TBPL SUCCESS # 03:52:39 INFO - Running post-action listener: _resource_record_post_action 03:52:39 INFO - [mozharness: 2016-08-03 10:52:39.937149Z] Finished run-tests step (success) 03:52:39 INFO - Running post-run listener: _resource_record_post_run 03:52:40 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 270336; Write bytes: 513544192; Read time: 76; Write time: 446728 03:52:40 INFO - TinderboxPrint: CPU usage
13.3% 03:52:40 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 76 03:52:40 INFO - TinderboxPrint: I/O write bytes / time
513,544,192 / 446,728 03:52:40 INFO - TinderboxPrint: CPU idle
8,210.5 (86.7%) 03:52:40 INFO - TinderboxPrint: CPU user
1,204.1 (12.7%) 03:52:40 INFO - TinderboxPrint: Swap in / out
0 / 0 03:52:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 258506752; Read time: 0; Write time: 257600 03:52:40 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 255037440; Read time: 64; Write time: 189128 03:52:40 INFO - Running post-run listener: _upload_blobber_files 03:52:40 INFO - Blob upload gear active. 03:52:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:40 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 03:52:40 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'] 03:52:40 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 03:52:40 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:52:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:52:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:41 INFO - (blobuploader) - INFO - Done attempting. 03:52:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:52:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:42 INFO - (blobuploader) - INFO - Done attempting. 03:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:52:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:52:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:46 INFO - (blobuploader) - INFO - Done attempting. 03:52:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:46 INFO - Return code: 0 03:52:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bcdc7f12395a5b0281fb2b6ec1213c036e4c4c6dcc0da8b9c82b5a0fe6e8e11d1d937febce7b9afc6994dabb596607d2152363491deb35133e293aafb9d69eb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13ec644c0f4984f7a59daba04e2bc9124582df54883e985cba9b3a16099d0d78a42e4821f9001ed76130cdb3b5ff2f843e3666d710dc069f4f866506aafb39f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00c3b4b1a783679693d0e5c790e8d5896c8d15a4c2e92ad6978f6fe6783ac50c87546ec29490ca69d261e8ec7d8d02b794b87ecd18c60b88c3a9a8cd0f76ea04"} 03:52:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:46 INFO - Contents: 03:52:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bcdc7f12395a5b0281fb2b6ec1213c036e4c4c6dcc0da8b9c82b5a0fe6e8e11d1d937febce7b9afc6994dabb596607d2152363491deb35133e293aafb9d69eb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13ec644c0f4984f7a59daba04e2bc9124582df54883e985cba9b3a16099d0d78a42e4821f9001ed76130cdb3b5ff2f843e3666d710dc069f4f866506aafb39f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00c3b4b1a783679693d0e5c790e8d5896c8d15a4c2e92ad6978f6fe6783ac50c87546ec29490ca69d261e8ec7d8d02b794b87ecd18c60b88c3a9a8cd0f76ea04"} 03:52:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:46 INFO - Copying logs to upload dir... 03:52:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1308.326529 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-08-03 03:52:46.025149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 03:52:46.028907) ========= 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=62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884 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/bcdc7f12395a5b0281fb2b6ec1213c036e4c4c6dcc0da8b9c82b5a0fe6e8e11d1d937febce7b9afc6994dabb596607d2152363491deb35133e293aafb9d69eb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13ec644c0f4984f7a59daba04e2bc9124582df54883e985cba9b3a16099d0d78a42e4821f9001ed76130cdb3b5ff2f843e3666d710dc069f4f866506aafb39f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00c3b4b1a783679693d0e5c790e8d5896c8d15a4c2e92ad6978f6fe6783ac50c87546ec29490ca69d261e8ec7d8d02b794b87ecd18c60b88c3a9a8cd0f76ea04"} build_url:https://queue.taskcluster.net/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://queue.taskcluster.net/v1/task/VKSumyELTqCPAdmWO5HMMw/artifacts/public/build/firefox-50.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/bcdc7f12395a5b0281fb2b6ec1213c036e4c4c6dcc0da8b9c82b5a0fe6e8e11d1d937febce7b9afc6994dabb596607d2152363491deb35133e293aafb9d69eb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/13ec644c0f4984f7a59daba04e2bc9124582df54883e985cba9b3a16099d0d78a42e4821f9001ed76130cdb3b5ff2f843e3666d710dc069f4f866506aafb39f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00c3b4b1a783679693d0e5c790e8d5896c8d15a4c2e92ad6978f6fe6783ac50c87546ec29490ca69d261e8ec7d8d02b794b87ecd18c60b88c3a9a8cd0f76ea04"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 03:52:46.054643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:52:46.055012) ========= 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=62c568580acbfdaac3eec7be000001dc-1470219910.245305-864769884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 03:52:46.137453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 03:52:46.137789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 03:52:46.138131) ========= ========= Total master_lag: 0.17 =========