builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1469736449.15 results: success (0) buildid: 20160728103037 builduid: 1c819480ab384290816389e326b0c021 revision: 410cc90a90da1146d73bb27b3e3018a5be95db6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:29.153726) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:29.154166) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:29.154440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:29.683881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:29.684287) ========= 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=826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 13:07:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-07-28 13:07:29 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:29.821596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:29.821951) ========= 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=826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013995 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:29.871888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:29.872240) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 410cc90a90da1146d73bb27b3e3018a5be95db6a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 410cc90a90da1146d73bb27b3e3018a5be95db6a --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=826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 13:07:30,051 truncating revision to first 12 chars 2016-07-28 13:07:30,051 Setting DEBUG logging. 2016-07-28 13:07:30,051 attempt 1/10 2016-07-28 13:07:30,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/410cc90a90da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 13:07:30,376 unpacking tar archive at: mozilla-inbound-410cc90a90da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658946 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:30.546168) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:30.546647) ========= script_repo_revision: 410cc90a90da1146d73bb27b3e3018a5be95db6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:30.547233) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:30.547642) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 13:07:30.558424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-28 13:07:30.558832) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:07:30 INFO - MultiFileLogger online at 20160728 13:07:30 in /builds/slave/test 13:07:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:07:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:30 INFO - {'append_to_log': False, 13:07:30 INFO - 'base_work_dir': '/builds/slave/test', 13:07:30 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:07:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:30 INFO - 'branch': 'Mozilla-Inbound', 13:07:30 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:30 INFO - 'config_files': ('talos/linux_config.py',), 13:07:30 INFO - 'default_actions': ('clobber', 13:07:30 INFO - 'read-buildbot-config', 13:07:30 INFO - 'download-and-extract', 13:07:30 INFO - 'populate-webroot', 13:07:30 INFO - 'create-virtualenv', 13:07:30 INFO - 'install', 13:07:30 INFO - 'run-tests'), 13:07:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:30 INFO - 'download_minidump_stackwalk': True, 13:07:30 INFO - 'download_symbols': 'ondemand', 13:07:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:30 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:30 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:30 INFO - 'installer_path': 'installer.exe', 13:07:30 INFO - 'log_level': 'info', 13:07:30 INFO - 'log_name': 'talos', 13:07:30 INFO - 'log_to_console': True, 13:07:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:07:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:07:30 INFO - 'opt_config_files': (), 13:07:30 INFO - 'pip_index': False, 13:07:30 INFO - 'sps_profile': False, 13:07:30 INFO - 'sps_profile_interval': 0, 13:07:30 INFO - 'suite': 'dromaeojs', 13:07:30 INFO - 'system_bits': '32', 13:07:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:30 INFO - 'title': 'talos-linux64-ix-052', 13:07:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:30 INFO - 'use_talos_json': True, 13:07:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:30 INFO - 'work_dir': 'build'} 13:07:30 INFO - [mozharness: 2016-07-28 20:07:30.828187Z] Running clobber step. 13:07:30 INFO - Running pre-action listener: _resource_record_pre_action 13:07:30 INFO - Running main action method: clobber 13:07:30 INFO - rmtree: /builds/slave/test/build 13:07:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:31 INFO - Running post-action listener: _resource_record_post_action 13:07:31 INFO - [mozharness: 2016-07-28 20:07:31.820174Z] Finished clobber step (success) 13:07:31 INFO - [mozharness: 2016-07-28 20:07:31.820275Z] Running read-buildbot-config step. 13:07:31 INFO - Running pre-action listener: _resource_record_pre_action 13:07:31 INFO - Running main action method: read_buildbot_config 13:07:31 INFO - Using buildbot properties: 13:07:31 INFO - { 13:07:31 INFO - "project": "", 13:07:31 INFO - "product": "firefox", 13:07:31 INFO - "script_repo_revision": "production", 13:07:31 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:07:31 INFO - "repository": "", 13:07:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:07:31 INFO - "buildid": "20160728103037", 13:07:31 INFO - "pgo_build": "True", 13:07:31 INFO - "basedir": "/builds/slave/test", 13:07:31 INFO - "buildnumber": 1415, 13:07:31 INFO - "slavename": "talos-linux64-ix-052", 13:07:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:07:31 INFO - "platform": "ubuntu64_hw", 13:07:31 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:07:31 INFO - "branch": "mozilla-inbound", 13:07:31 INFO - "repo_path": "integration/mozilla-inbound", 13:07:31 INFO - "revision": "410cc90a90da1146d73bb27b3e3018a5be95db6a", 13:07:31 INFO - "stage_platform": "linux64-pgo", 13:07:31 INFO - "builduid": "1c819480ab384290816389e326b0c021", 13:07:31 INFO - "slavebuilddir": "test" 13:07:31 INFO - } 13:07:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:07:31 INFO - Running post-action listener: _resource_record_post_action 13:07:31 INFO - [mozharness: 2016-07-28 20:07:31.823235Z] Finished read-buildbot-config step (success) 13:07:31 INFO - [mozharness: 2016-07-28 20:07:31.823325Z] Running download-and-extract step. 13:07:31 INFO - Running pre-action listener: _resource_record_pre_action 13:07:31 INFO - Running main action method: download_and_extract 13:07:31 INFO - mkdir: /builds/slave/test/build/tests 13:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:31 INFO - https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:07:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:07:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:07:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:07:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:07:32 INFO - Downloaded 1361 bytes. 13:07:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:07:32 INFO - Using the following test package requirements: 13:07:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:07:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:07:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:32 INFO - u'jsshell-linux-x86_64.zip'], 13:07:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:07:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:07:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:07:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:07:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:07:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:32 INFO - https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:07:33 INFO - Downloaded 24321409 bytes. 13:07:33 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'] 13:07:33 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 13:07:35 INFO - Return code: 0 13:07:35 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 13:07:35 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')]} 13:07:35 INFO - https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:07:36 INFO - Downloaded 24321409 bytes. 13:07:36 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'] 13:07:36 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 13:07:37 INFO - Return code: 0 13:07: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')]} 13:07:37 INFO - https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:07:38 INFO - Downloaded 14413725 bytes. 13:07:38 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'] 13:07:38 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 13:07:38 INFO - Return code: 0 13:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:38 INFO - https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Axlxd560TRyvkrlTHhd5zw/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 13:07:40 INFO - Downloaded 60998942 bytes. 13:07:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:40 INFO - mkdir: /builds/slave/test/properties 13:07:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:40 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:40 INFO - Contents: 13:07:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:40 INFO - Running post-action listener: _resource_record_post_action 13:07:40 INFO - Running post-action listener: set_extra_try_arguments 13:07:40 INFO - [mozharness: 2016-07-28 20:07:40.902210Z] Finished download-and-extract step (success) 13:07:40 INFO - [mozharness: 2016-07-28 20:07:40.902444Z] Running populate-webroot step. 13:07:40 INFO - Running pre-action listener: _resource_record_pre_action 13:07:40 INFO - Running main action method: populate_webroot 13:07:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:40 INFO - '--tppagecycles', 13:07:40 INFO - '7'], 13:07:40 INFO - 'tests': ['tsvgm']}}, 13:07:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:07:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:07:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:07:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:40 INFO - 'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:40 INFO - 'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['damp', 'tps']}, 13:07:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:40 INFO - 'tests': ['damp', 'tps']}, 13:07:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['dromaeo_dom']}, 13:07:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['basic_compositor_video']}, 13:07:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:07:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['a11yr', 13:07:40 INFO - 'ts_paint', 13:07:40 INFO - 'tpaint', 13:07:40 INFO - 'sessionrestore', 13:07:40 INFO - 'sessionrestore_no_auto_restore', 13:07:40 INFO - 'tabpaint']}, 13:07:40 INFO - 'other-e10s': {'tests': ['a11yr', 13:07:40 INFO - 'ts_paint', 13:07:40 INFO - 'tpaint', 13:07:40 INFO - 'sessionrestore', 13:07:40 INFO - 'sessionrestore_no_auto_restore', 13:07:40 INFO - 'tabpaint']}, 13:07:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:07:40 INFO - 'ts_paint', 13:07:40 INFO - 'tpaint', 13:07:40 INFO - 'sessionrestore', 13:07:40 INFO - 'sessionrestore_no_auto_restore', 13:07:40 INFO - 'tabpaint']}, 13:07:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:07:40 INFO - 'ts_paint', 13:07:40 INFO - 'tpaint', 13:07:40 INFO - 'sessionrestore', 13:07:40 INFO - 'sessionrestore_no_auto_restore', 13:07:40 INFO - 'tabpaint']}, 13:07:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['a11yr', 13:07:40 INFO - 'ts_paint', 13:07:40 INFO - 'tpaint', 13:07:40 INFO - 'sessionrestore', 13:07:40 INFO - 'sessionrestore_no_auto_restore', 13:07:40 INFO - 'tabpaint']}, 13:07:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['a11yr', 13:07:40 INFO - 'ts_paint', 13:07:40 INFO - 'tpaint', 13:07:40 INFO - 'sessionrestore', 13:07:40 INFO - 'sessionrestore_no_auto_restore', 13:07:40 INFO - 'tabpaint']}, 13:07:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['tsvgx', 13:07:40 INFO - 'tsvgr_opacity', 13:07:40 INFO - 'tart', 13:07:40 INFO - 'tscrollx', 13:07:40 INFO - 'cart']}, 13:07:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:07:40 INFO - 'tsvgr_opacity', 13:07:40 INFO - 'tart', 13:07:40 INFO - 'tscrollx', 13:07:40 INFO - 'cart']}, 13:07:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:40 INFO - 'talos_options': ['--disable-e10s'], 13:07:40 INFO - 'tests': ['tp5o']}, 13:07:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:40 INFO - 'tests': ['tp5o']}, 13:07:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:40 INFO - 'talos_options': ['--disable-e10s', 13:07:40 INFO - '--xperf_path', 13:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:40 INFO - 'tests': ['tp5n']}, 13:07:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:40 INFO - 'talos_options': ['--xperf_path', 13:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:40 INFO - 'tests': ['tp5n']}}, 13:07:40 INFO - 'talos.zip': {'path': '', 13:07:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:40 INFO - Running post-action listener: _resource_record_post_action 13:07:40 INFO - [mozharness: 2016-07-28 20:07:40.922528Z] Finished populate-webroot step (success) 13:07:40 INFO - [mozharness: 2016-07-28 20:07:40.922618Z] Running create-virtualenv step. 13:07:40 INFO - Running pre-action listener: _resource_record_pre_action 13:07:40 INFO - Running main action method: create_virtualenv 13:07:40 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:40 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 13:07:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:41 INFO - Using real prefix '/usr' 13:07:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:07:43 INFO - Installing pip.................done. 13:07:43 INFO - Return code: 0 13:07:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, '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': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', '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 13:07:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:07:43 INFO - Using env: {'DISPLAY': ':0', 13:07:43 INFO - 'HOME': '/home/cltbld', 13:07:43 INFO - 'LANG': 'en_US.UTF-8', 13:07:43 INFO - 'LANGUAGE': 'en_US:en', 13:07:43 INFO - 'LOGNAME': 'cltbld', 13:07:43 INFO - 'MAIL': '/var/mail/cltbld', 13:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:43 INFO - 'MOZ_NO_REMOTE': '1', 13:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:43 INFO - 'NO_EM_RESTART': '1', 13:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:43 INFO - 'PWD': '/builds/slave/test', 13:07:43 INFO - 'SHELL': '/bin/bash', 13:07:43 INFO - 'SHLVL': '1', 13:07:43 INFO - 'TERM': 'linux', 13:07:43 INFO - 'TMOUT': '86400', 13:07:43 INFO - 'USER': 'cltbld', 13:07:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:43 INFO - '_': '/tools/buildbot/bin/python'} 13:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:43 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 13:07:43 INFO - Cleaning up... 13:07:43 INFO - Return code: 0 13:07:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, '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': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', '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 13:07:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:07:43 INFO - Using env: {'DISPLAY': ':0', 13:07:43 INFO - 'HOME': '/home/cltbld', 13:07:43 INFO - 'LANG': 'en_US.UTF-8', 13:07:43 INFO - 'LANGUAGE': 'en_US:en', 13:07:43 INFO - 'LOGNAME': 'cltbld', 13:07:43 INFO - 'MAIL': '/var/mail/cltbld', 13:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:43 INFO - 'MOZ_NO_REMOTE': '1', 13:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:43 INFO - 'NO_EM_RESTART': '1', 13:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:43 INFO - 'PWD': '/builds/slave/test', 13:07:43 INFO - 'SHELL': '/bin/bash', 13:07:43 INFO - 'SHLVL': '1', 13:07:43 INFO - 'TERM': 'linux', 13:07:43 INFO - 'TMOUT': '86400', 13:07:43 INFO - 'USER': 'cltbld', 13:07:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:43 INFO - '_': '/tools/buildbot/bin/python'} 13:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:43 INFO - Downloading/unpacking psutil>=3.1.1 13:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:45 INFO - Installing collected packages: psutil 13:07:45 INFO - Running setup.py install for psutil 13:07:46 INFO - building 'psutil._psutil_linux' extension 13:07:46 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 13:07:46 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 13:07:46 INFO - building 'psutil._psutil_posix' extension 13:07:46 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 13:07:46 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 13:07:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:46 INFO - Successfully installed psutil 13:07:46 INFO - Cleaning up... 13:07:46 INFO - Return code: 0 13:07:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:07:46 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')]} 13:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:46 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')]} 13:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:46 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 0x10c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, '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': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', '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 13:07:46 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 13:07:46 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 13:07:46 INFO - Using env: {'DISPLAY': ':0', 13:07:46 INFO - 'HOME': '/home/cltbld', 13:07:46 INFO - 'LANG': 'en_US.UTF-8', 13:07:46 INFO - 'LANGUAGE': 'en_US:en', 13:07:46 INFO - 'LOGNAME': 'cltbld', 13:07:46 INFO - 'MAIL': '/var/mail/cltbld', 13:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:46 INFO - 'MOZ_NO_REMOTE': '1', 13:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:46 INFO - 'NO_EM_RESTART': '1', 13:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:46 INFO - 'PWD': '/builds/slave/test', 13:07:46 INFO - 'SHELL': '/bin/bash', 13:07:46 INFO - 'SHLVL': '1', 13:07:46 INFO - 'TERM': 'linux', 13:07:46 INFO - 'TMOUT': '86400', 13:07:46 INFO - 'USER': 'cltbld', 13:07:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:46 INFO - '_': '/tools/buildbot/bin/python'} 13:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 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 13:07:46 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 13:07:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:07:48 INFO - Installing collected packages: mozsystemmonitor 13:07:48 INFO - Running setup.py install for mozsystemmonitor 13:07:48 INFO - Successfully installed mozsystemmonitor 13:07:48 INFO - Cleaning up... 13:07:48 INFO - Return code: 0 13:07:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, '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': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', '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 13:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:07:48 INFO - Using env: {'DISPLAY': ':0', 13:07:48 INFO - 'HOME': '/home/cltbld', 13:07:48 INFO - 'LANG': 'en_US.UTF-8', 13:07:48 INFO - 'LANGUAGE': 'en_US:en', 13:07:48 INFO - 'LOGNAME': 'cltbld', 13:07:48 INFO - 'MAIL': '/var/mail/cltbld', 13:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:48 INFO - 'MOZ_NO_REMOTE': '1', 13:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:48 INFO - 'NO_EM_RESTART': '1', 13:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:48 INFO - 'PWD': '/builds/slave/test', 13:07:48 INFO - 'SHELL': '/bin/bash', 13:07:48 INFO - 'SHLVL': '1', 13:07:48 INFO - 'TERM': 'linux', 13:07:48 INFO - 'TMOUT': '86400', 13:07:48 INFO - 'USER': 'cltbld', 13:07:48 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:48 INFO - '_': '/tools/buildbot/bin/python'} 13:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:49 INFO - Downloading/unpacking jsonschema==2.5.1 13:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:07:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:51 INFO - Downloading functools32-3.2.3-2.tar.gz 13:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:07:51 INFO - warning: no files found matching '*.txt' 13:07:51 INFO - no previously-included directories found matching 'build' 13:07:51 INFO - no previously-included directories found matching 'dist' 13:07:51 INFO - no previously-included directories found matching '.git*' 13:07:51 INFO - Installing collected packages: jsonschema, functools32 13:07:51 INFO - Running setup.py install for functools32 13:07:51 INFO - warning: no files found matching '*.txt' 13:07:51 INFO - no previously-included directories found matching 'build' 13:07:51 INFO - no previously-included directories found matching 'dist' 13:07:51 INFO - no previously-included directories found matching '.git*' 13:07:51 INFO - Successfully installed jsonschema functools32 13:07:51 INFO - Cleaning up... 13:07:51 INFO - Return code: 0 13:07:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:51 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 0x10c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, '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': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', '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 13:07:51 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 13:07:51 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 13:07:51 INFO - Using env: {'DISPLAY': ':0', 13:07:51 INFO - 'HOME': '/home/cltbld', 13:07:51 INFO - 'LANG': 'en_US.UTF-8', 13:07:51 INFO - 'LANGUAGE': 'en_US:en', 13:07:51 INFO - 'LOGNAME': 'cltbld', 13:07:51 INFO - 'MAIL': '/var/mail/cltbld', 13:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:51 INFO - 'MOZ_NO_REMOTE': '1', 13:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:51 INFO - 'NO_EM_RESTART': '1', 13:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:51 INFO - 'PWD': '/builds/slave/test', 13:07:51 INFO - 'SHELL': '/bin/bash', 13:07:51 INFO - 'SHLVL': '1', 13:07:51 INFO - 'TERM': 'linux', 13:07:51 INFO - 'TMOUT': '86400', 13:07:51 INFO - 'USER': 'cltbld', 13:07:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:51 INFO - '_': '/tools/buildbot/bin/python'} 13:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:07:51 INFO - Cleaning up... 13:07:51 INFO - Return code: 0 13:07:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:51 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 0x10c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, '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': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', '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 13:07:51 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 13:07:51 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 13:07:51 INFO - Using env: {'DISPLAY': ':0', 13:07:51 INFO - 'HOME': '/home/cltbld', 13:07:51 INFO - 'LANG': 'en_US.UTF-8', 13:07:51 INFO - 'LANGUAGE': 'en_US:en', 13:07:51 INFO - 'LOGNAME': 'cltbld', 13:07:51 INFO - 'MAIL': '/var/mail/cltbld', 13:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:51 INFO - 'MOZ_NO_REMOTE': '1', 13:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:51 INFO - 'NO_EM_RESTART': '1', 13:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:51 INFO - 'PWD': '/builds/slave/test', 13:07:51 INFO - 'SHELL': '/bin/bash', 13:07:51 INFO - 'SHLVL': '1', 13:07:51 INFO - 'TERM': 'linux', 13:07:51 INFO - 'TMOUT': '86400', 13:07:51 INFO - 'USER': 'cltbld', 13:07:51 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:51 INFO - '_': '/tools/buildbot/bin/python'} 13:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:51 INFO - Downloading/unpacking blobuploader==1.2.4 13:07:51 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 13:07:51 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 13:07:51 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 13:07:51 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 13:07:51 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 13:07:51 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 13:07:53 INFO - Downloading blobuploader-1.2.4.tar.gz 13:07:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:07:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:07:53 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 13:07:53 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 13:07:53 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 13:07:53 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 13:07:53 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 13:07:53 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 13:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:07:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:54 INFO - Downloading docopt-0.6.1.tar.gz 13:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:07:54 INFO - Installing collected packages: blobuploader, requests, docopt 13:07:54 INFO - Running setup.py install for blobuploader 13:07:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:07:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:07:54 INFO - Running setup.py install for requests 13:07:54 INFO - Running setup.py install for docopt 13:07:55 INFO - Successfully installed blobuploader requests docopt 13:07:55 INFO - Cleaning up... 13:07:55 INFO - Return code: 0 13:07:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:55 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 0x10c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, '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': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', '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 13:07:55 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 13:07:55 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 13:07:55 INFO - Using env: {'DISPLAY': ':0', 13:07:55 INFO - 'HOME': '/home/cltbld', 13:07:55 INFO - 'LANG': 'en_US.UTF-8', 13:07:55 INFO - 'LANGUAGE': 'en_US:en', 13:07:55 INFO - 'LOGNAME': 'cltbld', 13:07:55 INFO - 'MAIL': '/var/mail/cltbld', 13:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:55 INFO - 'MOZ_NO_REMOTE': '1', 13:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:55 INFO - 'NO_EM_RESTART': '1', 13:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:55 INFO - 'PWD': '/builds/slave/test', 13:07:55 INFO - 'SHELL': '/bin/bash', 13:07:55 INFO - 'SHLVL': '1', 13:07:55 INFO - 'TERM': 'linux', 13:07:55 INFO - 'TMOUT': '86400', 13:07:55 INFO - 'USER': 'cltbld', 13:07:55 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:55 INFO - '_': '/tools/buildbot/bin/python'} 13:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:55 INFO - Running setup.py (path:/tmp/pip-9Qe4mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:55 INFO - Running setup.py (path:/tmp/pip-kRUXui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:55 INFO - Running setup.py (path:/tmp/pip-OJNuU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:55 INFO - Running setup.py (path:/tmp/pip-wHXjZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:55 INFO - Running setup.py (path:/tmp/pip-W0lASJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:55 INFO - Running setup.py (path:/tmp/pip-T79tCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:55 INFO - Running setup.py (path:/tmp/pip-wwL2rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:55 INFO - Running setup.py (path:/tmp/pip-WPCdq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:55 INFO - Running setup.py (path:/tmp/pip-NHZaxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:55 INFO - Running setup.py (path:/tmp/pip-isNInK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:56 INFO - Running setup.py (path:/tmp/pip-pp3CQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:56 INFO - Running setup.py (path:/tmp/pip-1etLxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:56 INFO - Running setup.py (path:/tmp/pip-hyAyt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:56 INFO - Running setup.py (path:/tmp/pip-WwxRbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:56 INFO - Running setup.py (path:/tmp/pip-VFuBAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:56 INFO - Running setup.py (path:/tmp/pip-x5WZNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:56 INFO - Running setup.py (path:/tmp/pip-JgDRDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:07:56 INFO - Running setup.py install for manifestparser 13:07:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:07:56 INFO - Running setup.py install for mozcrash 13:07:56 INFO - Running setup.py install for mozdebug 13:07:56 INFO - Running setup.py install for mozdevice 13:07:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:07:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:07:56 INFO - Running setup.py install for mozfile 13:07:57 INFO - Running setup.py install for mozhttpd 13:07:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Running setup.py install for mozinfo 13:07:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Running setup.py install for mozInstall 13:07:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Running setup.py install for mozleak 13:07:57 INFO - Running setup.py install for mozlog 13:07:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Running setup.py install for moznetwork 13:07:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Running setup.py install for mozprocess 13:07:57 INFO - Running setup.py install for mozprofile 13:07:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Running setup.py install for mozrunner 13:07:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Running setup.py install for mozscreenshot 13:07:58 INFO - Running setup.py install for moztest 13:07:58 INFO - Running setup.py install for mozversion 13:07:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:07:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:07:58 INFO - Cleaning up... 13:07:58 INFO - Return code: 0 13:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:58 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 0x10c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, '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': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', '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 13:07:58 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 13:07:58 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 13:07:58 INFO - Using env: {'DISPLAY': ':0', 13:07:58 INFO - 'HOME': '/home/cltbld', 13:07:58 INFO - 'LANG': 'en_US.UTF-8', 13:07:58 INFO - 'LANGUAGE': 'en_US:en', 13:07:58 INFO - 'LOGNAME': 'cltbld', 13:07:58 INFO - 'MAIL': '/var/mail/cltbld', 13:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:58 INFO - 'MOZ_NO_REMOTE': '1', 13:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:58 INFO - 'NO_EM_RESTART': '1', 13:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:58 INFO - 'PWD': '/builds/slave/test', 13:07:58 INFO - 'SHELL': '/bin/bash', 13:07:58 INFO - 'SHLVL': '1', 13:07:58 INFO - 'TERM': 'linux', 13:07:58 INFO - 'TMOUT': '86400', 13:07:58 INFO - 'USER': 'cltbld', 13:07:58 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:58 INFO - '_': '/tools/buildbot/bin/python'} 13:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:58 INFO - Running setup.py (path:/tmp/pip-s3T60Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:58 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)) 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:58 INFO - Running setup.py (path:/tmp/pip-K1jgHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:58 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)) 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:58 INFO - Running setup.py (path:/tmp/pip-QJTvoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:58 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)) 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:58 INFO - Running setup.py (path:/tmp/pip-szjtLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:58 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)) 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:58 INFO - Running setup.py (path:/tmp/pip-eKdbtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:58 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)) 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:58 INFO - Running setup.py (path:/tmp/pip-bbzpdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:58 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)) 13:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:58 INFO - Running setup.py (path:/tmp/pip-IB8xZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:59 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)) 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:59 INFO - Running setup.py (path:/tmp/pip-EN1gpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:59 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)) 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:59 INFO - Running setup.py (path:/tmp/pip-jrxwud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:59 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)) 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:59 INFO - Running setup.py (path:/tmp/pip-bNvBIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:59 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)) 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:59 INFO - Running setup.py (path:/tmp/pip-lW0pD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:59 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)) 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:59 INFO - Running setup.py (path:/tmp/pip-V4LoLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:59 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)) 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:59 INFO - Running setup.py (path:/tmp/pip-6zJTES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:59 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)) 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:59 INFO - Running setup.py (path:/tmp/pip-A47Mid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:59 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)) 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:59 INFO - Running setup.py (path:/tmp/pip-hGRo66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:59 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)) 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:59 INFO - Running setup.py (path:/tmp/pip-GADuto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:59 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)) 13:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:59 INFO - Running setup.py (path:/tmp/pip-J1iwkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 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)) 13:07:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:01 INFO - Downloading blessings-1.6.tar.gz 13:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:01 INFO - Installing collected packages: blessings 13:08:01 INFO - Running setup.py install for blessings 13:08:01 INFO - Successfully installed blessings 13:08:01 INFO - Cleaning up... 13:08:01 INFO - Return code: 0 13:08:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:02 INFO - Reading from file tmpfile_stdout 13:08:02 INFO - Current package versions: 13:08:02 INFO - argparse == 1.2.1 13:08:02 INFO - blessings == 1.6 13:08:02 INFO - blobuploader == 1.2.4 13:08:02 INFO - docopt == 0.6.1 13:08:02 INFO - functools32 == 3.2.3-2 13:08:02 INFO - jsonschema == 2.5.1 13:08:02 INFO - manifestparser == 1.1 13:08:02 INFO - mozInstall == 1.12 13:08:02 INFO - mozcrash == 0.17 13:08:02 INFO - mozdebug == 0.1 13:08:02 INFO - mozdevice == 0.48 13:08:02 INFO - mozfile == 1.2 13:08:02 INFO - mozhttpd == 0.7 13:08:02 INFO - mozinfo == 0.9 13:08:02 INFO - mozleak == 0.1 13:08:02 INFO - mozlog == 3.3 13:08:02 INFO - moznetwork == 0.27 13:08:02 INFO - mozprocess == 0.23 13:08:02 INFO - mozprofile == 0.28 13:08:02 INFO - mozrunner == 6.12 13:08:02 INFO - mozscreenshot == 0.1 13:08:02 INFO - mozsystemmonitor == 0.3 13:08:02 INFO - moztest == 0.7 13:08:02 INFO - mozversion == 1.4 13:08:02 INFO - psutil == 3.1.1 13:08:02 INFO - requests == 1.2.3 13:08:02 INFO - wsgiref == 0.1.2 13:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:02 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')]} 13:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:02 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')]} 13:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:02 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 0x10c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, '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': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', '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 13:08:02 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 13:08:02 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 13:08:02 INFO - Using env: {'DISPLAY': ':0', 13:08:02 INFO - 'HOME': '/home/cltbld', 13:08:02 INFO - 'LANG': 'en_US.UTF-8', 13:08:02 INFO - 'LANGUAGE': 'en_US:en', 13:08:02 INFO - 'LOGNAME': 'cltbld', 13:08:02 INFO - 'MAIL': '/var/mail/cltbld', 13:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:02 INFO - 'MOZ_NO_REMOTE': '1', 13:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:02 INFO - 'NO_EM_RESTART': '1', 13:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:02 INFO - 'PWD': '/builds/slave/test', 13:08:02 INFO - 'SHELL': '/bin/bash', 13:08:02 INFO - 'SHLVL': '1', 13:08:02 INFO - 'TERM': 'linux', 13:08:02 INFO - 'TMOUT': '86400', 13:08:02 INFO - 'USER': 'cltbld', 13:08:02 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:02 INFO - '_': '/tools/buildbot/bin/python'} 13:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:02 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)) 13:08:02 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)) 13:08:02 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)) 13:08:02 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)) 13:08:02 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)) 13:08:02 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)) 13:08:02 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)) 13:08:02 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)) 13:08:02 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)) 13:08:02 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)) 13:08:02 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)) 13:08:02 INFO - Cleaning up... 13:08:02 INFO - Return code: 0 13:08:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08:02 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')]} 13:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:02 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')]} 13:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:02 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 0x10c9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, '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': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', '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 13:08:02 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 13:08:02 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 13:08:02 INFO - Using env: {'DISPLAY': ':0', 13:08:02 INFO - 'HOME': '/home/cltbld', 13:08:02 INFO - 'LANG': 'en_US.UTF-8', 13:08:02 INFO - 'LANGUAGE': 'en_US:en', 13:08:02 INFO - 'LOGNAME': 'cltbld', 13:08:02 INFO - 'MAIL': '/var/mail/cltbld', 13:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:02 INFO - 'MOZ_NO_REMOTE': '1', 13:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:02 INFO - 'NO_EM_RESTART': '1', 13:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:02 INFO - 'PWD': '/builds/slave/test', 13:08:02 INFO - 'SHELL': '/bin/bash', 13:08:02 INFO - 'SHLVL': '1', 13:08:02 INFO - 'TERM': 'linux', 13:08:02 INFO - 'TMOUT': '86400', 13:08:02 INFO - 'USER': 'cltbld', 13:08:02 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:02 INFO - '_': '/tools/buildbot/bin/python'} 13:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:08:02 INFO - Cleaning up... 13:08:02 INFO - Return code: 0 13:08:02 INFO - Running post-action listener: _resource_record_post_action 13:08:02 INFO - Running post-action listener: _start_resource_monitoring 13:08:02 INFO - Starting resource monitoring. 13:08:02 INFO - [mozharness: 2016-07-28 20:08:02.621083Z] Finished create-virtualenv step (success) 13:08:02 INFO - [mozharness: 2016-07-28 20:08:02.621558Z] Running install step. 13:08:02 INFO - Running pre-action listener: _resource_record_pre_action 13:08:02 INFO - Running main action method: install 13:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:02 INFO - Reading from file tmpfile_stdout 13:08:02 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:02 INFO - Reading from file tmpfile_stdout 13:08:02 INFO - Output received: 13:08:02 INFO - Usage: mozinstall [options] installer 13:08:02 INFO - Options: 13:08:02 INFO - -h, --help show this help message and exit 13:08:02 INFO - -d DEST, --destination=DEST 13:08:02 INFO - Directory to install application into. [default: 13:08:02 INFO - "/builds/slave/test"] 13:08:02 INFO - --app=APP Application being installed. [default: firefox] 13:08:02 INFO - mkdir: /builds/slave/test/build/application 13:08:02 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'] 13:08:02 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 13:08:20 INFO - Reading from file tmpfile_stdout 13:08:20 INFO - Output received: 13:08:20 INFO - /builds/slave/test/build/application/firefox/firefox 13:08:20 INFO - Running post-action listener: _resource_record_post_action 13:08:20 INFO - [mozharness: 2016-07-28 20:08:20.173925Z] Finished install step (success) 13:08:20 INFO - [mozharness: 2016-07-28 20:08:20.174199Z] Running run-tests step. 13:08:20 INFO - Running pre-action listener: _resource_record_pre_action 13:08:20 INFO - Running main action method: run_tests 13:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:20 INFO - Python 2.7.3 13:08:20 INFO - Return code: 0 13:08:20 INFO - grabbing minidump binary from tooltool 13:08:20 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')]} 13:08:20 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 0x13883b0>, '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 0x13892b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1389740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:20 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 13:08:20 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 13:08:20 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 13:08:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:20 INFO - Return code: 0 13:08:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:08:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:08:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 13:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 13:08:20 INFO - Using env: {'DISPLAY': ':0', 13:08:20 INFO - 'HOME': '/home/cltbld', 13:08:20 INFO - 'LANG': 'en_US.UTF-8', 13:08:20 INFO - 'LANGUAGE': 'en_US:en', 13:08:20 INFO - 'LOGNAME': 'cltbld', 13:08:20 INFO - 'MAIL': '/var/mail/cltbld', 13:08:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:20 INFO - 'MOZ_NO_REMOTE': '1', 13:08:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:20 INFO - 'NO_EM_RESTART': '1', 13:08:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:20 INFO - 'PWD': '/builds/slave/test', 13:08:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:20 INFO - 'SHELL': '/bin/bash', 13:08:20 INFO - 'SHLVL': '1', 13:08:20 INFO - 'TERM': 'linux', 13:08:20 INFO - 'TMOUT': '86400', 13:08:20 INFO - 'USER': 'cltbld', 13:08:20 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152', 13:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:20 INFO - '_': '/tools/buildbot/bin/python'} 13:08:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 13:08:20 INFO - mozversion application_buildid: 20160728103037 13:08:20 INFO - mozversion application_changeset: 410cc90a90da1146d73bb27b3e3018a5be95db6a 13:08:20 INFO - mozversion application_display_name: Nightly 13:08:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:20 INFO - mozversion application_name: Firefox 13:08:20 INFO - mozversion application_remotingname: firefox 13:08:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:08:20 INFO - mozversion application_vendor: Mozilla 13:08:20 INFO - mozversion application_version: 50.0a1 13:08:20 INFO - mozversion platform_buildid: 20160728103037 13:08:20 INFO - mozversion platform_changeset: 410cc90a90da1146d73bb27b3e3018a5be95db6a 13:08:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:08:20 INFO - mozversion platform_version: 50.0a1 13:08:20 INFO - using testdate: 1469736500 13:08:20 INFO - actual date: 1469736500 13:08:20 INFO - starting webserver on 'localhost:33374' 13:08:20 INFO - SUITE-START | Running 2 tests 13:08:20 INFO - TEST-START | dromaeo_css 13:08:20 INFO - operating with platform_type : linux_ 13:08:20 INFO - Initialising browser for dromaeo_css test... 13:08:20 INFO - TEST-INFO | started process 13786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqgMcZP/profile http://localhost:33374/getInfo.html) 13:08:23 INFO - PROCESS | 13786 | JavaScript error: , line 0: uncaught exception: undefined 13:08:24 INFO - PROCESS | 13786 | __metrics Screen width/height:1600/1200 13:08:24 INFO - PROCESS | 13786 | colorDepth:24 13:08:24 INFO - PROCESS | 13786 | Browser inner width/height: 1024/697 13:08:24 INFO - PROCESS | 13786 | __metrics 13:08:25 INFO - PROCESS | 13786 | 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" 13:08:25 INFO - PROCESS | 13786 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:08:26 INFO - TEST-INFO | 13786: exit 0 13:08:26 INFO - Browser initialized. 13:08:26 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:26 INFO - TEST-INFO | started process 13867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqgMcZP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:38 INFO - PROCESS | 13867 | RSS: Main: 157855744 13:08:38 INFO - PROCESS | 13867 | 13:09:28 INFO - PROCESS | 13867 | 1469736568738 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] 13:11:37 INFO - PROCESS | 13867 | Cycle 1(1): loaded http://localhost:33374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33374/tests/dromaeo/cssquery-ext.html) 13:11:38 INFO - PROCESS | 13867 | RSS: Main: 254955520 13:11:38 INFO - PROCESS | 13867 | 13:14:41 INFO - PROCESS | 13867 | Cycle 1(1): loaded http://localhost:33374/tests/dromaeo/cssquery-ext.html (next: http://localhost:33374/tests/dromaeo/cssquery-jquery.html) 13:14:41 INFO - PROCESS | 13867 | RSS: Main: 246476800 13:14:41 INFO - PROCESS | 13867 | 13:17:43 INFO - PROCESS | 13867 | Cycle 1(1): loaded http://localhost:33374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33374/tests/dromaeo/cssquery-mootools.html) 13:17:44 INFO - PROCESS | 13867 | RSS: Main: 186941440 13:17:44 INFO - PROCESS | 13867 | 13:20:46 INFO - PROCESS | 13867 | Cycle 1(1): loaded http://localhost:33374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33374/tests/dromaeo/cssquery-prototype.html) 13:20:47 INFO - PROCESS | 13867 | RSS: Main: 186155008 13:20:47 INFO - PROCESS | 13867 | 13:23:49 INFO - PROCESS | 13867 | Cycle 1(1): loaded http://localhost:33374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33374/tests/dromaeo/cssquery-yui.html) 13:23:50 INFO - PROCESS | 13867 | RSS: Main: 190021632 13:23:50 INFO - PROCESS | 13867 | 13:26:53 INFO - PROCESS | 13867 | Cycle 1(1): loaded http://localhost:33374/tests/dromaeo/cssquery-yui.html (next: http://localhost:33374/tests/dromaeo/cssquery-dojo.html) 13:26:53 INFO - PROCESS | 13867 | RSS: Main: 271147008 13:26:53 INFO - PROCESS | 13867 | 13:26:53 INFO - PROCESS | 13867 | __start_tp_report 13:26:53 INFO - PROCESS | 13867 | _x_x_mozilla_page_load 13:26:53 INFO - PROCESS | 13867 | _x_x_mozilla_page_load_details 13:26:53 INFO - PROCESS | 13867 | |i|pagename|runs| 13:26:53 INFO - PROCESS | 13867 | |0;dojo.html;2980.2549362659333;2994.401119776043;3023.9395212095747;3027.424789290035;3036.165054609982;5103.591712662987;5157.458466860982;5184.585233181346;5190.636655434121;5227.869303267425;5245.921311180336;5252.395974462938;5254.238135470355;5262.131748261532;5301.443348448405;4796.976015119937;4811.639127065458;4811.975940120295;4849.078675051746;4867.369176985716;4888.926666099994;4899.706017638935;4980.576650984653;4982.750862456881;5012.423571289294;4771.785269662873;4804.807807687688;4856.757162141914;4900.607951363882;4901.754912254409;4801.399825021872;4850.345203397532;4862.36789217403;4874.902501949941;4920.926186107211;4816.084943860656;4826.710397376169;4839.44346400165;4840.104580652591;4871;5186.870328241786;5306.071437498423;5316;5359.14253719403;5372;5566.888662226733;5596;5623.887522249532;5642.153676948449;5693.77224911003;5658.43415658435;5699.173619825144;5735.1684005818925;5741.483266505993;5748.540116790647;5116.744162791845;5299.576033917316;5333.866653333697;5336.653117547347;5340.813071542478;5744.454276843693;5764.74058667361;5803.8549036274435;5810.709464526757;5819;5539.8892022160135;5541.27963364768;5579.832605021856;5584.050711379075;5586.245856809279;5479.315085614298;5614.9719251403485;5668;5676.375598684142;5678.176664383724;5484.177373393943;5561.888762224733;5569.443055694479;5573.860653483695;5626.549876009909;5577.27495425592;5580.218769372291;5625.240592519957;5628.802991895346;5632.662040277514;4171.207470580641;4243.893902652459;4246.915061698749;4250.659947204216;4284.978575107167;3808.5429748430365;3846.3653497172654;3879.7478163919254;3905.3165696003084;3974.2647610192207;5341.813036543703;5343.251944727741;5343.3587969443915;5345.797195630952;5349.625526213128;5697.230873832063;5698.800541981093;5701.885962280814;5706.743196556165;5746.42535746422;5167.354080739908;5248.291480650139;5327.440618735054;5327.760250788646;5398.865028374244;4867.58625516835;4886.291487734258;4886.95113048865;4895.118878601815;4943.678660887031;5921.67430791302;5939.287285525678;5941.049432090845;5941.970290148608;5943.405659434108;5489.64317319373;5636.4927156556105;5688.886222275614;5709.22925405065;5785.508231800344;5880.617759845596;5934.673592952429;5938.792142275172;5947.959107156144;5953.255843019622;5572.777088916398;5590.273264475592;5594.468525490072;5612.354579223442;5612.382637909745;5537.8061767837935;5598.944010559842;5614.943850561605;5661.122526008476;5734.3692193857805;5513.448655134454;5542.528885044655;5542.889142217214;5544.750486228048;5544.861378465571;5536;5540.91688624679;5541.639793413416;5544.556435485071;5595.160725890986;5310.840674779763;5383.461653834585;5404.216388623706;5425.511703946664;5511.035568775528;5515.531179849758;5523.7790488380015;5566.387697353369;5570.944290557042;5580.162975553537;5418.485243901823;5426.403095659395;5427.402985671494;5428;5433.619646624698 13:26:53 INFO - PROCESS | 13867 | |1;ext.html;577.5091172503372;601.170384868881;607.4623957797351;611.458858909865;621.2079598511893;42482.99999999996;43594.20463748989;43646.781766091124;43798.78100609496;45573;45457.77271113648;45942.54057459424;45969.7701511492;46012.53987460124;46073.539264607345;8074.596270186496;8697.391182617219;8851.645934162625;8856;10384.325018873787;10395.584176632963;10700.518476668529;10711.571537138505;10719.517621707002;10722.249442539025;10825.83761243582;10864.728381790479;10867.402292873929;10875.782484350308;10878.72803179919;10781.137508999262;10813.729656758565;10813.83779243316;10832.187585931008;10834.891651083468;10652.147828173727;10712.678619641423;10715.46422678863;10722.892771072346;10726;42298.365524517154;42675.35986960198;42721.35917961233;42807.785961069996;42812;3681.4661874028384;4027.496562929634;4136.91726165478;4265.594768496988;4271.060366719316;32637.836810816032;32710;32854.342913141845;33760.32479350399;34339.31321373583;4204;4216.241076606209;4222.345536441856;4255.893602659928;4256.59562341577;234555;235278;235854;236806;237939;57686;58126.12810807841;58266.7086664564;58267.417325827046;58293;35268.64731352705;35936.82031589825;36035.099122522144;60113.69943150344;60137;14239.359228834728;14599.489017884323;14610.634734131732;14641.34113964874;14652.853471465362;10093.19254459656;10534.36793792375;11297.26567773092;11480.196386253048;11585.246958947642;19142.808571914382;19157;19213;19271.325503607306;19458.8054119457;6964.616946068015;7159.520633826395;7199.424046076301;7253.3834624057545;7333.779986600411;959.8752162218867;978.7178795777554;1067.9092277156374;1106.7399161197113;1110.8444817725524;33231.833840830644;36219.818900905855;36414;36671.449928251095;36772.44841327382;1054.1988089052222;1075.983860242097;1102.7684186320803;1120.4229821641861;1140.766142940695;16501.58746031359;17169.31322747076;17211.397601083903;17353.529294141223;17399.217035233443;574643;575636;578158;579690;580835;56897.715511422175;57299.14051289234;57436.42563574311;57527.1370929428;57569.84860302854;1242.7949388351;1266.3731452930674;1343.6976680246867;1344.9865501345057;1395.699924516234;30456.736056952486;33764.15589610279;33860;33903.32193356168;33984.490232646036;49833.75083124561;50531.2420313703;50650.746746266035;50652;50683;428981;433391;433694;434079;436145;27736.72263277422;27818.721812781612;28714.71285287204;28751.8562407195;29453.410931781673;48480.27279590738;49079;49356.75321623369;49527.50472495373;51047;41062;42048.369274460296;42345.78827105968;42564.5743542573;43857.56142438662;42003.7899810499;42308;42654.36018459788;43884.78057609691;44119;41197;41588.79205603953;41869.278496897605;42739.358909617;42851.357229642206;35118;38309;38484.42273365846;38609.80695096507;39341.2131757369;28680.282992925342;28736.706848192298;29128.7087129126;29139.562906556843;29303.853480733313 13:26:53 INFO - PROCESS | 13867 | |2;jquery.html;365.6069725045577;374.7526632422601;386.4010783285908;390.7011136480593;399.6443165582632;17030;18932.432027039176;19021.904890475562;19170.424887253386;19969.500762480908;19178.424647260603;19257;19868.205271789113;19952.9002354988;20170.69743953842;5759.136129580555;5793.855153621151;5873.588848780587;5961.970190149043;5963.254593175853;5690.715464226772;5772.653640781546;5813.563982701315;5814.592978491507;5817.389174136718;5728.054870946289;5778.855528611776;5785.479306862381;5788.6816225107605;5819.7963071292515;5712.600117991721;5809.912851307234;5846.7076646167525;5847.44449277318;5854.765809367642;4888.804447822083;5157.767900444489;5173.870653233662;5248.9737551312;5251.369835619712;13497.392617332243;13624.523141689993;16957.406490772886;23211;23363.53272934532;2267.1724820440586;2312.895919683618;2363.078399424226;2364.456175079741;2406.3719696894377;9895.752606184831;10020.549075291628;10028.147607453375;12074.335911524862;13385.598432046956;1743.2678275124479;1748.3880641775404;1827.3238901606492;1883;1909.484439201408;76146;77224.22775772227;84841;89503;89794;10603.94698026505;10857.294275872044;11003.61487347939;11034.779304413867;11184.840743993098;15704.60738481547;15716.371345146295;15720.606984825243;15733.921330393276;15748.370065197263;8015.078265999368;8114.3102836258395;8129.349652027823;8282.792930176794;8307.252347288773;7663.31030207284;7703.229677032252;7771.4559980800805;7896.289333959971;7942.285194332538;4603.4839325485445;4647.465541462708;4680.1107789520565;4859.125357435625;4898.804047838046;1976.150255390196;1978.3768113044346;2025.8222410908334;2038.7961203879493;2058.4545095549693;886.5567216391804;895.0601868038664;908.9683209557201;948.3551185194134;950.353759443585;18927.81072189288;19498.902505487382;19918.30285939985;19931.60136797256;20119.698204526943;439.7625282347561;982.3271059324386;990.5988074829705;1020.2348238820884;1087;6034.63792172471;6127.816165515042;6298.370162983665;6396.232452105777;6524;301741;302214;377227;387796;451205;65634.34365656378;87146.56426717826;100767.49616251871;102834;106389;446.1144627913589;457.29804749709035;457.50589363487353;458.72476514091943;458.7752001519232;10347.84478232812;10942.17933654963;11132.777344452903;11155.553777848796;11253;42084.36873446839;42323.57676423196;42694.359584605634;43252.78373608112;44166.33750493681;62132.68933655303;62280.68859655673;62557.68721156365;62764;64129;8402;8405.705800297204;8445.493270403795;8516.531590762319;8731.039585645702;9373.484458354857;11218.66344009681;11319;12249.632511024683;13207.339633018119;11375.886241137814;11686.415679216176;11787.764244715228;11862;12221.327826969602;11099.667009989713;11746.711837385345;11807.173497855068;11887.82168267494;12254.080943929419;11606.30362178272;11846.407679616157;11925.344106073902;12046.277223366626;12531;8242.505449673039;8252.876206857021;8355;8364.916350836414;8649.091845356146;10828.566857325619;11396.772064558829;11876.643700688994;12150;12494.12541122149 13:26:53 INFO - PROCESS | 13867 | |3;mootools.html;1459.1755658053203;1520.7110648976695;1627.5686942960117;1746.4236801855388;1784.4468214853405;8333.958330208348;8816.074312197223;8817.030126686059;8825.205731484173;8841.690540831072;7624.618769061539;8096.554689492075;8388.412811103226;8389.28691061259;8689.956550217255;2218.1792736687407;2266.3314322274887;2278.293728944024;2284.4859906521065;2288.622377307742;2250.932472025842;2255.436140964759;2313.8843057847125;2314.4445333120098;2314.756950520188;2250.4598896264943;2264.275431861805;2267.954640907181;2325.453518423169;2327.138958585326;2215.9224427144973;2217.2793842001333;2219.933401997943;2222.388843068153;2229.108356657334;2156.5255643758505;2163.296928498244;2166.566686662674;2171.4137182960512;2172.2071443923014;8621.741347759576;8641.30869530436;8684.522351270678;8690.348223883171;8715.43349682275;5041.72270525121;5148.639595228298;5149.201873709543;5154.587632989352;5155;3095.086949349947;3102.10039088664;3259.071164718068;3261.46185879332;3263.396271689745;1037.4294138223947;1049.8372752223418;1052.5631862776938;1057.370864335719;1068.8396740488988;11669.416529173592;11880.346580938045;11883.40582970848;11885.346305953082;11903.107266955012;4163.292240319153;4347.282698354799;4365.628921541641;4384.47386313638;4394.846180383735;10224.846627300596;10234.48827558619;10239.232057595711;10239.7440063999;10258.076773090308;5017.422996355466;5039.4708555601865;5048.7728052237735;5049.899002019939;5051.62112841531;3618.9127527338605;4643.651726120487;4644.0944015916575;4657.394538709946;4767.046590681877;4010.3783913493453;4014.8996275092773;4096.713230073926;4097.836086556505;4132.8140233689555;1248.2136254160002;1260.212367270456;1262.27419233939;1272.6436597752459;1281.7885048966816;840.4495055738502;899.6266549381933;952.9666461673808;977.0459081836327;1040.0535512683423;5810.4189581041555;5971.552133589998;6064.241969753781;6097.847553811191;6248.062790581358;921.755734730297;944.918068811221;971.2084651009404;974.7270764186039;998.9960090109394;4208.22147902639;4260.68044896634;4283.186194623012;4327.697061205686;4335.6965012449455;10640.148788096934;10665.093467055387;10734.516946737416;10870.510827012804;10947.890521094847;10716.303440276357;10745.14038876888;10824.945875270574;10827.566897324019;10835.079018283534;7880.172581878935;7887.3830864673755;7930.0880398753725;8046.275835174863;8069.354451643854;5745.368009518866;5746.655200687972;5774.538036957118;5840.853978650398;6007.669578173242;9447.669331573363;9552.474613896302;9636.75908102303;9670.951645241728;9688.176504997155;9148;9592.520373981133;9616.567254473706;9770.658026969022;9783.315167938175;7534.4725869190825;7695.384369250334;7776.455648104805;7777.144514103331;7778.766637000899;8188.713395031145;8204.384671149806;8249.587520623825;8259.174082591693;8266.793330166553;7456.589887556236;7560.6219689016425;7580.393568514395;7613;7747.1090824555895;7421.998030265845;7490.101187857492;7515.624218788929;7594;7609.923900760921;6982.231954485104;7183.245759195418;7248.456365772694;7349.632518373953;7352.338289553966;5128.384593848762;5134.691918484903;5213.45258747826;5254.65844720092;5344.171653393731;5202.3497062867145;5231.372235331784;5346.25152478661;5423.267858839006;5430.185472179047 13:26:53 INFO - PROCESS | 13867 | |4;prototype.html;324.64289281790036;327.2146847565843;334.7054591959075;338.5852330894653;338.6545723362169;5342.679439233649;5351.759170837312;5411.891762164754;5416.995711586714;5423.538999185064;5287.656302340345;5295.841124766263;5349.973250133744;5370.865728356793;5384.219288203209;3696.4270538066644;4009.514766486879;4032.798360081999;4136.4415803866395;4143.482064741907;4147.523034850986;4150.418941348214;4151;4154.854580089697;4172.5201601815725;4092.9590704092875;4121.578055570823;4123.855665051724;4126.504819421659;4145.440365550642;4021.8994525136814;4081.8367265309353;4139.813708383115;4155.168966206756;4163.271427500205;3669.1560940983454;3686.2443199144377;3693.7968411737343;3723.143676954289;3726.6273372662786;5145.6398052136365;5167.767450464738;5168.198929165986;5185.066687996159;5246.711430871301;4658.930116048262;4740.265258884844;4750.4299484061785;4761.666683332168;4762.785674644615;5483.588730845163;5486.725663716798;5494.450554944514;5504.311961004874;5513.696746678931;4014.6186112319283;4028.8187031583648;4034.374671925856;4036.777977211252;4046.8785936421955;4836.373339432421;5398.703071331075;5832.270966129234;5837.270341207349;5854.151148083547;4154.673382905583;4156.418101465797;4162.167566486714;4171.791410429466;4180.790960452026;4197.4753155855515;4208.431861698693;4210.389493523422;4220.332968477434;4225.64082053029;4791.904161916812;4797.232442809134;4804.375431193992;4809.374781278411;4820.8794780130775;5392.676439413648;5590;5594.580406469531;5612.719364031782;5640.210370548127;1392.6309527975095;1408.4366253498683;1409.563035459011;1412.2303344677175;1415.8442571317146;876.6843936182969;914.3508109242513;928.4661319741176;931.6366617019368;943.2406912435418;4736.579026292098;4741;4772.904541909143;4778.133120127895;4784.928226076611;5107.821226257063;5135;5147.279380886679;5150.227465880073;5151.840835811987;4598.663855113018;4662.4405071390975;4805;4830.782614782343;4833.492483289204;2665.973340266611;2684.8120631555994;2688.5967104934416;2696.716844731275;2736.097087960968;5200.8959820803375;5292.788288468418;5337.798995226043;5353.705546194997;5368.141097424394;4939.407271127488;5187;5215.921761173586;5218.452062533455;5268.868278292996;5614.933162699074;5784.971075144597;5838;5916.230889984275;5921.17103605487;5662.03745363281;5710.743016564182;5710.857228569319;5721.113227449752;5744.396838331915;5430.484104010113;5632.915506267327;5652.6043176978865;5662.716864156858;5683.431656834284;5866.09351960606;5878.118282257525;5900.790337980789;5922.970385148046;5946.375630558729;3969.960300396959;3985.103351745834;3988.7806170659733;3988.960110398859;3989.2819292527624;5539.695316757617;5664.660120392789;5681.857953551194;5711.314642242957;5748.45389687979;5557.916631250454;5560.972195138998;5563.388027316911;5570.498655121059;5572.411862619134;5364.2490051393615;5522.392536820867;5565.6104072714525;5569.969555632221;5597.860053498695;5494.835154945358;5531.917021244604;5533.280673512418;5541.833744987657;5547.944520554905;5601.355844077983;5623.325200975909;5634.506855683166;5647.774089036392;5653.802116925888;5359.946400535945;5447.673139611636;5492.47821456961;5493.670379777226;5496.945030549643 13:26:53 INFO - PROCESS | 13867 | |5;yui.html;813.8250276190619;823.3824631526355;859.8048712289914;865.195368307474;889.1730690457875;17703;18444.723329150056;18594.53513662159;18610.44168674942;18963.336283230088;15711.60720981976;16180.919095404506;17109.23008464619;17273.395431159912;17327.82672173281;812.5896422306727;825.2984962781618;825.3232349473434;825.3892119831312;826.8759686047111;677.4512644757762;807.5760225881401;834.4826207751203;835.5613303015905;838.3502785341349;843.3548335523299;846.2257034813139;846.6190214403513;847.3009766942266;848.0374774630808;838.534613289624;841.7558907916697;842.2756429470651;843.0136740014168;843.0136740014168;512.9025485157808;522.1853907903683;525.6031696069481;615.2954866677629;615.938406159385;15111.773323400157;15777.763333550007;15810.683786324324;15927.522174334788;15962.920185399114;14484.565463036126;14689.559313220621;15219.467318643905;15284.617884552865;15612.843871561367;12636;12688.302143382203;12778.808317875239;12790.936045319806;13451.260180690058;3597.280543891206;3747.344214762433;3753.887383378503;3790.8294126764085;3819.197968426634;81307.18692813114;83409.58295208546;83778.58110709468;84676.57661711714;84736;11357.148213883991;11605.477753501113;11947;11993.160478766402;12170.81743773844;22292.32807539441;22311.888440557694;22429.55140897173;22482.55034899293;23021.19425820088;8290.08809031006;8497.532635705096;8543.530105844238;8543.615537300711;8658.350623703122;4638;4751.382320298339;4810.494898035656;4834.685745426536;4955.430125535538;3327.334533093391;3419.12812232879;3421.3157368526395;3424.298018906118;3437.4671925851535;562.3111688181945;569.1235497334059;627.6391075131818;660.3297652882328;667.5794249622707;771.4831063187678;778.8714862047811;790.4822341366414;797.2415442568777;809.6605653783695;9868.457234852009;10250.470537136245;10265.846012309821;10591;10934.125269978382;638.559394018126;720.4164626652323;722.552017748999;732.1616748822569;738.7783664900509;4762.190427627312;4996.125678006334;5030.37120359955;5063.721495317793;5065.468125846733;105596;105952;108564.4571777136;118841;129650;63130.684346577975;68364.3163568358;100021.49989250007;101549;102650;88200.55899720588;88735;89209.55395222982;90102.098979012;91176;9725.610975560898;9941.25440591973;10067.496625168566;10142.391456512632;10157.695269141937;48608.756956214995;49997.75001124971;50464.23375181851;54107.72946135244;54456;74092.62953685196;75312.62343688247;76308;77230.6138469304;78430.11933889204;12566;12654.810177847156;12806.1675991064;12879.291638959947;12949.417276222404;14914;15219.467318643794;15663.843361566238;16166.67666646637;16289.104099274653;13710.931445343109;14365.497207598102;14496.420143194155;15104;15485.070895746292;13229.801552976905;13517.729645407233;15015.624609384417;15066.09603423798;15156.545303640909;14171.929140354232;14184;14491;14763.557093287218;14944.850551494346;10169.33926245348;11074.11407087415;11465.31208127515;11502;11715.707107322385;11271.549138034714;11530.365829879438;11601;11661.708457288636;11852.348120853436 13:26:53 INFO - PROCESS | 13867 | __end_tp_report 13:26:53 INFO - PROCESS | 13867 | __start_cc_report 13:26:53 INFO - PROCESS | 13867 | _x_x_mozilla_cycle_collect,958 13:26:53 INFO - PROCESS | 13867 | __end_cc_report 13:26:53 INFO - PROCESS | 13867 | __startTimestamp1469737613470__endTimestamp 13:26:53 INFO - PROCESS | 13867 | 13:26:53 INFO - PROCESS | 13867 | ------- Summary: start ------- 13:26:53 INFO - PROCESS | 13867 | Number of tests: 6 13:26:53 INFO - PROCESS | 13867 | 13:26:53 INFO - PROCESS | 13867 | [#0] dojo.html Cycles:165 Average:5256.35 Median:5428.00 stddev:601.70 (11.1%) stddev-sans-first:576.44 13:26:53 INFO - PROCESS | 13867 | Values: 2980.3 2994.4 3023.9 3027.4 3036.2 5103.6 5157.5 5184.6 5190.6 5227.9 5245.9 5252.4 5254.2 5262.1 5301.4 4797.0 4811.6 4812.0 4849.1 4867.4 4888.9 4899.7 4980.6 4982.8 5012.4 4771.8 4804.8 4856.8 4900.6 4901.8 4801.4 4850.3 4862.4 4874.9 4920.9 4816.1 4826.7 4839.4 4840.1 4871.0 5186.9 5306.1 5316.0 5359.1 5372.0 5566.9 5596.0 5623.9 5642.2 5693.8 5658.4 5699.2 5735.2 5741.5 5748.5 5116.7 5299.6 5333.9 5336.7 5340.8 5744.5 5764.7 5803.9 5810.7 5819.0 5539.9 5541.3 5579.8 5584.1 5586.2 5479.3 5615.0 5668.0 5676.4 5678.2 5484.2 5561.9 5569.4 5573.9 5626.5 5577.3 5580.2 5625.2 5628.8 5632.7 4171.2 4243.9 4246.9 4250.7 4285.0 3808.5 3846.4 3879.7 3905.3 3974.3 5341.8 5343.3 5343.4 5345.8 5349.6 5697.2 5698.8 5701.9 5706.7 5746.4 5167.4 5248.3 5327.4 5327.8 5398.9 4867.6 4886.3 4887.0 4895.1 4943.7 5921.7 5939.3 5941.0 5942.0 5943.4 5489.6 5636.5 5688.9 5709.2 5785.5 5880.6 5934.7 5938.8 5948.0 5953.3 5572.8 5590.3 5594.5 5612.4 5612.4 5537.8 5598.9 5614.9 5661.1 5734.4 5513.4 5542.5 5542.9 5544.8 5544.9 5536.0 5540.9 5541.6 5544.6 5595.2 5310.8 5383.5 5404.2 5425.5 5511.0 5515.5 5523.8 5566.4 5570.9 5580.2 5418.5 5426.4 5427.4 5428.0 5433.6 13:26:53 INFO - PROCESS | 13867 | 13:26:53 INFO - PROCESS | 13867 | [#1] ext.html Cycles:180 Average:58309.31 Median:38547.11 stddev:116785.86 (303.0%) stddev-sans-first:117033.04 13:26:53 INFO - PROCESS | 13867 | Values: 577.5 601.2 607.5 611.5 621.2 42483.0 43594.2 43646.8 43798.8 45573.0 45457.8 45942.5 45969.8 46012.5 46073.5 8074.6 8697.4 8851.6 8856.0 10384.3 10395.6 10700.5 10711.6 10719.5 10722.2 10825.8 10864.7 10867.4 10875.8 10878.7 10781.1 10813.7 10813.8 10832.2 10834.9 10652.1 10712.7 10715.5 10722.9 10726.0 42298.4 42675.4 42721.4 42807.8 42812.0 3681.5 4027.5 4136.9 4265.6 4271.1 32637.8 32710.0 32854.3 33760.3 34339.3 4204.0 4216.2 4222.3 4255.9 4256.6 234555.0 235278.0 235854.0 236806.0 237939.0 57686.0 58126.1 58266.7 58267.4 58293.0 35268.6 35936.8 36035.1 60113.7 60137.0 14239.4 14599.5 14610.6 14641.3 14652.9 10093.2 10534.4 11297.3 11480.2 11585.2 19142.8 19157.0 19213.0 19271.3 19458.8 6964.6 7159.5 7199.4 7253.4 7333.8 959.9 978.7 1067.9 1106.7 1110.8 33231.8 36219.8 36414.0 36671.4 36772.4 1054.2 1076.0 1102.8 1120.4 1140.8 16501.6 17169.3 17211.4 17353.5 17399.2 574643.0 575636.0 578158.0 579690.0 580835.0 56897.7 57299.1 57436.4 57527.1 57569.8 1242.8 1266.4 1343.7 1345.0 1395.7 30456.7 33764.2 33860.0 33903.3 33984.5 49833.8 50531.2 50650.7 50652.0 50683.0 428981.0 433391.0 433694.0 434079.0 436145.0 27736.7 27818.7 28714.7 28751.9 29453.4 48480.3 49079.0 49356.8 49527.5 51047.0 41062.0 42048.4 42345.8 42564.6 43857.6 42003.8 42308.0 42654.4 43884.8 44119.0 41197.0 41588.8 41869.3 42739.4 42851.4 35118.0 38309.0 38484.4 38609.8 39341.2 28680.3 28736.7 29128.7 29139.6 29303.9 13:26:53 INFO - PROCESS | 13867 | 13:26:53 INFO - PROCESS | 13867 | [#2] jquery.html Cycles:180 Average:25295.64 Median:395.17 stddev:61988.93 (15686.5%) stddev-sans-first:62134.56 13:26:53 INFO - PROCESS | 13867 | Values: 365.6 374.8 386.4 390.7 399.6 17030.0 18932.4 19021.9 19170.4 19969.5 19178.4 19257.0 19868.2 19952.9 20170.7 5759.1 5793.9 5873.6 5962.0 5963.3 5690.7 5772.7 5813.6 5814.6 5817.4 5728.1 5778.9 5785.5 5788.7 5819.8 5712.6 5809.9 5846.7 5847.4 5854.8 4888.8 5157.8 5173.9 5249.0 5251.4 13497.4 13624.5 16957.4 23211.0 23363.5 2267.2 2312.9 2363.1 2364.5 2406.4 9895.8 10020.5 10028.1 12074.3 13385.6 1743.3 1748.4 1827.3 1883.0 1909.5 76146.0 77224.2 84841.0 89503.0 89794.0 10603.9 10857.3 11003.6 11034.8 11184.8 15704.6 15716.4 15720.6 15733.9 15748.4 8015.1 8114.3 8129.3 8282.8 8307.3 7663.3 7703.2 7771.5 7896.3 7942.3 4603.5 4647.5 4680.1 4859.1 4898.8 1976.2 1978.4 2025.8 2038.8 2058.5 886.6 895.1 909.0 948.4 950.4 18927.8 19498.9 19918.3 19931.6 20119.7 439.8 982.3 990.6 1020.2 1087.0 6034.6 6127.8 6298.4 6396.2 6524.0 301741.0 302214.0 377227.0 387796.0 451205.0 65634.3 87146.6 100767.5 102834.0 106389.0 446.1 457.3 457.5 458.7 458.8 10347.8 10942.2 11132.8 11155.6 11253.0 42084.4 42323.6 42694.4 43252.8 44166.3 62132.7 62280.7 62557.7 62764.0 64129.0 8402.0 8405.7 8445.5 8516.5 8731.0 9373.5 11218.7 11319.0 12249.6 13207.3 11375.9 11686.4 11787.8 11862.0 12221.3 11099.7 11746.7 11807.2 11887.8 12254.1 11606.3 11846.4 11925.3 12046.3 12531.0 8242.5 8252.9 8355.0 8364.9 8649.1 10828.6 11396.8 11876.6 12150.0 12494.1 13:26:53 INFO - PROCESS | 13867 | 13:26:53 INFO - PROCESS | 13867 | [#3] mootools.html Cycles:180 Average:5686.51 Median:5050.76 stddev:3207.24 (63.5%) stddev-sans-first:3200.51 13:26:53 INFO - PROCESS | 13867 | Values: 1459.2 1520.7 1627.6 1746.4 1784.4 8334.0 8816.1 8817.0 8825.2 8841.7 7624.6 8096.6 8388.4 8389.3 8690.0 2218.2 2266.3 2278.3 2284.5 2288.6 2250.9 2255.4 2313.9 2314.4 2314.8 2250.5 2264.3 2268.0 2325.5 2327.1 2215.9 2217.3 2219.9 2222.4 2229.1 2156.5 2163.3 2166.6 2171.4 2172.2 8621.7 8641.3 8684.5 8690.3 8715.4 5041.7 5148.6 5149.2 5154.6 5155.0 3095.1 3102.1 3259.1 3261.5 3263.4 1037.4 1049.8 1052.6 1057.4 1068.8 11669.4 11880.3 11883.4 11885.3 11903.1 4163.3 4347.3 4365.6 4384.5 4394.8 10224.8 10234.5 10239.2 10239.7 10258.1 5017.4 5039.5 5048.8 5049.9 5051.6 3618.9 4643.7 4644.1 4657.4 4767.0 4010.4 4014.9 4096.7 4097.8 4132.8 1248.2 1260.2 1262.3 1272.6 1281.8 840.4 899.6 953.0 977.0 1040.1 5810.4 5971.6 6064.2 6097.8 6248.1 921.8 944.9 971.2 974.7 999.0 4208.2 4260.7 4283.2 4327.7 4335.7 10640.1 10665.1 10734.5 10870.5 10947.9 10716.3 10745.1 10824.9 10827.6 10835.1 7880.2 7887.4 7930.1 8046.3 8069.4 5745.4 5746.7 5774.5 5840.9 6007.7 9447.7 9552.5 9636.8 9671.0 9688.2 9148.0 9592.5 9616.6 9770.7 9783.3 7534.5 7695.4 7776.5 7777.1 7778.8 8188.7 8204.4 8249.6 8259.2 8266.8 7456.6 7560.6 7580.4 7613.0 7747.1 7422.0 7490.1 7515.6 7594.0 7609.9 6982.2 7183.2 7248.5 7349.6 7352.3 5128.4 5134.7 5213.5 5254.7 5344.2 5202.3 5231.4 5346.3 5423.3 5430.2 13:26:53 INFO - PROCESS | 13867 | 13:26:53 INFO - PROCESS | 13867 | [#4] prototype.html Cycles:180 Average:4595.77 Median:5186.03 stddev:1348.68 (26.0%) stddev-sans-first:1313.81 13:26:53 INFO - PROCESS | 13867 | Values: 324.6 327.2 334.7 338.6 338.7 5342.7 5351.8 5411.9 5417.0 5423.5 5287.7 5295.8 5350.0 5370.9 5384.2 3696.4 4009.5 4032.8 4136.4 4143.5 4147.5 4150.4 4151.0 4154.9 4172.5 4093.0 4121.6 4123.9 4126.5 4145.4 4021.9 4081.8 4139.8 4155.2 4163.3 3669.2 3686.2 3693.8 3723.1 3726.6 5145.6 5167.8 5168.2 5185.1 5246.7 4658.9 4740.3 4750.4 4761.7 4762.8 5483.6 5486.7 5494.5 5504.3 5513.7 4014.6 4028.8 4034.4 4036.8 4046.9 4836.4 5398.7 5832.3 5837.3 5854.2 4154.7 4156.4 4162.2 4171.8 4180.8 4197.5 4208.4 4210.4 4220.3 4225.6 4791.9 4797.2 4804.4 4809.4 4820.9 5392.7 5590.0 5594.6 5612.7 5640.2 1392.6 1408.4 1409.6 1412.2 1415.8 876.7 914.4 928.5 931.6 943.2 4736.6 4741.0 4772.9 4778.1 4784.9 5107.8 5135.0 5147.3 5150.2 5151.8 4598.7 4662.4 4805.0 4830.8 4833.5 2666.0 2684.8 2688.6 2696.7 2736.1 5200.9 5292.8 5337.8 5353.7 5368.1 4939.4 5187.0 5215.9 5218.5 5268.9 5614.9 5785.0 5838.0 5916.2 5921.2 5662.0 5710.7 5710.9 5721.1 5744.4 5430.5 5632.9 5652.6 5662.7 5683.4 5866.1 5878.1 5900.8 5923.0 5946.4 3970.0 3985.1 3988.8 3989.0 3989.3 5539.7 5664.7 5681.9 5711.3 5748.5 5557.9 5561.0 5563.4 5570.5 5572.4 5364.2 5522.4 5565.6 5570.0 5597.9 5494.8 5531.9 5533.3 5541.8 5547.9 5601.4 5623.3 5634.5 5647.8 5653.8 5359.9 5447.7 5492.5 5493.7 5496.9 13:26:53 INFO - PROCESS | 13867 | 13:26:53 INFO - PROCESS | 13867 | [#5] yui.html Cycles:180 Average:21174.30 Median:3672.31 stddev:29815.54 (811.9%) stddev-sans-first:29859.99 13:26:53 INFO - PROCESS | 13867 | Values: 813.8 823.4 859.8 865.2 889.2 17703.0 18444.7 18594.5 18610.4 18963.3 15711.6 16180.9 17109.2 17273.4 17327.8 812.6 825.3 825.3 825.4 826.9 677.5 807.6 834.5 835.6 838.4 843.4 846.2 846.6 847.3 848.0 838.5 841.8 842.3 843.0 843.0 512.9 522.2 525.6 615.3 615.9 15111.8 15777.8 15810.7 15927.5 15962.9 14484.6 14689.6 15219.5 15284.6 15612.8 12636.0 12688.3 12778.8 12790.9 13451.3 3597.3 3747.3 3753.9 3790.8 3819.2 81307.2 83409.6 83778.6 84676.6 84736.0 11357.1 11605.5 11947.0 11993.2 12170.8 22292.3 22311.9 22429.6 22482.6 23021.2 8290.1 8497.5 8543.5 8543.6 8658.4 4638.0 4751.4 4810.5 4834.7 4955.4 3327.3 3419.1 3421.3 3424.3 3437.5 562.3 569.1 627.6 660.3 667.6 771.5 778.9 790.5 797.2 809.7 9868.5 10250.5 10265.8 10591.0 10934.1 638.6 720.4 722.6 732.2 738.8 4762.2 4996.1 5030.4 5063.7 5065.5 105596.0 105952.0 108564.5 118841.0 129650.0 63130.7 68364.3 100021.5 101549.0 102650.0 88200.6 88735.0 89209.6 90102.1 91176.0 9725.6 9941.3 10067.5 10142.4 10157.7 48608.8 49997.8 50464.2 54107.7 54456.0 74092.6 75312.6 76308.0 77230.6 78430.1 12566.0 12654.8 12806.2 12879.3 12949.4 14914.0 15219.5 15663.8 16166.7 16289.1 13710.9 14365.5 14496.4 15104.0 15485.1 13229.8 13517.7 15015.6 15066.1 15156.5 14171.9 14184.0 14491.0 14763.6 14944.9 10169.3 11074.1 11465.3 11502.0 11715.7 11271.5 11530.4 11601.0 11661.7 11852.3 13:26:53 INFO - PROCESS | 13867 | -------- Summary: end -------- 13:26:53 INFO - PROCESS | 13867 | 13:26:54 INFO - TEST-INFO | 13867: exit 0 13:26:54 INFO - TEST-OK | dromaeo_css | took 1113883ms 13:26:54 INFO - TEST-START | kraken 13:26:54 INFO - operating with platform_type : linux_ 13:26:54 INFO - Initialising browser for kraken test... 13:26:54 INFO - TEST-INFO | started process 14064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkO8C8b/profile http://localhost:33374/getInfo.html) 13:26:57 INFO - PROCESS | 14064 | JavaScript error: , line 0: uncaught exception: undefined 13:26:58 INFO - PROCESS | 14064 | __metrics Screen width/height:1600/1200 13:26:58 INFO - PROCESS | 14064 | colorDepth:24 13:26:58 INFO - PROCESS | 14064 | Browser inner width/height: 1024/697 13:26:58 INFO - PROCESS | 14064 | __metrics 13:26:58 INFO - PROCESS | 14064 | 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" 13:26:58 INFO - PROCESS | 14064 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:26:59 INFO - TEST-INFO | 14064: exit 0 13:26:59 INFO - Browser initialized. 13:26:59 INFO - Running cycle 1/1 for kraken test... 13:26:59 INFO - TEST-INFO | started process 14143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkO8C8b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:11 INFO - PROCESS | 14143 | RSS: Main: 158183424 13:27:11 INFO - PROCESS | 14143 | 13:27:14 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33374/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:15 INFO - PROCESS | 14143 | RSS: Main: 213778432 13:27:15 INFO - PROCESS | 14143 | 13:27:17 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33374/tests/kraken/driver.html?testName=audio-dft) 13:27:18 INFO - PROCESS | 14143 | RSS: Main: 193314816 13:27:18 INFO - PROCESS | 14143 | 13:27:21 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33374/tests/kraken/driver.html?testName=audio-fft) 13:27:21 INFO - PROCESS | 14143 | RSS: Main: 271245312 13:27:21 INFO - PROCESS | 14143 | 13:27:24 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33374/tests/kraken/driver.html?testName=audio-oscillator) 13:27:24 INFO - PROCESS | 14143 | RSS: Main: 180899840 13:27:24 INFO - PROCESS | 14143 | 13:27:26 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:27:27 INFO - PROCESS | 14143 | RSS: Main: 185823232 13:27:27 INFO - PROCESS | 14143 | 13:27:30 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33374/tests/kraken/driver.html?testName=imaging-darkroom) 13:27:31 INFO - PROCESS | 14143 | RSS: Main: 220893184 13:27:31 INFO - PROCESS | 14143 | 13:27:34 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33374/tests/kraken/driver.html?testName=imaging-desaturate) 13:27:34 INFO - PROCESS | 14143 | RSS: Main: 220766208 13:27:34 INFO - PROCESS | 14143 | 13:27:37 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33374/tests/kraken/driver.html?testName=json-parse-financial) 13:27:38 INFO - PROCESS | 14143 | RSS: Main: 220766208 13:27:38 INFO - PROCESS | 14143 | 13:27:39 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:27:40 INFO - PROCESS | 14143 | RSS: Main: 185442304 13:27:40 INFO - PROCESS | 14143 | 13:27:42 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33374/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:27:42 INFO - PROCESS | 14143 | RSS: Main: 191115264 13:27:42 INFO - PROCESS | 14143 | 13:27:44 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:27:45 INFO - PROCESS | 14143 | RSS: Main: 195477504 13:27:45 INFO - PROCESS | 14143 | 13:27:48 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:27:48 INFO - PROCESS | 14143 | RSS: Main: 188309504 13:27:48 INFO - PROCESS | 14143 | 13:27:51 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:27:51 INFO - PROCESS | 14143 | RSS: Main: 193380352 13:27:51 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | Cycle 1(1): loaded http://localhost:33374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33374/tests/kraken/driver.html?testName=ai-astar) 13:27:53 INFO - PROCESS | 14143 | RSS: Main: 244703232 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | __start_tp_report 13:27:53 INFO - PROCESS | 14143 | _x_x_mozilla_page_load 13:27:53 INFO - PROCESS | 14143 | _x_x_mozilla_page_load_details 13:27:53 INFO - PROCESS | 14143 | |i|pagename|runs| 13:27:53 INFO - PROCESS | 14143 | |0;ai-astar;102;111;112;111;111;112;112;110;110;112 13:27:53 INFO - PROCESS | 14143 | |1;audio-beat-detection;161;118;120;175;118;118;146;123;154;119 13:27:53 INFO - PROCESS | 14143 | |2;audio-dft;160;160;161;161;160;161;159;160;160;160 13:27:53 INFO - PROCESS | 14143 | |3;audio-fft;74;75;76;117;75;76;76;74;112;75 13:27:53 INFO - PROCESS | 14143 | |4;audio-oscillator;83;84;113;84;85;85;120;83;85;130 13:27:53 INFO - PROCESS | 14143 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;117 13:27:53 INFO - PROCESS | 14143 | |6;imaging-darkroom;146;145;146;145;145;146;145;146;145;145 13:27:53 INFO - PROCESS | 14143 | |7;imaging-desaturate;96;95;95;94;96;94;94;95;95;94 13:27:53 INFO - PROCESS | 14143 | |8;json-parse-financial;53;52;54;52;52;53;54;52;53;52 13:27:53 INFO - PROCESS | 14143 | |9;json-stringify-tinderbox;63;63;63;63;63;63;63;64;63;63 13:27:53 INFO - PROCESS | 14143 | |10;stanford-crypto-aes;76;76;76;75;76;76;75;76;75;80 13:27:53 INFO - PROCESS | 14143 | |11;stanford-crypto-ccm;120;127;125;121;122;117;119;127;204;120 13:27:53 INFO - PROCESS | 14143 | |12;stanford-crypto-pbkdf2;158;157;158;158;154;159;158;159;165;157 13:27:53 INFO - PROCESS | 14143 | |13;stanford-crypto-sha256-iterative;65;61;65;62;62;62;63;63;63;65 13:27:53 INFO - PROCESS | 14143 | __end_tp_report 13:27:53 INFO - PROCESS | 14143 | __start_cc_report 13:27:53 INFO - PROCESS | 14143 | _x_x_mozilla_cycle_collect,1670 13:27:53 INFO - PROCESS | 14143 | __end_cc_report 13:27:53 INFO - PROCESS | 14143 | __startTimestamp1469737673858__endTimestamp 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | ------- Summary: start ------- 13:27:53 INFO - PROCESS | 14143 | Number of tests: 14 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.02 (2.7%) stddev-sans-first:0.83 13:27:53 INFO - PROCESS | 14143 | Values: 102.0 111.0 112.0 111.0 111.0 112.0 112.0 110.0 110.0 112.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:134.50 stddev:21.73 (16.2%) stddev-sans-first:20.95 13:27:53 INFO - PROCESS | 14143 | Values: 161.0 118.0 120.0 175.0 118.0 118.0 146.0 123.0 154.0 119.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:27:53 INFO - PROCESS | 14143 | Values: 160.0 160.0 161.0 161.0 160.0 161.0 159.0 160.0 160.0 160.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:16.66 (22.2%) stddev-sans-first:17.35 13:27:53 INFO - PROCESS | 14143 | Values: 74.0 75.0 76.0 117.0 75.0 76.0 76.0 74.0 112.0 75.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:84.00 stddev:18.27 (21.7%) stddev-sans-first:18.84 13:27:53 INFO - PROCESS | 14143 | Values: 83.0 84.0 113.0 84.0 85.0 85.0 120.0 83.0 85.0 130.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:27:53 INFO - PROCESS | 14143 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 13:27:53 INFO - PROCESS | 14143 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 145.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 13:27:53 INFO - PROCESS | 14143 | Values: 96.0 95.0 95.0 94.0 96.0 94.0 94.0 95.0 95.0 94.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 13:27:53 INFO - PROCESS | 14143 | Values: 53.0 52.0 54.0 52.0 52.0 53.0 54.0 52.0 53.0 52.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 13:27:53 INFO - PROCESS | 14143 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 63.0 64.0 63.0 63.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:1.45 (1.9%) stddev-sans-first:1.54 13:27:53 INFO - PROCESS | 14143 | Values: 76.0 76.0 76.0 75.0 76.0 76.0 75.0 76.0 75.0 80.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:123.50 stddev:26.15 (21.2%) stddev-sans-first:27.47 13:27:53 INFO - PROCESS | 14143 | Values: 120.0 127.0 125.0 121.0 122.0 117.0 119.0 127.0 204.0 120.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:158.00 stddev:2.75 (1.7%) stddev-sans-first:2.92 13:27:53 INFO - PROCESS | 14143 | Values: 158.0 157.0 158.0 158.0 154.0 159.0 158.0 159.0 165.0 157.0 13:27:53 INFO - PROCESS | 14143 | 13:27:53 INFO - PROCESS | 14143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.45 (2.3%) stddev-sans-first:1.36 13:27:53 INFO - PROCESS | 14143 | Values: 65.0 61.0 65.0 62.0 62.0 62.0 63.0 63.0 63.0 65.0 13:27:53 INFO - PROCESS | 14143 | -------- Summary: end -------- 13:27:53 INFO - PROCESS | 14143 | 13:27:54 INFO - TEST-INFO | 14143: exit 0 13:27:54 INFO - TEST-OK | kraken | took 60545ms 13:27:54 INFO - SUITE-END | took 1174s 13:27:55 INFO - Completed test suite (00:19:34) 13:27:55 INFO - javascript benchmark 13:27:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2980.2549362659333, 2994.401119776043, 3023.9395212095747, 3027.424789290035, 3036.165054609982, 5103.591712662987, 5157.458466860982, 5184.585233181346, 5190.636655434121, 5227.869303267425, 5245.921311180336, 5252.395974462938, 5254.238135470355, 5262.131748261532, 5301.443348448405, 4796.976015119937, 4811.639127065458, 4811.975940120295, 4849.078675051746, 4867.369176985716, 4888.926666099994, 4899.706017638935, 4980.576650984653, 4982.750862456881, 5012.423571289294, 4771.785269662873, 4804.807807687688, 4856.757162141914, 4900.607951363882, 4901.754912254409, 4801.399825021872, 4850.345203397532, 4862.36789217403, 4874.902501949941, 4920.926186107211, 4816.084943860656, 4826.710397376169, 4839.44346400165, 4840.104580652591, 4871.0, 5186.870328241786, 5306.071437498423, 5316.0, 5359.14253719403, 5372.0, 5566.888662226733, 5596.0, 5623.887522249532, 5642.153676948449, 5693.77224911003, 5658.43415658435, 5699.173619825144, 5735.1684005818925, 5741.483266505993, 5748.540116790647, 5116.744162791845, 5299.576033917316, 5333.866653333697, 5336.653117547347, 5340.813071542478, 5744.454276843693, 5764.74058667361, 5803.8549036274435, 5810.709464526757, 5819.0, 5539.8892022160135, 5541.27963364768, 5579.832605021856, 5584.050711379075, 5586.245856809279, 5479.315085614298, 5614.9719251403485, 5668.0, 5676.375598684142, 5678.176664383724, 5484.177373393943, 5561.888762224733, 5569.443055694479, 5573.860653483695, 5626.549876009909, 5577.27495425592, 5580.218769372291, 5625.240592519957, 5628.802991895346, 5632.662040277514, 4171.207470580641, 4243.893902652459, 4246.915061698749, 4250.659947204216, 4284.978575107167, 3808.5429748430365, 3846.3653497172654, 3879.7478163919254, 3905.3165696003084, 3974.2647610192207, 5341.813036543703, 5343.251944727741, 5343.3587969443915, 5345.797195630952, 5349.625526213128, 5697.230873832063, 5698.800541981093, 5701.885962280814, 5706.743196556165, 5746.42535746422, 5167.354080739908, 5248.291480650139, 5327.440618735054, 5327.760250788646, 5398.865028374244, 4867.58625516835, 4886.291487734258, 4886.95113048865, 4895.118878601815, 4943.678660887031, 5921.67430791302, 5939.287285525678, 5941.049432090845, 5941.970290148608, 5943.405659434108, 5489.64317319373, 5636.4927156556105, 5688.886222275614, 5709.22925405065, 5785.508231800344, 5880.617759845596, 5934.673592952429, 5938.792142275172, 5947.959107156144, 5953.255843019622, 5572.777088916398, 5590.273264475592, 5594.468525490072, 5612.354579223442, 5612.382637909745, 5537.8061767837935, 5598.944010559842, 5614.943850561605, 5661.122526008476, 5734.3692193857805, 5513.448655134454, 5542.528885044655, 5542.889142217214, 5544.750486228048, 5544.861378465571, 5536.0, 5540.91688624679, 5541.639793413416, 5544.556435485071, 5595.160725890986, 5310.840674779763, 5383.461653834585, 5404.216388623706, 5425.511703946664, 5511.035568775528, 5515.531179849758, 5523.7790488380015, 5566.387697353369, 5570.944290557042, 5580.162975553537, 5418.485243901823, 5426.403095659395, 5427.402985671494, 5428.0, 5433.619646624698], "value": 5215.033375340523, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.5091172503372, 601.170384868881, 607.4623957797351, 611.458858909865, 621.2079598511893, 42482.99999999996, 43594.20463748989, 43646.781766091124, 43798.78100609496, 45573.0, 45457.77271113648, 45942.54057459424, 45969.7701511492, 46012.53987460124, 46073.539264607345, 8074.596270186496, 8697.391182617219, 8851.645934162625, 8856.0, 10384.325018873787, 10395.584176632963, 10700.518476668529, 10711.571537138505, 10719.517621707002, 10722.249442539025, 10825.83761243582, 10864.728381790479, 10867.402292873929, 10875.782484350308, 10878.72803179919, 10781.137508999262, 10813.729656758565, 10813.83779243316, 10832.187585931008, 10834.891651083468, 10652.147828173727, 10712.678619641423, 10715.46422678863, 10722.892771072346, 10726.0, 42298.365524517154, 42675.35986960198, 42721.35917961233, 42807.785961069996, 42812.0, 3681.4661874028384, 4027.496562929634, 4136.91726165478, 4265.594768496988, 4271.060366719316, 32637.836810816032, 32710.0, 32854.342913141845, 33760.32479350399, 34339.31321373583, 4204.0, 4216.241076606209, 4222.345536441856, 4255.893602659928, 4256.59562341577, 234555.0, 235278.0, 235854.0, 236806.0, 237939.0, 57686.0, 58126.12810807841, 58266.7086664564, 58267.417325827046, 58293.0, 35268.64731352705, 35936.82031589825, 36035.099122522144, 60113.69943150344, 60137.0, 14239.359228834728, 14599.489017884323, 14610.634734131732, 14641.34113964874, 14652.853471465362, 10093.19254459656, 10534.36793792375, 11297.26567773092, 11480.196386253048, 11585.246958947642, 19142.808571914382, 19157.0, 19213.0, 19271.325503607306, 19458.8054119457, 6964.616946068015, 7159.520633826395, 7199.424046076301, 7253.3834624057545, 7333.779986600411, 959.8752162218867, 978.7178795777554, 1067.9092277156374, 1106.7399161197113, 1110.8444817725524, 33231.833840830644, 36219.818900905855, 36414.0, 36671.449928251095, 36772.44841327382, 1054.1988089052222, 1075.983860242097, 1102.7684186320803, 1120.4229821641861, 1140.766142940695, 16501.58746031359, 17169.31322747076, 17211.397601083903, 17353.529294141223, 17399.217035233443, 574643.0, 575636.0, 578158.0, 579690.0, 580835.0, 56897.715511422175, 57299.14051289234, 57436.42563574311, 57527.1370929428, 57569.84860302854, 1242.7949388351, 1266.3731452930674, 1343.6976680246867, 1344.9865501345057, 1395.699924516234, 30456.736056952486, 33764.15589610279, 33860.0, 33903.32193356168, 33984.490232646036, 49833.75083124561, 50531.2420313703, 50650.746746266035, 50652.0, 50683.0, 428981.0, 433391.0, 433694.0, 434079.0, 436145.0, 27736.72263277422, 27818.721812781612, 28714.71285287204, 28751.8562407195, 29453.410931781673, 48480.27279590738, 49079.0, 49356.75321623369, 49527.50472495373, 51047.0, 41062.0, 42048.369274460296, 42345.78827105968, 42564.5743542573, 43857.56142438662, 42003.7899810499, 42308.0, 42654.36018459788, 43884.78057609691, 44119.0, 41197.0, 41588.79205603953, 41869.278496897605, 42739.358909617, 42851.357229642206, 35118.0, 38309.0, 38484.42273365846, 38609.80695096507, 39341.2131757369, 28680.282992925342, 28736.706848192298, 29128.7087129126, 29139.562906556843, 29303.853480733313], "value": 20365.16406052245, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.6069725045577, 374.7526632422601, 386.4010783285908, 390.7011136480593, 399.6443165582632, 17030.0, 18932.432027039176, 19021.904890475562, 19170.424887253386, 19969.500762480908, 19178.424647260603, 19257.0, 19868.205271789113, 19952.9002354988, 20170.69743953842, 5759.136129580555, 5793.855153621151, 5873.588848780587, 5961.970190149043, 5963.254593175853, 5690.715464226772, 5772.653640781546, 5813.563982701315, 5814.592978491507, 5817.389174136718, 5728.054870946289, 5778.855528611776, 5785.479306862381, 5788.6816225107605, 5819.7963071292515, 5712.600117991721, 5809.912851307234, 5846.7076646167525, 5847.44449277318, 5854.765809367642, 4888.804447822083, 5157.767900444489, 5173.870653233662, 5248.9737551312, 5251.369835619712, 13497.392617332243, 13624.523141689993, 16957.406490772886, 23211.0, 23363.53272934532, 2267.1724820440586, 2312.895919683618, 2363.078399424226, 2364.456175079741, 2406.3719696894377, 9895.752606184831, 10020.549075291628, 10028.147607453375, 12074.335911524862, 13385.598432046956, 1743.2678275124479, 1748.3880641775404, 1827.3238901606492, 1883.0, 1909.484439201408, 76146.0, 77224.22775772227, 84841.0, 89503.0, 89794.0, 10603.94698026505, 10857.294275872044, 11003.61487347939, 11034.779304413867, 11184.840743993098, 15704.60738481547, 15716.371345146295, 15720.606984825243, 15733.921330393276, 15748.370065197263, 8015.078265999368, 8114.3102836258395, 8129.349652027823, 8282.792930176794, 8307.252347288773, 7663.31030207284, 7703.229677032252, 7771.4559980800805, 7896.289333959971, 7942.285194332538, 4603.4839325485445, 4647.465541462708, 4680.1107789520565, 4859.125357435625, 4898.804047838046, 1976.150255390196, 1978.3768113044346, 2025.8222410908334, 2038.7961203879493, 2058.4545095549693, 886.5567216391804, 895.0601868038664, 908.9683209557201, 948.3551185194134, 950.353759443585, 18927.81072189288, 19498.902505487382, 19918.30285939985, 19931.60136797256, 20119.698204526943, 439.7625282347561, 982.3271059324386, 990.5988074829705, 1020.2348238820884, 1087.0, 6034.63792172471, 6127.816165515042, 6298.370162983665, 6396.232452105777, 6524.0, 301741.0, 302214.0, 377227.0, 387796.0, 451205.0, 65634.34365656378, 87146.56426717826, 100767.49616251871, 102834.0, 106389.0, 446.1144627913589, 457.29804749709035, 457.50589363487353, 458.72476514091943, 458.7752001519232, 10347.84478232812, 10942.17933654963, 11132.777344452903, 11155.553777848796, 11253.0, 42084.36873446839, 42323.57676423196, 42694.359584605634, 43252.78373608112, 44166.33750493681, 62132.68933655303, 62280.68859655673, 62557.68721156365, 62764.0, 64129.0, 8402.0, 8405.705800297204, 8445.493270403795, 8516.531590762319, 8731.039585645702, 9373.484458354857, 11218.66344009681, 11319.0, 12249.632511024683, 13207.339633018119, 11375.886241137814, 11686.415679216176, 11787.764244715228, 11862.0, 12221.327826969602, 11099.667009989713, 11746.711837385345, 11807.173497855068, 11887.82168267494, 12254.080943929419, 11606.30362178272, 11846.407679616157, 11925.344106073902, 12046.277223366626, 12531.0, 8242.505449673039, 8252.876206857021, 8355.0, 8364.916350836414, 8649.091845356146, 10828.566857325619, 11396.772064558829, 11876.643700688994, 12150.0, 12494.12541122149], "value": 8614.583608892073, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.1755658053203, 1520.7110648976695, 1627.5686942960117, 1746.4236801855388, 1784.4468214853405, 8333.958330208348, 8816.074312197223, 8817.030126686059, 8825.205731484173, 8841.690540831072, 7624.618769061539, 8096.554689492075, 8388.412811103226, 8389.28691061259, 8689.956550217255, 2218.1792736687407, 2266.3314322274887, 2278.293728944024, 2284.4859906521065, 2288.622377307742, 2250.932472025842, 2255.436140964759, 2313.8843057847125, 2314.4445333120098, 2314.756950520188, 2250.4598896264943, 2264.275431861805, 2267.954640907181, 2325.453518423169, 2327.138958585326, 2215.9224427144973, 2217.2793842001333, 2219.933401997943, 2222.388843068153, 2229.108356657334, 2156.5255643758505, 2163.296928498244, 2166.566686662674, 2171.4137182960512, 2172.2071443923014, 8621.741347759576, 8641.30869530436, 8684.522351270678, 8690.348223883171, 8715.43349682275, 5041.72270525121, 5148.639595228298, 5149.201873709543, 5154.587632989352, 5155.0, 3095.086949349947, 3102.10039088664, 3259.071164718068, 3261.46185879332, 3263.396271689745, 1037.4294138223947, 1049.8372752223418, 1052.5631862776938, 1057.370864335719, 1068.8396740488988, 11669.416529173592, 11880.346580938045, 11883.40582970848, 11885.346305953082, 11903.107266955012, 4163.292240319153, 4347.282698354799, 4365.628921541641, 4384.47386313638, 4394.846180383735, 10224.846627300596, 10234.48827558619, 10239.232057595711, 10239.7440063999, 10258.076773090308, 5017.422996355466, 5039.4708555601865, 5048.7728052237735, 5049.899002019939, 5051.62112841531, 3618.9127527338605, 4643.651726120487, 4644.0944015916575, 4657.394538709946, 4767.046590681877, 4010.3783913493453, 4014.8996275092773, 4096.713230073926, 4097.836086556505, 4132.8140233689555, 1248.2136254160002, 1260.212367270456, 1262.27419233939, 1272.6436597752459, 1281.7885048966816, 840.4495055738502, 899.6266549381933, 952.9666461673808, 977.0459081836327, 1040.0535512683423, 5810.4189581041555, 5971.552133589998, 6064.241969753781, 6097.847553811191, 6248.062790581358, 921.755734730297, 944.918068811221, 971.2084651009404, 974.7270764186039, 998.9960090109394, 4208.22147902639, 4260.68044896634, 4283.186194623012, 4327.697061205686, 4335.6965012449455, 10640.148788096934, 10665.093467055387, 10734.516946737416, 10870.510827012804, 10947.890521094847, 10716.303440276357, 10745.14038876888, 10824.945875270574, 10827.566897324019, 10835.079018283534, 7880.172581878935, 7887.3830864673755, 7930.0880398753725, 8046.275835174863, 8069.354451643854, 5745.368009518866, 5746.655200687972, 5774.538036957118, 5840.853978650398, 6007.669578173242, 9447.669331573363, 9552.474613896302, 9636.75908102303, 9670.951645241728, 9688.176504997155, 9148.0, 9592.520373981133, 9616.567254473706, 9770.658026969022, 9783.315167938175, 7534.4725869190825, 7695.384369250334, 7776.455648104805, 7777.144514103331, 7778.766637000899, 8188.713395031145, 8204.384671149806, 8249.587520623825, 8259.174082591693, 8266.793330166553, 7456.589887556236, 7560.6219689016425, 7580.393568514395, 7613.0, 7747.1090824555895, 7421.998030265845, 7490.101187857492, 7515.624218788929, 7594.0, 7609.923900760921, 6982.231954485104, 7183.245759195418, 7248.456365772694, 7349.632518373953, 7352.338289553966, 5128.384593848762, 5134.691918484903, 5213.45258747826, 5254.65844720092, 5344.171653393731, 5202.3497062867145, 5231.372235331784, 5346.25152478661, 5423.267858839006, 5430.185472179047], "value": 4557.331274524535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.64289281790036, 327.2146847565843, 334.7054591959075, 338.5852330894653, 338.6545723362169, 5342.679439233649, 5351.759170837312, 5411.891762164754, 5416.995711586714, 5423.538999185064, 5287.656302340345, 5295.841124766263, 5349.973250133744, 5370.865728356793, 5384.219288203209, 3696.4270538066644, 4009.514766486879, 4032.798360081999, 4136.4415803866395, 4143.482064741907, 4147.523034850986, 4150.418941348214, 4151.0, 4154.854580089697, 4172.5201601815725, 4092.9590704092875, 4121.578055570823, 4123.855665051724, 4126.504819421659, 4145.440365550642, 4021.8994525136814, 4081.8367265309353, 4139.813708383115, 4155.168966206756, 4163.271427500205, 3669.1560940983454, 3686.2443199144377, 3693.7968411737343, 3723.143676954289, 3726.6273372662786, 5145.6398052136365, 5167.767450464738, 5168.198929165986, 5185.066687996159, 5246.711430871301, 4658.930116048262, 4740.265258884844, 4750.4299484061785, 4761.666683332168, 4762.785674644615, 5483.588730845163, 5486.725663716798, 5494.450554944514, 5504.311961004874, 5513.696746678931, 4014.6186112319283, 4028.8187031583648, 4034.374671925856, 4036.777977211252, 4046.8785936421955, 4836.373339432421, 5398.703071331075, 5832.270966129234, 5837.270341207349, 5854.151148083547, 4154.673382905583, 4156.418101465797, 4162.167566486714, 4171.791410429466, 4180.790960452026, 4197.4753155855515, 4208.431861698693, 4210.389493523422, 4220.332968477434, 4225.64082053029, 4791.904161916812, 4797.232442809134, 4804.375431193992, 4809.374781278411, 4820.8794780130775, 5392.676439413648, 5590.0, 5594.580406469531, 5612.719364031782, 5640.210370548127, 1392.6309527975095, 1408.4366253498683, 1409.563035459011, 1412.2303344677175, 1415.8442571317146, 876.6843936182969, 914.3508109242513, 928.4661319741176, 931.6366617019368, 943.2406912435418, 4736.579026292098, 4741.0, 4772.904541909143, 4778.133120127895, 4784.928226076611, 5107.821226257063, 5135.0, 5147.279380886679, 5150.227465880073, 5151.840835811987, 4598.663855113018, 4662.4405071390975, 4805.0, 4830.782614782343, 4833.492483289204, 2665.973340266611, 2684.8120631555994, 2688.5967104934416, 2696.716844731275, 2736.097087960968, 5200.8959820803375, 5292.788288468418, 5337.798995226043, 5353.705546194997, 5368.141097424394, 4939.407271127488, 5187.0, 5215.921761173586, 5218.452062533455, 5268.868278292996, 5614.933162699074, 5784.971075144597, 5838.0, 5916.230889984275, 5921.17103605487, 5662.03745363281, 5710.743016564182, 5710.857228569319, 5721.113227449752, 5744.396838331915, 5430.484104010113, 5632.915506267327, 5652.6043176978865, 5662.716864156858, 5683.431656834284, 5866.09351960606, 5878.118282257525, 5900.790337980789, 5922.970385148046, 5946.375630558729, 3969.960300396959, 3985.103351745834, 3988.7806170659733, 3988.960110398859, 3989.2819292527624, 5539.695316757617, 5664.660120392789, 5681.857953551194, 5711.314642242957, 5748.45389687979, 5557.916631250454, 5560.972195138998, 5563.388027316911, 5570.498655121059, 5572.411862619134, 5364.2490051393615, 5522.392536820867, 5565.6104072714525, 5569.969555632221, 5597.860053498695, 5494.835154945358, 5531.917021244604, 5533.280673512418, 5541.833744987657, 5547.944520554905, 5601.355844077983, 5623.325200975909, 5634.506855683166, 5647.774089036392, 5653.802116925888, 5359.946400535945, 5447.673139611636, 5492.47821456961, 5493.670379777226, 5496.945030549643], "value": 4166.3277093740435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.8250276190619, 823.3824631526355, 859.8048712289914, 865.195368307474, 889.1730690457875, 17703.0, 18444.723329150056, 18594.53513662159, 18610.44168674942, 18963.336283230088, 15711.60720981976, 16180.919095404506, 17109.23008464619, 17273.395431159912, 17327.82672173281, 812.5896422306727, 825.2984962781618, 825.3232349473434, 825.3892119831312, 826.8759686047111, 677.4512644757762, 807.5760225881401, 834.4826207751203, 835.5613303015905, 838.3502785341349, 843.3548335523299, 846.2257034813139, 846.6190214403513, 847.3009766942266, 848.0374774630808, 838.534613289624, 841.7558907916697, 842.2756429470651, 843.0136740014168, 843.0136740014168, 512.9025485157808, 522.1853907903683, 525.6031696069481, 615.2954866677629, 615.938406159385, 15111.773323400157, 15777.763333550007, 15810.683786324324, 15927.522174334788, 15962.920185399114, 14484.565463036126, 14689.559313220621, 15219.467318643905, 15284.617884552865, 15612.843871561367, 12636.0, 12688.302143382203, 12778.808317875239, 12790.936045319806, 13451.260180690058, 3597.280543891206, 3747.344214762433, 3753.887383378503, 3790.8294126764085, 3819.197968426634, 81307.18692813114, 83409.58295208546, 83778.58110709468, 84676.57661711714, 84736.0, 11357.148213883991, 11605.477753501113, 11947.0, 11993.160478766402, 12170.81743773844, 22292.32807539441, 22311.888440557694, 22429.55140897173, 22482.55034899293, 23021.19425820088, 8290.08809031006, 8497.532635705096, 8543.530105844238, 8543.615537300711, 8658.350623703122, 4638.0, 4751.382320298339, 4810.494898035656, 4834.685745426536, 4955.430125535538, 3327.334533093391, 3419.12812232879, 3421.3157368526395, 3424.298018906118, 3437.4671925851535, 562.3111688181945, 569.1235497334059, 627.6391075131818, 660.3297652882328, 667.5794249622707, 771.4831063187678, 778.8714862047811, 790.4822341366414, 797.2415442568777, 809.6605653783695, 9868.457234852009, 10250.470537136245, 10265.846012309821, 10591.0, 10934.125269978382, 638.559394018126, 720.4164626652323, 722.552017748999, 732.1616748822569, 738.7783664900509, 4762.190427627312, 4996.125678006334, 5030.37120359955, 5063.721495317793, 5065.468125846733, 105596.0, 105952.0, 108564.4571777136, 118841.0, 129650.0, 63130.684346577975, 68364.3163568358, 100021.49989250007, 101549.0, 102650.0, 88200.55899720588, 88735.0, 89209.55395222982, 90102.098979012, 91176.0, 9725.610975560898, 9941.25440591973, 10067.496625168566, 10142.391456512632, 10157.695269141937, 48608.756956214995, 49997.75001124971, 50464.23375181851, 54107.72946135244, 54456.0, 74092.62953685196, 75312.62343688247, 76308.0, 77230.6138469304, 78430.11933889204, 12566.0, 12654.810177847156, 12806.1675991064, 12879.291638959947, 12949.417276222404, 14914.0, 15219.467318643794, 15663.843361566238, 16166.67666646637, 16289.104099274653, 13710.931445343109, 14365.497207598102, 14496.420143194155, 15104.0, 15485.070895746292, 13229.801552976905, 13517.729645407233, 15015.624609384417, 15066.09603423798, 15156.545303640909, 14171.929140354232, 14184.0, 14491.0, 14763.557093287218, 14944.850551494346, 10169.33926245348, 11074.11407087415, 11465.31208127515, 11502.0, 11715.707107322385, 11271.549138034714, 11530.365829879438, 11601.0, 11661.708457288636, 11852.348120853436], "value": 7783.315223712649, "unit": "score"}], "name": "dromaeo_css", "value": 7164.332950526122, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 111.0, 111.0, 112.0, 112.0, 110.0, 110.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 118.0, 120.0, 175.0, 118.0, 118.0, 146.0, 123.0, 154.0, 119.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 160.0, 161.0, 159.0, 160.0, 160.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 117.0, 75.0, 76.0, 76.0, 74.0, 112.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 113.0, 84.0, 85.0, 85.0, 120.0, 83.0, 85.0, 130.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 96.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 52.0, 52.0, 53.0, 54.0, 52.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 75.0, 76.0, 76.0, 75.0, 76.0, 75.0, 80.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 127.0, 125.0, 121.0, 122.0, 117.0, 119.0, 127.0, 204.0, 120.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 158.0, 158.0, 154.0, 159.0, 158.0, 159.0, 165.0, 157.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 65.0, 62.0, 62.0, 62.0, 63.0, 63.0, 63.0, 65.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1484.6999999999998, "alertThreshold": 2.0}]} 13:27:55 INFO - Return code: 0 13:27:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:27:55 INFO - # TBPL SUCCESS # 13:27:55 INFO - Running post-action listener: _resource_record_post_action 13:27:55 INFO - [mozharness: 2016-07-28 20:27:55.148197Z] Finished run-tests step (success) 13:27:55 INFO - Running post-run listener: _resource_record_post_run 13:27:55 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 555188224; Read time: 88; Write time: 659168 13:27:55 INFO - TinderboxPrint: CPU usage
13.1% 13:27:55 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 88 13:27:55 INFO - TinderboxPrint: I/O write bytes / time
555,188,224 / 659,168 13:27:55 INFO - TinderboxPrint: CPU idle
8,269.4 (86.9%) 13:27:55 INFO - TinderboxPrint: CPU user
1,199.1 (12.6%) 13:27:55 INFO - TinderboxPrint: Swap in / out
0 / 0 13:27:55 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257441792; Read time: 0; Write time: 370904 13:27:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297746432; Read time: 80; Write time: 288264 13:27:55 INFO - Running post-run listener: _upload_blobber_files 13:27:55 INFO - Blob upload gear active. 13:27:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:27:55 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 13:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:27:56 INFO - (blobuploader) - INFO - Open directory for files ... 13:27:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:27:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:27:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:56 INFO - (blobuploader) - INFO - Done attempting. 13:27:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:00 INFO - (blobuploader) - INFO - Done attempting. 13:28:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:28:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:28:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:01 INFO - (blobuploader) - INFO - Done attempting. 13:28:01 INFO - (blobuploader) - INFO - Iteration through files over. 13:28:01 INFO - Return code: 0 13:28:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c463e7b8c2ade944c07f2e7ca829be34fd24611da70ac2a3d1a8aa92c91a5402bb1b8fdd97131dc49b6c489dd46ec62c7b127d71cb5c2584f374540bbb60c005", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78559dfbf980882cd377eade378635dd2c2bc11d5d76acd2a49918ceb9fbbe7eaef976f1aabe4d9c14c5caefd37de065e8c2947b2e490fde5a14e049a54dadbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0dbd54d06ee707ea1e8150dafddff891d8a121f0a3dcdcbd0f869df05c725b25f12aac13d6330e091346339c524ee0cdf5b31c092afa2c528de9842837ccee9b"} 13:28:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:01 INFO - Contents: 13:28:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c463e7b8c2ade944c07f2e7ca829be34fd24611da70ac2a3d1a8aa92c91a5402bb1b8fdd97131dc49b6c489dd46ec62c7b127d71cb5c2584f374540bbb60c005", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78559dfbf980882cd377eade378635dd2c2bc11d5d76acd2a49918ceb9fbbe7eaef976f1aabe4d9c14c5caefd37de065e8c2947b2e490fde5a14e049a54dadbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0dbd54d06ee707ea1e8150dafddff891d8a121f0a3dcdcbd0f869df05c725b25f12aac13d6330e091346339c524ee0cdf5b31c092afa2c528de9842837ccee9b"} 13:28:01 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:01 INFO - Copying logs to upload dir... 13:28:01 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.869480 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-28 13:28:01.434327) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 13:28:01.438685) ========= 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=826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c463e7b8c2ade944c07f2e7ca829be34fd24611da70ac2a3d1a8aa92c91a5402bb1b8fdd97131dc49b6c489dd46ec62c7b127d71cb5c2584f374540bbb60c005", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78559dfbf980882cd377eade378635dd2c2bc11d5d76acd2a49918ceb9fbbe7eaef976f1aabe4d9c14c5caefd37de065e8c2947b2e490fde5a14e049a54dadbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0dbd54d06ee707ea1e8150dafddff891d8a121f0a3dcdcbd0f869df05c725b25f12aac13d6330e091346339c524ee0cdf5b31c092afa2c528de9842837ccee9b"} build_url:https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/Axlxd560TRyvkrlTHhd5zw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c463e7b8c2ade944c07f2e7ca829be34fd24611da70ac2a3d1a8aa92c91a5402bb1b8fdd97131dc49b6c489dd46ec62c7b127d71cb5c2584f374540bbb60c005", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/78559dfbf980882cd377eade378635dd2c2bc11d5d76acd2a49918ceb9fbbe7eaef976f1aabe4d9c14c5caefd37de065e8c2947b2e490fde5a14e049a54dadbd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0dbd54d06ee707ea1e8150dafddff891d8a121f0a3dcdcbd0f869df05c725b25f12aac13d6330e091346339c524ee0cdf5b31c092afa2c528de9842837ccee9b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 13:28:01.464514) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:28:01.464857) ========= 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=826874ccc97bd7bf541b4875000001d5-1469736446.574738-1315369152 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:28:01.546896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 13:28:01.547215) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 13:28:01.547498) ========= ========= Total master_lag: 0.16 =========