builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1469764732.83 results: success (0) buildid: 20160728193028 builduid: 9242f12a3fe3497389ddada42c056cc1 revision: ddeb0295df692695b36295177d6790e5393e1f9a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:52.831627) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:52.832458) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:52.832927) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:52.867320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:52.867770) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 20:58:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-28 20:58:53 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.394596 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:53.277137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:53.277466) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019583 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:53.327228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 20:58:53.327591) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ddeb0295df692695b36295177d6790e5393e1f9a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ddeb0295df692695b36295177d6790e5393e1f9a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 20:58:53,584 truncating revision to first 12 chars 2016-07-28 20:58:53,584 Setting DEBUG logging. 2016-07-28 20:58:53,584 attempt 1/10 2016-07-28 20:58:53,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ddeb0295df69?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 20:58:54,291 unpacking tar archive at: mozilla-central-ddeb0295df69/testing/mozharness/ program finished with exit code 0 elapsedTime=1.032169 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-28 20:58:54.373284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:54.373610) ========= script_repo_revision: ddeb0295df692695b36295177d6790e5393e1f9a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:54.374041) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:54.374314) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 20:58:54.385495) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-28 20:58:54.386005) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:58:54 INFO - MultiFileLogger online at 20160728 20:58:54 in /builds/slave/test 20:58:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:58:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:58:54 INFO - {'append_to_log': False, 20:58:54 INFO - 'base_work_dir': '/builds/slave/test', 20:58:54 INFO - 'blob_upload_branch': 'Firefox', 20:58:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:58:54 INFO - 'branch': 'Firefox', 20:58:54 INFO - 'buildbot_json_path': 'buildprops.json', 20:58:54 INFO - 'config_files': ('talos/linux_config.py',), 20:58:54 INFO - 'default_actions': ('clobber', 20:58:54 INFO - 'read-buildbot-config', 20:58:54 INFO - 'download-and-extract', 20:58:54 INFO - 'populate-webroot', 20:58:54 INFO - 'create-virtualenv', 20:58:54 INFO - 'install', 20:58:54 INFO - 'run-tests'), 20:58:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:58:54 INFO - 'download_minidump_stackwalk': True, 20:58:54 INFO - 'download_symbols': 'ondemand', 20:58:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:58:54 INFO - 'tooltool.py': '/tools/tooltool.py', 20:58:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:58:54 INFO - '/tools/misc-python/virtualenv.py')}, 20:58:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:58:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:58:54 INFO - 'installer_path': 'installer.exe', 20:58:54 INFO - 'log_level': 'info', 20:58:54 INFO - 'log_name': 'talos', 20:58:54 INFO - 'log_to_console': True, 20:58:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:58:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:58:54 INFO - 'opt_config_files': (), 20:58:54 INFO - 'pip_index': False, 20:58:54 INFO - 'sps_profile': False, 20:58:54 INFO - 'sps_profile_interval': 0, 20:58:54 INFO - 'suite': 'dromaeojs', 20:58:54 INFO - 'system_bits': '32', 20:58:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:58:54 INFO - 'title': 'talos-linux64-ix-018', 20:58:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:58:54 INFO - 'use_talos_json': True, 20:58:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:58:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:58:54 INFO - 'work_dir': 'build'} 20:58:54 INFO - [mozharness: 2016-07-29 03:58:54.737413Z] Running clobber step. 20:58:54 INFO - Running pre-action listener: _resource_record_pre_action 20:58:54 INFO - Running main action method: clobber 20:58:54 INFO - rmtree: /builds/slave/test/build 20:58:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:58:55 INFO - Running post-action listener: _resource_record_post_action 20:58:55 INFO - [mozharness: 2016-07-29 03:58:55.207207Z] Finished clobber step (success) 20:58:55 INFO - [mozharness: 2016-07-29 03:58:55.207306Z] Running read-buildbot-config step. 20:58:55 INFO - Running pre-action listener: _resource_record_pre_action 20:58:55 INFO - Running main action method: read_buildbot_config 20:58:55 INFO - Using buildbot properties: 20:58:55 INFO - { 20:58:55 INFO - "project": "", 20:58:55 INFO - "product": "firefox", 20:58:55 INFO - "script_repo_revision": "production", 20:58:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:58:55 INFO - "repository": "", 20:58:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 20:58:55 INFO - "buildid": "20160728193028", 20:58:55 INFO - "pgo_build": "True", 20:58:55 INFO - "basedir": "/builds/slave/test", 20:58:55 INFO - "buildnumber": 811, 20:58:55 INFO - "slavename": "talos-linux64-ix-018", 20:58:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:58:55 INFO - "platform": "ubuntu64_hw", 20:58:55 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 20:58:55 INFO - "branch": "mozilla-central", 20:58:55 INFO - "repo_path": "mozilla-central", 20:58:55 INFO - "revision": "ddeb0295df692695b36295177d6790e5393e1f9a", 20:58:55 INFO - "stage_platform": "linux64-pgo", 20:58:55 INFO - "builduid": "9242f12a3fe3497389ddada42c056cc1", 20:58:55 INFO - "slavebuilddir": "test" 20:58:55 INFO - } 20:58:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:58:55 INFO - Running post-action listener: _resource_record_post_action 20:58:55 INFO - [mozharness: 2016-07-29 03:58:55.209743Z] Finished read-buildbot-config step (success) 20:58:55 INFO - [mozharness: 2016-07-29 03:58:55.209833Z] Running download-and-extract step. 20:58:55 INFO - Running pre-action listener: _resource_record_pre_action 20:58:55 INFO - Running main action method: download_and_extract 20:58:55 INFO - mkdir: /builds/slave/test/build/tests 20:58:55 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')]} 20:58:55 INFO - https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:58:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:58:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:58:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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 20:58:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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 20:58:58 INFO - Downloaded 1361 bytes. 20:58:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:58:58 INFO - Using the following test package requirements: 20:58:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:58:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:58:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:58:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:58 INFO - u'jsshell-linux-x86_64.zip'], 20:58:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:58:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:58:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:58:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:58:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:58:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:58:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:58:58 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')]} 20:58:58 INFO - https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:58:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:58:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:58:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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 20:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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 20:59:03 INFO - Downloaded 24321116 bytes. 20:59:03 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'] 20:59:03 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 20:59:04 INFO - Return code: 0 20:59:04 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 20:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:04 INFO - https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:59:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:59:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:59:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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 20:59:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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 20:59:11 INFO - Downloaded 24321116 bytes. 20:59:11 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'] 20:59:11 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 20:59:13 INFO - Return code: 0 20:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:13 INFO - https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:59:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:59:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:59:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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 20:59:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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 20:59:13 INFO - Downloaded 14413725 bytes. 20:59:13 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'] 20:59:13 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 20:59:14 INFO - Return code: 0 20:59: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')]} 20:59:14 INFO - https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:59:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:59:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:59:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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 20:59:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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 20:59:15 INFO - Downloaded 61000305 bytes. 20:59:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:59:15 INFO - mkdir: /builds/slave/test/properties 20:59:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:59:15 INFO - Writing to file /builds/slave/test/properties/build_url 20:59:15 INFO - Contents: 20:59:15 INFO - build_url:https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:59:16 INFO - Running post-action listener: _resource_record_post_action 20:59:16 INFO - Running post-action listener: set_extra_try_arguments 20:59:16 INFO - [mozharness: 2016-07-29 03:59:16.108052Z] Finished download-and-extract step (success) 20:59:16 INFO - [mozharness: 2016-07-29 03:59:16.108283Z] Running populate-webroot step. 20:59:16 INFO - Running pre-action listener: _resource_record_pre_action 20:59:16 INFO - Running main action method: populate_webroot 20:59:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:59:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:59:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:59:16 INFO - '--tppagecycles', 20:59:16 INFO - '7'], 20:59:16 INFO - 'tests': ['tsvgm']}}, 20:59:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:59:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:59:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:59:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:59:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:16 INFO - 'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:59:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:59:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:16 INFO - 'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['damp', 'tps']}, 20:59:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:16 INFO - 'tests': ['damp', 'tps']}, 20:59:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['dromaeo_dom']}, 20:59:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:59:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['basic_compositor_video']}, 20:59:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:59:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['a11yr', 20:59:16 INFO - 'ts_paint', 20:59:16 INFO - 'tpaint', 20:59:16 INFO - 'sessionrestore', 20:59:16 INFO - 'sessionrestore_no_auto_restore', 20:59:16 INFO - 'tabpaint']}, 20:59:16 INFO - 'other-e10s': {'tests': ['a11yr', 20:59:16 INFO - 'ts_paint', 20:59:16 INFO - 'tpaint', 20:59:16 INFO - 'sessionrestore', 20:59:16 INFO - 'sessionrestore_no_auto_restore', 20:59:16 INFO - 'tabpaint']}, 20:59:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:59:16 INFO - 'ts_paint', 20:59:16 INFO - 'tpaint', 20:59:16 INFO - 'sessionrestore', 20:59:16 INFO - 'sessionrestore_no_auto_restore', 20:59:16 INFO - 'tabpaint']}, 20:59:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:59:16 INFO - 'ts_paint', 20:59:16 INFO - 'tpaint', 20:59:16 INFO - 'sessionrestore', 20:59:16 INFO - 'sessionrestore_no_auto_restore', 20:59:16 INFO - 'tabpaint']}, 20:59:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['a11yr', 20:59:16 INFO - 'ts_paint', 20:59:16 INFO - 'tpaint', 20:59:16 INFO - 'sessionrestore', 20:59:16 INFO - 'sessionrestore_no_auto_restore', 20:59:16 INFO - 'tabpaint']}, 20:59:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['a11yr', 20:59:16 INFO - 'ts_paint', 20:59:16 INFO - 'tpaint', 20:59:16 INFO - 'sessionrestore', 20:59:16 INFO - 'sessionrestore_no_auto_restore', 20:59:16 INFO - 'tabpaint']}, 20:59:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['tsvgx', 20:59:16 INFO - 'tsvgr_opacity', 20:59:16 INFO - 'tart', 20:59:16 INFO - 'tscrollx', 20:59:16 INFO - 'cart']}, 20:59:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:59:16 INFO - 'tsvgr_opacity', 20:59:16 INFO - 'tart', 20:59:16 INFO - 'tscrollx', 20:59:16 INFO - 'cart']}, 20:59:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:16 INFO - 'talos_options': ['--disable-e10s'], 20:59:16 INFO - 'tests': ['tp5o']}, 20:59:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:16 INFO - 'tests': ['tp5o']}, 20:59:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:16 INFO - 'talos_options': ['--disable-e10s', 20:59:16 INFO - '--xperf_path', 20:59:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:59:16 INFO - 'tests': ['tp5n']}, 20:59:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:59:16 INFO - 'talos_options': ['--xperf_path', 20:59:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:59:16 INFO - 'tests': ['tp5n']}}, 20:59:16 INFO - 'talos.zip': {'path': '', 20:59:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:59:16 INFO - Running post-action listener: _resource_record_post_action 20:59:16 INFO - [mozharness: 2016-07-29 03:59:16.129401Z] Finished populate-webroot step (success) 20:59:16 INFO - [mozharness: 2016-07-29 03:59:16.129489Z] Running create-virtualenv step. 20:59:16 INFO - Running pre-action listener: _resource_record_pre_action 20:59:16 INFO - Running main action method: create_virtualenv 20:59:16 INFO - Creating virtualenv /builds/slave/test/build/venv 20:59:16 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 20:59:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:59:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:59:16 INFO - Using real prefix '/usr' 20:59:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:59:16 INFO - Installing distribute.............................................................................................................................................................................................done. 20:59:18 INFO - Installing pip.................done. 20:59:18 INFO - Return code: 0 20:59:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', '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 20:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:59:18 INFO - Using env: {'DISPLAY': ':0', 20:59:18 INFO - 'HOME': '/home/cltbld', 20:59:18 INFO - 'LANG': 'en_US.UTF-8', 20:59:18 INFO - 'LANGUAGE': 'en_US:en', 20:59:18 INFO - 'LOGNAME': 'cltbld', 20:59:18 INFO - 'MAIL': '/var/mail/cltbld', 20:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:18 INFO - 'MOZ_NO_REMOTE': '1', 20:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:18 INFO - 'NO_EM_RESTART': '1', 20:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:18 INFO - 'PWD': '/builds/slave/test', 20:59:18 INFO - 'SHELL': '/bin/bash', 20:59:18 INFO - 'SHLVL': '1', 20:59:18 INFO - 'TERM': 'linux', 20:59:18 INFO - 'TMOUT': '86400', 20:59:18 INFO - 'USER': 'cltbld', 20:59:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:18 INFO - '_': '/tools/buildbot/bin/python'} 20:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:18 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 20:59:18 INFO - Cleaning up... 20:59:19 INFO - Return code: 0 20:59:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:59:19 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')]} 20:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:19 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')]} 20:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:19 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 0x1a2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', '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 20:59:19 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 20:59:19 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 20:59:19 INFO - Using env: {'DISPLAY': ':0', 20:59:19 INFO - 'HOME': '/home/cltbld', 20:59:19 INFO - 'LANG': 'en_US.UTF-8', 20:59:19 INFO - 'LANGUAGE': 'en_US:en', 20:59:19 INFO - 'LOGNAME': 'cltbld', 20:59:19 INFO - 'MAIL': '/var/mail/cltbld', 20:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:19 INFO - 'MOZ_NO_REMOTE': '1', 20:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:19 INFO - 'NO_EM_RESTART': '1', 20:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:19 INFO - 'PWD': '/builds/slave/test', 20:59:19 INFO - 'SHELL': '/bin/bash', 20:59:19 INFO - 'SHLVL': '1', 20:59:19 INFO - 'TERM': 'linux', 20:59:19 INFO - 'TMOUT': '86400', 20:59:19 INFO - 'USER': 'cltbld', 20:59:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:19 INFO - '_': '/tools/buildbot/bin/python'} 20:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:19 INFO - Downloading/unpacking psutil>=3.1.1 20:59:19 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 20:59:19 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 20:59:19 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 20:59:19 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 20:59:19 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 20:59:19 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 20:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:59:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:59:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:59:21 INFO - Installing collected packages: psutil 20:59:21 INFO - Running setup.py install for psutil 20:59:21 INFO - building 'psutil._psutil_linux' extension 20:59:21 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 20:59:21 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 20:59:21 INFO - building 'psutil._psutil_posix' extension 20:59:21 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 20:59:21 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 20:59:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:59:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:59:21 INFO - Successfully installed psutil 20:59:21 INFO - Cleaning up... 20:59:21 INFO - Return code: 0 20:59:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', '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 20:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:59:21 INFO - Using env: {'DISPLAY': ':0', 20:59:21 INFO - 'HOME': '/home/cltbld', 20:59:21 INFO - 'LANG': 'en_US.UTF-8', 20:59:21 INFO - 'LANGUAGE': 'en_US:en', 20:59:21 INFO - 'LOGNAME': 'cltbld', 20:59:21 INFO - 'MAIL': '/var/mail/cltbld', 20:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:21 INFO - 'MOZ_NO_REMOTE': '1', 20:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:21 INFO - 'NO_EM_RESTART': '1', 20:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:21 INFO - 'PWD': '/builds/slave/test', 20:59:21 INFO - 'SHELL': '/bin/bash', 20:59:21 INFO - 'SHLVL': '1', 20:59:21 INFO - 'TERM': 'linux', 20:59:21 INFO - 'TMOUT': '86400', 20:59:21 INFO - 'USER': 'cltbld', 20:59:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:21 INFO - '_': '/tools/buildbot/bin/python'} 20:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:59:23 INFO - Installing collected packages: mozsystemmonitor 20:59:23 INFO - Running setup.py install for mozsystemmonitor 20:59:24 INFO - Successfully installed mozsystemmonitor 20:59:24 INFO - Cleaning up... 20:59:24 INFO - Return code: 0 20:59:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:24 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 0x1a2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', '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 20:59:24 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 20:59:24 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 20:59:24 INFO - Using env: {'DISPLAY': ':0', 20:59:24 INFO - 'HOME': '/home/cltbld', 20:59:24 INFO - 'LANG': 'en_US.UTF-8', 20:59:24 INFO - 'LANGUAGE': 'en_US:en', 20:59:24 INFO - 'LOGNAME': 'cltbld', 20:59:24 INFO - 'MAIL': '/var/mail/cltbld', 20:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:24 INFO - 'MOZ_NO_REMOTE': '1', 20:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:24 INFO - 'NO_EM_RESTART': '1', 20:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:24 INFO - 'PWD': '/builds/slave/test', 20:59:24 INFO - 'SHELL': '/bin/bash', 20:59:24 INFO - 'SHLVL': '1', 20:59:24 INFO - 'TERM': 'linux', 20:59:24 INFO - 'TMOUT': '86400', 20:59:24 INFO - 'USER': 'cltbld', 20:59:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:24 INFO - '_': '/tools/buildbot/bin/python'} 20:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:24 INFO - Downloading/unpacking jsonschema==2.5.1 20:59:24 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 20:59:24 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 20:59:24 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 20:59:24 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 20:59:24 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 20:59:24 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 20:59:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:59:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59:26 INFO - Downloading functools32-3.2.3-2.tar.gz 20:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:59:26 INFO - warning: no files found matching '*.txt' 20:59:26 INFO - no previously-included directories found matching 'build' 20:59:26 INFO - no previously-included directories found matching 'dist' 20:59:26 INFO - no previously-included directories found matching '.git*' 20:59:26 INFO - Installing collected packages: jsonschema, functools32 20:59:26 INFO - Running setup.py install for functools32 20:59:26 INFO - warning: no files found matching '*.txt' 20:59:26 INFO - no previously-included directories found matching 'build' 20:59:26 INFO - no previously-included directories found matching 'dist' 20:59:26 INFO - no previously-included directories found matching '.git*' 20:59:26 INFO - Successfully installed jsonschema functools32 20:59:26 INFO - Cleaning up... 20:59:26 INFO - Return code: 0 20:59:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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', '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 0x1a2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', '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 20:59: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:59: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 functools32==3.2.3-2 20:59:26 INFO - Using env: {'DISPLAY': ':0', 20:59:26 INFO - 'HOME': '/home/cltbld', 20:59:26 INFO - 'LANG': 'en_US.UTF-8', 20:59:26 INFO - 'LANGUAGE': 'en_US:en', 20:59:26 INFO - 'LOGNAME': 'cltbld', 20:59:26 INFO - 'MAIL': '/var/mail/cltbld', 20:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:26 INFO - 'MOZ_NO_REMOTE': '1', 20:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:26 INFO - 'NO_EM_RESTART': '1', 20:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:26 INFO - 'PWD': '/builds/slave/test', 20:59:26 INFO - 'SHELL': '/bin/bash', 20:59:26 INFO - 'SHLVL': '1', 20:59:26 INFO - 'TERM': 'linux', 20:59:26 INFO - 'TMOUT': '86400', 20:59:26 INFO - 'USER': 'cltbld', 20:59:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:26 INFO - '_': '/tools/buildbot/bin/python'} 20:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:59:26 INFO - Cleaning up... 20:59:26 INFO - Return code: 0 20:59:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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', '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 0x1a2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', '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 20:59: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:59: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 blobuploader==1.2.4 20:59:26 INFO - Using env: {'DISPLAY': ':0', 20:59:26 INFO - 'HOME': '/home/cltbld', 20:59:26 INFO - 'LANG': 'en_US.UTF-8', 20:59:26 INFO - 'LANGUAGE': 'en_US:en', 20:59:26 INFO - 'LOGNAME': 'cltbld', 20:59:26 INFO - 'MAIL': '/var/mail/cltbld', 20:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:26 INFO - 'MOZ_NO_REMOTE': '1', 20:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:26 INFO - 'NO_EM_RESTART': '1', 20:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:26 INFO - 'PWD': '/builds/slave/test', 20:59:26 INFO - 'SHELL': '/bin/bash', 20:59:26 INFO - 'SHLVL': '1', 20:59:26 INFO - 'TERM': 'linux', 20:59:26 INFO - 'TMOUT': '86400', 20:59:26 INFO - 'USER': 'cltbld', 20:59:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:26 INFO - '_': '/tools/buildbot/bin/python'} 20:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:27 INFO - Downloading/unpacking blobuploader==1.2.4 20:59:27 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 20:59:27 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 20:59:27 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 20:59:27 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 20:59:27 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 20:59:27 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 20:59:28 INFO - Downloading blobuploader-1.2.4.tar.gz 20:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:59:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:59:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:29 INFO - Downloading docopt-0.6.1.tar.gz 20:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:59:29 INFO - Installing collected packages: blobuploader, requests, docopt 20:59:29 INFO - Running setup.py install for blobuploader 20:59:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:59:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:59:29 INFO - Running setup.py install for requests 20:59:30 INFO - Running setup.py install for docopt 20:59:30 INFO - Successfully installed blobuploader requests docopt 20:59:30 INFO - Cleaning up... 20:59:30 INFO - Return code: 0 20:59:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:30 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 0x1a2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', '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 20:59:30 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 20:59:30 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 20:59:30 INFO - Using env: {'DISPLAY': ':0', 20:59:30 INFO - 'HOME': '/home/cltbld', 20:59:30 INFO - 'LANG': 'en_US.UTF-8', 20:59:30 INFO - 'LANGUAGE': 'en_US:en', 20:59:30 INFO - 'LOGNAME': 'cltbld', 20:59:30 INFO - 'MAIL': '/var/mail/cltbld', 20:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:30 INFO - 'MOZ_NO_REMOTE': '1', 20:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:30 INFO - 'NO_EM_RESTART': '1', 20:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:30 INFO - 'PWD': '/builds/slave/test', 20:59:30 INFO - 'SHELL': '/bin/bash', 20:59:30 INFO - 'SHLVL': '1', 20:59:30 INFO - 'TERM': 'linux', 20:59:30 INFO - 'TMOUT': '86400', 20:59:30 INFO - 'USER': 'cltbld', 20:59:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:30 INFO - '_': '/tools/buildbot/bin/python'} 20:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:59:30 INFO - Running setup.py (path:/tmp/pip-6Cdi5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:59:30 INFO - Running setup.py (path:/tmp/pip-XtGKoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:59:30 INFO - Running setup.py (path:/tmp/pip-XLmtpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:59:30 INFO - Running setup.py (path:/tmp/pip-u90878-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:59:30 INFO - Running setup.py (path:/tmp/pip-M0bFoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:59:30 INFO - Running setup.py (path:/tmp/pip-gKiiHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:59:30 INFO - Running setup.py (path:/tmp/pip-HKn__d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:59:31 INFO - Running setup.py (path:/tmp/pip-kHIoSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:59:31 INFO - Running setup.py (path:/tmp/pip-9zwNMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:59:31 INFO - Running setup.py (path:/tmp/pip-HqevjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:59:31 INFO - Running setup.py (path:/tmp/pip-gljvVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:59:31 INFO - Running setup.py (path:/tmp/pip-xWcF3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:59:31 INFO - Running setup.py (path:/tmp/pip-JYJNJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:59:31 INFO - Running setup.py (path:/tmp/pip-jJWEom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:31 INFO - Running setup.py (path:/tmp/pip-CftcH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:59:31 INFO - Running setup.py (path:/tmp/pip-rYGnyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:59:31 INFO - Running setup.py (path:/tmp/pip-bb4uKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:59:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:59:31 INFO - Running setup.py install for manifestparser 20:59:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:59:31 INFO - Running setup.py install for mozcrash 20:59:31 INFO - Running setup.py install for mozdebug 20:59:32 INFO - Running setup.py install for mozdevice 20:59:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:59:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:59:32 INFO - Running setup.py install for mozfile 20:59:32 INFO - Running setup.py install for mozhttpd 20:59:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:59:32 INFO - Running setup.py install for mozinfo 20:59:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:59:32 INFO - Running setup.py install for mozInstall 20:59:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:59:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:59:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:59:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:59:32 INFO - Running setup.py install for mozleak 20:59:32 INFO - Running setup.py install for mozlog 20:59:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:59:32 INFO - Running setup.py install for moznetwork 20:59:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:59:32 INFO - Running setup.py install for mozprocess 20:59:32 INFO - Running setup.py install for mozprofile 20:59:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:59:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:59:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:59:33 INFO - Running setup.py install for mozrunner 20:59:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:59:33 INFO - Running setup.py install for mozscreenshot 20:59:33 INFO - Running setup.py install for moztest 20:59:33 INFO - Running setup.py install for mozversion 20:59:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:59:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:59:33 INFO - Cleaning up... 20:59:33 INFO - Return code: 0 20:59:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:33 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 0x1a2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', '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 20:59:33 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 20:59:33 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 20:59:33 INFO - Using env: {'DISPLAY': ':0', 20:59:33 INFO - 'HOME': '/home/cltbld', 20:59:33 INFO - 'LANG': 'en_US.UTF-8', 20:59:33 INFO - 'LANGUAGE': 'en_US:en', 20:59:33 INFO - 'LOGNAME': 'cltbld', 20:59:33 INFO - 'MAIL': '/var/mail/cltbld', 20:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:33 INFO - 'MOZ_NO_REMOTE': '1', 20:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:33 INFO - 'NO_EM_RESTART': '1', 20:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:33 INFO - 'PWD': '/builds/slave/test', 20:59:33 INFO - 'SHELL': '/bin/bash', 20:59:33 INFO - 'SHLVL': '1', 20:59:33 INFO - 'TERM': 'linux', 20:59:33 INFO - 'TMOUT': '86400', 20:59:33 INFO - 'USER': 'cltbld', 20:59:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:33 INFO - '_': '/tools/buildbot/bin/python'} 20:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:59:33 INFO - Running setup.py (path:/tmp/pip-jNRSek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:59:33 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)) 20:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:59:33 INFO - Running setup.py (path:/tmp/pip-1mxJiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:59:33 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)) 20:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:59:33 INFO - Running setup.py (path:/tmp/pip-OhuvrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:59:34 INFO - Running setup.py (path:/tmp/pip-nmkZEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:59:34 INFO - Running setup.py (path:/tmp/pip-BoImai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:59:34 INFO - Running setup.py (path:/tmp/pip-iV05dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:59:34 INFO - Running setup.py (path:/tmp/pip-CSFlYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:59:34 INFO - Running setup.py (path:/tmp/pip-F7sfdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:59:34 INFO - Running setup.py (path:/tmp/pip-xHu50a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:59:34 INFO - Running setup.py (path:/tmp/pip-FVUgfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:59:34 INFO - Running setup.py (path:/tmp/pip-sXWv6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:59:34 INFO - Running setup.py (path:/tmp/pip-Vzz5SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:59:34 INFO - Running setup.py (path:/tmp/pip-OLkNw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:59:34 INFO - Running setup.py (path:/tmp/pip-tQdu4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:34 INFO - Running setup.py (path:/tmp/pip-iuorbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:34 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)) 20:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:59:34 INFO - Running setup.py (path:/tmp/pip-urGHU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:59:35 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)) 20:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:59:35 INFO - Running setup.py (path:/tmp/pip-7hrpZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:59:35 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)) 20:59:35 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)) 20:59:35 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)) 20:59:35 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)) 20:59:35 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)) 20:59:35 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)) 20:59:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:59:35 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 20:59:35 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 20:59:35 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 20:59:35 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 20:59:35 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 20:59:35 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 20:59:36 INFO - Downloading blessings-1.6.tar.gz 20:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:59:37 INFO - Installing collected packages: blessings 20:59:37 INFO - Running setup.py install for blessings 20:59:37 INFO - Successfully installed blessings 20:59:37 INFO - Cleaning up... 20:59:37 INFO - Return code: 0 20:59:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:59:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:59:37 INFO - Reading from file tmpfile_stdout 20:59:37 INFO - Current package versions: 20:59:37 INFO - argparse == 1.2.1 20:59:37 INFO - blessings == 1.6 20:59:37 INFO - blobuploader == 1.2.4 20:59:37 INFO - docopt == 0.6.1 20:59:37 INFO - functools32 == 3.2.3-2 20:59:37 INFO - jsonschema == 2.5.1 20:59:37 INFO - manifestparser == 1.1 20:59:37 INFO - mozInstall == 1.12 20:59:37 INFO - mozcrash == 0.17 20:59:37 INFO - mozdebug == 0.1 20:59:37 INFO - mozdevice == 0.48 20:59:37 INFO - mozfile == 1.2 20:59:37 INFO - mozhttpd == 0.7 20:59:37 INFO - mozinfo == 0.9 20:59:37 INFO - mozleak == 0.1 20:59:37 INFO - mozlog == 3.3 20:59:37 INFO - moznetwork == 0.27 20:59:37 INFO - mozprocess == 0.23 20:59:37 INFO - mozprofile == 0.28 20:59:37 INFO - mozrunner == 6.12 20:59:37 INFO - mozscreenshot == 0.1 20:59:37 INFO - mozsystemmonitor == 0.3 20:59:37 INFO - moztest == 0.7 20:59:37 INFO - mozversion == 1.4 20:59:37 INFO - psutil == 3.1.1 20:59:37 INFO - requests == 1.2.3 20:59:37 INFO - wsgiref == 0.1.2 20:59:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:37 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 0x1a2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', '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 20:59:37 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 20:59:37 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 20:59:37 INFO - Using env: {'DISPLAY': ':0', 20:59:37 INFO - 'HOME': '/home/cltbld', 20:59:37 INFO - 'LANG': 'en_US.UTF-8', 20:59:37 INFO - 'LANGUAGE': 'en_US:en', 20:59:37 INFO - 'LOGNAME': 'cltbld', 20:59:37 INFO - 'MAIL': '/var/mail/cltbld', 20:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:37 INFO - 'MOZ_NO_REMOTE': '1', 20:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:37 INFO - 'NO_EM_RESTART': '1', 20:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:37 INFO - 'PWD': '/builds/slave/test', 20:59:37 INFO - 'SHELL': '/bin/bash', 20:59:37 INFO - 'SHLVL': '1', 20:59:37 INFO - 'TERM': 'linux', 20:59:37 INFO - 'TMOUT': '86400', 20:59:37 INFO - 'USER': 'cltbld', 20:59:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:37 INFO - '_': '/tools/buildbot/bin/python'} 20:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:37 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)) 20:59:37 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)) 20:59:37 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)) 20:59:37 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)) 20:59:37 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)) 20:59:37 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)) 20:59:37 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)) 20:59:37 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)) 20:59:37 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)) 20:59:37 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)) 20:59:37 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)) 20:59:37 INFO - Cleaning up... 20:59:37 INFO - Return code: 0 20:59:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cee180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', '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 20:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:59:37 INFO - Using env: {'DISPLAY': ':0', 20:59:37 INFO - 'HOME': '/home/cltbld', 20:59:37 INFO - 'LANG': 'en_US.UTF-8', 20:59:37 INFO - 'LANGUAGE': 'en_US:en', 20:59:37 INFO - 'LOGNAME': 'cltbld', 20:59:37 INFO - 'MAIL': '/var/mail/cltbld', 20:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:37 INFO - 'MOZ_NO_REMOTE': '1', 20:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:37 INFO - 'NO_EM_RESTART': '1', 20:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:37 INFO - 'PWD': '/builds/slave/test', 20:59:37 INFO - 'SHELL': '/bin/bash', 20:59:37 INFO - 'SHLVL': '1', 20:59:37 INFO - 'TERM': 'linux', 20:59:37 INFO - 'TMOUT': '86400', 20:59:37 INFO - 'USER': 'cltbld', 20:59:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:37 INFO - '_': '/tools/buildbot/bin/python'} 20:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:59:37 INFO - Cleaning up... 20:59:37 INFO - Return code: 0 20:59:37 INFO - Running post-action listener: _resource_record_post_action 20:59:37 INFO - Running post-action listener: _start_resource_monitoring 20:59:37 INFO - Starting resource monitoring. 20:59:37 INFO - [mozharness: 2016-07-29 03:59:37.902734Z] Finished create-virtualenv step (success) 20:59:37 INFO - [mozharness: 2016-07-29 03:59:37.903209Z] Running install step. 20:59:37 INFO - Running pre-action listener: _resource_record_pre_action 20:59:37 INFO - Running main action method: install 20:59:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:59:38 INFO - Reading from file tmpfile_stdout 20:59:38 INFO - Detecting whether we're running mozinstall >=1.0... 20:59:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:59:38 INFO - Reading from file tmpfile_stdout 20:59:38 INFO - Output received: 20:59:38 INFO - Usage: mozinstall [options] installer 20:59:38 INFO - Options: 20:59:38 INFO - -h, --help show this help message and exit 20:59:38 INFO - -d DEST, --destination=DEST 20:59:38 INFO - Directory to install application into. [default: 20:59:38 INFO - "/builds/slave/test"] 20:59:38 INFO - --app=APP Application being installed. [default: firefox] 20:59:38 INFO - mkdir: /builds/slave/test/build/application 20:59:38 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'] 20:59:38 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 20:59:55 INFO - Reading from file tmpfile_stdout 20:59:55 INFO - Output received: 20:59:55 INFO - /builds/slave/test/build/application/firefox/firefox 20:59:55 INFO - Running post-action listener: _resource_record_post_action 20:59:55 INFO - [mozharness: 2016-07-29 03:59:55.457897Z] Finished install step (success) 20:59:55 INFO - [mozharness: 2016-07-29 03:59:55.458172Z] Running run-tests step. 20:59:55 INFO - Running pre-action listener: _resource_record_pre_action 20:59:55 INFO - Running main action method: run_tests 20:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:59:55 INFO - Python 2.7.3 20:59:55 INFO - Return code: 0 20:59:55 INFO - grabbing minidump binary from tooltool 20:59:55 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')]} 20:59:55 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 0x1cec3b0>, '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 0x1ced2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ced740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:59:55 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 20:59:55 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 20:59:55 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 20:59:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:59:55 INFO - Return code: 0 20:59:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:59:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:59:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:59:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:59:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:59:55 INFO - Using env: {'DISPLAY': ':0', 20:59:55 INFO - 'HOME': '/home/cltbld', 20:59:55 INFO - 'LANG': 'en_US.UTF-8', 20:59:55 INFO - 'LANGUAGE': 'en_US:en', 20:59:55 INFO - 'LOGNAME': 'cltbld', 20:59:55 INFO - 'MAIL': '/var/mail/cltbld', 20:59:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:59:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:55 INFO - 'MOZ_NO_REMOTE': '1', 20:59:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:55 INFO - 'NO_EM_RESTART': '1', 20:59:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:55 INFO - 'PWD': '/builds/slave/test', 20:59:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:59:55 INFO - 'SHELL': '/bin/bash', 20:59:55 INFO - 'SHLVL': '1', 20:59:55 INFO - 'TERM': 'linux', 20:59:55 INFO - 'TMOUT': '86400', 20:59:55 INFO - 'USER': 'cltbld', 20:59:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236', 20:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:55 INFO - '_': '/tools/buildbot/bin/python'} 20:59:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:59:55 INFO - mozversion application_buildid: 20160728193028 20:59:55 INFO - mozversion application_changeset: ddeb0295df692695b36295177d6790e5393e1f9a 20:59:55 INFO - mozversion application_display_name: Nightly 20:59:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:59:55 INFO - mozversion application_name: Firefox 20:59:55 INFO - mozversion application_remotingname: firefox 20:59:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:59:55 INFO - mozversion application_vendor: Mozilla 20:59:55 INFO - mozversion application_version: 50.0a1 20:59:55 INFO - mozversion platform_buildid: 20160728193028 20:59:55 INFO - mozversion platform_changeset: ddeb0295df692695b36295177d6790e5393e1f9a 20:59:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:59:55 INFO - mozversion platform_version: 50.0a1 20:59:55 INFO - using testdate: 1469764795 20:59:55 INFO - actual date: 1469764795 20:59:55 INFO - starting webserver on 'localhost:38193' 20:59:55 INFO - SUITE-START | Running 2 tests 20:59:55 INFO - TEST-START | dromaeo_css 20:59:55 INFO - operating with platform_type : linux_ 20:59:55 INFO - Initialising browser for dromaeo_css test... 20:59:55 INFO - TEST-INFO | started process 1351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK2T6j3/profile http://localhost:38193/getInfo.html) 20:59:58 INFO - PROCESS | 1351 | JavaScript error: , line 0: uncaught exception: undefined 20:59:59 INFO - PROCESS | 1351 | __metrics Screen width/height:1600/1200 20:59:59 INFO - PROCESS | 1351 | colorDepth:24 20:59:59 INFO - PROCESS | 1351 | Browser inner width/height: 1024/697 20:59:59 INFO - PROCESS | 1351 | __metrics 21:00:00 INFO - PROCESS | 1351 | 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" 21:00:00 INFO - PROCESS | 1351 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:00:00 INFO - PROCESS | 1351 | console.error: PushService: 21:00:00 INFO - PROCESS | 1351 | stateChangeProcessEnqueue: Error transitioning state 21:00:00 INFO - PROCESS | 1351 | UnknownError 21:00:01 INFO - TEST-INFO | 1351: exit 0 21:00:01 INFO - Browser initialized. 21:00:01 INFO - Running cycle 1/1 for dromaeo_css test... 21:00:01 INFO - TEST-INFO | started process 1433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK2T6j3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:00:13 INFO - PROCESS | 1433 | RSS: Main: 157290496 21:00:13 INFO - PROCESS | 1433 | 21:01:04 INFO - PROCESS | 1433 | 1469764864078 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] 21:03:12 INFO - PROCESS | 1433 | Cycle 1(1): loaded http://localhost:38193/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38193/tests/dromaeo/cssquery-ext.html) 21:03:14 INFO - PROCESS | 1433 | RSS: Main: 279900160 21:03:14 INFO - PROCESS | 1433 | 21:06:16 INFO - PROCESS | 1433 | Cycle 1(1): loaded http://localhost:38193/tests/dromaeo/cssquery-ext.html (next: http://localhost:38193/tests/dromaeo/cssquery-jquery.html) 21:06:17 INFO - PROCESS | 1433 | RSS: Main: 251596800 21:06:17 INFO - PROCESS | 1433 | 21:09:19 INFO - PROCESS | 1433 | Cycle 1(1): loaded http://localhost:38193/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38193/tests/dromaeo/cssquery-mootools.html) 21:09:19 INFO - PROCESS | 1433 | RSS: Main: 187461632 21:09:19 INFO - PROCESS | 1433 | 21:12:21 INFO - PROCESS | 1433 | Cycle 1(1): loaded http://localhost:38193/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38193/tests/dromaeo/cssquery-prototype.html) 21:12:22 INFO - PROCESS | 1433 | RSS: Main: 219844608 21:12:22 INFO - PROCESS | 1433 | 21:15:25 INFO - PROCESS | 1433 | Cycle 1(1): loaded http://localhost:38193/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38193/tests/dromaeo/cssquery-yui.html) 21:15:25 INFO - PROCESS | 1433 | RSS: Main: 187744256 21:15:25 INFO - PROCESS | 1433 | 21:18:28 INFO - PROCESS | 1433 | Cycle 1(1): loaded http://localhost:38193/tests/dromaeo/cssquery-yui.html (next: http://localhost:38193/tests/dromaeo/cssquery-dojo.html) 21:18:28 INFO - PROCESS | 1433 | RSS: Main: 254341120 21:18:28 INFO - PROCESS | 1433 | 21:18:28 INFO - PROCESS | 1433 | __start_tp_report 21:18:28 INFO - PROCESS | 1433 | _x_x_mozilla_page_load 21:18:28 INFO - PROCESS | 1433 | _x_x_mozilla_page_load_details 21:18:28 INFO - PROCESS | 1433 | |i|pagename|runs| 21:18:28 INFO - PROCESS | 1433 | |0;dojo.html;2963.659179194392;2969.7030296970297;2982.731554160126;3005.7294843464083;3016.6078409806723;4975.9004819903585;5039.748012599369;5059.215821547657;5119.795208191673;5149.1503901856195;4983.20268756998;5004.649674522785;5091.083604951107;5096.949030509694;5131.512506311894;4594.287885377764;4637.304404339342;4682.41469816273;4683.7189768613825;4828.299896515004;4760.095581839457;4787.736674482902;4794.208955522335;4807.326974223612;4811.037792441526;4581.427321584802;4608.999999999984;4636.049609829976;4645.279981602857;4678.064387122572;4593.425821772278;4599.563041511051;4611.538846115362;4686.461056978457;4708;4618.49196588375;4642.837500687494;4650.627949764011;4667.393238878958;4700.059988002413;4937.753112344369;4986.650934434555;5101.056304583664;5129.051125541787;5140.946106048288;5367.0339338918975;5447.346318441772;5449.128139497661;5450.5367043801325;5460.453954604547;5448.945510544883;5481;5494.120940649477;5496.697681627509;5496.945030549683;4939.160342741742;4986.626003049786;5035.269885866529;5115.923261151086;5126.794928202868;5514.365847927459;5526;5541.944580554224;5550;5581.274434323512;5314.362276526765;5345.652532585447;5346.4386239445075;5358.571314294847;5366.946330536723;5286.180642000496;5371.301730775052;5421.566274698014;5435.755391007414;5440.4287549807495;5415.945840541544;5418.431064738224;5424.891502170013;5448.918266225931;5462.863428414322;5420.756065977041;5430.212619170277;5434.70109143993;5436.836894893159;5494.340679118452;4092.7135100542678;4134.111166099303;4143.875683729493;4216.810243539048;4221.409002739619;3731.6828069613844;3751.9062023449633;3770.038640146745;3770.5098337215986;3772.358699021173;5025.095482813129;5068.518490743373;5073.137566613685;5075.238714192827;5076.568491678175;5383.67697938125;5434.3207099112615;5440.646357986719;5474.151506516497;5537.363203231599;5125.64120511568;5135.12702840518;5135.486451354909;5138.434772175057;5168.2764412982215;4559.908801824011;4705.811767529329;4708.387909571802;4709.788059537329;4711.316859055418;5513.724313784295;5518.696471694015;5545.390007099216;5563.833085007456;5609.49514543693;5383.946160538501;5384.865378365572;5388.622796404293;5393.191021346829;5396.21754845553;5515.834524964257;5541.806036788693;5584.4136365681015;5585.69278689676;5628.155776633538;5328;5351.357837059578;5388.407275199646;5410.3507579090765;5458.208559758892;5496.890062198654;5502.862428439321;5507;5507.03626865289;5510.338759348904;5157.587393008475;5377.865553361197;5386.8383948481605;5386.916205190162;5433.7554810034435;5276.920846187233;5309.628326017296;5342.198670199501;5364.9731751341;5411.431799661136;5331.306930099062;5334.226537152169;5334.466553344634;5335.253064570886;5343.171808369553;5204.869878252923;5411.783528658967;5432.891342173213;5468.0977638690765;5468.890622187613;5127.615428842777;5180.041692286939;5183.170692689152;5228.398734145622;5264.15773476242 21:18:28 INFO - PROCESS | 1433 | |1;ext.html;579.7043507811018;596.6211455725613;605.7001784116862;611.10778263735;625.2996643758989;30883.38233235334;31386.215344616397;44856;45970.770146149305;46135.538644613545;41508.584914150924;46395.07209855801;46420.76789616047;46466.53533464664;46502.06995860089;8925.393429182745;9089.454632722058;9092.681756138536;9098.226650734696;9105.863412048824;9060.77348066297;9140.588673509708;9149.634014639407;9153.038930912258;9153.496557689325;9150.816983660323;9186.219171370409;9201.447913125201;9209.631614735403;9213.677521286756;9124;9126.908730912672;9127.863082053775;9172.990970993218;9174.954125229398;8977.596008179647;9059.50172740499;9061.592228349675;9061.909380906238;9063.637454501812;44083.77958110221;44370.33444498335;44439.33340999888;44442.88892777674;44499.77750111229;3463.2727127303297;3493.668101530376;3525.6826885580163;3725.1059745660846;4006.258842114189;33909;33920;34231.82884085589;34595.827020864985;35782.82108589466;4395.582419670126;4498.325251212312;4505.459344878603;4609.562091601292;4647.744374059425;362241.9999999974;363450;363902;364525;364630.1768491167;61303.6934815332;61500;61521.38478615246;61671.38328616746;61834.38165618376;64804;64917.0787314572;64924.35075649183;64982.67508662521;64986.67506662436;14756.926215368854;14838.851611483962;14845.554633361016;14850.292216395037;14860.777088343684;12819.615411537483;12965.546205882938;12968.870311296767;12970.156939798882;12977.935110324388;15407.460738874086;18215.453536393663;18234.270629174684;18257.269709211483;18259;5924.4667979882015;5927.614705044159;5951.315598706117;6005.159277701126;6072.696365181723;724.9145193023983;987.8221920054316;1008.7226012846526;1088.0370871778375;1161.7502237018912;31357.686423135478;32580;32582.185445364055;32819.8513052042;33481.83259083689;806.4838503357855;1085.066842515436;1137.971550711239;1157.1552766480515;1166;15973.600659983362;16909.154542272838;16912.154392280336;16952.152392380332;17179.742303865452;543423;545592;547012;547907;548756;61126.38873611296;61196.69401652963;61539.692301538205;61661;61683.691581542706;1221.6090850927797;1251.7746805574902;1324.4966912573352;1325.1783893985792;1345.1391109689612;32395.51406728854;33015;33276;33742.01673560998;33882.49176262407;52012.73993630007;52404.73797630987;52492.95014099773;52571.474285256656;52662.736686316326;392242;395458;398280;399135;682617;27946.161615151577;27981;28119.297017574725;28236.71763282423;28294.858525708063;46115.538844611125;46311.305330419396;46663.76668116773;47148.52851471442;47726.52273477221;39712.404313934734;40288.59711402848;40981.18037639171;41001.79499102486;42369.788151059045;40044.79977600093;40257;41028;41535.7923210382;41706.79146604247;40444.797776010935;40574.79712601418;40721.59278407178;42042.57957420387;42486;35959.64040359668;38452;38710.22579548337;39295.41056884092;39380.60619393884;28411.43177136487;28628.427431450837;28630;28767;28936.276593085342 21:18:28 INFO - PROCESS | 1433 | |2;jquery.html;345.3697002969581;376.12363193758546;376.48233678691815;383.3444809375967;386.7408836079826;14286.214258215794;18441.99999999998;18579.071046447676;18768;19627;18078.728819067725;18149.63700725988;18519.81480185198;18669.159887805046;18878.43364699058;5463.644863083887;5683.602147849652;5701.629394089392;5723.2559767230205;5727.570432217601;5501.972490137564;5576.219329293902;5586.162075688639;5593.412691667378;5844.824655260349;5964.940350596504;5974.55190860685;5976.88046239075;5984.072468767326;5985.940140598582;5728.885422291552;5768.307803063638;5812.360640329561;5824.650520968756;5942.524598032169;5642.802501912454;5646.520045796112;5655.519280861132;5660.830175094754;5662;13070.607881763563;13238.404271807793;13318.600441986757;13421;13730.107543009672;2434.707835059804;2504.599264117732;2580.1743442098536;2716.2530304166316;2836.5886946392866;9752.122308992153;15212.163331016789;15212.315445804965;15924.681506369807;16206.432774852823;1953.658109830774;2043.764967028781;2059.979400205994;2078.3349328214977;2094.476380904774;55270;75003.99984000633;76621;89474.10525894788;89620;16210.83789162117;16699;17260;17276.13619319029;17537.386191483492;29650.29371328584;29784.851075744915;29821.85089074541;29834.701652983193;29870.25324366908;9542.284328675238;9568.521573921276;9689.467079310705;9703.417794932328;9737.756556086013;7949.046114466301;7977.122516523178;8018.358531317597;8391.664333426594;8470.237678608955;8345.290650294672;8713.782155446164;8764.517951512727;9059.81880362389;9086;3176.8093914365213;3279.212988882651;3442.249695420304;3533.7526373153632;3537.5401197844117;883.6288758721353;947.9952600237093;957.5978089202551;998.7503124218945;1018.1193267823279;18050.18774155166;19268;19389;19394.612107757766;19616.509587260432;926.8192702423098;978.7406337320616;979.8971108033696;993.5876611206413;1004.7538353103537;10228.6419975302;10645.84031239532;10822.945885270681;10842.783144337227;10845.51195196218;437653;438147;438626;439041;444677;85330.57334713287;86385.56807215924;86948;87403.56298218595;89133.10866891377;966.7824739433712;1021.8722659667691;1047.5704960965968;1049.5725812894457;1051.6266725312557;16852.410165644633;17302.91348543249;17948.76922154025;18094.919084305475;18358.72461913099;30786.84606576953;41065;41878;41965.370519441625;42542.78728606461;55158.44841551533;57727;60170;60877;60912.39087609067;7945.284924356835;7964.601769911365;8283.627236774239;8296.419250652396;8346.87479687793;11266.94366528162;12211.084168687561;12445;12572.685682858002;12771.169873958162;9799.804003919739;10105.44420056904;10422.114120299557;10487.26589138753;10583.470826458492;10910.399928004035;10920.126389888948;10965.83551246716;11059.958511409426;11196.104311655212;10342.276040677081;10428.634997775041;10512.842307365549;10578;10849.67450976472;7630.313271805342;7908.169642187488;7913.248241417056;7954.443188976948;8111.634976425957;9789.9021009789;10218.131458825786;10332.380057196593;10503.05472507478;10714.946425267824 21:18:28 INFO - PROCESS | 1433 | |3;mootools.html;1329.4682127149133;1436.5044059799368;1484.8218213814341;1593.5139782366382;1743.9128043597816;8326.16738326167;8629.91370086299;8657.264132548726;8832.91167088329;8877.55612219388;8784.51685157316;8824.073472285414;8831.205191532761;8852.51311177885;8871.201591856732;2293.5068960173517;2311.7457079721216;2312.063614236237;2315.3285547191376;2316.316686577455;2279.954400911989;2338.2985104468676;2345.355027367479;2349.189529612281;2350.7296660884044;2285.8514196577253;2293.2088429491882;2310.0875154314035;2311.595470792613;2320.8491448055906;2194.9122035118576;2218.279059305724;2229.754726980039;2235.9329220123423;2242.461809165805;2128.287023847013;2133.0294715904224;2133.264023911748;2137.1130980643015;2140.518383363746;8444.071152173256;8727.170918762708;8819.823603527957;8899.822003559893;8925.866112008325;4974.801007959713;5102.056119617882;5107.974460127675;5113.642045056848;5127.359080114986;3159.2575744699975;3286.622038465583;3290.851911663981;3324.1357247115684;3324.734021278292;1150.6030419505257;1152.631158029431;1154.7632735289246;1155.6764106050318;1176.529388244709;11818.17272790905;11931.642050738492;11985.161038727292;11987.460564274541;11999.820002699966;4148.398482220122;4319.287317592625;4431.578999995059;4437.667174961891;4440.711353761995;9540.427574345562;9545.331826772199;9552.95223523878;9562.61749530025;9577.090176433228;5101.821436249787;5115.693058416507;5116.488351164854;5119.436861945183;5120.692758434506;4245.61789438952;4592.10453961481;4751.667383283206;4774.355462012584;4808.687435316693;3722.9813850930573;3726.7763934164036;3854.6338097880657;3856.9421458678144;3872.419137129397;1096.8647449889327;1106.9889301107046;1114.9442527873573;1130.4517309105076;1140.1619809440222;914.131575003749;920.6455514626917;925.5418567808978;950.382251536493;957.9425234485954;5437.238786569884;5570.721463926788;5631.2397826293745;5708.20085188074;5777.768889244383;410.32296710427437;415.6425474092278;421.21443507857623;421.7090207756638;428.95067067287664;3984.561698213194;4055.614716601918;4059.715819892638;4068.3287257602756;4083.775392353449;10484;10911.727206819893;10996;10999.560017599366;11014.339139651487;10808.675739727663;10829.83755243672;10847.077998370227;10877.129829613612;11002.174836887265;7633.160352361236;8064.516129032277;8127.5123492589455;8139.064007639079;8140.104588495261;5871.4715675589405;5922.170896074639;5943.64338139713;5975.970120149372;6099.8780024398375;9482.762930926507;9643.180329672057;9844.064813842673;9883.851742224017;9904.356216845881;9943.950280248553;10086.546105425126;10141.84787228207;10156.644517441853;10234.948825255826;6787.830304242433;7335.046443962464;7434.479586428898;7539.321461068311;7571.205023472456;8646.394752367274;8687.869681954902;8693.695720649746;8700.303975681803;8729.912700873165;7296.927030729625;7499.02512673349;7530.9246907532415;7569.1295501018085;7638.923610764044;7094.396976257076;7211.278872112956;7254.310840470147;7310.81722956909;7536.208698086622;6918.93081069203;7008.684609192496;7014.088168538057;7020.403265722471;7023.508354415142;4945.67853089548;4956.306117143675;5021.899562008813;5061.443241243386;5191.896162076661;4909.533594308535;4917.704937703749;5150.381954165524;5152.793888244429;5153.587712982878 21:18:28 INFO - PROCESS | 1433 | |4;prototype.html;310.6582758965139;324.8310878343262;326.91663625775425;328.884890288399;335.1520652748544;5295.391030031543;5341.866453338668;5382.91925621116;5383.407825139231;5395.8381248562555;4958.925616115752;5064.366954130734;5113.565346945505;5114.232865070241;5284.788608455667;4032.8103209553105;4082.8979275518054;4142.337226043834;4193.769342686151;4196.559361267069;4153.356229784373;4167.603627913946;4184.811683474251;4186.4139020536995;4200.747955122687;4090;4124.824425038864;4131.111810960643;4143.212789569987;4150.377443383486;3909.530856297248;3999.120193557398;4064.654504367132;4065.6747460203114;4078.775667338295;3621.818909054563;3631.328204282216;3637.926811590587;3637.9818100909324;3640.3265395901576;5138.586888605626;5151.124308867502;5153.433122356538;5159.664621799571;5179.430262671103;4666.743329116897;4727.7163370197895;4738;4744.952550474485;4754.690945088592;5461.924468701907;5463.344398672145;5465.836024919259;5479.726013699339;5480.91778623321;4006.557639249868;4018.8995275118064;4025.892879458143;4028.2144981728575;4031.879043628696;5620.803271885506;5676.659400435946;5681.176229446748;5706.54347652191;5766.538676905838;3992.7005474589523;4004.6395824375945;4018.6584140347813;4022.2960981828064;4028.798560071985;4073.837046518165;4074.409210664437;4074.9388759168637;4075.898102547401;4077.4903137107863;4551.726896386227;4658.86023419298;4667.229907065296;4686.343911852344;4723.102610503994;5453.890922181534;5504.889902201933;5510.393856675762;5522.171674248895;5584.832455026356;1433.6200906759716;1451.397669966973;1453.4985430026625;1454.549089782171;1457.0820383158543;897.9709310692261;938.4556956965081;948.9572969216401;954.71358592422;954.7517645412242;4707.317438971399;4750.7387093709485;4765.617191404298;4794.256890182028;4805.927911081337;5003;5025.497450254945;5028.522290382408;5040.420351659533;5097.8215762448135;4657.720536767804;4810.975945120252;4814.181589129857;4848.957474143076;4849.181556916156;2683.342581067651;2690.448458066092;2696.703362630109;2709.6477457930737;2715.823471474348;5188.273641690166;5191.299174611379;5233.84855331834;5256.579473642099;5269.683818970874;4821.855344339676;5080.74596270185;5126.948730512721;5173.732435553238;5193.195054766517;5130.640855140179;5173.611979101507;5188.507091826271;5273.050850846885;5281.471852814688;5086.64393492452;5105.540501354896;5126.6923984561045;5128;5132.307138536399;4678.883027924329;4861.6596838220985;4906.975465122651;4989.725565093955;5119.539241468286;5106.029854327814;5136.871578210575;5145.92281115776;5172.301739265302;5172.379314482287;3752.7373083883867;3765.5104836371097;3789.4505296732373;3821.617838216156;3834.789086600152;5094.955534115424;5131.25596788471;5285.497877701612;5602.299712535933;5656.660600363992;5521.3926468087675;5524.944750552604;5527.115661494142;5541.722913854211;5551.306086739158;5523.558115350682;5576.944230557642;5579.107342825128;5598.300212473441;5623.662580245198;5295.814646487354;5484.945150548603;5530.944690553204;5536.7231638418725;5536.861578460571;5339.893202136013;5458.5087342139395;5498.8279629546905;5550.888982220414;5588.273524441959;5427.701476418835;5476.315460567429;5479.657483916466;5484.122540393518;5489.478499542697 21:18:28 INFO - PROCESS | 1433 | |5;yui.html;754.1063839350373;774.8605251054807;795.8408318336333;811.9228673276044;826.2109685250584;16254;16838.57903552412;16839.579010524743;16912.323507059704;16932.492025239248;14391;14392.49626263081;14429.855701442983;14438.639034024154;14438.783418248735;648.5557393185659;777.110208810914;778.5289899610739;802.8795680647892;806.1213277527494;788.7870275025768;789.2778108031144;795.1650766694976;795.6817273090752;796.6216047377508;841.8947631546057;843.4517563583689;843.4559708987699;844.1010324004915;844.8986121665408;687.0964681443885;840.1262686805715;841.5665932045001;843.4475418600827;843.4770442325766;610.700756629253;617.6633734614646;618.3260246331475;619.2909119058653;621.6145989486547;15115.39538418462;15124;15154.469593564172;15161.772573411408;15170.696586068327;13748.725025499534;14182.290885455686;14197.574072777834;14349.210793406359;14358.210298433582;12934;12993.935030324883;13186.604401867864;13251.734965300737;13260.933695331558;4385.868423947287;4421.9115617687785;4460.5316441773475;4497.8425755098415;4664.580187783082;77293.61353193199;77603;77678.61160694217;77684.22315776884;80148.59925700392;10835.729106772236;10975.780484390267;10995.505202265917;11026.117910567136;11280.605178818701;19393.127309271116;19422;19432.902835485733;19436.90281548583;19452.124654390587;8262.8347433051;8374.832503349899;8440.451370660887;8525.44584601999;8812.250958668585;4827.155247831615;4961.330220420269;4983.451820299764;5009;5079.314292570456;3148.102790704638;3219.597550306212;3228.0638614801915;3228.9677103229137;3250.3011852451837;564.7656222667629;566.4816692726109;570.1960236067125;585.1223165252122;595.5027551994046;561.4559960109698;639.9025670974208;706.5689929143218;712.1347562711227;720.9243029481934;8907.866382004275;9281.582328795086;9543.856842147234;9555.331126821195;9627.422354658604;670.269406347084;692.2108795972596;696.2828286864537;726.5822152262471;730.1931365840776;4773.162332502012;4834.371531700926;4841.903161936812;4866.6106711463;4914.262860570871;113803;113898;115504.42247788876;121702.39148804199;121780;96405;101449;102769;103341;104239;53218.201726974126;91371;91518.08481915228;91881.54059229794;95047;8869.11308869108;8985.236254918405;9084.500352480676;9336.813263734823;9353.298502612195;54276.72861635667;54479;54561.454385457226;55635.44364556303;55771.74967254231;72689;79130.6043469779;79544.60227698824;79627;80391.59804200941;11774.705632359259;12080.818787718015;12095.637130886087;12142.939285303517;12609.43257553394;13017.284049377375;13080.737038477855;13687.931560342135;13693.520726774515;13702.93148534251;12327.383630818244;12643.810342844681;12785.872141278469;13275.66810829737;13291;12486.188397754117;12582.559610413591;12647.367631618567;13052.738945220852;13112.278824664734;11934.22427542207;12424.949883269159;12439.253644781342;12791.936040320112;12844.165129266568;10390.998930823072;10513.106385956973;10531.524102256357;10536.315139515908;10615.203859710398;9246.180168709227;9475.52622368865;9910.702678919644;10459.633912813015;10510.211734120125 21:18:28 INFO - PROCESS | 1433 | __end_tp_report 21:18:28 INFO - PROCESS | 1433 | __start_cc_report 21:18:28 INFO - PROCESS | 1433 | _x_x_mozilla_cycle_collect,1074 21:18:28 INFO - PROCESS | 1433 | __end_cc_report 21:18:28 INFO - PROCESS | 1433 | __startTimestamp1469765908465__endTimestamp 21:18:28 INFO - PROCESS | 1433 | 21:18:28 INFO - PROCESS | 1433 | ------- Summary: start ------- 21:18:28 INFO - PROCESS | 1433 | Number of tests: 6 21:18:28 INFO - PROCESS | 1433 | 21:18:28 INFO - PROCESS | 1433 | [#0] dojo.html Cycles:165 Average:5059.92 Median:5276.92 stddev:558.46 (10.6%) stddev-sans-first:535.41 21:18:28 INFO - PROCESS | 1433 | Values: 2963.7 2969.7 2982.7 3005.7 3016.6 4975.9 5039.7 5059.2 5119.8 5149.2 4983.2 5004.6 5091.1 5096.9 5131.5 4594.3 4637.3 4682.4 4683.7 4828.3 4760.1 4787.7 4794.2 4807.3 4811.0 4581.4 4609.0 4636.0 4645.3 4678.1 4593.4 4599.6 4611.5 4686.5 4708.0 4618.5 4642.8 4650.6 4667.4 4700.1 4937.8 4986.7 5101.1 5129.1 5140.9 5367.0 5447.3 5449.1 5450.5 5460.5 5448.9 5481.0 5494.1 5496.7 5496.9 4939.2 4986.6 5035.3 5115.9 5126.8 5514.4 5526.0 5541.9 5550.0 5581.3 5314.4 5345.7 5346.4 5358.6 5366.9 5286.2 5371.3 5421.6 5435.8 5440.4 5415.9 5418.4 5424.9 5448.9 5462.9 5420.8 5430.2 5434.7 5436.8 5494.3 4092.7 4134.1 4143.9 4216.8 4221.4 3731.7 3751.9 3770.0 3770.5 3772.4 5025.1 5068.5 5073.1 5075.2 5076.6 5383.7 5434.3 5440.6 5474.2 5537.4 5125.6 5135.1 5135.5 5138.4 5168.3 4559.9 4705.8 4708.4 4709.8 4711.3 5513.7 5518.7 5545.4 5563.8 5609.5 5383.9 5384.9 5388.6 5393.2 5396.2 5515.8 5541.8 5584.4 5585.7 5628.2 5328.0 5351.4 5388.4 5410.4 5458.2 5496.9 5502.9 5507.0 5507.0 5510.3 5157.6 5377.9 5386.8 5386.9 5433.8 5276.9 5309.6 5342.2 5365.0 5411.4 5331.3 5334.2 5334.5 5335.3 5343.2 5204.9 5411.8 5432.9 5468.1 5468.9 5127.6 5180.0 5183.2 5228.4 5264.2 21:18:28 INFO - PROCESS | 1433 | 21:18:28 INFO - PROCESS | 1433 | [#1] ext.html Cycles:180 Average:61807.84 Median:41874.69 stddev:123686.78 (295.4%) stddev-sans-first:123948.33 21:18:28 INFO - PROCESS | 1433 | Values: 579.7 596.6 605.7 611.1 625.3 30883.4 31386.2 44856.0 45970.8 46135.5 41508.6 46395.1 46420.8 46466.5 46502.1 8925.4 9089.5 9092.7 9098.2 9105.9 9060.8 9140.6 9149.6 9153.0 9153.5 9150.8 9186.2 9201.4 9209.6 9213.7 9124.0 9126.9 9127.9 9173.0 9175.0 8977.6 9059.5 9061.6 9061.9 9063.6 44083.8 44370.3 44439.3 44442.9 44499.8 3463.3 3493.7 3525.7 3725.1 4006.3 33909.0 33920.0 34231.8 34595.8 35782.8 4395.6 4498.3 4505.5 4609.6 4647.7 362242.0 363450.0 363902.0 364525.0 364630.2 61303.7 61500.0 61521.4 61671.4 61834.4 64804.0 64917.1 64924.4 64982.7 64986.7 14756.9 14838.9 14845.6 14850.3 14860.8 12819.6 12965.5 12968.9 12970.2 12977.9 15407.5 18215.5 18234.3 18257.3 18259.0 5924.5 5927.6 5951.3 6005.2 6072.7 724.9 987.8 1008.7 1088.0 1161.8 31357.7 32580.0 32582.2 32819.9 33481.8 806.5 1085.1 1138.0 1157.2 1166.0 15973.6 16909.2 16912.2 16952.2 17179.7 543423.0 545592.0 547012.0 547907.0 548756.0 61126.4 61196.7 61539.7 61661.0 61683.7 1221.6 1251.8 1324.5 1325.2 1345.1 32395.5 33015.0 33276.0 33742.0 33882.5 52012.7 52404.7 52493.0 52571.5 52662.7 392242.0 395458.0 398280.0 399135.0 682617.0 27946.2 27981.0 28119.3 28236.7 28294.9 46115.5 46311.3 46663.8 47148.5 47726.5 39712.4 40288.6 40981.2 41001.8 42369.8 40044.8 40257.0 41028.0 41535.8 41706.8 40444.8 40574.8 40721.6 42042.6 42486.0 35959.6 38452.0 38710.2 39295.4 39380.6 28411.4 28628.4 28630.0 28767.0 28936.3 21:18:28 INFO - PROCESS | 1433 | 21:18:28 INFO - PROCESS | 1433 | [#2] jquery.html Cycles:180 Average:27728.16 Median:376.30 stddev:72573.23 (19285.8%) stddev-sans-first:72747.69 21:18:28 INFO - PROCESS | 1433 | Values: 345.4 376.1 376.5 383.3 386.7 14286.2 18442.0 18579.1 18768.0 19627.0 18078.7 18149.6 18519.8 18669.2 18878.4 5463.6 5683.6 5701.6 5723.3 5727.6 5502.0 5576.2 5586.2 5593.4 5844.8 5964.9 5974.6 5976.9 5984.1 5985.9 5728.9 5768.3 5812.4 5824.7 5942.5 5642.8 5646.5 5655.5 5660.8 5662.0 13070.6 13238.4 13318.6 13421.0 13730.1 2434.7 2504.6 2580.2 2716.3 2836.6 9752.1 15212.2 15212.3 15924.7 16206.4 1953.7 2043.8 2060.0 2078.3 2094.5 55270.0 75004.0 76621.0 89474.1 89620.0 16210.8 16699.0 17260.0 17276.1 17537.4 29650.3 29784.9 29821.9 29834.7 29870.3 9542.3 9568.5 9689.5 9703.4 9737.8 7949.0 7977.1 8018.4 8391.7 8470.2 8345.3 8713.8 8764.5 9059.8 9086.0 3176.8 3279.2 3442.2 3533.8 3537.5 883.6 948.0 957.6 998.8 1018.1 18050.2 19268.0 19389.0 19394.6 19616.5 926.8 978.7 979.9 993.6 1004.8 10228.6 10645.8 10822.9 10842.8 10845.5 437653.0 438147.0 438626.0 439041.0 444677.0 85330.6 86385.6 86948.0 87403.6 89133.1 966.8 1021.9 1047.6 1049.6 1051.6 16852.4 17302.9 17948.8 18094.9 18358.7 30786.8 41065.0 41878.0 41965.4 42542.8 55158.4 57727.0 60170.0 60877.0 60912.4 7945.3 7964.6 8283.6 8296.4 8346.9 11266.9 12211.1 12445.0 12572.7 12771.2 9799.8 10105.4 10422.1 10487.3 10583.5 10910.4 10920.1 10965.8 11060.0 11196.1 10342.3 10428.6 10512.8 10578.0 10849.7 7630.3 7908.2 7913.2 7954.4 8111.6 9789.9 10218.1 10332.4 10503.1 10714.9 21:18:28 INFO - PROCESS | 1433 | 21:18:28 INFO - PROCESS | 1433 | [#3] mootools.html Cycles:180 Average:5657.43 Median:4931.69 stddev:3265.76 (66.2%) stddev-sans-first:3258.73 21:18:28 INFO - PROCESS | 1433 | Values: 1329.5 1436.5 1484.8 1593.5 1743.9 8326.2 8629.9 8657.3 8832.9 8877.6 8784.5 8824.1 8831.2 8852.5 8871.2 2293.5 2311.7 2312.1 2315.3 2316.3 2280.0 2338.3 2345.4 2349.2 2350.7 2285.9 2293.2 2310.1 2311.6 2320.8 2194.9 2218.3 2229.8 2235.9 2242.5 2128.3 2133.0 2133.3 2137.1 2140.5 8444.1 8727.2 8819.8 8899.8 8925.9 4974.8 5102.1 5108.0 5113.6 5127.4 3159.3 3286.6 3290.9 3324.1 3324.7 1150.6 1152.6 1154.8 1155.7 1176.5 11818.2 11931.6 11985.2 11987.5 11999.8 4148.4 4319.3 4431.6 4437.7 4440.7 9540.4 9545.3 9553.0 9562.6 9577.1 5101.8 5115.7 5116.5 5119.4 5120.7 4245.6 4592.1 4751.7 4774.4 4808.7 3723.0 3726.8 3854.6 3856.9 3872.4 1096.9 1107.0 1114.9 1130.5 1140.2 914.1 920.6 925.5 950.4 957.9 5437.2 5570.7 5631.2 5708.2 5777.8 410.3 415.6 421.2 421.7 429.0 3984.6 4055.6 4059.7 4068.3 4083.8 10484.0 10911.7 10996.0 10999.6 11014.3 10808.7 10829.8 10847.1 10877.1 11002.2 7633.2 8064.5 8127.5 8139.1 8140.1 5871.5 5922.2 5943.6 5976.0 6099.9 9482.8 9643.2 9844.1 9883.9 9904.4 9944.0 10086.5 10141.8 10156.6 10234.9 6787.8 7335.0 7434.5 7539.3 7571.2 8646.4 8687.9 8693.7 8700.3 8729.9 7296.9 7499.0 7530.9 7569.1 7638.9 7094.4 7211.3 7254.3 7310.8 7536.2 6918.9 7008.7 7014.1 7020.4 7023.5 4945.7 4956.3 5021.9 5061.4 5191.9 4909.5 4917.7 5150.4 5152.8 5153.6 21:18:28 INFO - PROCESS | 1433 | 21:18:28 INFO - PROCESS | 1433 | [#4] prototype.html Cycles:180 Average:4480.23 Median:5072.56 stddev:1282.93 (25.3%) stddev-sans-first:1247.78 21:18:28 INFO - PROCESS | 1433 | Values: 310.7 324.8 326.9 328.9 335.2 5295.4 5341.9 5382.9 5383.4 5395.8 4958.9 5064.4 5113.6 5114.2 5284.8 4032.8 4082.9 4142.3 4193.8 4196.6 4153.4 4167.6 4184.8 4186.4 4200.7 4090.0 4124.8 4131.1 4143.2 4150.4 3909.5 3999.1 4064.7 4065.7 4078.8 3621.8 3631.3 3637.9 3638.0 3640.3 5138.6 5151.1 5153.4 5159.7 5179.4 4666.7 4727.7 4738.0 4745.0 4754.7 5461.9 5463.3 5465.8 5479.7 5480.9 4006.6 4018.9 4025.9 4028.2 4031.9 5620.8 5676.7 5681.2 5706.5 5766.5 3992.7 4004.6 4018.7 4022.3 4028.8 4073.8 4074.4 4074.9 4075.9 4077.5 4551.7 4658.9 4667.2 4686.3 4723.1 5453.9 5504.9 5510.4 5522.2 5584.8 1433.6 1451.4 1453.5 1454.5 1457.1 898.0 938.5 949.0 954.7 954.8 4707.3 4750.7 4765.6 4794.3 4805.9 5003.0 5025.5 5028.5 5040.4 5097.8 4657.7 4811.0 4814.2 4849.0 4849.2 2683.3 2690.4 2696.7 2709.6 2715.8 5188.3 5191.3 5233.8 5256.6 5269.7 4821.9 5080.7 5126.9 5173.7 5193.2 5130.6 5173.6 5188.5 5273.1 5281.5 5086.6 5105.5 5126.7 5128.0 5132.3 4678.9 4861.7 4907.0 4989.7 5119.5 5106.0 5136.9 5145.9 5172.3 5172.4 3752.7 3765.5 3789.5 3821.6 3834.8 5095.0 5131.3 5285.5 5602.3 5656.7 5521.4 5524.9 5527.1 5541.7 5551.3 5523.6 5576.9 5579.1 5598.3 5623.7 5295.8 5484.9 5530.9 5536.7 5536.9 5339.9 5458.5 5498.8 5550.9 5588.3 5427.7 5476.3 5479.7 5484.1 5489.5 21:18:28 INFO - PROCESS | 1433 | 21:18:28 INFO - PROCESS | 1433 | [#5] yui.html Cycles:180 Average:20949.24 Median:4890.44 stddev:30780.73 (629.4%) stddev-sans-first:30829.73 21:18:28 INFO - PROCESS | 1433 | Values: 754.1 774.9 795.8 811.9 826.2 16254.0 16838.6 16839.6 16912.3 16932.5 14391.0 14392.5 14429.9 14438.6 14438.8 648.6 777.1 778.5 802.9 806.1 788.8 789.3 795.2 795.7 796.6 841.9 843.5 843.5 844.1 844.9 687.1 840.1 841.6 843.4 843.5 610.7 617.7 618.3 619.3 621.6 15115.4 15124.0 15154.5 15161.8 15170.7 13748.7 14182.3 14197.6 14349.2 14358.2 12934.0 12993.9 13186.6 13251.7 13260.9 4385.9 4421.9 4460.5 4497.8 4664.6 77293.6 77603.0 77678.6 77684.2 80148.6 10835.7 10975.8 10995.5 11026.1 11280.6 19393.1 19422.0 19432.9 19436.9 19452.1 8262.8 8374.8 8440.5 8525.4 8812.3 4827.2 4961.3 4983.5 5009.0 5079.3 3148.1 3219.6 3228.1 3229.0 3250.3 564.8 566.5 570.2 585.1 595.5 561.5 639.9 706.6 712.1 720.9 8907.9 9281.6 9543.9 9555.3 9627.4 670.3 692.2 696.3 726.6 730.2 4773.2 4834.4 4841.9 4866.6 4914.3 113803.0 113898.0 115504.4 121702.4 121780.0 96405.0 101449.0 102769.0 103341.0 104239.0 53218.2 91371.0 91518.1 91881.5 95047.0 8869.1 8985.2 9084.5 9336.8 9353.3 54276.7 54479.0 54561.5 55635.4 55771.7 72689.0 79130.6 79544.6 79627.0 80391.6 11774.7 12080.8 12095.6 12142.9 12609.4 13017.3 13080.7 13687.9 13693.5 13702.9 12327.4 12643.8 12785.9 13275.7 13291.0 12486.2 12582.6 12647.4 13052.7 13112.3 11934.2 12424.9 12439.3 12791.9 12844.2 10391.0 10513.1 10531.5 10536.3 10615.2 9246.2 9475.5 9910.7 10459.6 10510.2 21:18:28 INFO - PROCESS | 1433 | -------- Summary: end -------- 21:18:28 INFO - PROCESS | 1433 | 21:18:29 INFO - TEST-INFO | 1433: exit 0 21:18:29 INFO - TEST-OK | dromaeo_css | took 1113445ms 21:18:29 INFO - TEST-START | kraken 21:18:29 INFO - operating with platform_type : linux_ 21:18:29 INFO - Initialising browser for kraken test... 21:18:29 INFO - TEST-INFO | started process 1626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6gom0Z/profile http://localhost:38193/getInfo.html) 21:18:32 INFO - PROCESS | 1626 | JavaScript error: , line 0: uncaught exception: undefined 21:18:32 INFO - PROCESS | 1626 | __metrics Screen width/height:1600/1200 21:18:32 INFO - PROCESS | 1626 | colorDepth:24 21:18:32 INFO - PROCESS | 1626 | Browser inner width/height: 1024/697 21:18:32 INFO - PROCESS | 1626 | __metrics 21:18:33 INFO - PROCESS | 1626 | 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" 21:18:33 INFO - PROCESS | 1626 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:18:34 INFO - TEST-INFO | 1626: exit 0 21:18:34 INFO - Browser initialized. 21:18:34 INFO - Running cycle 1/1 for kraken test... 21:18:34 INFO - TEST-INFO | started process 1705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6gom0Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:18:46 INFO - PROCESS | 1705 | RSS: Main: 157966336 21:18:46 INFO - PROCESS | 1705 | 21:18:48 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38193/tests/kraken/driver.html?testName=audio-beat-detection) 21:18:49 INFO - PROCESS | 1705 | RSS: Main: 214654976 21:18:49 INFO - PROCESS | 1705 | 21:18:52 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38193/tests/kraken/driver.html?testName=audio-dft) 21:18:52 INFO - PROCESS | 1705 | RSS: Main: 192217088 21:18:52 INFO - PROCESS | 1705 | 21:18:56 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38193/tests/kraken/driver.html?testName=audio-fft) 21:18:56 INFO - PROCESS | 1705 | RSS: Main: 272007168 21:18:56 INFO - PROCESS | 1705 | 21:18:58 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38193/tests/kraken/driver.html?testName=audio-oscillator) 21:18:59 INFO - PROCESS | 1705 | RSS: Main: 180498432 21:18:59 INFO - PROCESS | 1705 | 21:19:01 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38193/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:19:02 INFO - PROCESS | 1705 | RSS: Main: 185901056 21:19:02 INFO - PROCESS | 1705 | 21:19:05 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38193/tests/kraken/driver.html?testName=imaging-darkroom) 21:19:05 INFO - PROCESS | 1705 | RSS: Main: 220508160 21:19:05 INFO - PROCESS | 1705 | 21:19:09 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38193/tests/kraken/driver.html?testName=imaging-desaturate) 21:19:09 INFO - PROCESS | 1705 | RSS: Main: 221417472 21:19:09 INFO - PROCESS | 1705 | 21:19:12 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38193/tests/kraken/driver.html?testName=json-parse-financial) 21:19:13 INFO - PROCESS | 1705 | RSS: Main: 220790784 21:19:13 INFO - PROCESS | 1705 | 21:19:14 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38193/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:19:15 INFO - PROCESS | 1705 | RSS: Main: 185352192 21:19:15 INFO - PROCESS | 1705 | 21:19:16 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38193/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:19:17 INFO - PROCESS | 1705 | RSS: Main: 191528960 21:19:17 INFO - PROCESS | 1705 | 21:19:19 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38193/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:19:20 INFO - PROCESS | 1705 | RSS: Main: 196124672 21:19:20 INFO - PROCESS | 1705 | 21:19:22 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:19:23 INFO - PROCESS | 1705 | RSS: Main: 189296640 21:19:23 INFO - PROCESS | 1705 | 21:19:26 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:19:26 INFO - PROCESS | 1705 | RSS: Main: 194174976 21:19:26 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | Cycle 1(1): loaded http://localhost:38193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38193/tests/kraken/driver.html?testName=ai-astar) 21:19:28 INFO - PROCESS | 1705 | RSS: Main: 245403648 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | __start_tp_report 21:19:28 INFO - PROCESS | 1705 | _x_x_mozilla_page_load 21:19:28 INFO - PROCESS | 1705 | _x_x_mozilla_page_load_details 21:19:28 INFO - PROCESS | 1705 | |i|pagename|runs| 21:19:28 INFO - PROCESS | 1705 | |0;ai-astar;101;112;112;110;112;111;109;109;111;111 21:19:28 INFO - PROCESS | 1705 | |1;audio-beat-detection;144;115;118;173;118;118;145;118;154;116 21:19:28 INFO - PROCESS | 1705 | |2;audio-dft;159;159;162;158;161;159;159;160;161;160 21:19:28 INFO - PROCESS | 1705 | |3;audio-fft;75;74;74;118;75;75;74;74;97;75 21:19:28 INFO - PROCESS | 1705 | |4;audio-oscillator;84;83;116;84;85;84;121;84;84;126 21:19:28 INFO - PROCESS | 1705 | |5;imaging-gaussian-blur;117;117;118;117;116;117;117;118;117;117 21:19:28 INFO - PROCESS | 1705 | |6;imaging-darkroom;147;145;145;146;146;147;145;146;146;145 21:19:28 INFO - PROCESS | 1705 | |7;imaging-desaturate;96;95;95;95;96;95;95;96;95;95 21:19:28 INFO - PROCESS | 1705 | |8;json-parse-financial;53;52;52;51;51;52;53;50;56;51 21:19:28 INFO - PROCESS | 1705 | |9;json-stringify-tinderbox;62;62;62;62;63;62;62;63;65;62 21:19:28 INFO - PROCESS | 1705 | |10;stanford-crypto-aes;82;76;75;82;75;86;76;75;86;76 21:19:28 INFO - PROCESS | 1705 | |11;stanford-crypto-ccm;121;131;120;120;130;119;128;120;163;120 21:19:28 INFO - PROCESS | 1705 | |12;stanford-crypto-pbkdf2;170;156;160;158;163;158;161;157;157;157 21:19:28 INFO - PROCESS | 1705 | |13;stanford-crypto-sha256-iterative;66;63;65;63;63;63;62;63;64;61 21:19:28 INFO - PROCESS | 1705 | __end_tp_report 21:19:28 INFO - PROCESS | 1705 | __start_cc_report 21:19:28 INFO - PROCESS | 1705 | _x_x_mozilla_cycle_collect,1692 21:19:28 INFO - PROCESS | 1705 | __end_cc_report 21:19:28 INFO - PROCESS | 1705 | __startTimestamp1469765968623__endTimestamp 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | ------- Summary: start ------- 21:19:28 INFO - PROCESS | 1705 | Number of tests: 14 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.29 (3.0%) stddev-sans-first:1.20 21:19:28 INFO - PROCESS | 1705 | Values: 101.0 112.0 112.0 110.0 112.0 111.0 109.0 109.0 111.0 111.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:131.00 stddev:20.57 (15.7%) stddev-sans-first:21.34 21:19:28 INFO - PROCESS | 1705 | Values: 144.0 115.0 118.0 173.0 118.0 118.0 145.0 118.0 154.0 116.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 21:19:28 INFO - PROCESS | 1705 | Values: 159.0 159.0 162.0 158.0 161.0 159.0 159.0 160.0 161.0 160.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:14.78 (19.7%) stddev-sans-first:15.51 21:19:28 INFO - PROCESS | 1705 | Values: 75.0 74.0 74.0 118.0 75.0 75.0 74.0 74.0 97.0 75.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:84.00 stddev:18.03 (21.5%) stddev-sans-first:18.67 21:19:28 INFO - PROCESS | 1705 | Values: 84.0 83.0 116.0 84.0 85.0 84.0 121.0 84.0 84.0 126.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 21:19:28 INFO - PROCESS | 1705 | Values: 117.0 117.0 118.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 21:19:28 INFO - PROCESS | 1705 | Values: 147.0 145.0 145.0 146.0 146.0 147.0 145.0 146.0 146.0 145.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 21:19:28 INFO - PROCESS | 1705 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.66 (3.2%) stddev-sans-first:1.73 21:19:28 INFO - PROCESS | 1705 | Values: 53.0 52.0 52.0 51.0 51.0 52.0 53.0 50.0 56.0 51.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 21:19:28 INFO - PROCESS | 1705 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 65.0 62.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:4.61 (5.8%) stddev-sans-first:4.75 21:19:28 INFO - PROCESS | 1705 | Values: 82.0 76.0 75.0 82.0 75.0 86.0 76.0 75.0 86.0 76.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:124.50 stddev:13.41 (10.8%) stddev-sans-first:14.03 21:19:28 INFO - PROCESS | 1705 | Values: 121.0 131.0 120.0 120.0 130.0 119.0 128.0 120.0 163.0 120.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:159.00 stddev:4.22 (2.7%) stddev-sans-first:2.30 21:19:28 INFO - PROCESS | 1705 | Values: 170.0 156.0 160.0 158.0 163.0 158.0 161.0 157.0 157.0 157.0 21:19:28 INFO - PROCESS | 1705 | 21:19:28 INFO - PROCESS | 1705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.42 (2.3%) stddev-sans-first:1.12 21:19:28 INFO - PROCESS | 1705 | Values: 66.0 63.0 65.0 63.0 63.0 63.0 62.0 63.0 64.0 61.0 21:19:28 INFO - PROCESS | 1705 | -------- Summary: end -------- 21:19:28 INFO - PROCESS | 1705 | 21:19:29 INFO - TEST-INFO | 1705: exit 0 21:19:29 INFO - TEST-OK | kraken | took 60490ms 21:19:29 INFO - SUITE-END | took 1173s 21:19:29 INFO - Completed test suite (00:19:34) 21:19:29 INFO - javascript benchmark 21:19:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2963.659179194392, 2969.7030296970297, 2982.731554160126, 3005.7294843464083, 3016.6078409806723, 4975.9004819903585, 5039.748012599369, 5059.215821547657, 5119.795208191673, 5149.1503901856195, 4983.20268756998, 5004.649674522785, 5091.083604951107, 5096.949030509694, 5131.512506311894, 4594.287885377764, 4637.304404339342, 4682.41469816273, 4683.7189768613825, 4828.299896515004, 4760.095581839457, 4787.736674482902, 4794.208955522335, 4807.326974223612, 4811.037792441526, 4581.427321584802, 4608.999999999984, 4636.049609829976, 4645.279981602857, 4678.064387122572, 4593.425821772278, 4599.563041511051, 4611.538846115362, 4686.461056978457, 4708.0, 4618.49196588375, 4642.837500687494, 4650.627949764011, 4667.393238878958, 4700.059988002413, 4937.753112344369, 4986.650934434555, 5101.056304583664, 5129.051125541787, 5140.946106048288, 5367.0339338918975, 5447.346318441772, 5449.128139497661, 5450.5367043801325, 5460.453954604547, 5448.945510544883, 5481.0, 5494.120940649477, 5496.697681627509, 5496.945030549683, 4939.160342741742, 4986.626003049786, 5035.269885866529, 5115.923261151086, 5126.794928202868, 5514.365847927459, 5526.0, 5541.944580554224, 5550.0, 5581.274434323512, 5314.362276526765, 5345.652532585447, 5346.4386239445075, 5358.571314294847, 5366.946330536723, 5286.180642000496, 5371.301730775052, 5421.566274698014, 5435.755391007414, 5440.4287549807495, 5415.945840541544, 5418.431064738224, 5424.891502170013, 5448.918266225931, 5462.863428414322, 5420.756065977041, 5430.212619170277, 5434.70109143993, 5436.836894893159, 5494.340679118452, 4092.7135100542678, 4134.111166099303, 4143.875683729493, 4216.810243539048, 4221.409002739619, 3731.6828069613844, 3751.9062023449633, 3770.038640146745, 3770.5098337215986, 3772.358699021173, 5025.095482813129, 5068.518490743373, 5073.137566613685, 5075.238714192827, 5076.568491678175, 5383.67697938125, 5434.3207099112615, 5440.646357986719, 5474.151506516497, 5537.363203231599, 5125.64120511568, 5135.12702840518, 5135.486451354909, 5138.434772175057, 5168.2764412982215, 4559.908801824011, 4705.811767529329, 4708.387909571802, 4709.788059537329, 4711.316859055418, 5513.724313784295, 5518.696471694015, 5545.390007099216, 5563.833085007456, 5609.49514543693, 5383.946160538501, 5384.865378365572, 5388.622796404293, 5393.191021346829, 5396.21754845553, 5515.834524964257, 5541.806036788693, 5584.4136365681015, 5585.69278689676, 5628.155776633538, 5328.0, 5351.357837059578, 5388.407275199646, 5410.3507579090765, 5458.208559758892, 5496.890062198654, 5502.862428439321, 5507.0, 5507.03626865289, 5510.338759348904, 5157.587393008475, 5377.865553361197, 5386.8383948481605, 5386.916205190162, 5433.7554810034435, 5276.920846187233, 5309.628326017296, 5342.198670199501, 5364.9731751341, 5411.431799661136, 5331.306930099062, 5334.226537152169, 5334.466553344634, 5335.253064570886, 5343.171808369553, 5204.869878252923, 5411.783528658967, 5432.891342173213, 5468.0977638690765, 5468.890622187613, 5127.615428842777, 5180.041692286939, 5183.170692689152, 5228.398734145622, 5264.15773476242], "value": 5023.342436028781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.7043507811018, 596.6211455725613, 605.7001784116862, 611.10778263735, 625.2996643758989, 30883.38233235334, 31386.215344616397, 44856.0, 45970.770146149305, 46135.538644613545, 41508.584914150924, 46395.07209855801, 46420.76789616047, 46466.53533464664, 46502.06995860089, 8925.393429182745, 9089.454632722058, 9092.681756138536, 9098.226650734696, 9105.863412048824, 9060.77348066297, 9140.588673509708, 9149.634014639407, 9153.038930912258, 9153.496557689325, 9150.816983660323, 9186.219171370409, 9201.447913125201, 9209.631614735403, 9213.677521286756, 9124.0, 9126.908730912672, 9127.863082053775, 9172.990970993218, 9174.954125229398, 8977.596008179647, 9059.50172740499, 9061.592228349675, 9061.909380906238, 9063.637454501812, 44083.77958110221, 44370.33444498335, 44439.33340999888, 44442.88892777674, 44499.77750111229, 3463.2727127303297, 3493.668101530376, 3525.6826885580163, 3725.1059745660846, 4006.258842114189, 33909.0, 33920.0, 34231.82884085589, 34595.827020864985, 35782.82108589466, 4395.582419670126, 4498.325251212312, 4505.459344878603, 4609.562091601292, 4647.744374059425, 362241.9999999974, 363450.0, 363902.0, 364525.0, 364630.1768491167, 61303.6934815332, 61500.0, 61521.38478615246, 61671.38328616746, 61834.38165618376, 64804.0, 64917.0787314572, 64924.35075649183, 64982.67508662521, 64986.67506662436, 14756.926215368854, 14838.851611483962, 14845.554633361016, 14850.292216395037, 14860.777088343684, 12819.615411537483, 12965.546205882938, 12968.870311296767, 12970.156939798882, 12977.935110324388, 15407.460738874086, 18215.453536393663, 18234.270629174684, 18257.269709211483, 18259.0, 5924.4667979882015, 5927.614705044159, 5951.315598706117, 6005.159277701126, 6072.696365181723, 724.9145193023983, 987.8221920054316, 1008.7226012846526, 1088.0370871778375, 1161.7502237018912, 31357.686423135478, 32580.0, 32582.185445364055, 32819.8513052042, 33481.83259083689, 806.4838503357855, 1085.066842515436, 1137.971550711239, 1157.1552766480515, 1166.0, 15973.600659983362, 16909.154542272838, 16912.154392280336, 16952.152392380332, 17179.742303865452, 543423.0, 545592.0, 547012.0, 547907.0, 548756.0, 61126.38873611296, 61196.69401652963, 61539.692301538205, 61661.0, 61683.691581542706, 1221.6090850927797, 1251.7746805574902, 1324.4966912573352, 1325.1783893985792, 1345.1391109689612, 32395.51406728854, 33015.0, 33276.0, 33742.01673560998, 33882.49176262407, 52012.73993630007, 52404.73797630987, 52492.95014099773, 52571.474285256656, 52662.736686316326, 392242.0, 395458.0, 398280.0, 399135.0, 682617.0, 27946.161615151577, 27981.0, 28119.297017574725, 28236.71763282423, 28294.858525708063, 46115.538844611125, 46311.305330419396, 46663.76668116773, 47148.52851471442, 47726.52273477221, 39712.404313934734, 40288.59711402848, 40981.18037639171, 41001.79499102486, 42369.788151059045, 40044.79977600093, 40257.0, 41028.0, 41535.7923210382, 41706.79146604247, 40444.797776010935, 40574.79712601418, 40721.59278407178, 42042.57957420387, 42486.0, 35959.64040359668, 38452.0, 38710.22579548337, 39295.41056884092, 39380.60619393884, 28411.43177136487, 28628.427431450837, 28630.0, 28767.0, 28936.276593085342], "value": 20224.312811376458, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.3697002969581, 376.12363193758546, 376.48233678691815, 383.3444809375967, 386.7408836079826, 14286.214258215794, 18441.99999999998, 18579.071046447676, 18768.0, 19627.0, 18078.728819067725, 18149.63700725988, 18519.81480185198, 18669.159887805046, 18878.43364699058, 5463.644863083887, 5683.602147849652, 5701.629394089392, 5723.2559767230205, 5727.570432217601, 5501.972490137564, 5576.219329293902, 5586.162075688639, 5593.412691667378, 5844.824655260349, 5964.940350596504, 5974.55190860685, 5976.88046239075, 5984.072468767326, 5985.940140598582, 5728.885422291552, 5768.307803063638, 5812.360640329561, 5824.650520968756, 5942.524598032169, 5642.802501912454, 5646.520045796112, 5655.519280861132, 5660.830175094754, 5662.0, 13070.607881763563, 13238.404271807793, 13318.600441986757, 13421.0, 13730.107543009672, 2434.707835059804, 2504.599264117732, 2580.1743442098536, 2716.2530304166316, 2836.5886946392866, 9752.122308992153, 15212.163331016789, 15212.315445804965, 15924.681506369807, 16206.432774852823, 1953.658109830774, 2043.764967028781, 2059.979400205994, 2078.3349328214977, 2094.476380904774, 55270.0, 75003.99984000633, 76621.0, 89474.10525894788, 89620.0, 16210.83789162117, 16699.0, 17260.0, 17276.13619319029, 17537.386191483492, 29650.29371328584, 29784.851075744915, 29821.85089074541, 29834.701652983193, 29870.25324366908, 9542.284328675238, 9568.521573921276, 9689.467079310705, 9703.417794932328, 9737.756556086013, 7949.046114466301, 7977.122516523178, 8018.358531317597, 8391.664333426594, 8470.237678608955, 8345.290650294672, 8713.782155446164, 8764.517951512727, 9059.81880362389, 9086.0, 3176.8093914365213, 3279.212988882651, 3442.249695420304, 3533.7526373153632, 3537.5401197844117, 883.6288758721353, 947.9952600237093, 957.5978089202551, 998.7503124218945, 1018.1193267823279, 18050.18774155166, 19268.0, 19389.0, 19394.612107757766, 19616.509587260432, 926.8192702423098, 978.7406337320616, 979.8971108033696, 993.5876611206413, 1004.7538353103537, 10228.6419975302, 10645.84031239532, 10822.945885270681, 10842.783144337227, 10845.51195196218, 437653.0, 438147.0, 438626.0, 439041.0, 444677.0, 85330.57334713287, 86385.56807215924, 86948.0, 87403.56298218595, 89133.10866891377, 966.7824739433712, 1021.8722659667691, 1047.5704960965968, 1049.5725812894457, 1051.6266725312557, 16852.410165644633, 17302.91348543249, 17948.76922154025, 18094.919084305475, 18358.72461913099, 30786.84606576953, 41065.0, 41878.0, 41965.370519441625, 42542.78728606461, 55158.44841551533, 57727.0, 60170.0, 60877.0, 60912.39087609067, 7945.284924356835, 7964.601769911365, 8283.627236774239, 8296.419250652396, 8346.87479687793, 11266.94366528162, 12211.084168687561, 12445.0, 12572.685682858002, 12771.169873958162, 9799.804003919739, 10105.44420056904, 10422.114120299557, 10487.26589138753, 10583.470826458492, 10910.399928004035, 10920.126389888948, 10965.83551246716, 11059.958511409426, 11196.104311655212, 10342.276040677081, 10428.634997775041, 10512.842307365549, 10578.0, 10849.67450976472, 7630.313271805342, 7908.169642187488, 7913.248241417056, 7954.443188976948, 8111.634976425957, 9789.9021009789, 10218.131458825786, 10332.380057196593, 10503.05472507478, 10714.946425267824], "value": 9593.535735947142, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.4682127149133, 1436.5044059799368, 1484.8218213814341, 1593.5139782366382, 1743.9128043597816, 8326.16738326167, 8629.91370086299, 8657.264132548726, 8832.91167088329, 8877.55612219388, 8784.51685157316, 8824.073472285414, 8831.205191532761, 8852.51311177885, 8871.201591856732, 2293.5068960173517, 2311.7457079721216, 2312.063614236237, 2315.3285547191376, 2316.316686577455, 2279.954400911989, 2338.2985104468676, 2345.355027367479, 2349.189529612281, 2350.7296660884044, 2285.8514196577253, 2293.2088429491882, 2310.0875154314035, 2311.595470792613, 2320.8491448055906, 2194.9122035118576, 2218.279059305724, 2229.754726980039, 2235.9329220123423, 2242.461809165805, 2128.287023847013, 2133.0294715904224, 2133.264023911748, 2137.1130980643015, 2140.518383363746, 8444.071152173256, 8727.170918762708, 8819.823603527957, 8899.822003559893, 8925.866112008325, 4974.801007959713, 5102.056119617882, 5107.974460127675, 5113.642045056848, 5127.359080114986, 3159.2575744699975, 3286.622038465583, 3290.851911663981, 3324.1357247115684, 3324.734021278292, 1150.6030419505257, 1152.631158029431, 1154.7632735289246, 1155.6764106050318, 1176.529388244709, 11818.17272790905, 11931.642050738492, 11985.161038727292, 11987.460564274541, 11999.820002699966, 4148.398482220122, 4319.287317592625, 4431.578999995059, 4437.667174961891, 4440.711353761995, 9540.427574345562, 9545.331826772199, 9552.95223523878, 9562.61749530025, 9577.090176433228, 5101.821436249787, 5115.693058416507, 5116.488351164854, 5119.436861945183, 5120.692758434506, 4245.61789438952, 4592.10453961481, 4751.667383283206, 4774.355462012584, 4808.687435316693, 3722.9813850930573, 3726.7763934164036, 3854.6338097880657, 3856.9421458678144, 3872.419137129397, 1096.8647449889327, 1106.9889301107046, 1114.9442527873573, 1130.4517309105076, 1140.1619809440222, 914.131575003749, 920.6455514626917, 925.5418567808978, 950.382251536493, 957.9425234485954, 5437.238786569884, 5570.721463926788, 5631.2397826293745, 5708.20085188074, 5777.768889244383, 410.32296710427437, 415.6425474092278, 421.21443507857623, 421.7090207756638, 428.95067067287664, 3984.561698213194, 4055.614716601918, 4059.715819892638, 4068.3287257602756, 4083.775392353449, 10484.0, 10911.727206819893, 10996.0, 10999.560017599366, 11014.339139651487, 10808.675739727663, 10829.83755243672, 10847.077998370227, 10877.129829613612, 11002.174836887265, 7633.160352361236, 8064.516129032277, 8127.5123492589455, 8139.064007639079, 8140.104588495261, 5871.4715675589405, 5922.170896074639, 5943.64338139713, 5975.970120149372, 6099.8780024398375, 9482.762930926507, 9643.180329672057, 9844.064813842673, 9883.851742224017, 9904.356216845881, 9943.950280248553, 10086.546105425126, 10141.84787228207, 10156.644517441853, 10234.948825255826, 6787.830304242433, 7335.046443962464, 7434.479586428898, 7539.321461068311, 7571.205023472456, 8646.394752367274, 8687.869681954902, 8693.695720649746, 8700.303975681803, 8729.912700873165, 7296.927030729625, 7499.02512673349, 7530.9246907532415, 7569.1295501018085, 7638.923610764044, 7094.396976257076, 7211.278872112956, 7254.310840470147, 7310.81722956909, 7536.208698086622, 6918.93081069203, 7008.684609192496, 7014.088168538057, 7020.403265722471, 7023.508354415142, 4945.67853089548, 4956.306117143675, 5021.899562008813, 5061.443241243386, 5191.896162076661, 4909.533594308535, 4917.704937703749, 5150.381954165524, 5152.793888244429, 5153.587712982878], "value": 4425.848463008222, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.6582758965139, 324.8310878343262, 326.91663625775425, 328.884890288399, 335.1520652748544, 5295.391030031543, 5341.866453338668, 5382.91925621116, 5383.407825139231, 5395.8381248562555, 4958.925616115752, 5064.366954130734, 5113.565346945505, 5114.232865070241, 5284.788608455667, 4032.8103209553105, 4082.8979275518054, 4142.337226043834, 4193.769342686151, 4196.559361267069, 4153.356229784373, 4167.603627913946, 4184.811683474251, 4186.4139020536995, 4200.747955122687, 4090.0, 4124.824425038864, 4131.111810960643, 4143.212789569987, 4150.377443383486, 3909.530856297248, 3999.120193557398, 4064.654504367132, 4065.6747460203114, 4078.775667338295, 3621.818909054563, 3631.328204282216, 3637.926811590587, 3637.9818100909324, 3640.3265395901576, 5138.586888605626, 5151.124308867502, 5153.433122356538, 5159.664621799571, 5179.430262671103, 4666.743329116897, 4727.7163370197895, 4738.0, 4744.952550474485, 4754.690945088592, 5461.924468701907, 5463.344398672145, 5465.836024919259, 5479.726013699339, 5480.91778623321, 4006.557639249868, 4018.8995275118064, 4025.892879458143, 4028.2144981728575, 4031.879043628696, 5620.803271885506, 5676.659400435946, 5681.176229446748, 5706.54347652191, 5766.538676905838, 3992.7005474589523, 4004.6395824375945, 4018.6584140347813, 4022.2960981828064, 4028.798560071985, 4073.837046518165, 4074.409210664437, 4074.9388759168637, 4075.898102547401, 4077.4903137107863, 4551.726896386227, 4658.86023419298, 4667.229907065296, 4686.343911852344, 4723.102610503994, 5453.890922181534, 5504.889902201933, 5510.393856675762, 5522.171674248895, 5584.832455026356, 1433.6200906759716, 1451.397669966973, 1453.4985430026625, 1454.549089782171, 1457.0820383158543, 897.9709310692261, 938.4556956965081, 948.9572969216401, 954.71358592422, 954.7517645412242, 4707.317438971399, 4750.7387093709485, 4765.617191404298, 4794.256890182028, 4805.927911081337, 5003.0, 5025.497450254945, 5028.522290382408, 5040.420351659533, 5097.8215762448135, 4657.720536767804, 4810.975945120252, 4814.181589129857, 4848.957474143076, 4849.181556916156, 2683.342581067651, 2690.448458066092, 2696.703362630109, 2709.6477457930737, 2715.823471474348, 5188.273641690166, 5191.299174611379, 5233.84855331834, 5256.579473642099, 5269.683818970874, 4821.855344339676, 5080.74596270185, 5126.948730512721, 5173.732435553238, 5193.195054766517, 5130.640855140179, 5173.611979101507, 5188.507091826271, 5273.050850846885, 5281.471852814688, 5086.64393492452, 5105.540501354896, 5126.6923984561045, 5128.0, 5132.307138536399, 4678.883027924329, 4861.6596838220985, 4906.975465122651, 4989.725565093955, 5119.539241468286, 5106.029854327814, 5136.871578210575, 5145.92281115776, 5172.301739265302, 5172.379314482287, 3752.7373083883867, 3765.5104836371097, 3789.4505296732373, 3821.617838216156, 3834.789086600152, 5094.955534115424, 5131.25596788471, 5285.497877701612, 5602.299712535933, 5656.660600363992, 5521.3926468087675, 5524.944750552604, 5527.115661494142, 5541.722913854211, 5551.306086739158, 5523.558115350682, 5576.944230557642, 5579.107342825128, 5598.300212473441, 5623.662580245198, 5295.814646487354, 5484.945150548603, 5530.944690553204, 5536.7231638418725, 5536.861578460571, 5339.893202136013, 5458.5087342139395, 5498.8279629546905, 5550.888982220414, 5588.273524441959, 5427.701476418835, 5476.315460567429, 5479.657483916466, 5484.122540393518, 5489.478499542697], "value": 4076.1238192261826, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.1063839350373, 774.8605251054807, 795.8408318336333, 811.9228673276044, 826.2109685250584, 16254.0, 16838.57903552412, 16839.579010524743, 16912.323507059704, 16932.492025239248, 14391.0, 14392.49626263081, 14429.855701442983, 14438.639034024154, 14438.783418248735, 648.5557393185659, 777.110208810914, 778.5289899610739, 802.8795680647892, 806.1213277527494, 788.7870275025768, 789.2778108031144, 795.1650766694976, 795.6817273090752, 796.6216047377508, 841.8947631546057, 843.4517563583689, 843.4559708987699, 844.1010324004915, 844.8986121665408, 687.0964681443885, 840.1262686805715, 841.5665932045001, 843.4475418600827, 843.4770442325766, 610.700756629253, 617.6633734614646, 618.3260246331475, 619.2909119058653, 621.6145989486547, 15115.39538418462, 15124.0, 15154.469593564172, 15161.772573411408, 15170.696586068327, 13748.725025499534, 14182.290885455686, 14197.574072777834, 14349.210793406359, 14358.210298433582, 12934.0, 12993.935030324883, 13186.604401867864, 13251.734965300737, 13260.933695331558, 4385.868423947287, 4421.9115617687785, 4460.5316441773475, 4497.8425755098415, 4664.580187783082, 77293.61353193199, 77603.0, 77678.61160694217, 77684.22315776884, 80148.59925700392, 10835.729106772236, 10975.780484390267, 10995.505202265917, 11026.117910567136, 11280.605178818701, 19393.127309271116, 19422.0, 19432.902835485733, 19436.90281548583, 19452.124654390587, 8262.8347433051, 8374.832503349899, 8440.451370660887, 8525.44584601999, 8812.250958668585, 4827.155247831615, 4961.330220420269, 4983.451820299764, 5009.0, 5079.314292570456, 3148.102790704638, 3219.597550306212, 3228.0638614801915, 3228.9677103229137, 3250.3011852451837, 564.7656222667629, 566.4816692726109, 570.1960236067125, 585.1223165252122, 595.5027551994046, 561.4559960109698, 639.9025670974208, 706.5689929143218, 712.1347562711227, 720.9243029481934, 8907.866382004275, 9281.582328795086, 9543.856842147234, 9555.331126821195, 9627.422354658604, 670.269406347084, 692.2108795972596, 696.2828286864537, 726.5822152262471, 730.1931365840776, 4773.162332502012, 4834.371531700926, 4841.903161936812, 4866.6106711463, 4914.262860570871, 113803.0, 113898.0, 115504.42247788876, 121702.39148804199, 121780.0, 96405.0, 101449.0, 102769.0, 103341.0, 104239.0, 53218.201726974126, 91371.0, 91518.08481915228, 91881.54059229794, 95047.0, 8869.11308869108, 8985.236254918405, 9084.500352480676, 9336.813263734823, 9353.298502612195, 54276.72861635667, 54479.0, 54561.454385457226, 55635.44364556303, 55771.74967254231, 72689.0, 79130.6043469779, 79544.60227698824, 79627.0, 80391.59804200941, 11774.705632359259, 12080.818787718015, 12095.637130886087, 12142.939285303517, 12609.43257553394, 13017.284049377375, 13080.737038477855, 13687.931560342135, 13693.520726774515, 13702.93148534251, 12327.383630818244, 12643.810342844681, 12785.872141278469, 13275.66810829737, 13291.0, 12486.188397754117, 12582.559610413591, 12647.367631618567, 13052.738945220852, 13112.278824664734, 11934.22427542207, 12424.949883269159, 12439.253644781342, 12791.936040320112, 12844.165129266568, 10390.998930823072, 10513.106385956973, 10531.524102256357, 10536.315139515908, 10615.203859710398, 9246.180168709227, 9475.52622368865, 9910.702678919644, 10459.633912813015, 10510.211734120125], "value": 7442.778065854756, "unit": "score"}], "name": "dromaeo_css", "value": 7125.452629952422, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 110.0, 112.0, 111.0, 109.0, 109.0, 111.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 115.0, 118.0, 173.0, 118.0, 118.0, 145.0, 118.0, 154.0, 116.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 162.0, 158.0, 161.0, 159.0, 159.0, 160.0, 161.0, 160.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 118.0, 75.0, 75.0, 74.0, 74.0, 97.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 84.0, 85.0, 84.0, 121.0, 84.0, 84.0, 126.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 51.0, 51.0, 52.0, 53.0, 50.0, 56.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 65.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 75.0, 82.0, 75.0, 86.0, 76.0, 75.0, 86.0, 76.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 131.0, 120.0, 120.0, 130.0, 119.0, 128.0, 120.0, 163.0, 120.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 156.0, 160.0, 158.0, 163.0, 158.0, 161.0, 157.0, 157.0, 157.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 65.0, 63.0, 63.0, 63.0, 62.0, 63.0, 64.0, 61.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1479.6000000000001, "alertThreshold": 2.0}]} 21:19:29 INFO - Return code: 0 21:19:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:19:29 INFO - # TBPL SUCCESS # 21:19:29 INFO - Running post-action listener: _resource_record_post_action 21:19:29 INFO - [mozharness: 2016-07-29 04:19:29.935563Z] Finished run-tests step (success) 21:19:29 INFO - Running post-run listener: _resource_record_post_run 21:19:30 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 557346816; Read time: 0; Write time: 450952 21:19:30 INFO - TinderboxPrint: CPU usage
13.1% 21:19:30 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:19:30 INFO - TinderboxPrint: I/O write bytes / time
557,346,816 / 450,952 21:19:30 INFO - TinderboxPrint: CPU idle
8,261.6 (86.9%) 21:19:30 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 21:19:30 INFO - TinderboxPrint: Swap in / out
0 / 0 21:19:30 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257593344; Read time: 0; Write time: 255196 21:19:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 299753472; Read time: 0; Write time: 195756 21:19:30 INFO - Running post-run listener: _upload_blobber_files 21:19:30 INFO - Blob upload gear active. 21:19:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:19:30 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 21:19:30 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:19:30 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:19:30 INFO - (blobuploader) - INFO - Open directory for files ... 21:19:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:19:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:19:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:31 INFO - (blobuploader) - INFO - Done attempting. 21:19:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:19:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:32 INFO - (blobuploader) - INFO - Done attempting. 21:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:19:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:36 INFO - (blobuploader) - INFO - Done attempting. 21:19:36 INFO - (blobuploader) - INFO - Iteration through files over. 21:19:36 INFO - Return code: 0 21:19:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:19:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:19:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90609d68df742fd1a88470172afb12cb94045c8f61debfce51e3c0942d17669f0a2dceff0c8fc49bc458fa81a08b4ebeffd8907992abb08ce9a8c00e964c2ee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bffe12feb68103d78eab45ecbce691676c35c301510a92853ce7d252e767c610eca1b332f6041a1b6debe8e52b9465d442318cf0c8e1dd03964b0e12abcbdfea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bdb83b46102c57e17c1cae501e0af770c9473dd36c9cc389c61d5d315438bddfd6315b476970cbea217031c4fc9cdf8dfda568039e62bfaa5b7fe84cb7a1498"} 21:19:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:19:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:19:36 INFO - Contents: 21:19:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90609d68df742fd1a88470172afb12cb94045c8f61debfce51e3c0942d17669f0a2dceff0c8fc49bc458fa81a08b4ebeffd8907992abb08ce9a8c00e964c2ee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bffe12feb68103d78eab45ecbce691676c35c301510a92853ce7d252e767c610eca1b332f6041a1b6debe8e52b9465d442318cf0c8e1dd03964b0e12abcbdfea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bdb83b46102c57e17c1cae501e0af770c9473dd36c9cc389c61d5d315438bddfd6315b476970cbea217031c4fc9cdf8dfda568039e62bfaa5b7fe84cb7a1498"} 21:19:36 INFO - Running post-run listener: copy_logs_to_upload_dir 21:19:36 INFO - Copying logs to upload dir... 21:19:36 INFO - mkdir: /builds/slave/test/build/upload/logs 21:19:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.871499 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-28 21:19:36.279173) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 21:19:36.282814) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90609d68df742fd1a88470172afb12cb94045c8f61debfce51e3c0942d17669f0a2dceff0c8fc49bc458fa81a08b4ebeffd8907992abb08ce9a8c00e964c2ee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bffe12feb68103d78eab45ecbce691676c35c301510a92853ce7d252e767c610eca1b332f6041a1b6debe8e52b9465d442318cf0c8e1dd03964b0e12abcbdfea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bdb83b46102c57e17c1cae501e0af770c9473dd36c9cc389c61d5d315438bddfd6315b476970cbea217031c4fc9cdf8dfda568039e62bfaa5b7fe84cb7a1498"} build_url:https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/eK3jWPSKS5a2Lnesqo61Gw/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/Firefox/sha512/90609d68df742fd1a88470172afb12cb94045c8f61debfce51e3c0942d17669f0a2dceff0c8fc49bc458fa81a08b4ebeffd8907992abb08ce9a8c00e964c2ee6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bffe12feb68103d78eab45ecbce691676c35c301510a92853ce7d252e767c610eca1b332f6041a1b6debe8e52b9465d442318cf0c8e1dd03964b0e12abcbdfea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bdb83b46102c57e17c1cae501e0af770c9473dd36c9cc389c61d5d315438bddfd6315b476970cbea217031c4fc9cdf8dfda568039e62bfaa5b7fe84cb7a1498"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 21:19:36.309215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 21:19:36.309599) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1469764047.844888-1901250236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004394 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 21:19:36.393550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 21:19:36.393916) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 21:19:36.394281) ========= ========= Total master_lag: 0.17 =========