builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1469855580.2 results: success (0) buildid: 20160729193029 builduid: 480d39ea13b14810b3370927e7638099 revision: d539c846b609c990aab2a9f489330b2da81df53a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:00.199583) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:00.199963) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:00.200256) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:00.253350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:00.253632) ========= 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=ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 22:13:00-- 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% 88.9M=0s 2016-07-29 22:13:00 (88.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127088 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:00.405521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:00.405816) ========= 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=ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020034 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:00.465919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 22:13:00.466227) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d539c846b609c990aab2a9f489330b2da81df53a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d539c846b609c990aab2a9f489330b2da81df53a --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=ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 22:13:00,665 truncating revision to first 12 chars 2016-07-29 22:13:00,665 Setting DEBUG logging. 2016-07-29 22:13:00,665 attempt 1/10 2016-07-29 22:13:00,666 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d539c846b609?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 22:13:01,743 unpacking tar archive at: mozilla-inbound-d539c846b609/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 22:13:01.852994) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:01.853375) ========= script_repo_revision: d539c846b609c990aab2a9f489330b2da81df53a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:01.853775) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:01.854050) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 22:13:01.864689) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-29 22:13:01.865021) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:13:02 INFO - MultiFileLogger online at 20160729 22:13:02 in /builds/slave/test 22:13:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:13:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:13:02 INFO - {'append_to_log': False, 22:13:02 INFO - 'base_work_dir': '/builds/slave/test', 22:13:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:13:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:13:02 INFO - 'branch': 'Mozilla-Inbound', 22:13:02 INFO - 'buildbot_json_path': 'buildprops.json', 22:13:02 INFO - 'config_files': ('talos/linux_config.py',), 22:13:02 INFO - 'default_actions': ('clobber', 22:13:02 INFO - 'read-buildbot-config', 22:13:02 INFO - 'download-and-extract', 22:13:02 INFO - 'populate-webroot', 22:13:02 INFO - 'create-virtualenv', 22:13:02 INFO - 'install', 22:13:02 INFO - 'run-tests'), 22:13:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:13:02 INFO - 'download_minidump_stackwalk': True, 22:13:02 INFO - 'download_symbols': 'ondemand', 22:13:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:13:02 INFO - 'tooltool.py': '/tools/tooltool.py', 22:13:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:13:02 INFO - '/tools/misc-python/virtualenv.py')}, 22:13:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:13:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:13:02 INFO - 'installer_path': 'installer.exe', 22:13:02 INFO - 'log_level': 'info', 22:13:02 INFO - 'log_name': 'talos', 22:13:02 INFO - 'log_to_console': True, 22:13:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:13:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:13:02 INFO - 'opt_config_files': (), 22:13:02 INFO - 'pip_index': False, 22:13:02 INFO - 'sps_profile': False, 22:13:02 INFO - 'sps_profile_interval': 0, 22:13:02 INFO - 'suite': 'dromaeojs', 22:13:02 INFO - 'system_bits': '32', 22:13:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:13:02 INFO - 'title': 'talos-linux64-ix-035', 22:13:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:13:02 INFO - 'use_talos_json': True, 22:13:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:13:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:13:02 INFO - 'work_dir': 'build'} 22:13:02 INFO - [mozharness: 2016-07-30 05:13:02.155209Z] Running clobber step. 22:13:02 INFO - Running pre-action listener: _resource_record_pre_action 22:13:02 INFO - Running main action method: clobber 22:13:02 INFO - rmtree: /builds/slave/test/build 22:13:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:13:03 INFO - Running post-action listener: _resource_record_post_action 22:13:03 INFO - [mozharness: 2016-07-30 05:13:03.133542Z] Finished clobber step (success) 22:13:03 INFO - [mozharness: 2016-07-30 05:13:03.133642Z] Running read-buildbot-config step. 22:13:03 INFO - Running pre-action listener: _resource_record_pre_action 22:13:03 INFO - Running main action method: read_buildbot_config 22:13:03 INFO - Using buildbot properties: 22:13:03 INFO - { 22:13:03 INFO - "project": "", 22:13:03 INFO - "product": "firefox", 22:13:03 INFO - "script_repo_revision": "production", 22:13:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:13:03 INFO - "repository": "", 22:13:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:13:03 INFO - "buildid": "20160729193029", 22:13:03 INFO - "pgo_build": "True", 22:13:03 INFO - "basedir": "/builds/slave/test", 22:13:03 INFO - "buildnumber": 1321, 22:13:03 INFO - "slavename": "talos-linux64-ix-035", 22:13:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:13:03 INFO - "platform": "ubuntu64_hw", 22:13:03 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:13:03 INFO - "branch": "mozilla-inbound", 22:13:03 INFO - "repo_path": "integration/mozilla-inbound", 22:13:03 INFO - "revision": "d539c846b609c990aab2a9f489330b2da81df53a", 22:13:03 INFO - "stage_platform": "linux64-pgo", 22:13:03 INFO - "builduid": "480d39ea13b14810b3370927e7638099", 22:13:03 INFO - "slavebuilddir": "test" 22:13:03 INFO - } 22:13:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:13:03 INFO - Running post-action listener: _resource_record_post_action 22:13:03 INFO - [mozharness: 2016-07-30 05:13:03.136063Z] Finished read-buildbot-config step (success) 22:13:03 INFO - [mozharness: 2016-07-30 05:13:03.136151Z] Running download-and-extract step. 22:13:03 INFO - Running pre-action listener: _resource_record_pre_action 22:13:03 INFO - Running main action method: download_and_extract 22:13:03 INFO - mkdir: /builds/slave/test/build/tests 22:13:03 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')]} 22:13:03 INFO - https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:13:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:13:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:13:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:13:08 INFO - Downloaded 1361 bytes. 22:13:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:13:08 INFO - Using the following test package requirements: 22:13:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:13:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:13:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:13:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:08 INFO - u'jsshell-linux-x86_64.zip'], 22:13:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:13:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:13:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:13:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:13:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:13:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:13:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:13:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:13: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')]} 22:13:08 INFO - https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:13:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:13 INFO - Downloaded 24330204 bytes. 22:13:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:13:14 INFO - Return code: 0 22:13:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:13:14 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')]} 22:13:14 INFO - https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:13:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:13:16 INFO - Downloaded 24330204 bytes. 22:13:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:13:17 INFO - Return code: 0 22:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:17 INFO - https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:13:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:13:18 INFO - Downloaded 14413723 bytes. 22:13:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:13:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:13:18 INFO - Return code: 0 22:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:18 INFO - https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:13:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:13:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:13:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:13:19 INFO - Downloaded 61044300 bytes. 22:13:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:13:19 INFO - mkdir: /builds/slave/test/properties 22:13:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:13:19 INFO - Writing to file /builds/slave/test/properties/build_url 22:13:19 INFO - Contents: 22:13:19 INFO - build_url:https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:13:20 INFO - Running post-action listener: _resource_record_post_action 22:13:20 INFO - Running post-action listener: set_extra_try_arguments 22:13:20 INFO - [mozharness: 2016-07-30 05:13:20.592033Z] Finished download-and-extract step (success) 22:13:20 INFO - [mozharness: 2016-07-30 05:13:20.592267Z] Running populate-webroot step. 22:13:20 INFO - Running pre-action listener: _resource_record_pre_action 22:13:20 INFO - Running main action method: populate_webroot 22:13:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:13:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:13:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:13:20 INFO - '--tppagecycles', 22:13:20 INFO - '7'], 22:13:20 INFO - 'tests': ['tsvgm']}}, 22:13:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:13:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:13:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:13:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:13:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:20 INFO - 'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:13:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:20 INFO - 'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['damp', 'tps']}, 22:13:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:20 INFO - 'tests': ['damp', 'tps']}, 22:13:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['dromaeo_dom']}, 22:13:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:13:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['basic_compositor_video']}, 22:13:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:13:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['a11yr', 22:13:20 INFO - 'ts_paint', 22:13:20 INFO - 'tpaint', 22:13:20 INFO - 'sessionrestore', 22:13:20 INFO - 'sessionrestore_no_auto_restore', 22:13:20 INFO - 'tabpaint']}, 22:13:20 INFO - 'other-e10s': {'tests': ['a11yr', 22:13:20 INFO - 'ts_paint', 22:13:20 INFO - 'tpaint', 22:13:20 INFO - 'sessionrestore', 22:13:20 INFO - 'sessionrestore_no_auto_restore', 22:13:20 INFO - 'tabpaint']}, 22:13:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:13:20 INFO - 'ts_paint', 22:13:20 INFO - 'tpaint', 22:13:20 INFO - 'sessionrestore', 22:13:20 INFO - 'sessionrestore_no_auto_restore', 22:13:20 INFO - 'tabpaint']}, 22:13:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:13:20 INFO - 'ts_paint', 22:13:20 INFO - 'tpaint', 22:13:20 INFO - 'sessionrestore', 22:13:20 INFO - 'sessionrestore_no_auto_restore', 22:13:20 INFO - 'tabpaint']}, 22:13:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['a11yr', 22:13:20 INFO - 'ts_paint', 22:13:20 INFO - 'tpaint', 22:13:20 INFO - 'sessionrestore', 22:13:20 INFO - 'sessionrestore_no_auto_restore', 22:13:20 INFO - 'tabpaint']}, 22:13:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['a11yr', 22:13:20 INFO - 'ts_paint', 22:13:20 INFO - 'tpaint', 22:13:20 INFO - 'sessionrestore', 22:13:20 INFO - 'sessionrestore_no_auto_restore', 22:13:20 INFO - 'tabpaint']}, 22:13:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['tsvgx', 22:13:20 INFO - 'tsvgr_opacity', 22:13:20 INFO - 'tart', 22:13:20 INFO - 'tscrollx', 22:13:20 INFO - 'cart']}, 22:13:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:13:20 INFO - 'tsvgr_opacity', 22:13:20 INFO - 'tart', 22:13:20 INFO - 'tscrollx', 22:13:20 INFO - 'cart']}, 22:13:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:20 INFO - 'talos_options': ['--disable-e10s'], 22:13:20 INFO - 'tests': ['tp5o']}, 22:13:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:20 INFO - 'tests': ['tp5o']}, 22:13:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:20 INFO - 'talos_options': ['--disable-e10s', 22:13:20 INFO - '--xperf_path', 22:13:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:20 INFO - 'tests': ['tp5n']}, 22:13:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:13:20 INFO - 'talos_options': ['--xperf_path', 22:13:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:13:20 INFO - 'tests': ['tp5n']}}, 22:13:20 INFO - 'talos.zip': {'path': '', 22:13:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:13:20 INFO - Running post-action listener: _resource_record_post_action 22:13:20 INFO - [mozharness: 2016-07-30 05:13:20.608810Z] Finished populate-webroot step (success) 22:13:20 INFO - [mozharness: 2016-07-30 05:13:20.608899Z] Running create-virtualenv step. 22:13:20 INFO - Running pre-action listener: _resource_record_pre_action 22:13:20 INFO - Running main action method: create_virtualenv 22:13:20 INFO - Creating virtualenv /builds/slave/test/build/venv 22:13:20 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 22:13:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:13:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:13:20 INFO - Using real prefix '/usr' 22:13:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:13:21 INFO - Installing distribute.............................................................................................................................................................................................done. 22:13:23 INFO - Installing pip.................done. 22:13:23 INFO - Return code: 0 22:13:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:23 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 0x18d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', '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 22:13:23 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 22:13:23 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 22:13:23 INFO - Using env: {'DISPLAY': ':0', 22:13:23 INFO - 'HOME': '/home/cltbld', 22:13:23 INFO - 'LANG': 'en_US.UTF-8', 22:13:23 INFO - 'LANGUAGE': 'en_US:en', 22:13:23 INFO - 'LOGNAME': 'cltbld', 22:13:23 INFO - 'MAIL': '/var/mail/cltbld', 22:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:23 INFO - 'MOZ_NO_REMOTE': '1', 22:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:23 INFO - 'NO_EM_RESTART': '1', 22:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:23 INFO - 'PWD': '/builds/slave/test', 22:13:23 INFO - 'SHELL': '/bin/bash', 22:13:23 INFO - 'SHLVL': '1', 22:13:23 INFO - 'TERM': 'linux', 22:13:23 INFO - 'TMOUT': '86400', 22:13:23 INFO - 'USER': 'cltbld', 22:13:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:23 INFO - '_': '/tools/buildbot/bin/python'} 22:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:23 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 22:13:23 INFO - Cleaning up... 22:13:23 INFO - Return code: 0 22:13:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:23 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 0x18d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', '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 22:13:23 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 22:13:23 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 22:13:23 INFO - Using env: {'DISPLAY': ':0', 22:13:23 INFO - 'HOME': '/home/cltbld', 22:13:23 INFO - 'LANG': 'en_US.UTF-8', 22:13:23 INFO - 'LANGUAGE': 'en_US:en', 22:13:23 INFO - 'LOGNAME': 'cltbld', 22:13:23 INFO - 'MAIL': '/var/mail/cltbld', 22:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:23 INFO - 'MOZ_NO_REMOTE': '1', 22:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:23 INFO - 'NO_EM_RESTART': '1', 22:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:23 INFO - 'PWD': '/builds/slave/test', 22:13:23 INFO - 'SHELL': '/bin/bash', 22:13:23 INFO - 'SHLVL': '1', 22:13:23 INFO - 'TERM': 'linux', 22:13:23 INFO - 'TMOUT': '86400', 22:13:23 INFO - 'USER': 'cltbld', 22:13:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:23 INFO - '_': '/tools/buildbot/bin/python'} 22:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:23 INFO - Downloading/unpacking psutil>=3.1.1 22:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:13:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:25 INFO - Installing collected packages: psutil 22:13:25 INFO - Running setup.py install for psutil 22:13:25 INFO - building 'psutil._psutil_linux' extension 22:13:25 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 22:13:25 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 22:13:25 INFO - building 'psutil._psutil_posix' extension 22:13:25 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 22:13:26 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 22:13:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:13:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:13:26 INFO - Successfully installed psutil 22:13:26 INFO - Cleaning up... 22:13:26 INFO - Return code: 0 22:13:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:13: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')]} 22:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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')]} 22:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', '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 22:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:13:26 INFO - Using env: {'DISPLAY': ':0', 22:13:26 INFO - 'HOME': '/home/cltbld', 22:13:26 INFO - 'LANG': 'en_US.UTF-8', 22:13:26 INFO - 'LANGUAGE': 'en_US:en', 22:13:26 INFO - 'LOGNAME': 'cltbld', 22:13:26 INFO - 'MAIL': '/var/mail/cltbld', 22:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:26 INFO - 'MOZ_NO_REMOTE': '1', 22:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:26 INFO - 'NO_EM_RESTART': '1', 22:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:26 INFO - 'PWD': '/builds/slave/test', 22:13:26 INFO - 'SHELL': '/bin/bash', 22:13:26 INFO - 'SHLVL': '1', 22:13:26 INFO - 'TERM': 'linux', 22:13:26 INFO - 'TMOUT': '86400', 22:13:26 INFO - 'USER': 'cltbld', 22:13:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:26 INFO - '_': '/tools/buildbot/bin/python'} 22:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:13:26 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 22:13:26 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 22:13:26 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 22:13:26 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 22:13:26 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 22:13:26 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 22:13:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:13:28 INFO - Installing collected packages: mozsystemmonitor 22:13:28 INFO - Running setup.py install for mozsystemmonitor 22:13:28 INFO - Successfully installed mozsystemmonitor 22:13:28 INFO - Cleaning up... 22:13:28 INFO - Return code: 0 22:13:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:13:28 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')]} 22:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:28 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')]} 22:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:28 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 0x18d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', '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 22:13:28 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 22:13:28 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 22:13:28 INFO - Using env: {'DISPLAY': ':0', 22:13:28 INFO - 'HOME': '/home/cltbld', 22:13:28 INFO - 'LANG': 'en_US.UTF-8', 22:13:28 INFO - 'LANGUAGE': 'en_US:en', 22:13:28 INFO - 'LOGNAME': 'cltbld', 22:13:28 INFO - 'MAIL': '/var/mail/cltbld', 22:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:28 INFO - 'MOZ_NO_REMOTE': '1', 22:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:28 INFO - 'NO_EM_RESTART': '1', 22:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:28 INFO - 'PWD': '/builds/slave/test', 22:13:28 INFO - 'SHELL': '/bin/bash', 22:13:28 INFO - 'SHLVL': '1', 22:13:28 INFO - 'TERM': 'linux', 22:13:28 INFO - 'TMOUT': '86400', 22:13:28 INFO - 'USER': 'cltbld', 22:13:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:28 INFO - '_': '/tools/buildbot/bin/python'} 22:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:28 INFO - Downloading/unpacking jsonschema==2.5.1 22:13:28 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 22:13:28 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 22:13:28 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 22:13:28 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 22:13:28 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 22:13:28 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 22:13:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:13:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:13:30 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 22:13:30 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 22:13:30 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 22:13:30 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 22:13:30 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 22:13:30 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 22:13:30 INFO - Downloading functools32-3.2.3-2.tar.gz 22:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:13:30 INFO - warning: no files found matching '*.txt' 22:13:30 INFO - no previously-included directories found matching 'build' 22:13:30 INFO - no previously-included directories found matching 'dist' 22:13:30 INFO - no previously-included directories found matching '.git*' 22:13:30 INFO - Installing collected packages: jsonschema, functools32 22:13:30 INFO - Running setup.py install for functools32 22:13:30 INFO - warning: no files found matching '*.txt' 22:13:30 INFO - no previously-included directories found matching 'build' 22:13:30 INFO - no previously-included directories found matching 'dist' 22:13:30 INFO - no previously-included directories found matching '.git*' 22:13:30 INFO - Successfully installed jsonschema functools32 22:13:30 INFO - Cleaning up... 22:13:30 INFO - Return code: 0 22:13:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:30 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 0x18d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', '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 22:13:30 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 22:13:30 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 22:13:30 INFO - Using env: {'DISPLAY': ':0', 22:13:30 INFO - 'HOME': '/home/cltbld', 22:13:30 INFO - 'LANG': 'en_US.UTF-8', 22:13:30 INFO - 'LANGUAGE': 'en_US:en', 22:13:30 INFO - 'LOGNAME': 'cltbld', 22:13:30 INFO - 'MAIL': '/var/mail/cltbld', 22:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:30 INFO - 'MOZ_NO_REMOTE': '1', 22:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:30 INFO - 'NO_EM_RESTART': '1', 22:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:30 INFO - 'PWD': '/builds/slave/test', 22:13:30 INFO - 'SHELL': '/bin/bash', 22:13:30 INFO - 'SHLVL': '1', 22:13:31 INFO - 'TERM': 'linux', 22:13:31 INFO - 'TMOUT': '86400', 22:13:31 INFO - 'USER': 'cltbld', 22:13:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:31 INFO - '_': '/tools/buildbot/bin/python'} 22:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:13:31 INFO - Cleaning up... 22:13:31 INFO - Return code: 0 22:13:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', '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 22:13:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:13:31 INFO - Using env: {'DISPLAY': ':0', 22:13:31 INFO - 'HOME': '/home/cltbld', 22:13:31 INFO - 'LANG': 'en_US.UTF-8', 22:13:31 INFO - 'LANGUAGE': 'en_US:en', 22:13:31 INFO - 'LOGNAME': 'cltbld', 22:13:31 INFO - 'MAIL': '/var/mail/cltbld', 22:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:31 INFO - 'MOZ_NO_REMOTE': '1', 22:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:31 INFO - 'NO_EM_RESTART': '1', 22:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:31 INFO - 'PWD': '/builds/slave/test', 22:13:31 INFO - 'SHELL': '/bin/bash', 22:13:31 INFO - 'SHLVL': '1', 22:13:31 INFO - 'TERM': 'linux', 22:13:31 INFO - 'TMOUT': '86400', 22:13:31 INFO - 'USER': 'cltbld', 22:13:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:31 INFO - '_': '/tools/buildbot/bin/python'} 22:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:31 INFO - Downloading/unpacking blobuploader==1.2.4 22:13:31 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 22:13:31 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 22:13:31 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 22:13:31 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 22:13:31 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 22:13:31 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 22:13:33 INFO - Downloading blobuploader-1.2.4.tar.gz 22:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:13:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:13: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 22:13: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 22:13: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 22:13: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 22:13: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 22:13: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 22:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:13:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:13: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 22:13: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 22:13: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 22:13: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 22:13: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 22:13: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 22:13:33 INFO - Downloading docopt-0.6.1.tar.gz 22:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:13:34 INFO - Installing collected packages: blobuploader, requests, docopt 22:13:34 INFO - Running setup.py install for blobuploader 22:13:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:13:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:13:34 INFO - Running setup.py install for requests 22:13:34 INFO - Running setup.py install for docopt 22:13:34 INFO - Successfully installed blobuploader requests docopt 22:13:34 INFO - Cleaning up... 22:13:34 INFO - Return code: 0 22:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:34 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 0x18d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', '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 22:13:34 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 22:13:34 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 22:13:34 INFO - Using env: {'DISPLAY': ':0', 22:13:34 INFO - 'HOME': '/home/cltbld', 22:13:34 INFO - 'LANG': 'en_US.UTF-8', 22:13:34 INFO - 'LANGUAGE': 'en_US:en', 22:13:34 INFO - 'LOGNAME': 'cltbld', 22:13:34 INFO - 'MAIL': '/var/mail/cltbld', 22:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:34 INFO - 'MOZ_NO_REMOTE': '1', 22:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:34 INFO - 'NO_EM_RESTART': '1', 22:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:34 INFO - 'PWD': '/builds/slave/test', 22:13:34 INFO - 'SHELL': '/bin/bash', 22:13:34 INFO - 'SHLVL': '1', 22:13:34 INFO - 'TERM': 'linux', 22:13:34 INFO - 'TMOUT': '86400', 22:13:34 INFO - 'USER': 'cltbld', 22:13:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:34 INFO - '_': '/tools/buildbot/bin/python'} 22:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:34 INFO - Running setup.py (path:/tmp/pip-BfJGQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:34 INFO - Running setup.py (path:/tmp/pip-wUlRXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:34 INFO - Running setup.py (path:/tmp/pip-ImeHIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:35 INFO - Running setup.py (path:/tmp/pip-lFcmMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:35 INFO - Running setup.py (path:/tmp/pip-2PEuoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:35 INFO - Running setup.py (path:/tmp/pip-9bw9wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:35 INFO - Running setup.py (path:/tmp/pip-BAhnrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:35 INFO - Running setup.py (path:/tmp/pip-Qkx1zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:35 INFO - Running setup.py (path:/tmp/pip-3XmPcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:35 INFO - Running setup.py (path:/tmp/pip-urhM3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:35 INFO - Running setup.py (path:/tmp/pip-NC8RIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:35 INFO - Running setup.py (path:/tmp/pip-OsZFrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:35 INFO - Running setup.py (path:/tmp/pip-OQ2a5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:35 INFO - Running setup.py (path:/tmp/pip-imT6uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:35 INFO - Running setup.py (path:/tmp/pip-GaqK_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:35 INFO - Running setup.py (path:/tmp/pip-lAuzuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:36 INFO - Running setup.py (path:/tmp/pip-j7pdLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:13:36 INFO - Running setup.py install for manifestparser 22:13:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:13:36 INFO - Running setup.py install for mozcrash 22:13:36 INFO - Running setup.py install for mozdebug 22:13:36 INFO - Running setup.py install for mozdevice 22:13:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:13:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:13:36 INFO - Running setup.py install for mozfile 22:13:36 INFO - Running setup.py install for mozhttpd 22:13:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:13:36 INFO - Running setup.py install for mozinfo 22:13:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:13:36 INFO - Running setup.py install for mozInstall 22:13:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:13:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:13:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:13:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:13:36 INFO - Running setup.py install for mozleak 22:13:36 INFO - Running setup.py install for mozlog 22:13:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:13:37 INFO - Running setup.py install for moznetwork 22:13:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:13:37 INFO - Running setup.py install for mozprocess 22:13:37 INFO - Running setup.py install for mozprofile 22:13:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:13:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:13:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:13:37 INFO - Running setup.py install for mozrunner 22:13:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:13:37 INFO - Running setup.py install for mozscreenshot 22:13:37 INFO - Running setup.py install for moztest 22:13:37 INFO - Running setup.py install for mozversion 22:13:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:13:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:13:37 INFO - Cleaning up... 22:13:37 INFO - Return code: 0 22:13:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:37 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 0x18d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', '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 22:13:37 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 22:13:37 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 22:13:37 INFO - Using env: {'DISPLAY': ':0', 22:13:37 INFO - 'HOME': '/home/cltbld', 22:13:37 INFO - 'LANG': 'en_US.UTF-8', 22:13:37 INFO - 'LANGUAGE': 'en_US:en', 22:13:37 INFO - 'LOGNAME': 'cltbld', 22:13:37 INFO - 'MAIL': '/var/mail/cltbld', 22:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:37 INFO - 'MOZ_NO_REMOTE': '1', 22:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:37 INFO - 'NO_EM_RESTART': '1', 22:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:37 INFO - 'PWD': '/builds/slave/test', 22:13:37 INFO - 'SHELL': '/bin/bash', 22:13:37 INFO - 'SHLVL': '1', 22:13:37 INFO - 'TERM': 'linux', 22:13:37 INFO - 'TMOUT': '86400', 22:13:37 INFO - 'USER': 'cltbld', 22:13:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:37 INFO - '_': '/tools/buildbot/bin/python'} 22:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:13:38 INFO - Running setup.py (path:/tmp/pip-oi_P62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:13:38 INFO - Running setup.py (path:/tmp/pip-K8x7vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:13:38 INFO - Running setup.py (path:/tmp/pip-O_Cu2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:13:38 INFO - Running setup.py (path:/tmp/pip-dsxOxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:13:38 INFO - Running setup.py (path:/tmp/pip-6HXFuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:13:38 INFO - Running setup.py (path:/tmp/pip-2mscQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:13:38 INFO - Running setup.py (path:/tmp/pip-av6a2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:13:38 INFO - Running setup.py (path:/tmp/pip-CoU2sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:13:38 INFO - Running setup.py (path:/tmp/pip-tQRbNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:13:38 INFO - Running setup.py (path:/tmp/pip-53wDIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:13:38 INFO - Running setup.py (path:/tmp/pip-PRpxBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:13:38 INFO - Running setup.py (path:/tmp/pip-1CreHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:13:38 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)) 22:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:13:38 INFO - Running setup.py (path:/tmp/pip-KogWcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:13:39 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)) 22:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:13:39 INFO - Running setup.py (path:/tmp/pip-YqU0qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:13:39 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)) 22:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:39 INFO - Running setup.py (path:/tmp/pip-XBize2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:13:39 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)) 22:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:13:39 INFO - Running setup.py (path:/tmp/pip-y1NzfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:13:39 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)) 22:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:13:39 INFO - Running setup.py (path:/tmp/pip-Tal5QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:13:39 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)) 22:13:39 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)) 22:13:39 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)) 22:13:39 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)) 22:13:39 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)) 22:13:39 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)) 22:13:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:13:41 INFO - Downloading blessings-1.6.tar.gz 22:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:13:41 INFO - Installing collected packages: blessings 22:13:41 INFO - Running setup.py install for blessings 22:13:41 INFO - Successfully installed blessings 22:13:41 INFO - Cleaning up... 22:13:41 INFO - Return code: 0 22:13:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:13:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:41 INFO - Reading from file tmpfile_stdout 22:13:41 INFO - Current package versions: 22:13:41 INFO - argparse == 1.2.1 22:13:41 INFO - blessings == 1.6 22:13:41 INFO - blobuploader == 1.2.4 22:13:41 INFO - docopt == 0.6.1 22:13:41 INFO - functools32 == 3.2.3-2 22:13:41 INFO - jsonschema == 2.5.1 22:13:41 INFO - manifestparser == 1.1 22:13:41 INFO - mozInstall == 1.12 22:13:41 INFO - mozcrash == 0.17 22:13:41 INFO - mozdebug == 0.1 22:13:41 INFO - mozdevice == 0.48 22:13:41 INFO - mozfile == 1.2 22:13:41 INFO - mozhttpd == 0.7 22:13:41 INFO - mozinfo == 0.9 22:13:41 INFO - mozleak == 0.1 22:13:41 INFO - mozlog == 3.3 22:13:41 INFO - moznetwork == 0.27 22:13:41 INFO - mozprocess == 0.23 22:13:41 INFO - mozprofile == 0.28 22:13:41 INFO - mozrunner == 6.12 22:13:41 INFO - mozscreenshot == 0.1 22:13:41 INFO - mozsystemmonitor == 0.3 22:13:41 INFO - moztest == 0.7 22:13:41 INFO - mozversion == 1.4 22:13:41 INFO - psutil == 3.1.1 22:13:41 INFO - requests == 1.2.3 22:13:41 INFO - wsgiref == 0.1.2 22:13:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:13: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')]} 22:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13: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')]} 22:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:41 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 0x18d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', '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 22:13:41 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 22:13:41 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 22:13:41 INFO - Using env: {'DISPLAY': ':0', 22:13:41 INFO - 'HOME': '/home/cltbld', 22:13:41 INFO - 'LANG': 'en_US.UTF-8', 22:13:41 INFO - 'LANGUAGE': 'en_US:en', 22:13:41 INFO - 'LOGNAME': 'cltbld', 22:13:41 INFO - 'MAIL': '/var/mail/cltbld', 22:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:41 INFO - 'MOZ_NO_REMOTE': '1', 22:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:41 INFO - 'NO_EM_RESTART': '1', 22:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:41 INFO - 'PWD': '/builds/slave/test', 22:13:41 INFO - 'SHELL': '/bin/bash', 22:13:41 INFO - 'SHLVL': '1', 22:13:41 INFO - 'TERM': 'linux', 22:13:41 INFO - 'TMOUT': '86400', 22:13:41 INFO - 'USER': 'cltbld', 22:13:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:41 INFO - '_': '/tools/buildbot/bin/python'} 22:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:42 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)) 22:13:42 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)) 22:13:42 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)) 22:13:42 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)) 22:13:42 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)) 22:13:42 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)) 22:13:42 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)) 22:13:42 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)) 22:13:42 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)) 22:13:42 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)) 22:13:42 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)) 22:13:42 INFO - Cleaning up... 22:13:42 INFO - Return code: 0 22:13:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:13:42 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 0x18d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b91180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, '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': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', '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 22:13:42 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 22:13:42 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 22:13:42 INFO - Using env: {'DISPLAY': ':0', 22:13:42 INFO - 'HOME': '/home/cltbld', 22:13:42 INFO - 'LANG': 'en_US.UTF-8', 22:13:42 INFO - 'LANGUAGE': 'en_US:en', 22:13:42 INFO - 'LOGNAME': 'cltbld', 22:13:42 INFO - 'MAIL': '/var/mail/cltbld', 22:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:42 INFO - 'MOZ_NO_REMOTE': '1', 22:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:42 INFO - 'NO_EM_RESTART': '1', 22:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:42 INFO - 'PWD': '/builds/slave/test', 22:13:42 INFO - 'SHELL': '/bin/bash', 22:13:42 INFO - 'SHLVL': '1', 22:13:42 INFO - 'TERM': 'linux', 22:13:42 INFO - 'TMOUT': '86400', 22:13:42 INFO - 'USER': 'cltbld', 22:13:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:42 INFO - '_': '/tools/buildbot/bin/python'} 22:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:13:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:13:42 INFO - Cleaning up... 22:13:42 INFO - Return code: 0 22:13:42 INFO - Running post-action listener: _resource_record_post_action 22:13:42 INFO - Running post-action listener: _start_resource_monitoring 22:13:42 INFO - Starting resource monitoring. 22:13:42 INFO - [mozharness: 2016-07-30 05:13:42.296551Z] Finished create-virtualenv step (success) 22:13:42 INFO - [mozharness: 2016-07-30 05:13:42.296980Z] Running install step. 22:13:42 INFO - Running pre-action listener: _resource_record_pre_action 22:13:42 INFO - Running main action method: install 22:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:13:42 INFO - Reading from file tmpfile_stdout 22:13:42 INFO - Detecting whether we're running mozinstall >=1.0... 22:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:13:42 INFO - Reading from file tmpfile_stdout 22:13:42 INFO - Output received: 22:13:42 INFO - Usage: mozinstall [options] installer 22:13:42 INFO - Options: 22:13:42 INFO - -h, --help show this help message and exit 22:13:42 INFO - -d DEST, --destination=DEST 22:13:42 INFO - Directory to install application into. [default: 22:13:42 INFO - "/builds/slave/test"] 22:13:42 INFO - --app=APP Application being installed. [default: firefox] 22:13:42 INFO - mkdir: /builds/slave/test/build/application 22:13:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:13:59 INFO - Reading from file tmpfile_stdout 22:13:59 INFO - Output received: 22:13:59 INFO - /builds/slave/test/build/application/firefox/firefox 22:13:59 INFO - Running post-action listener: _resource_record_post_action 22:13:59 INFO - [mozharness: 2016-07-30 05:13:59.862658Z] Finished install step (success) 22:13:59 INFO - [mozharness: 2016-07-30 05:13:59.862932Z] Running run-tests step. 22:13:59 INFO - Running pre-action listener: _resource_record_pre_action 22:13:59 INFO - Running main action method: run_tests 22:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:13:59 INFO - Python 2.7.3 22:13:59 INFO - Return code: 0 22:13:59 INFO - grabbing minidump binary from tooltool 22:13: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')]} 22:13:59 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 0x1b8f3b0>, '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 0x1b902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b90740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:13:59 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 22:13:59 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 22:13:59 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 22:13:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:13:59 INFO - Return code: 0 22:13:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:13:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:13:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:13:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:13:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:13:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:13:59 INFO - Using env: {'DISPLAY': ':0', 22:13:59 INFO - 'HOME': '/home/cltbld', 22:13:59 INFO - 'LANG': 'en_US.UTF-8', 22:13:59 INFO - 'LANGUAGE': 'en_US:en', 22:13:59 INFO - 'LOGNAME': 'cltbld', 22:13:59 INFO - 'MAIL': '/var/mail/cltbld', 22:13:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:13:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:59 INFO - 'MOZ_NO_REMOTE': '1', 22:13:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:59 INFO - 'NO_EM_RESTART': '1', 22:13:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:59 INFO - 'PWD': '/builds/slave/test', 22:13:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:13:59 INFO - 'SHELL': '/bin/bash', 22:13:59 INFO - 'SHLVL': '1', 22:13:59 INFO - 'TERM': 'linux', 22:13:59 INFO - 'TMOUT': '86400', 22:13:59 INFO - 'USER': 'cltbld', 22:13:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228', 22:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:59 INFO - '_': '/tools/buildbot/bin/python'} 22:13:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:14:00 INFO - mozversion application_buildid: 20160729193029 22:14:00 INFO - mozversion application_changeset: d539c846b609c990aab2a9f489330b2da81df53a 22:14:00 INFO - mozversion application_display_name: Nightly 22:14:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:14:00 INFO - mozversion application_name: Firefox 22:14:00 INFO - mozversion application_remotingname: firefox 22:14:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:14:00 INFO - mozversion application_vendor: Mozilla 22:14:00 INFO - mozversion application_version: 50.0a1 22:14:00 INFO - mozversion platform_buildid: 20160729193029 22:14:00 INFO - mozversion platform_changeset: d539c846b609c990aab2a9f489330b2da81df53a 22:14:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:14:00 INFO - mozversion platform_version: 50.0a1 22:14:00 INFO - using testdate: 1469855640 22:14:00 INFO - actual date: 1469855640 22:14:00 INFO - starting webserver on 'localhost:39998' 22:14:00 INFO - SUITE-START | Running 2 tests 22:14:00 INFO - TEST-START | dromaeo_css 22:14:00 INFO - operating with platform_type : linux_ 22:14:00 INFO - Initialising browser for dromaeo_css test... 22:14:00 INFO - TEST-INFO | started process 352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOvKvst/profile http://localhost:39998/getInfo.html) 22:14:03 INFO - PROCESS | 352 | JavaScript error: , line 0: uncaught exception: undefined 22:14:04 INFO - PROCESS | 352 | __metrics Screen width/height:1600/1200 22:14:04 INFO - PROCESS | 352 | colorDepth:24 22:14:04 INFO - PROCESS | 352 | Browser inner width/height: 1024/697 22:14:04 INFO - PROCESS | 352 | __metrics 22:14:04 INFO - PROCESS | 352 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:14:04 INFO - PROCESS | 352 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:14:05 INFO - TEST-INFO | 352: exit 0 22:14:05 INFO - Browser initialized. 22:14:05 INFO - Running cycle 1/1 for dromaeo_css test... 22:14:05 INFO - TEST-INFO | started process 437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOvKvst/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:17 INFO - PROCESS | 437 | RSS: Main: 158359552 22:14:17 INFO - PROCESS | 437 | 22:15:08 INFO - PROCESS | 437 | 1469855708364 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] 22:17:17 INFO - PROCESS | 437 | Cycle 1(1): loaded http://localhost:39998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39998/tests/dromaeo/cssquery-ext.html) 22:17:18 INFO - PROCESS | 437 | RSS: Main: 258891776 22:17:18 INFO - PROCESS | 437 | 22:20:20 INFO - PROCESS | 437 | Cycle 1(1): loaded http://localhost:39998/tests/dromaeo/cssquery-ext.html (next: http://localhost:39998/tests/dromaeo/cssquery-jquery.html) 22:20:21 INFO - PROCESS | 437 | RSS: Main: 250089472 22:20:21 INFO - PROCESS | 437 | 22:23:23 INFO - PROCESS | 437 | Cycle 1(1): loaded http://localhost:39998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39998/tests/dromaeo/cssquery-mootools.html) 22:23:23 INFO - PROCESS | 437 | RSS: Main: 240472064 22:23:23 INFO - PROCESS | 437 | 22:26:25 INFO - PROCESS | 437 | Cycle 1(1): loaded http://localhost:39998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39998/tests/dromaeo/cssquery-prototype.html) 22:26:26 INFO - PROCESS | 437 | RSS: Main: 240762880 22:26:26 INFO - PROCESS | 437 | 22:29:29 INFO - PROCESS | 437 | Cycle 1(1): loaded http://localhost:39998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39998/tests/dromaeo/cssquery-yui.html) 22:29:29 INFO - PROCESS | 437 | RSS: Main: 186335232 22:29:29 INFO - PROCESS | 437 | 22:32:32 INFO - PROCESS | 437 | Cycle 1(1): loaded http://localhost:39998/tests/dromaeo/cssquery-yui.html (next: http://localhost:39998/tests/dromaeo/cssquery-dojo.html) 22:32:32 INFO - PROCESS | 437 | RSS: Main: 275189760 22:32:32 INFO - PROCESS | 437 | 22:32:32 INFO - PROCESS | 437 | __start_tp_report 22:32:32 INFO - PROCESS | 437 | _x_x_mozilla_page_load 22:32:32 INFO - PROCESS | 437 | _x_x_mozilla_page_load_details 22:32:32 INFO - PROCESS | 437 | |i|pagename|runs| 22:32:32 INFO - PROCESS | 437 | |0;dojo.html;2972.7324540791324;2982.0755565774607;3020.546917962307;3022.5012872875977;3028.9242768930776;5053.343065401493;5073.188289873617;5123.820666276681;5164.2770012198325;5245.86885327867;5131.512506311904;5161.870953226171;5168.405633352166;5191.558717509016;5229.843104706855;4652.534746525345;4679.204535229002;4705.858824235262;4716.740579268139;4870.391201099863;4798.7600619969035;4831.71009739415;4832.758362081881;4851.175300198957;4868.172410690191;4642.326862604903;4645.140648979949;4702.3416721659;4717.834875779331;4777.856664300077;4666.113438446719;4689.484156742756;4696.272077827942;4751.691140075884;4764.213904705754;4717.386739723814;4738.384010078667;4747.287906813971;4750.14497390473;4783.091212669582;4989.65072444929;5042.243663450475;5174.2238664200295;5221.347331583552;5240.764165612557;5371.194320851864;5464.617476776627;5472.26124473195;5472.452754724535;5477.534409575191;5417.079096553595;5473.698946557938;5478.808241711521;5504.91742623861;5506.64206826559;5031.949680503185;5090.08378491875;5130.7947682093045;5174.637775355726;5174.948250517485;5648.068068768689;5656.434356564393;5670.262865827499;5671.432856714378;5671.688057156896;5471.261379713767;5472.5621950243885;5477.370102438191;5477.589180811455;5488.149336852714;5322.441143679858;5412;5462.918056229159;5572.693501857356;5575.191597218381;5451.2640793493165;5451.427600102012;5460.453954604508;5498.202760599691;5498.835034948958;5460.481254280837;5465.234867118606;5466.9179962300595;5469;5474.589405794582;4194.391813187131;4211.894702632459;4231.513375961804;4248.808803603845;4295.72077814941;3774.7735135891385;3793.4499497572697;3824.043989002749;3855.36386496225;3880.534335879656;5164.302819119446;5203.427622961472;5209.843704688789;5212.244224587414;5212.869678257998;5365.168398898177;5505.504504594605;5511.834644960658;5521.861953451196;5523.972380138073;5212.478752124757;5218.9739051304505;5234.450382709761;5235.214717792285;5239.29269548606;4815.903681926412;4821.566059054702;4823.5658790709;4826.758662066883;4866.343043689128;5638.887222255532;5716.714164291769;5826.6795326256615;5839.386864379264;5845.766169353264;5469.507744303032;5569.303837020372;5614.129809879475;5614.747336369792;5616.1014237721765;5820;5826.650400975955;5829.737661805144;5832;5834.649921004753;5323.840284791462;5478.808241711521;5479.561635069105;5485.917711234255;5486.862828429321;5522.889542209053;5553.972230138824;5576.609637325349;5617.073182924772;5670.546356291405;5440.047991601533;5480.177973304037;5482.150266708666;5483.8080667176455;5486.396496385315;5239.895202096013;5429.809956651498;5472.5348345391085;5485.369182543899;5533.170024496358;5300.469953004668;5331.253624492651;5371.274877891435;5413.160960051198;5460.126379779216;5501.284832971688;5513.531349835309;5558.610897237155;5567.276254086943;5569.610127291051;5184.45563215872;5392.676439413648;5400.864978375572;5401.405845356929;5404.32445944257 22:32:32 INFO - PROCESS | 437 | |1;ext.html;605.4187979539643;619.1177571959959;637.1303171171353;643.4112786800076;649.8862699027669;31553.842230788843;44860.55139448604;45706.54293457064;45782.313265301;48673.51326486734;45899;46410.07179856401;46421.30368044482;46449.071018579605;46558.53441465584;8951.731448056553;9093.499857507835;9099.044600316938;9107.590158442887;9109.407888487227;8934.73195804127;9014.54927253638;9025.142611451902;9026.052264512196;9028.142326479006;8997.820043599124;9064.728058158265;9072.228860546862;9072.31957603179;9074.36479446439;9016.54917254138;9017.954910225408;9062.637494500212;9065.637374505011;9069.727908162766;8993.640254389817;9075.954620226856;9076.546172691338;9083.81832363349;9087.954560227157;43942.780286098365;44125.33811992823;44260.77869610664;44379.334309985374;44405;3427.7943323400677;3560.9109772255642;3600.9279814403567;4032.2741906456827;4330.624198610006;32511.83744081288;34029.14927126817;34050.65949340499;34063.82968085168;34116.658833411595;4289.935650965238;4447.177272204653;4468.910621787579;4477.820887164509;4609.884752881171;247710.7614461934;249008;249840;250449;251835;58918.70540647269;59765.40234597685;60029;60035;60108;62503;63070.36929630737;63229.68385158045;63300;63340.04989925155;14645.048071875293;14721.190334531704;14806.92596537032;14818.110913345234;14845.92577037108;11433.314001159957;11488.597899073493;11497.310161390344;11497.482613282422;11500.367479788692;16880.746788798177;17010.744838827428;17026.574335641708;17041.318347266217;17082.316707331815;6099.664518451439;6134.8159555213415;6242.469390101802;6306.873862522724;6332;985.5860538573672;1041.656253436364;1065.414022287754;1088.7223757941674;1104.928179668319;32297.838510807294;32561.185970350456;32590;32888;32983.83508082444;1043.4730461117088;1090.6891535912227;1118.904893084097;1119.8040342939953;1124.42092322454;16860.915695421445;16959.491215263562;17177.398791042502;17236.396726114526;17346.3061477542;528483;536519;538676;540122;541074;60770.69614651898;60867;61065.694671526355;61081;61185.69407152936;1193.6001439517859;1239.4732238798474;1266.2212739165532;1310.9410076546578;1356.3828458051562;32793.34413311768;34045.319093618484;34358;34365.14087147841;34385.484217737256;52260.738696307795;52720.73639631777;52737;52754.73622631862;52801;397676;400233;401130;402327;402972;35717.82141089382;41313.1737365257;41479.37780933228;41671.37492937548;43578.56421435872;48958.75520622374;49285.753571231915;49620;49778;49893.501064988886;41638;41971;42568.36147457729;42578.361324579535;44348.556514434444;41770.37344439897;43038.35442468303;43544;43956.560434395244;44878.326825097;41951.160976780906;42789.57210427856;42879.57120428756;43131.78434107935;43425.782871085445;35694.28611427809;37597.047471922626;37738.43392349172;38510.2297954045;38704;28550.45101741117;28964;29254;29270.560941585467;29384 22:32:32 INFO - PROCESS | 437 | |2;jquery.html;381.25084209528274;384.70185606155206;389.1535909397061;395.55895176877783;415.9916801663967;14365.92817035916;17914.64170716585;18343.17455714493;19552.413427597177;19595.902020489913;17446.389376371797;17982.730259046126;18832.43502694918;19091.236350545998;19160.61678766424;5587.38538760737;5590.049691552425;5631.2960879890015;5670.121131224667;5671.886562268752;5597.188407680884;5670.716464176795;5674.063779476382;5674.971625141869;5677.233573467591;5509.146082357241;5566.304211973504;5566.693831839248;5587.776488940458;5693.715314234271;5572.554195664377;5664.291963504562;5679.2333035040365;5685.488306052454;5685.772569097231;4916.311716359713;5049.267856160873;5052.671576347526;5055.140626093573;5057.873553161164;23019.769802302097;23345.533089338118;23356.649650255258;23386.64920026201;23544.882275588683;2334.0780391745166;2517.546841568517;2522.7603377679275;2547.2994926395204;3053.046050527664;14559.854401455956;14692.48576299835;14739.926300368537;14907;14921.477748278867;1881.9529511762178;1930.758655168104;1938.4572319750494;1956.6478033953883;1972.753405824272;76988;77959;78302.60848695778;78893.60553197197;79120;10019;10057.145142662956;10225.59097636101;10696.839547406795;10726.839097413545;11904.523819047314;13874.86125138756;13899.235542045284;13910.234937078558;13921.373538190806;7045.577265364094;7253.673584688596;7369.926300737031;7422.220666830013;7939.126696063428;7605.809854753565;7610.353119984863;7631.809204769814;7834.921650783534;7853.018372703412;6307.842303942438;6371.39471750183;6434.806955791334;6509.674516274262;6574.046763219402;1798.1998010885031;1802.8647851411197;1803.2336257090683;1806.6296409236074;1853.9073046347628;929.2844509727472;997.5660587644398;998.9350692204983;1055.8099542082498;1066.386827574148;19613.60478946161;20367.185312587626;20377.184912603625;20409.591808163754;20598.27906023282;1030.6959446963165;1081.5187241677536;1085.592902661502;1096.4543358435685;1099.8955099265556;11060;11439.88560114405;11528.538858445569;11533.653990380302;11600.94199528997;442603;449463;451134;451388;452587;77371.61314193394;78709.60645196737;79357.20642793499;79635;80238.59880700675;1020.2246292817512;1027.984580231297;1037;1037.8235699930879;1043.6660268713938;17085.65828683444;17692.38076667362;17905.37331193402;18038.72941905846;18428.539286517407;29458.852705736335;38768.22463550769;39049.6095039046;40635;41093.38359924544;44502.332465012405;49375;49517.257241142135;55323;55736.72131639316;8102.4328297021;8376.120507346885;8494.74515764528;8495.513285174946;8503.787405314917;13207.801882971955;13217.669558261121;13330.26683532415;13519.662008449868;13830.37763300674;10845.403502807421;10985.725356865823;11057.668269951915;11129;11179.88820111821;10855.945720271347;10915.945420272848;11258.83111753308;11260.83108753353;11314.773704526027;10917.454127293444;11080.61217857371;11552.82670759956;11699.941500292443;11722.025394890026;8239.464434811718;8286.668533258602;8480.448770829877;8493.193146651058;8592.527410992205;10825.675229742805;11082.667519974413;11271.7745645085;11365.374904380007;11390.37352945596 22:32:32 INFO - PROCESS | 437 | |3;mootools.html;1457.0820383158612;1523.756199008159;1586.3575252022936;1710.1791140252685;1754.6227561074365;8327.791805204864;8854.601542930568;8867.778305542364;8873;8874.955625221874;7266.019087423197;7447.776566703008;7451.962740186305;7621.504602200853;8660.91339086609;2234.106357457022;2322.8257880658934;2325.2094287942095;2327.022650486791;2329.0683726509365;2328.115316179858;2347.8708671023087;2361.315218586608;2372.78644921957;2373.703287089114;2322.7096612923383;2331.5686597979343;2339.099446713011;2339.590571649963;2339.801116905065;2241.4396400899777;2244.4164517225477;2248.2580748353084;2251.864888106719;2252.560750653623;2157.8165855902266;2199.813015893651;2219.0236296029857;2219.9889000554895;2227.376334626307;8586.527740974245;8641.52471614061;8660.48037117775;8723.214910658071;8730.126987301282;4977.352944117278;5092.567131793802;5098.209777484496;5102.821401250939;5104.106781313292;3382.1882748140515;3445.534852794866;3485.599156097056;3494.7204223662047;3496.4405695088917;1058.5130839813694;1097.5554900265406;1106.1593189176203;1111.1444187975294;1136.198979719296;11879.643610691779;11881.584144554985;11886;11898.881011189864;11903.880961190363;4509.391232183613;4568.611668008257;4667.159911215946;4723.95276047242;4732.272720457008;10179.694609161737;10223.335483193569;10230.744231394126;10238.33450825694;10246.795064098676;5149.742512874342;5153.613478989091;5154.53609175176;5156.432792392834;5159.277701121846;4627.9074418511445;4751.548602882721;4752.7861246244;4779.211430113992;4823.1800593899125;3782.678472329828;3789.734718569729;3862.787546684959;3871.3805791073855;3894.844206231776;1120.5181771838188;1128.98476219947;1140.680609429361;1146.094585277638;1150.3328069719544;801.3028665061433;816.3713940266081;820.5158956215741;959.3284700709531;1001.379144930148;5751.884962300731;5766.135079738073;5800.651960882276;5843.970780146157;5989.921814073421;912.6805618033635;914.3873604684877;918.6325469812128;939.7415710679618;959.4387283439266;3772.849086036583;3863.5943225961432;3963.781991990468;3986.7209295349626;3997.8600748973645;10506.159507239403;10881.83677244842;10896.237263391486;10904.836427453594;10908.454577271104;10664.093552048163;10670.786584268271;10679.466026698634;10732.302400343953;10758.892411075789;7745.845083098419;8064.516129032277;8071.636776345079;8082.151374105634;8240.50556966572;5742.913856292075;5791.536677065909;5800.9419905800405;5830.9416905832095;5874.970625146847;9683.806323873623;9926.801463970825;9967.252456065678;9995.050470205319;10017.5492102857;9189.494577798017;10046.69859904204;10066.748331291776;10288.742781430525;10328.431936243578;7627.275408836152;7816.53100813953;7850.842983140419;8019.117897031439;8020.278174964281;8314.542700151549;8461.323094152576;8465.195806398382;8524.232819046316;8573.74278771638;7641.732539361095;7696.114946781192;7811.4922530035365;7824.726134585262;7856.45004849655;7599.924000760143;7602.239776022354;7615.809604759704;7701.075870895528;7811.257930496594;6495.188101487314;6574.408303252731;6590.47276217911;6683.565568238049;6736.629485378351;4908.410990681141;4941.209406494943;4942.481039490802;5027.773750181177;5095;4854.441739200037;5045.369328833895;5060.3168572242275;5093.847184584469;5096.796128154832 22:32:32 INFO - PROCESS | 437 | |4;prototype.html;298.64013863294747;313.8289632150478;316.24575387700327;320.2745780806473;325.18378869038713;4781.18719817631;5048.268001139832;5176.689398636085;5204.646791834127;5233.215017747335;5089.821856235032;5109.514596113372;5127.538521533062;5168.508991645797;5170.53465188133;4092.8362865485346;4096.426500289962;4101.118259574191;4102.220578090153;4113.938290925638;3894.3768996960493;3935.4096885467125;4092.8362865485346;4114.732542384751;4114.835406583748;4051.7771522566245;4070.531888832778;4072.6538244249127;4080.326746086892;4087.202995415895;4060.4112403701447;4077.7349472284354;4084.571120032413;4087.2847251730827;4089.7506371495856;3407.1822762537063;3663.9267214655824;3664.706823454117;3667.1015601177614;3676.761010534307;5015.172496538067;5037.874053148664;5044.167712327461;5052.621053420971;5088.6692364996525;4575.862724118282;4582.747948862811;4599.816007359735;4603.608693261077;4627.930581041287;5160.92258616121;5292.179712144623;5315.7873685052555;5346.893062138735;5361.383440904307;3867.845286188549;3876.127871228979;3887.5140607424073;3887.747296425723;3893.1824316893203;5380.24676545284;5527.309086364205;5631.267935168402;5634.774609015634;5639.8590035249035;3740.775553466801;3840.2895464339185;3874.5737968823405;3876.205377897524;3882.9805850970565;3901.765894046366;3902.9609703903166;3905.4922860028014;3920.666743326792;3921.725439232261;4543.409356783597;4543.545645435496;4545.909081818345;4558.49856515783;4563.361129441881;5192;5385.8114965976;5416.485433883775;5424.159255315432;5448.782048718086;1364.6179069860455;1365.7951307303786;1381.3438616657209;1384.9653758655913;1388.632012516684;854.679495189304;893.5041052215953;894.6197865906963;913.1507697840939;915.8534634458588;4667.463241727177;4691.179043667413;4700.694454860423;4706.176419126639;4725.944214266805;4911.901761964741;4938.950610493849;4942.418426103684;4950.925736113961;4956.281339205795;4389.890252743707;4635.930461043087;4680.438347398334;4692.343071969927;4706.247000479907;2615.790736741056;2640.775534079586;2644.7223041580355;2670.893164273446;2672.919812405631;5164.612654050961;5171.63798534099;5172.379314482287;5198.4924371932475;5207.817726379559;4795.808167673324;4914.36113305268;4977.626677999165;4985.485232910789;5047.570956468668;5081.441041485507;5096.745162741848;5103.464136265638;5110.514501122388;5132.740709649325;4913.729744864067;4944.629152813625;4946.109700253989;4953.2570114483115;4986.1772807487805;4811.374521312207;4833.951660483491;4876;5167.379914410295;5475.808346707846;5523.342997100774;5605.262368665727;5789.710514474344;5812.505936995233;5816.1857339973285;3900.8049597519444;3917.8628747993685;3931.410288456754;3955.8022098895517;3963.128111815396;5659.236003139524;5662.150677398423;5673.631213971244;5697.401772813961;5701.714914254354;5315.867103322448;5437.755301011543;5460.726963651722;5476.863078422912;5569.693666848362;5447.93765215795;5449.754761035842;5458.890822183614;5459.699716515471;5459.863503412446;5348.251244825649;5356.812511562077;5360.410354860885;5446.128619420873;5456.918146227889;5234.921476177937;5469.890602187855;5503.422140675171;5503.972480137573;5515.696636685021;5401.432849550898;5406.459354064562;5425.050616142238;5432.7555260012605;5474.863128421821 22:32:32 INFO - PROCESS | 437 | |5;yui.html;772.8454309138173;789.159545084485;793.6825269892042;816.7958010497375;850.2900078434509;15694.764578531316;16679.66640667186;16719.498415047554;16725.83274167258;16773.245203965806;14982.475613353536;15126;15152.318145683443;15153.54539363818;15162.801393797892;651.8956966885299;771.5486440432354;794.3248238996849;797.9441439099265;800.4076983032572;803.3051410529908;805.6012273924416;814.5194335342147;815.4821688227988;815.571824791983;855.9614817333235;857.1428571428571;857.661223816592;857.9656813727444;858.2618947704968;685.0819901332189;701.8526109516956;843.9324854011695;851.535912927456;851.7870532366877;518.5644058990466;599.466474837395;614.6158650843223;617.2130533569734;619.3342157181048;15463.149526776022;15481.767773483407;15506.844931550653;15512.069275843485;15515.534533963999;14748.410063597443;14821.110733356034;14939.477118300807;15043.548693539211;15047.473338433212;13374.933125334408;13468.93265533676;13610.183388996691;13687.31563421825;14133.717325653532;4621.237495813187;4646.256598944153;4673.275642275453;4729.9763501182615;4844.20070688336;66720.6663966682;77299.22700772976;77598.61200694017;77970.61014694948;78003.60998194973;11525.538978440769;11534.769304613861;12613;12820.23078615286;13414.530491432753;23401.41496462602;23483.765162348158;23493.88253058758;23500.647490287658;24055.51888962246;9209.815803684023;9254.12085851843;9281.953590232006;9512.95243523778;9582.425054496613;4793.257045158006;4886.438059623118;4889.706617602955;5113.463086375951;5113.8721531961255;3535.646435356444;3702.6852717519314;3708.6291370863237;3709.9629003710156;3711.7958512281543;629.2511910826103;629.7418058595954;642.6626021338834;645.1709553224179;652.3867564489365;502.90193412284987;551.2970962023452;655.9409653131241;674.9426298764562;698.27728301208;9216.585253663601;9334.953325233466;9407.858882116774;9476;9634.518274086267;689.2142957028991;696.5437638346891;703.9190493093257;705.1009962298111;724.847781965793;4347.3261644445165;4437.424639515324;4571.634269258451;4580.152671755669;4597.3333866589155;79849;109124;116473.41763291298;117065.4146729278;118361;96546;98556.50721746346;99114.5044274774;101520;102414.48792755988;67379;87338.56330718305;87369.12630873737;87668;91242.08757912336;9637.566309515949;10068.748281293027;10142.695719128438;10255;10280.331778434378;49987.00025999387;50207.74896125496;50444.243336350715;51664.22503662373;52238.73880630572;71401;71526;72335.63832180806;73018;75841;12191.390430478617;12214.816777748518;12580.433880475217;12893.290869002294;13971.720565588834;15062.32219550101;15236.466723664618;15280.15959122259;15515.534533963999;16042.839571604134;8100.672311239572;13697.657558561115;13838.23889686077;13927.164370137823;13942.651433714238;13342.799858002332;13778.379972901444;13920.303984800517;14049;14569.271536422924;13666.316684165951;13931.164130152223;14417;14591.270436477922;14764.63088422798;10582.206334524788;10714.785704285714;11035.558577656804;11045.33727976324;11136;10283.675643534802;10410.947945260225;10453.738656533647;10458.68623941283;10753.085987691135 22:32:32 INFO - PROCESS | 437 | __end_tp_report 22:32:32 INFO - PROCESS | 437 | __start_cc_report 22:32:32 INFO - PROCESS | 437 | _x_x_mozilla_cycle_collect,994 22:32:32 INFO - PROCESS | 437 | __end_cc_report 22:32:32 INFO - PROCESS | 437 | __startTimestamp1469856752848__endTimestamp 22:32:32 INFO - PROCESS | 437 | 22:32:32 INFO - PROCESS | 437 | ------- Summary: start ------- 22:32:32 INFO - PROCESS | 437 | Number of tests: 6 22:32:32 INFO - PROCESS | 437 | 22:32:32 INFO - PROCESS | 437 | [#0] dojo.html Cycles:165 Average:5150.63 Median:5371.19 stddev:578.04 (10.8%) stddev-sans-first:553.98 22:32:32 INFO - PROCESS | 437 | Values: 2972.7 2982.1 3020.5 3022.5 3028.9 5053.3 5073.2 5123.8 5164.3 5245.9 5131.5 5161.9 5168.4 5191.6 5229.8 4652.5 4679.2 4705.9 4716.7 4870.4 4798.8 4831.7 4832.8 4851.2 4868.2 4642.3 4645.1 4702.3 4717.8 4777.9 4666.1 4689.5 4696.3 4751.7 4764.2 4717.4 4738.4 4747.3 4750.1 4783.1 4989.7 5042.2 5174.2 5221.3 5240.8 5371.2 5464.6 5472.3 5472.5 5477.5 5417.1 5473.7 5478.8 5504.9 5506.6 5031.9 5090.1 5130.8 5174.6 5174.9 5648.1 5656.4 5670.3 5671.4 5671.7 5471.3 5472.6 5477.4 5477.6 5488.1 5322.4 5412.0 5462.9 5572.7 5575.2 5451.3 5451.4 5460.5 5498.2 5498.8 5460.5 5465.2 5466.9 5469.0 5474.6 4194.4 4211.9 4231.5 4248.8 4295.7 3774.8 3793.4 3824.0 3855.4 3880.5 5164.3 5203.4 5209.8 5212.2 5212.9 5365.2 5505.5 5511.8 5521.9 5524.0 5212.5 5219.0 5234.5 5235.2 5239.3 4815.9 4821.6 4823.6 4826.8 4866.3 5638.9 5716.7 5826.7 5839.4 5845.8 5469.5 5569.3 5614.1 5614.7 5616.1 5820.0 5826.7 5829.7 5832.0 5834.6 5323.8 5478.8 5479.6 5485.9 5486.9 5522.9 5554.0 5576.6 5617.1 5670.5 5440.0 5480.2 5482.2 5483.8 5486.4 5239.9 5429.8 5472.5 5485.4 5533.2 5300.5 5331.3 5371.3 5413.2 5460.1 5501.3 5513.5 5558.6 5567.3 5569.6 5184.5 5392.7 5400.9 5401.4 5404.3 22:32:32 INFO - PROCESS | 437 | 22:32:32 INFO - PROCESS | 437 | [#1] ext.html Cycles:180 Average:57457.03 Median:43484.89 stddev:109514.83 (251.8%) stddev-sans-first:109738.86 22:32:32 INFO - PROCESS | 437 | Values: 605.4 619.1 637.1 643.4 649.9 31553.8 44860.6 45706.5 45782.3 48673.5 45899.0 46410.1 46421.3 46449.1 46558.5 8951.7 9093.5 9099.0 9107.6 9109.4 8934.7 9014.5 9025.1 9026.1 9028.1 8997.8 9064.7 9072.2 9072.3 9074.4 9016.5 9018.0 9062.6 9065.6 9069.7 8993.6 9076.0 9076.5 9083.8 9088.0 43942.8 44125.3 44260.8 44379.3 44405.0 3427.8 3560.9 3600.9 4032.3 4330.6 32511.8 34029.1 34050.7 34063.8 34116.7 4289.9 4447.2 4468.9 4477.8 4609.9 247710.8 249008.0 249840.0 250449.0 251835.0 58918.7 59765.4 60029.0 60035.0 60108.0 62503.0 63070.4 63229.7 63300.0 63340.0 14645.0 14721.2 14806.9 14818.1 14845.9 11433.3 11488.6 11497.3 11497.5 11500.4 16880.7 17010.7 17026.6 17041.3 17082.3 6099.7 6134.8 6242.5 6306.9 6332.0 985.6 1041.7 1065.4 1088.7 1104.9 32297.8 32561.2 32590.0 32888.0 32983.8 1043.5 1090.7 1118.9 1119.8 1124.4 16860.9 16959.5 17177.4 17236.4 17346.3 528483.0 536519.0 538676.0 540122.0 541074.0 60770.7 60867.0 61065.7 61081.0 61185.7 1193.6 1239.5 1266.2 1310.9 1356.4 32793.3 34045.3 34358.0 34365.1 34385.5 52260.7 52720.7 52737.0 52754.7 52801.0 397676.0 400233.0 401130.0 402327.0 402972.0 35717.8 41313.2 41479.4 41671.4 43578.6 48958.8 49285.8 49620.0 49778.0 49893.5 41638.0 41971.0 42568.4 42578.4 44348.6 41770.4 43038.4 43544.0 43956.6 44878.3 41951.2 42789.6 42879.6 43131.8 43425.8 35694.3 37597.0 37738.4 38510.2 38704.0 28550.5 28964.0 29254.0 29270.6 29384.0 22:32:32 INFO - PROCESS | 437 | 22:32:32 INFO - PROCESS | 437 | [#2] jquery.html Cycles:180 Average:27147.86 Median:23371.65 stddev:73922.71 (316.3%) stddev-sans-first:74102.76 22:32:32 INFO - PROCESS | 437 | Values: 381.3 384.7 389.2 395.6 416.0 14365.9 17914.6 18343.2 19552.4 19595.9 17446.4 17982.7 18832.4 19091.2 19160.6 5587.4 5590.0 5631.3 5670.1 5671.9 5597.2 5670.7 5674.1 5675.0 5677.2 5509.1 5566.3 5566.7 5587.8 5693.7 5572.6 5664.3 5679.2 5685.5 5685.8 4916.3 5049.3 5052.7 5055.1 5057.9 23019.8 23345.5 23356.6 23386.6 23544.9 2334.1 2517.5 2522.8 2547.3 3053.0 14559.9 14692.5 14739.9 14907.0 14921.5 1882.0 1930.8 1938.5 1956.6 1972.8 76988.0 77959.0 78302.6 78893.6 79120.0 10019.0 10057.1 10225.6 10696.8 10726.8 11904.5 13874.9 13899.2 13910.2 13921.4 7045.6 7253.7 7369.9 7422.2 7939.1 7605.8 7610.4 7631.8 7834.9 7853.0 6307.8 6371.4 6434.8 6509.7 6574.0 1798.2 1802.9 1803.2 1806.6 1853.9 929.3 997.6 998.9 1055.8 1066.4 19613.6 20367.2 20377.2 20409.6 20598.3 1030.7 1081.5 1085.6 1096.5 1099.9 11060.0 11439.9 11528.5 11533.7 11600.9 442603.0 449463.0 451134.0 451388.0 452587.0 77371.6 78709.6 79357.2 79635.0 80238.6 1020.2 1028.0 1037.0 1037.8 1043.7 17085.7 17692.4 17905.4 18038.7 18428.5 29458.9 38768.2 39049.6 40635.0 41093.4 44502.3 49375.0 49517.3 55323.0 55736.7 8102.4 8376.1 8494.7 8495.5 8503.8 13207.8 13217.7 13330.3 13519.7 13830.4 10845.4 10985.7 11057.7 11129.0 11179.9 10855.9 10915.9 11258.8 11260.8 11314.8 10917.5 11080.6 11552.8 11699.9 11722.0 8239.5 8286.7 8480.4 8493.2 8592.5 10825.7 11082.7 11271.8 11365.4 11390.4 22:32:32 INFO - PROCESS | 437 | 22:32:32 INFO - PROCESS | 437 | [#3] mootools.html Cycles:180 Average:5685.30 Median:4838.81 stddev:3231.99 (66.8%) stddev-sans-first:3225.44 22:32:32 INFO - PROCESS | 437 | Values: 1457.1 1523.8 1586.4 1710.2 1754.6 8327.8 8854.6 8867.8 8873.0 8875.0 7266.0 7447.8 7452.0 7621.5 8660.9 2234.1 2322.8 2325.2 2327.0 2329.1 2328.1 2347.9 2361.3 2372.8 2373.7 2322.7 2331.6 2339.1 2339.6 2339.8 2241.4 2244.4 2248.3 2251.9 2252.6 2157.8 2199.8 2219.0 2220.0 2227.4 8586.5 8641.5 8660.5 8723.2 8730.1 4977.4 5092.6 5098.2 5102.8 5104.1 3382.2 3445.5 3485.6 3494.7 3496.4 1058.5 1097.6 1106.2 1111.1 1136.2 11879.6 11881.6 11886.0 11898.9 11903.9 4509.4 4568.6 4667.2 4724.0 4732.3 10179.7 10223.3 10230.7 10238.3 10246.8 5149.7 5153.6 5154.5 5156.4 5159.3 4627.9 4751.5 4752.8 4779.2 4823.2 3782.7 3789.7 3862.8 3871.4 3894.8 1120.5 1129.0 1140.7 1146.1 1150.3 801.3 816.4 820.5 959.3 1001.4 5751.9 5766.1 5800.7 5844.0 5989.9 912.7 914.4 918.6 939.7 959.4 3772.8 3863.6 3963.8 3986.7 3997.9 10506.2 10881.8 10896.2 10904.8 10908.5 10664.1 10670.8 10679.5 10732.3 10758.9 7745.8 8064.5 8071.6 8082.2 8240.5 5742.9 5791.5 5800.9 5830.9 5875.0 9683.8 9926.8 9967.3 9995.1 10017.5 9189.5 10046.7 10066.7 10288.7 10328.4 7627.3 7816.5 7850.8 8019.1 8020.3 8314.5 8461.3 8465.2 8524.2 8573.7 7641.7 7696.1 7811.5 7824.7 7856.5 7599.9 7602.2 7615.8 7701.1 7811.3 6495.2 6574.4 6590.5 6683.6 6736.6 4908.4 4941.2 4942.5 5027.8 5095.0 4854.4 5045.4 5060.3 5093.8 5096.8 22:32:32 INFO - PROCESS | 437 | 22:32:32 INFO - PROCESS | 437 | [#4] prototype.html Cycles:180 Average:4427.54 Median:4945.37 stddev:1286.84 (26.0%) stddev-sans-first:1252.58 22:32:32 INFO - PROCESS | 437 | Values: 298.6 313.8 316.2 320.3 325.2 4781.2 5048.3 5176.7 5204.6 5233.2 5089.8 5109.5 5127.5 5168.5 5170.5 4092.8 4096.4 4101.1 4102.2 4113.9 3894.4 3935.4 4092.8 4114.7 4114.8 4051.8 4070.5 4072.7 4080.3 4087.2 4060.4 4077.7 4084.6 4087.3 4089.8 3407.2 3663.9 3664.7 3667.1 3676.8 5015.2 5037.9 5044.2 5052.6 5088.7 4575.9 4582.7 4599.8 4603.6 4627.9 5160.9 5292.2 5315.8 5346.9 5361.4 3867.8 3876.1 3887.5 3887.7 3893.2 5380.2 5527.3 5631.3 5634.8 5639.9 3740.8 3840.3 3874.6 3876.2 3883.0 3901.8 3903.0 3905.5 3920.7 3921.7 4543.4 4543.5 4545.9 4558.5 4563.4 5192.0 5385.8 5416.5 5424.2 5448.8 1364.6 1365.8 1381.3 1385.0 1388.6 854.7 893.5 894.6 913.2 915.9 4667.5 4691.2 4700.7 4706.2 4725.9 4911.9 4939.0 4942.4 4950.9 4956.3 4389.9 4635.9 4680.4 4692.3 4706.2 2615.8 2640.8 2644.7 2670.9 2672.9 5164.6 5171.6 5172.4 5198.5 5207.8 4795.8 4914.4 4977.6 4985.5 5047.6 5081.4 5096.7 5103.5 5110.5 5132.7 4913.7 4944.6 4946.1 4953.3 4986.2 4811.4 4834.0 4876.0 5167.4 5475.8 5523.3 5605.3 5789.7 5812.5 5816.2 3900.8 3917.9 3931.4 3955.8 3963.1 5659.2 5662.2 5673.6 5697.4 5701.7 5315.9 5437.8 5460.7 5476.9 5569.7 5447.9 5449.8 5458.9 5459.7 5459.9 5348.3 5356.8 5360.4 5446.1 5456.9 5234.9 5469.9 5503.4 5504.0 5515.7 5401.4 5406.5 5425.1 5432.8 5474.9 22:32:32 INFO - PROCESS | 437 | 22:32:32 INFO - PROCESS | 437 | [#5] yui.html Cycles:180 Average:20741.34 Median:4659.77 stddev:29216.47 (627.0%) stddev-sans-first:29259.96 22:32:32 INFO - PROCESS | 437 | Values: 772.8 789.2 793.7 816.8 850.3 15694.8 16679.7 16719.5 16725.8 16773.2 14982.5 15126.0 15152.3 15153.5 15162.8 651.9 771.5 794.3 797.9 800.4 803.3 805.6 814.5 815.5 815.6 856.0 857.1 857.7 858.0 858.3 685.1 701.9 843.9 851.5 851.8 518.6 599.5 614.6 617.2 619.3 15463.1 15481.8 15506.8 15512.1 15515.5 14748.4 14821.1 14939.5 15043.5 15047.5 13374.9 13468.9 13610.2 13687.3 14133.7 4621.2 4646.3 4673.3 4730.0 4844.2 66720.7 77299.2 77598.6 77970.6 78003.6 11525.5 11534.8 12613.0 12820.2 13414.5 23401.4 23483.8 23493.9 23500.6 24055.5 9209.8 9254.1 9282.0 9513.0 9582.4 4793.3 4886.4 4889.7 5113.5 5113.9 3535.6 3702.7 3708.6 3710.0 3711.8 629.3 629.7 642.7 645.2 652.4 502.9 551.3 655.9 674.9 698.3 9216.6 9335.0 9407.9 9476.0 9634.5 689.2 696.5 703.9 705.1 724.8 4347.3 4437.4 4571.6 4580.2 4597.3 79849.0 109124.0 116473.4 117065.4 118361.0 96546.0 98556.5 99114.5 101520.0 102414.5 67379.0 87338.6 87369.1 87668.0 91242.1 9637.6 10068.7 10142.7 10255.0 10280.3 49987.0 50207.7 50444.2 51664.2 52238.7 71401.0 71526.0 72335.6 73018.0 75841.0 12191.4 12214.8 12580.4 12893.3 13971.7 15062.3 15236.5 15280.2 15515.5 16042.8 8100.7 13697.7 13838.2 13927.2 13942.7 13342.8 13778.4 13920.3 14049.0 14569.3 13666.3 13931.2 14417.0 14591.3 14764.6 10582.2 10714.8 11035.6 11045.3 11136.0 10283.7 10410.9 10453.7 10458.7 10753.1 22:32:32 INFO - PROCESS | 437 | -------- Summary: end -------- 22:32:32 INFO - PROCESS | 437 | 22:32:33 INFO - TEST-INFO | 437: exit 0 22:32:33 INFO - TEST-OK | dromaeo_css | took 1113459ms 22:32:33 INFO - TEST-START | kraken 22:32:33 INFO - operating with platform_type : linux_ 22:32:33 INFO - Initialising browser for kraken test... 22:32:33 INFO - TEST-INFO | started process 630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ypkei/profile http://localhost:39998/getInfo.html) 22:32:36 INFO - PROCESS | 630 | JavaScript error: , line 0: uncaught exception: undefined 22:32:37 INFO - PROCESS | 630 | __metrics Screen width/height:1600/1200 22:32:37 INFO - PROCESS | 630 | colorDepth:24 22:32:37 INFO - PROCESS | 630 | Browser inner width/height: 1024/697 22:32:37 INFO - PROCESS | 630 | __metrics 22:32:38 INFO - PROCESS | 630 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:32:38 INFO - PROCESS | 630 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:32:38 INFO - PROCESS | 630 | console.error: PushService: 22:32:38 INFO - PROCESS | 630 | stateChangeProcessEnqueue: Error transitioning state 22:32:38 INFO - PROCESS | 630 | UnknownError 22:32:39 INFO - TEST-INFO | 630: exit 0 22:32:39 INFO - Browser initialized. 22:32:39 INFO - Running cycle 1/1 for kraken test... 22:32:39 INFO - TEST-INFO | started process 712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ypkei/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:51 INFO - PROCESS | 712 | RSS: Main: 157274112 22:32:51 INFO - PROCESS | 712 | 22:32:53 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39998/tests/kraken/driver.html?testName=audio-beat-detection) 22:32:54 INFO - PROCESS | 712 | RSS: Main: 214433792 22:32:54 INFO - PROCESS | 712 | 22:32:56 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39998/tests/kraken/driver.html?testName=audio-dft) 22:32:57 INFO - PROCESS | 712 | RSS: Main: 193310720 22:32:57 INFO - PROCESS | 712 | 22:33:00 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39998/tests/kraken/driver.html?testName=audio-fft) 22:33:01 INFO - PROCESS | 712 | RSS: Main: 270651392 22:33:01 INFO - PROCESS | 712 | 22:33:03 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39998/tests/kraken/driver.html?testName=audio-oscillator) 22:33:03 INFO - PROCESS | 712 | RSS: Main: 181313536 22:33:03 INFO - PROCESS | 712 | 22:33:05 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:33:06 INFO - PROCESS | 712 | RSS: Main: 184987648 22:33:06 INFO - PROCESS | 712 | 22:33:09 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39998/tests/kraken/driver.html?testName=imaging-darkroom) 22:33:10 INFO - PROCESS | 712 | RSS: Main: 220327936 22:33:10 INFO - PROCESS | 712 | 22:33:13 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39998/tests/kraken/driver.html?testName=imaging-desaturate) 22:33:14 INFO - PROCESS | 712 | RSS: Main: 221061120 22:33:14 INFO - PROCESS | 712 | 22:33:16 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39998/tests/kraken/driver.html?testName=json-parse-financial) 22:33:17 INFO - PROCESS | 712 | RSS: Main: 220577792 22:33:17 INFO - PROCESS | 712 | 22:33:18 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:33:19 INFO - PROCESS | 712 | RSS: Main: 185057280 22:33:19 INFO - PROCESS | 712 | 22:33:21 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39998/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:33:21 INFO - PROCESS | 712 | RSS: Main: 190992384 22:33:21 INFO - PROCESS | 712 | 22:33:23 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:33:24 INFO - PROCESS | 712 | RSS: Main: 195522560 22:33:24 INFO - PROCESS | 712 | 22:33:27 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:33:27 INFO - PROCESS | 712 | RSS: Main: 189050880 22:33:27 INFO - PROCESS | 712 | 22:33:30 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:33:31 INFO - PROCESS | 712 | RSS: Main: 194220032 22:33:31 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | Cycle 1(1): loaded http://localhost:39998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39998/tests/kraken/driver.html?testName=ai-astar) 22:33:32 INFO - PROCESS | 712 | RSS: Main: 245256192 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | __start_tp_report 22:33:32 INFO - PROCESS | 712 | _x_x_mozilla_page_load 22:33:32 INFO - PROCESS | 712 | _x_x_mozilla_page_load_details 22:33:32 INFO - PROCESS | 712 | |i|pagename|runs| 22:33:32 INFO - PROCESS | 712 | |0;ai-astar;103;112;114;110;112;113;111;110;110;110 22:33:32 INFO - PROCESS | 712 | |1;audio-beat-detection;151;117;117;178;120;117;146;115;166;119 22:33:32 INFO - PROCESS | 712 | |2;audio-dft;161;163;162;162;161;160;162;165;161;163 22:33:32 INFO - PROCESS | 712 | |3;audio-fft;74;74;75;124;74;78;75;75;106;74 22:33:32 INFO - PROCESS | 712 | |4;audio-oscillator;83;84;118;84;84;84;127;83;83;121 22:33:32 INFO - PROCESS | 712 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;116;117 22:33:32 INFO - PROCESS | 712 | |6;imaging-darkroom;145;145;147;145;145;145;146;145;145;145 22:33:32 INFO - PROCESS | 712 | |7;imaging-desaturate;95;94;95;96;95;94;95;95;95;95 22:33:32 INFO - PROCESS | 712 | |8;json-parse-financial;52;50;50;52;51;53;59;54;51;53 22:33:32 INFO - PROCESS | 712 | |9;json-stringify-tinderbox;62;63;61;63;63;63;64;63;63;63 22:33:32 INFO - PROCESS | 712 | |10;stanford-crypto-aes;76;81;76;78;81;85;75;76;76;82 22:33:32 INFO - PROCESS | 712 | |11;stanford-crypto-ccm;132;128;130;119;119;134;122;118;173;137 22:33:32 INFO - PROCESS | 712 | |12;stanford-crypto-pbkdf2;158;153;152;156;155;154;155;154;154;154 22:33:32 INFO - PROCESS | 712 | |13;stanford-crypto-sha256-iterative;62;62;62;62;61;65;62;61;61;61 22:33:32 INFO - PROCESS | 712 | __end_tp_report 22:33:32 INFO - PROCESS | 712 | __start_cc_report 22:33:32 INFO - PROCESS | 712 | _x_x_mozilla_cycle_collect,1715 22:33:32 INFO - PROCESS | 712 | __end_cc_report 22:33:32 INFO - PROCESS | 712 | __startTimestamp1469856812960__endTimestamp 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | ------- Summary: start ------- 22:33:32 INFO - PROCESS | 712 | Number of tests: 14 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.99 (2.7%) stddev-sans-first:1.50 22:33:32 INFO - PROCESS | 712 | Values: 103.0 112.0 114.0 110.0 112.0 113.0 111.0 110.0 110.0 110.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:133.00 stddev:23.66 (17.8%) stddev-sans-first:24.34 22:33:32 INFO - PROCESS | 712 | Values: 151.0 117.0 117.0 178.0 120.0 117.0 146.0 115.0 166.0 119.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 22:33:32 INFO - PROCESS | 712 | Values: 161.0 163.0 162.0 162.0 161.0 160.0 162.0 165.0 161.0 163.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#3] audio-fft Cycles:10 Average:82.90 Median:74.50 stddev:17.48 (23.5%) stddev-sans-first:18.24 22:33:32 INFO - PROCESS | 712 | Values: 74.0 74.0 75.0 124.0 74.0 78.0 75.0 75.0 106.0 74.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:83.50 stddev:18.69 (22.4%) stddev-sans-first:19.31 22:33:32 INFO - PROCESS | 712 | Values: 83.0 84.0 118.0 84.0 84.0 84.0 127.0 83.0 83.0 121.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:33:32 INFO - PROCESS | 712 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 22:33:32 INFO - PROCESS | 712 | Values: 145.0 145.0 147.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:33:32 INFO - PROCESS | 712 | Values: 95.0 94.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:2.64 (5.0%) stddev-sans-first:2.79 22:33:32 INFO - PROCESS | 712 | Values: 52.0 50.0 50.0 52.0 51.0 53.0 59.0 54.0 51.0 53.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 22:33:32 INFO - PROCESS | 712 | Values: 62.0 63.0 61.0 63.0 63.0 63.0 64.0 63.0 63.0 63.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.50 stddev:3.41 (4.3%) stddev-sans-first:3.48 22:33:32 INFO - PROCESS | 712 | Values: 76.0 81.0 76.0 78.0 81.0 85.0 75.0 76.0 76.0 82.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:131.00 stddev:16.19 (12.4%) stddev-sans-first:17.16 22:33:32 INFO - PROCESS | 712 | Values: 132.0 128.0 130.0 119.0 119.0 134.0 122.0 118.0 173.0 137.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:154.50 stddev:1.65 (1.1%) stddev-sans-first:1.17 22:33:32 INFO - PROCESS | 712 | Values: 158.0 153.0 152.0 156.0 155.0 154.0 155.0 154.0 154.0 154.0 22:33:32 INFO - PROCESS | 712 | 22:33:32 INFO - PROCESS | 712 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:62.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 22:33:32 INFO - PROCESS | 712 | Values: 62.0 62.0 62.0 62.0 61.0 65.0 62.0 61.0 61.0 61.0 22:33:32 INFO - PROCESS | 712 | -------- Summary: end -------- 22:33:32 INFO - PROCESS | 712 | 22:33:33 INFO - TEST-INFO | 712: exit 0 22:33:33 INFO - TEST-OK | kraken | took 60358ms 22:33:33 INFO - SUITE-END | took 1173s 22:33:34 INFO - Completed test suite (00:19:33) 22:33:34 INFO - javascript benchmark 22:33:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2972.7324540791324, 2982.0755565774607, 3020.546917962307, 3022.5012872875977, 3028.9242768930776, 5053.343065401493, 5073.188289873617, 5123.820666276681, 5164.2770012198325, 5245.86885327867, 5131.512506311904, 5161.870953226171, 5168.405633352166, 5191.558717509016, 5229.843104706855, 4652.534746525345, 4679.204535229002, 4705.858824235262, 4716.740579268139, 4870.391201099863, 4798.7600619969035, 4831.71009739415, 4832.758362081881, 4851.175300198957, 4868.172410690191, 4642.326862604903, 4645.140648979949, 4702.3416721659, 4717.834875779331, 4777.856664300077, 4666.113438446719, 4689.484156742756, 4696.272077827942, 4751.691140075884, 4764.213904705754, 4717.386739723814, 4738.384010078667, 4747.287906813971, 4750.14497390473, 4783.091212669582, 4989.65072444929, 5042.243663450475, 5174.2238664200295, 5221.347331583552, 5240.764165612557, 5371.194320851864, 5464.617476776627, 5472.26124473195, 5472.452754724535, 5477.534409575191, 5417.079096553595, 5473.698946557938, 5478.808241711521, 5504.91742623861, 5506.64206826559, 5031.949680503185, 5090.08378491875, 5130.7947682093045, 5174.637775355726, 5174.948250517485, 5648.068068768689, 5656.434356564393, 5670.262865827499, 5671.432856714378, 5671.688057156896, 5471.261379713767, 5472.5621950243885, 5477.370102438191, 5477.589180811455, 5488.149336852714, 5322.441143679858, 5412.0, 5462.918056229159, 5572.693501857356, 5575.191597218381, 5451.2640793493165, 5451.427600102012, 5460.453954604508, 5498.202760599691, 5498.835034948958, 5460.481254280837, 5465.234867118606, 5466.9179962300595, 5469.0, 5474.589405794582, 4194.391813187131, 4211.894702632459, 4231.513375961804, 4248.808803603845, 4295.72077814941, 3774.7735135891385, 3793.4499497572697, 3824.043989002749, 3855.36386496225, 3880.534335879656, 5164.302819119446, 5203.427622961472, 5209.843704688789, 5212.244224587414, 5212.869678257998, 5365.168398898177, 5505.504504594605, 5511.834644960658, 5521.861953451196, 5523.972380138073, 5212.478752124757, 5218.9739051304505, 5234.450382709761, 5235.214717792285, 5239.29269548606, 4815.903681926412, 4821.566059054702, 4823.5658790709, 4826.758662066883, 4866.343043689128, 5638.887222255532, 5716.714164291769, 5826.6795326256615, 5839.386864379264, 5845.766169353264, 5469.507744303032, 5569.303837020372, 5614.129809879475, 5614.747336369792, 5616.1014237721765, 5820.0, 5826.650400975955, 5829.737661805144, 5832.0, 5834.649921004753, 5323.840284791462, 5478.808241711521, 5479.561635069105, 5485.917711234255, 5486.862828429321, 5522.889542209053, 5553.972230138824, 5576.609637325349, 5617.073182924772, 5670.546356291405, 5440.047991601533, 5480.177973304037, 5482.150266708666, 5483.8080667176455, 5486.396496385315, 5239.895202096013, 5429.809956651498, 5472.5348345391085, 5485.369182543899, 5533.170024496358, 5300.469953004668, 5331.253624492651, 5371.274877891435, 5413.160960051198, 5460.126379779216, 5501.284832971688, 5513.531349835309, 5558.610897237155, 5567.276254086943, 5569.610127291051, 5184.45563215872, 5392.676439413648, 5400.864978375572, 5401.405845356929, 5404.32445944257], "value": 5112.116725419245, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.4187979539643, 619.1177571959959, 637.1303171171353, 643.4112786800076, 649.8862699027669, 31553.842230788843, 44860.55139448604, 45706.54293457064, 45782.313265301, 48673.51326486734, 45899.0, 46410.07179856401, 46421.30368044482, 46449.071018579605, 46558.53441465584, 8951.731448056553, 9093.499857507835, 9099.044600316938, 9107.590158442887, 9109.407888487227, 8934.73195804127, 9014.54927253638, 9025.142611451902, 9026.052264512196, 9028.142326479006, 8997.820043599124, 9064.728058158265, 9072.228860546862, 9072.31957603179, 9074.36479446439, 9016.54917254138, 9017.954910225408, 9062.637494500212, 9065.637374505011, 9069.727908162766, 8993.640254389817, 9075.954620226856, 9076.546172691338, 9083.81832363349, 9087.954560227157, 43942.780286098365, 44125.33811992823, 44260.77869610664, 44379.334309985374, 44405.0, 3427.7943323400677, 3560.9109772255642, 3600.9279814403567, 4032.2741906456827, 4330.624198610006, 32511.83744081288, 34029.14927126817, 34050.65949340499, 34063.82968085168, 34116.658833411595, 4289.935650965238, 4447.177272204653, 4468.910621787579, 4477.820887164509, 4609.884752881171, 247710.7614461934, 249008.0, 249840.0, 250449.0, 251835.0, 58918.70540647269, 59765.40234597685, 60029.0, 60035.0, 60108.0, 62503.0, 63070.36929630737, 63229.68385158045, 63300.0, 63340.04989925155, 14645.048071875293, 14721.190334531704, 14806.92596537032, 14818.110913345234, 14845.92577037108, 11433.314001159957, 11488.597899073493, 11497.310161390344, 11497.482613282422, 11500.367479788692, 16880.746788798177, 17010.744838827428, 17026.574335641708, 17041.318347266217, 17082.316707331815, 6099.664518451439, 6134.8159555213415, 6242.469390101802, 6306.873862522724, 6332.0, 985.5860538573672, 1041.656253436364, 1065.414022287754, 1088.7223757941674, 1104.928179668319, 32297.838510807294, 32561.185970350456, 32590.0, 32888.0, 32983.83508082444, 1043.4730461117088, 1090.6891535912227, 1118.904893084097, 1119.8040342939953, 1124.42092322454, 16860.915695421445, 16959.491215263562, 17177.398791042502, 17236.396726114526, 17346.3061477542, 528483.0, 536519.0, 538676.0, 540122.0, 541074.0, 60770.69614651898, 60867.0, 61065.694671526355, 61081.0, 61185.69407152936, 1193.6001439517859, 1239.4732238798474, 1266.2212739165532, 1310.9410076546578, 1356.3828458051562, 32793.34413311768, 34045.319093618484, 34358.0, 34365.14087147841, 34385.484217737256, 52260.738696307795, 52720.73639631777, 52737.0, 52754.73622631862, 52801.0, 397676.0, 400233.0, 401130.0, 402327.0, 402972.0, 35717.82141089382, 41313.1737365257, 41479.37780933228, 41671.37492937548, 43578.56421435872, 48958.75520622374, 49285.753571231915, 49620.0, 49778.0, 49893.501064988886, 41638.0, 41971.0, 42568.36147457729, 42578.361324579535, 44348.556514434444, 41770.37344439897, 43038.35442468303, 43544.0, 43956.560434395244, 44878.326825097, 41951.160976780906, 42789.57210427856, 42879.57120428756, 43131.78434107935, 43425.782871085445, 35694.28611427809, 37597.047471922626, 37738.43392349172, 38510.2297954045, 38704.0, 28550.45101741117, 28964.0, 29254.0, 29270.560941585467, 29384.0], "value": 20273.947818941175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.25084209528274, 384.70185606155206, 389.1535909397061, 395.55895176877783, 415.9916801663967, 14365.92817035916, 17914.64170716585, 18343.17455714493, 19552.413427597177, 19595.902020489913, 17446.389376371797, 17982.730259046126, 18832.43502694918, 19091.236350545998, 19160.61678766424, 5587.38538760737, 5590.049691552425, 5631.2960879890015, 5670.121131224667, 5671.886562268752, 5597.188407680884, 5670.716464176795, 5674.063779476382, 5674.971625141869, 5677.233573467591, 5509.146082357241, 5566.304211973504, 5566.693831839248, 5587.776488940458, 5693.715314234271, 5572.554195664377, 5664.291963504562, 5679.2333035040365, 5685.488306052454, 5685.772569097231, 4916.311716359713, 5049.267856160873, 5052.671576347526, 5055.140626093573, 5057.873553161164, 23019.769802302097, 23345.533089338118, 23356.649650255258, 23386.64920026201, 23544.882275588683, 2334.0780391745166, 2517.546841568517, 2522.7603377679275, 2547.2994926395204, 3053.046050527664, 14559.854401455956, 14692.48576299835, 14739.926300368537, 14907.0, 14921.477748278867, 1881.9529511762178, 1930.758655168104, 1938.4572319750494, 1956.6478033953883, 1972.753405824272, 76988.0, 77959.0, 78302.60848695778, 78893.60553197197, 79120.0, 10019.0, 10057.145142662956, 10225.59097636101, 10696.839547406795, 10726.839097413545, 11904.523819047314, 13874.86125138756, 13899.235542045284, 13910.234937078558, 13921.373538190806, 7045.577265364094, 7253.673584688596, 7369.926300737031, 7422.220666830013, 7939.126696063428, 7605.809854753565, 7610.353119984863, 7631.809204769814, 7834.921650783534, 7853.018372703412, 6307.842303942438, 6371.39471750183, 6434.806955791334, 6509.674516274262, 6574.046763219402, 1798.1998010885031, 1802.8647851411197, 1803.2336257090683, 1806.6296409236074, 1853.9073046347628, 929.2844509727472, 997.5660587644398, 998.9350692204983, 1055.8099542082498, 1066.386827574148, 19613.60478946161, 20367.185312587626, 20377.184912603625, 20409.591808163754, 20598.27906023282, 1030.6959446963165, 1081.5187241677536, 1085.592902661502, 1096.4543358435685, 1099.8955099265556, 11060.0, 11439.88560114405, 11528.538858445569, 11533.653990380302, 11600.94199528997, 442603.0, 449463.0, 451134.0, 451388.0, 452587.0, 77371.61314193394, 78709.60645196737, 79357.20642793499, 79635.0, 80238.59880700675, 1020.2246292817512, 1027.984580231297, 1037.0, 1037.8235699930879, 1043.6660268713938, 17085.65828683444, 17692.38076667362, 17905.37331193402, 18038.72941905846, 18428.539286517407, 29458.852705736335, 38768.22463550769, 39049.6095039046, 40635.0, 41093.38359924544, 44502.332465012405, 49375.0, 49517.257241142135, 55323.0, 55736.72131639316, 8102.4328297021, 8376.120507346885, 8494.74515764528, 8495.513285174946, 8503.787405314917, 13207.801882971955, 13217.669558261121, 13330.26683532415, 13519.662008449868, 13830.37763300674, 10845.403502807421, 10985.725356865823, 11057.668269951915, 11129.0, 11179.88820111821, 10855.945720271347, 10915.945420272848, 11258.83111753308, 11260.83108753353, 11314.773704526027, 10917.454127293444, 11080.61217857371, 11552.82670759956, 11699.941500292443, 11722.025394890026, 8239.464434811718, 8286.668533258602, 8480.448770829877, 8493.193146651058, 8592.527410992205, 10825.675229742805, 11082.667519974413, 11271.7745645085, 11365.374904380007, 11390.37352945596], "value": 9141.808791477986, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.0820383158612, 1523.756199008159, 1586.3575252022936, 1710.1791140252685, 1754.6227561074365, 8327.791805204864, 8854.601542930568, 8867.778305542364, 8873.0, 8874.955625221874, 7266.019087423197, 7447.776566703008, 7451.962740186305, 7621.504602200853, 8660.91339086609, 2234.106357457022, 2322.8257880658934, 2325.2094287942095, 2327.022650486791, 2329.0683726509365, 2328.115316179858, 2347.8708671023087, 2361.315218586608, 2372.78644921957, 2373.703287089114, 2322.7096612923383, 2331.5686597979343, 2339.099446713011, 2339.590571649963, 2339.801116905065, 2241.4396400899777, 2244.4164517225477, 2248.2580748353084, 2251.864888106719, 2252.560750653623, 2157.8165855902266, 2199.813015893651, 2219.0236296029857, 2219.9889000554895, 2227.376334626307, 8586.527740974245, 8641.52471614061, 8660.48037117775, 8723.214910658071, 8730.126987301282, 4977.352944117278, 5092.567131793802, 5098.209777484496, 5102.821401250939, 5104.106781313292, 3382.1882748140515, 3445.534852794866, 3485.599156097056, 3494.7204223662047, 3496.4405695088917, 1058.5130839813694, 1097.5554900265406, 1106.1593189176203, 1111.1444187975294, 1136.198979719296, 11879.643610691779, 11881.584144554985, 11886.0, 11898.881011189864, 11903.880961190363, 4509.391232183613, 4568.611668008257, 4667.159911215946, 4723.95276047242, 4732.272720457008, 10179.694609161737, 10223.335483193569, 10230.744231394126, 10238.33450825694, 10246.795064098676, 5149.742512874342, 5153.613478989091, 5154.53609175176, 5156.432792392834, 5159.277701121846, 4627.9074418511445, 4751.548602882721, 4752.7861246244, 4779.211430113992, 4823.1800593899125, 3782.678472329828, 3789.734718569729, 3862.787546684959, 3871.3805791073855, 3894.844206231776, 1120.5181771838188, 1128.98476219947, 1140.680609429361, 1146.094585277638, 1150.3328069719544, 801.3028665061433, 816.3713940266081, 820.5158956215741, 959.3284700709531, 1001.379144930148, 5751.884962300731, 5766.135079738073, 5800.651960882276, 5843.970780146157, 5989.921814073421, 912.6805618033635, 914.3873604684877, 918.6325469812128, 939.7415710679618, 959.4387283439266, 3772.849086036583, 3863.5943225961432, 3963.781991990468, 3986.7209295349626, 3997.8600748973645, 10506.159507239403, 10881.83677244842, 10896.237263391486, 10904.836427453594, 10908.454577271104, 10664.093552048163, 10670.786584268271, 10679.466026698634, 10732.302400343953, 10758.892411075789, 7745.845083098419, 8064.516129032277, 8071.636776345079, 8082.151374105634, 8240.50556966572, 5742.913856292075, 5791.536677065909, 5800.9419905800405, 5830.9416905832095, 5874.970625146847, 9683.806323873623, 9926.801463970825, 9967.252456065678, 9995.050470205319, 10017.5492102857, 9189.494577798017, 10046.69859904204, 10066.748331291776, 10288.742781430525, 10328.431936243578, 7627.275408836152, 7816.53100813953, 7850.842983140419, 8019.117897031439, 8020.278174964281, 8314.542700151549, 8461.323094152576, 8465.195806398382, 8524.232819046316, 8573.74278771638, 7641.732539361095, 7696.114946781192, 7811.4922530035365, 7824.726134585262, 7856.45004849655, 7599.924000760143, 7602.239776022354, 7615.809604759704, 7701.075870895528, 7811.257930496594, 6495.188101487314, 6574.408303252731, 6590.47276217911, 6683.565568238049, 6736.629485378351, 4908.410990681141, 4941.209406494943, 4942.481039490802, 5027.773750181177, 5095.0, 4854.441739200037, 5045.369328833895, 5060.3168572242275, 5093.847184584469, 5096.796128154832], "value": 4540.870412868979, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.64013863294747, 313.8289632150478, 316.24575387700327, 320.2745780806473, 325.18378869038713, 4781.18719817631, 5048.268001139832, 5176.689398636085, 5204.646791834127, 5233.215017747335, 5089.821856235032, 5109.514596113372, 5127.538521533062, 5168.508991645797, 5170.53465188133, 4092.8362865485346, 4096.426500289962, 4101.118259574191, 4102.220578090153, 4113.938290925638, 3894.3768996960493, 3935.4096885467125, 4092.8362865485346, 4114.732542384751, 4114.835406583748, 4051.7771522566245, 4070.531888832778, 4072.6538244249127, 4080.326746086892, 4087.202995415895, 4060.4112403701447, 4077.7349472284354, 4084.571120032413, 4087.2847251730827, 4089.7506371495856, 3407.1822762537063, 3663.9267214655824, 3664.706823454117, 3667.1015601177614, 3676.761010534307, 5015.172496538067, 5037.874053148664, 5044.167712327461, 5052.621053420971, 5088.6692364996525, 4575.862724118282, 4582.747948862811, 4599.816007359735, 4603.608693261077, 4627.930581041287, 5160.92258616121, 5292.179712144623, 5315.7873685052555, 5346.893062138735, 5361.383440904307, 3867.845286188549, 3876.127871228979, 3887.5140607424073, 3887.747296425723, 3893.1824316893203, 5380.24676545284, 5527.309086364205, 5631.267935168402, 5634.774609015634, 5639.8590035249035, 3740.775553466801, 3840.2895464339185, 3874.5737968823405, 3876.205377897524, 3882.9805850970565, 3901.765894046366, 3902.9609703903166, 3905.4922860028014, 3920.666743326792, 3921.725439232261, 4543.409356783597, 4543.545645435496, 4545.909081818345, 4558.49856515783, 4563.361129441881, 5192.0, 5385.8114965976, 5416.485433883775, 5424.159255315432, 5448.782048718086, 1364.6179069860455, 1365.7951307303786, 1381.3438616657209, 1384.9653758655913, 1388.632012516684, 854.679495189304, 893.5041052215953, 894.6197865906963, 913.1507697840939, 915.8534634458588, 4667.463241727177, 4691.179043667413, 4700.694454860423, 4706.176419126639, 4725.944214266805, 4911.901761964741, 4938.950610493849, 4942.418426103684, 4950.925736113961, 4956.281339205795, 4389.890252743707, 4635.930461043087, 4680.438347398334, 4692.343071969927, 4706.247000479907, 2615.790736741056, 2640.775534079586, 2644.7223041580355, 2670.893164273446, 2672.919812405631, 5164.612654050961, 5171.63798534099, 5172.379314482287, 5198.4924371932475, 5207.817726379559, 4795.808167673324, 4914.36113305268, 4977.626677999165, 4985.485232910789, 5047.570956468668, 5081.441041485507, 5096.745162741848, 5103.464136265638, 5110.514501122388, 5132.740709649325, 4913.729744864067, 4944.629152813625, 4946.109700253989, 4953.2570114483115, 4986.1772807487805, 4811.374521312207, 4833.951660483491, 4876.0, 5167.379914410295, 5475.808346707846, 5523.342997100774, 5605.262368665727, 5789.710514474344, 5812.505936995233, 5816.1857339973285, 3900.8049597519444, 3917.8628747993685, 3931.410288456754, 3955.8022098895517, 3963.128111815396, 5659.236003139524, 5662.150677398423, 5673.631213971244, 5697.401772813961, 5701.714914254354, 5315.867103322448, 5437.755301011543, 5460.726963651722, 5476.863078422912, 5569.693666848362, 5447.93765215795, 5449.754761035842, 5458.890822183614, 5459.699716515471, 5459.863503412446, 5348.251244825649, 5356.812511562077, 5360.410354860885, 5446.128619420873, 5456.918146227889, 5234.921476177937, 5469.890602187855, 5503.422140675171, 5503.972480137573, 5515.696636685021, 5401.432849550898, 5406.459354064562, 5425.050616142238, 5432.7555260012605, 5474.863128421821], "value": 4017.2065068384622, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.8454309138173, 789.159545084485, 793.6825269892042, 816.7958010497375, 850.2900078434509, 15694.764578531316, 16679.66640667186, 16719.498415047554, 16725.83274167258, 16773.245203965806, 14982.475613353536, 15126.0, 15152.318145683443, 15153.54539363818, 15162.801393797892, 651.8956966885299, 771.5486440432354, 794.3248238996849, 797.9441439099265, 800.4076983032572, 803.3051410529908, 805.6012273924416, 814.5194335342147, 815.4821688227988, 815.571824791983, 855.9614817333235, 857.1428571428571, 857.661223816592, 857.9656813727444, 858.2618947704968, 685.0819901332189, 701.8526109516956, 843.9324854011695, 851.535912927456, 851.7870532366877, 518.5644058990466, 599.466474837395, 614.6158650843223, 617.2130533569734, 619.3342157181048, 15463.149526776022, 15481.767773483407, 15506.844931550653, 15512.069275843485, 15515.534533963999, 14748.410063597443, 14821.110733356034, 14939.477118300807, 15043.548693539211, 15047.473338433212, 13374.933125334408, 13468.93265533676, 13610.183388996691, 13687.31563421825, 14133.717325653532, 4621.237495813187, 4646.256598944153, 4673.275642275453, 4729.9763501182615, 4844.20070688336, 66720.6663966682, 77299.22700772976, 77598.61200694017, 77970.61014694948, 78003.60998194973, 11525.538978440769, 11534.769304613861, 12613.0, 12820.23078615286, 13414.530491432753, 23401.41496462602, 23483.765162348158, 23493.88253058758, 23500.647490287658, 24055.51888962246, 9209.815803684023, 9254.12085851843, 9281.953590232006, 9512.95243523778, 9582.425054496613, 4793.257045158006, 4886.438059623118, 4889.706617602955, 5113.463086375951, 5113.8721531961255, 3535.646435356444, 3702.6852717519314, 3708.6291370863237, 3709.9629003710156, 3711.7958512281543, 629.2511910826103, 629.7418058595954, 642.6626021338834, 645.1709553224179, 652.3867564489365, 502.90193412284987, 551.2970962023452, 655.9409653131241, 674.9426298764562, 698.27728301208, 9216.585253663601, 9334.953325233466, 9407.858882116774, 9476.0, 9634.518274086267, 689.2142957028991, 696.5437638346891, 703.9190493093257, 705.1009962298111, 724.847781965793, 4347.3261644445165, 4437.424639515324, 4571.634269258451, 4580.152671755669, 4597.3333866589155, 79849.0, 109124.0, 116473.41763291298, 117065.4146729278, 118361.0, 96546.0, 98556.50721746346, 99114.5044274774, 101520.0, 102414.48792755988, 67379.0, 87338.56330718305, 87369.12630873737, 87668.0, 91242.08757912336, 9637.566309515949, 10068.748281293027, 10142.695719128438, 10255.0, 10280.331778434378, 49987.00025999387, 50207.74896125496, 50444.243336350715, 51664.22503662373, 52238.73880630572, 71401.0, 71526.0, 72335.63832180806, 73018.0, 75841.0, 12191.390430478617, 12214.816777748518, 12580.433880475217, 12893.290869002294, 13971.720565588834, 15062.32219550101, 15236.466723664618, 15280.15959122259, 15515.534533963999, 16042.839571604134, 8100.672311239572, 13697.657558561115, 13838.23889686077, 13927.164370137823, 13942.651433714238, 13342.799858002332, 13778.379972901444, 13920.303984800517, 14049.0, 14569.271536422924, 13666.316684165951, 13931.164130152223, 14417.0, 14591.270436477922, 14764.63088422798, 10582.206334524788, 10714.785704285714, 11035.558577656804, 11045.33727976324, 11136.0, 10283.675643534802, 10410.947945260225, 10453.738656533647, 10458.68623941283, 10753.085987691135], "value": 7646.677146927825, "unit": "score"}], "name": "dromaeo_css", "value": 7137.170838770245, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 114.0, 110.0, 112.0, 113.0, 111.0, 110.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 117.0, 117.0, 178.0, 120.0, 117.0, 146.0, 115.0, 166.0, 119.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 161.0, 160.0, 162.0, 165.0, 161.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 124.0, 74.0, 78.0, 75.0, 75.0, 106.0, 74.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 118.0, 84.0, 84.0, 84.0, 127.0, 83.0, 83.0, 121.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 52.0, 51.0, 53.0, 59.0, 54.0, 51.0, 53.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 76.0, 78.0, 81.0, 85.0, 75.0, 76.0, 76.0, 82.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 128.0, 130.0, 119.0, 119.0, 134.0, 122.0, 118.0, 173.0, 137.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 153.0, 152.0, 156.0, 155.0, 154.0, 155.0, 154.0, 154.0, 154.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 61.0, 65.0, 62.0, 61.0, 61.0, 61.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1483.6000000000001, "alertThreshold": 2.0}]} 22:33:34 INFO - Return code: 0 22:33:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:33:34 INFO - # TBPL SUCCESS # 22:33:34 INFO - Running post-action listener: _resource_record_post_action 22:33:34 INFO - [mozharness: 2016-07-30 05:33:34.279985Z] Finished run-tests step (success) 22:33:34 INFO - Running post-run listener: _resource_record_post_run 22:33:34 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 556167168; Read time: 0; Write time: 451296 22:33:34 INFO - TinderboxPrint: CPU usage
13.0% 22:33:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:33:34 INFO - TinderboxPrint: I/O write bytes / time
556,167,168 / 451,296 22:33:34 INFO - TinderboxPrint: CPU idle
8,270.1 (87.0%) 22:33:34 INFO - TinderboxPrint: CPU user
1,190.4 (12.5%) 22:33:34 INFO - TinderboxPrint: Swap in / out
0 / 0 22:33:34 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257466368; Read time: 0; Write time: 286988 22:33:34 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 298700800; Read time: 0; Write time: 164308 22:33:34 INFO - Running post-run listener: _upload_blobber_files 22:33:34 INFO - Blob upload gear active. 22:33:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:33:34 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 22:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:33:35 INFO - (blobuploader) - INFO - Open directory for files ... 22:33:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:33:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:36 INFO - (blobuploader) - INFO - Done attempting. 22:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:39 INFO - (blobuploader) - INFO - Done attempting. 22:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:33:40 INFO - (blobuploader) - INFO - Done attempting. 22:33:40 INFO - (blobuploader) - INFO - Iteration through files over. 22:33:40 INFO - Return code: 0 22:33:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:33:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:33:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d59b842666d02eef5f6f973db0e34fc1dbc48240b6db51fd75ae5127a12b2553fcb0e5a99970f5939c5ade42bc761bcc24b22784b11ccd2d6fb14df17ce3fab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/455355bbeec4f9ebac72b6b40f178fb02cc17f22e82000188349e425ba148826e697b92659304f8ceb33871897fd1bd6f4214bdfec9e3eb1e68247cf796d4ad2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8eb0b1c4b33c8717e69579b446535ff0ae12f3f40d523183e1c4acb4fad402e075548e8f81c1bfb580ad56573829dad2d1102f4668c4b2bd053f7f2fcabf20cc"} 22:33:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:33:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:33:40 INFO - Contents: 22:33:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d59b842666d02eef5f6f973db0e34fc1dbc48240b6db51fd75ae5127a12b2553fcb0e5a99970f5939c5ade42bc761bcc24b22784b11ccd2d6fb14df17ce3fab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/455355bbeec4f9ebac72b6b40f178fb02cc17f22e82000188349e425ba148826e697b92659304f8ceb33871897fd1bd6f4214bdfec9e3eb1e68247cf796d4ad2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8eb0b1c4b33c8717e69579b446535ff0ae12f3f40d523183e1c4acb4fad402e075548e8f81c1bfb580ad56573829dad2d1102f4668c4b2bd053f7f2fcabf20cc"} 22:33:40 INFO - Running post-run listener: copy_logs_to_upload_dir 22:33:40 INFO - Copying logs to upload dir... 22:33:40 INFO - mkdir: /builds/slave/test/build/upload/logs 22:33:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.391851 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-29 22:33:40.264529) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 22:33:40.267626) ========= 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=ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d59b842666d02eef5f6f973db0e34fc1dbc48240b6db51fd75ae5127a12b2553fcb0e5a99970f5939c5ade42bc761bcc24b22784b11ccd2d6fb14df17ce3fab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/455355bbeec4f9ebac72b6b40f178fb02cc17f22e82000188349e425ba148826e697b92659304f8ceb33871897fd1bd6f4214bdfec9e3eb1e68247cf796d4ad2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8eb0b1c4b33c8717e69579b446535ff0ae12f3f40d523183e1c4acb4fad402e075548e8f81c1bfb580ad56573829dad2d1102f4668c4b2bd053f7f2fcabf20cc"} build_url:https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011133 build_url: 'https://queue.taskcluster.net/v1/task/MTy19TnbRkO4HGyYCahQjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3d59b842666d02eef5f6f973db0e34fc1dbc48240b6db51fd75ae5127a12b2553fcb0e5a99970f5939c5ade42bc761bcc24b22784b11ccd2d6fb14df17ce3fab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/455355bbeec4f9ebac72b6b40f178fb02cc17f22e82000188349e425ba148826e697b92659304f8ceb33871897fd1bd6f4214bdfec9e3eb1e68247cf796d4ad2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8eb0b1c4b33c8717e69579b446535ff0ae12f3f40d523183e1c4acb4fad402e075548e8f81c1bfb580ad56573829dad2d1102f4668c4b2bd053f7f2fcabf20cc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 22:33:40.292439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 22:33:40.292807) ========= 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=ed14279e38b05397cf4aa391000001a4-1469853626.329550-1300462228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 22:33:40.378154) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 22:33:40.378483) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 22:33:40.378801) ========= ========= Total master_lag: 0.19 =========