builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1470039720.42 results: success (0) buildid: 20160731223027 builduid: 1ab1df06771248d9a006953ba12b3986 revision: a517dfb9fc0b8512fba4fa28da989758f9347dc6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:00.419752) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:00.420309) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:00.420628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:00.460892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:00.461246) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 01:22:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.7M=0s 2016-08-01 01:22:02 (35.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126569 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:00.602691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:00.603043) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017395 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:00.657963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:00.658429) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a517dfb9fc0b8512fba4fa28da989758f9347dc6 --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 a517dfb9fc0b8512fba4fa28da989758f9347dc6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 01:22:02,295 truncating revision to first 12 chars 2016-08-01 01:22:02,295 Setting DEBUG logging. 2016-08-01 01:22:02,295 attempt 1/10 2016-08-01 01:22:02,295 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a517dfb9fc0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 01:22:02,595 unpacking tar archive at: mozilla-inbound-a517dfb9fc0b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640425 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:01.315612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:01.316252) ========= script_repo_revision: a517dfb9fc0b8512fba4fa28da989758f9347dc6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:01.317041) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:01.317666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 01:22:01.329745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-01 01:22:01.330044) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:22:03 INFO - MultiFileLogger online at 20160801 01:22:03 in /builds/slave/test 01:22:03 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 01:22:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:22:03 INFO - {'append_to_log': False, 01:22:03 INFO - 'base_work_dir': '/builds/slave/test', 01:22:03 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:22:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:22:03 INFO - 'branch': 'Mozilla-Inbound', 01:22:03 INFO - 'buildbot_json_path': 'buildprops.json', 01:22:03 INFO - 'config_files': ('talos/linux_config.py',), 01:22:03 INFO - 'default_actions': ('clobber', 01:22:03 INFO - 'read-buildbot-config', 01:22:03 INFO - 'download-and-extract', 01:22:03 INFO - 'populate-webroot', 01:22:03 INFO - 'create-virtualenv', 01:22:03 INFO - 'install', 01:22:03 INFO - 'run-tests'), 01:22:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:22:03 INFO - 'download_minidump_stackwalk': True, 01:22:03 INFO - 'download_symbols': 'ondemand', 01:22:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:22:03 INFO - 'tooltool.py': '/tools/tooltool.py', 01:22:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:22:03 INFO - '/tools/misc-python/virtualenv.py')}, 01:22:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:22:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:22:03 INFO - 'installer_path': 'installer.exe', 01:22:03 INFO - 'log_level': 'info', 01:22:03 INFO - 'log_name': 'talos', 01:22:03 INFO - 'log_to_console': True, 01:22:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:22:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:22:03 INFO - 'opt_config_files': (), 01:22:03 INFO - 'pip_index': False, 01:22:03 INFO - 'sps_profile': False, 01:22:03 INFO - 'sps_profile_interval': 0, 01:22:03 INFO - 'suite': 'dromaeojs', 01:22:03 INFO - 'system_bits': '32', 01:22:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:22:03 INFO - 'title': 'talos-linux64-ix-035', 01:22:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:22:03 INFO - 'use_talos_json': True, 01:22:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:22:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:22:03 INFO - 'work_dir': 'build'} 01:22:03 INFO - [mozharness: 2016-08-01 08:22:03.057342Z] Running clobber step. 01:22:03 INFO - Running pre-action listener: _resource_record_pre_action 01:22:03 INFO - Running main action method: clobber 01:22:03 INFO - rmtree: /builds/slave/test/build 01:22:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:22:03 INFO - Running post-action listener: _resource_record_post_action 01:22:03 INFO - [mozharness: 2016-08-01 08:22:03.511741Z] Finished clobber step (success) 01:22:03 INFO - [mozharness: 2016-08-01 08:22:03.511842Z] Running read-buildbot-config step. 01:22:03 INFO - Running pre-action listener: _resource_record_pre_action 01:22:03 INFO - Running main action method: read_buildbot_config 01:22:03 INFO - Using buildbot properties: 01:22:03 INFO - { 01:22:03 INFO - "project": "", 01:22:03 INFO - "product": "firefox", 01:22:03 INFO - "script_repo_revision": "production", 01:22:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:22:03 INFO - "repository": "", 01:22:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:22:03 INFO - "buildid": "20160731223027", 01:22:03 INFO - "pgo_build": "True", 01:22:03 INFO - "basedir": "/builds/slave/test", 01:22:03 INFO - "buildnumber": 1330, 01:22:03 INFO - "slavename": "talos-linux64-ix-035", 01:22:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:22:03 INFO - "platform": "ubuntu64_hw", 01:22:03 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:22:03 INFO - "branch": "mozilla-inbound", 01:22:03 INFO - "repo_path": "integration/mozilla-inbound", 01:22:03 INFO - "revision": "a517dfb9fc0b8512fba4fa28da989758f9347dc6", 01:22:03 INFO - "stage_platform": "linux64-pgo", 01:22:03 INFO - "builduid": "1ab1df06771248d9a006953ba12b3986", 01:22:03 INFO - "slavebuilddir": "test" 01:22:03 INFO - } 01:22:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:22:03 INFO - Running post-action listener: _resource_record_post_action 01:22:03 INFO - [mozharness: 2016-08-01 08:22:03.514328Z] Finished read-buildbot-config step (success) 01:22:03 INFO - [mozharness: 2016-08-01 08:22:03.514418Z] Running download-and-extract step. 01:22:03 INFO - Running pre-action listener: _resource_record_pre_action 01:22:03 INFO - Running main action method: download_and_extract 01:22:03 INFO - mkdir: /builds/slave/test/build/tests 01:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:03 INFO - https://queue.taskcluster.net/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:22:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:22:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:22:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/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 01:22:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/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 01:22:13 INFO - Downloaded 1361 bytes. 01:22:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:22:13 INFO - Using the following test package requirements: 01:22:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:22:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:22:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:22:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:13 INFO - u'jsshell-linux-x86_64.zip'], 01:22:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:22:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:22:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:22:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:22:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:22:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:22:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:22:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:13 INFO - https://queue.taskcluster.net/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:22:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:22:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:22:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/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 01:22:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/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 01:22:20 INFO - Downloaded 21808087 bytes. 01:22:20 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'] 01:22:20 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 01:22:21 INFO - Return code: 0 01:22:21 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 01:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:21 INFO - https://queue.taskcluster.net/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:22:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:22:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:22:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/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 01:22:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/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 01:22:22 INFO - Downloaded 21808087 bytes. 01:22:22 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'] 01:22:22 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 01:22:24 INFO - Return code: 0 01:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:24 INFO - https://queue.taskcluster.net/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/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 01:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/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 01:22:25 INFO - Downloaded 14413723 bytes. 01:22:25 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'] 01:22:25 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 01:22:25 INFO - Return code: 0 01:22:25 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')]} 01:22:25 INFO - https://queue.taskcluster.net/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:22:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:22:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:22:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/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 01:22:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WmelMcykQgaVmt6s_FeSyA/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 01:22:27 INFO - Downloaded 59384787 bytes. 01:22:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:22:27 INFO - mkdir: /builds/slave/test/properties 01:22:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:22:27 INFO - Writing to file /builds/slave/test/properties/build_url 01:22:27 INFO - Contents: 01:22:27 INFO - build_url:https://queue.taskcluster.net/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:22:28 INFO - Running post-action listener: _resource_record_post_action 01:22:28 INFO - Running post-action listener: set_extra_try_arguments 01:22:28 INFO - [mozharness: 2016-08-01 08:22:28.095300Z] Finished download-and-extract step (success) 01:22:28 INFO - [mozharness: 2016-08-01 08:22:28.095532Z] Running populate-webroot step. 01:22:28 INFO - Running pre-action listener: _resource_record_pre_action 01:22:28 INFO - Running main action method: populate_webroot 01:22:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:22:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:22:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:22:28 INFO - '--tppagecycles', 01:22:28 INFO - '7'], 01:22:28 INFO - 'tests': ['tsvgm']}}, 01:22:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:22:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:22:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:22:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:22:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:22:28 INFO - 'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:22:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:22:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:22:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:22:28 INFO - 'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['damp', 'tps']}, 01:22:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:22:28 INFO - 'tests': ['damp', 'tps']}, 01:22:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['dromaeo_dom']}, 01:22:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:22:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['basic_compositor_video']}, 01:22:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:22:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['a11yr', 01:22:28 INFO - 'ts_paint', 01:22:28 INFO - 'tpaint', 01:22:28 INFO - 'sessionrestore', 01:22:28 INFO - 'sessionrestore_no_auto_restore', 01:22:28 INFO - 'tabpaint']}, 01:22:28 INFO - 'other-e10s': {'tests': ['a11yr', 01:22:28 INFO - 'ts_paint', 01:22:28 INFO - 'tpaint', 01:22:28 INFO - 'sessionrestore', 01:22:28 INFO - 'sessionrestore_no_auto_restore', 01:22:28 INFO - 'tabpaint']}, 01:22:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:22:28 INFO - 'ts_paint', 01:22:28 INFO - 'tpaint', 01:22:28 INFO - 'sessionrestore', 01:22:28 INFO - 'sessionrestore_no_auto_restore', 01:22:28 INFO - 'tabpaint']}, 01:22:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:22:28 INFO - 'ts_paint', 01:22:28 INFO - 'tpaint', 01:22:28 INFO - 'sessionrestore', 01:22:28 INFO - 'sessionrestore_no_auto_restore', 01:22:28 INFO - 'tabpaint']}, 01:22:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['a11yr', 01:22:28 INFO - 'ts_paint', 01:22:28 INFO - 'tpaint', 01:22:28 INFO - 'sessionrestore', 01:22:28 INFO - 'sessionrestore_no_auto_restore', 01:22:28 INFO - 'tabpaint']}, 01:22:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['a11yr', 01:22:28 INFO - 'ts_paint', 01:22:28 INFO - 'tpaint', 01:22:28 INFO - 'sessionrestore', 01:22:28 INFO - 'sessionrestore_no_auto_restore', 01:22:28 INFO - 'tabpaint']}, 01:22:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['tsvgx', 01:22:28 INFO - 'tsvgr_opacity', 01:22:28 INFO - 'tart', 01:22:28 INFO - 'tscrollx', 01:22:28 INFO - 'cart']}, 01:22:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:22:28 INFO - 'tsvgr_opacity', 01:22:28 INFO - 'tart', 01:22:28 INFO - 'tscrollx', 01:22:28 INFO - 'cart']}, 01:22:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:22:28 INFO - 'talos_options': ['--disable-e10s'], 01:22:28 INFO - 'tests': ['tp5o']}, 01:22:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:22:28 INFO - 'tests': ['tp5o']}, 01:22:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:22:28 INFO - 'talos_options': ['--disable-e10s', 01:22:28 INFO - '--xperf_path', 01:22:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:22:28 INFO - 'tests': ['tp5n']}, 01:22:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:22:28 INFO - 'talos_options': ['--xperf_path', 01:22:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:22:28 INFO - 'tests': ['tp5n']}}, 01:22:28 INFO - 'talos.zip': {'path': '', 01:22:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:22:28 INFO - Running post-action listener: _resource_record_post_action 01:22:28 INFO - [mozharness: 2016-08-01 08:22:28.117570Z] Finished populate-webroot step (success) 01:22:28 INFO - [mozharness: 2016-08-01 08:22:28.117667Z] Running create-virtualenv step. 01:22:28 INFO - Running pre-action listener: _resource_record_pre_action 01:22:28 INFO - Running main action method: create_virtualenv 01:22:28 INFO - Creating virtualenv /builds/slave/test/build/venv 01:22:28 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 01:22:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:22:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:22:28 INFO - Using real prefix '/usr' 01:22:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:22:28 INFO - Installing distribute.............................................................................................................................................................................................done. 01:22:30 INFO - Installing pip.................done. 01:22:30 INFO - Return code: 0 01:22:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', '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 01:22:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:22:30 INFO - Using env: {'DISPLAY': ':0', 01:22:30 INFO - 'HOME': '/home/cltbld', 01:22:30 INFO - 'LANG': 'en_US.UTF-8', 01:22:30 INFO - 'LANGUAGE': 'en_US:en', 01:22:30 INFO - 'LOGNAME': 'cltbld', 01:22:30 INFO - 'MAIL': '/var/mail/cltbld', 01:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:30 INFO - 'MOZ_NO_REMOTE': '1', 01:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:30 INFO - 'NO_EM_RESTART': '1', 01:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:30 INFO - 'PWD': '/builds/slave/test', 01:22:30 INFO - 'SHELL': '/bin/bash', 01:22:30 INFO - 'SHLVL': '1', 01:22:30 INFO - 'TERM': 'linux', 01:22:30 INFO - 'TMOUT': '86400', 01:22:30 INFO - 'USER': 'cltbld', 01:22:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:30 INFO - '_': '/tools/buildbot/bin/python'} 01:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:30 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 01:22:30 INFO - Cleaning up... 01:22:30 INFO - Return code: 0 01:22:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', '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 01:22:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:22:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:22:30 INFO - Using env: {'DISPLAY': ':0', 01:22:30 INFO - 'HOME': '/home/cltbld', 01:22:30 INFO - 'LANG': 'en_US.UTF-8', 01:22:30 INFO - 'LANGUAGE': 'en_US:en', 01:22:30 INFO - 'LOGNAME': 'cltbld', 01:22:30 INFO - 'MAIL': '/var/mail/cltbld', 01:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:30 INFO - 'MOZ_NO_REMOTE': '1', 01:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:30 INFO - 'NO_EM_RESTART': '1', 01:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:30 INFO - 'PWD': '/builds/slave/test', 01:22:30 INFO - 'SHELL': '/bin/bash', 01:22:30 INFO - 'SHLVL': '1', 01:22:30 INFO - 'TERM': 'linux', 01:22:30 INFO - 'TMOUT': '86400', 01:22:30 INFO - 'USER': 'cltbld', 01:22:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:30 INFO - '_': '/tools/buildbot/bin/python'} 01:22:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:31 INFO - Downloading/unpacking psutil>=3.1.1 01:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:22:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:22:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:22:33 INFO - Installing collected packages: psutil 01:22:33 INFO - Running setup.py install for psutil 01:22:33 INFO - building 'psutil._psutil_linux' extension 01:22:33 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 01:22:33 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 01:22:33 INFO - building 'psutil._psutil_posix' extension 01:22:33 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 01:22:33 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 01:22:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:22:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:22:33 INFO - Successfully installed psutil 01:22:33 INFO - Cleaning up... 01:22:33 INFO - Return code: 0 01:22:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', '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 01:22:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:22:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:22:33 INFO - Using env: {'DISPLAY': ':0', 01:22:33 INFO - 'HOME': '/home/cltbld', 01:22:33 INFO - 'LANG': 'en_US.UTF-8', 01:22:33 INFO - 'LANGUAGE': 'en_US:en', 01:22:33 INFO - 'LOGNAME': 'cltbld', 01:22:33 INFO - 'MAIL': '/var/mail/cltbld', 01:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:33 INFO - 'MOZ_NO_REMOTE': '1', 01:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:33 INFO - 'NO_EM_RESTART': '1', 01:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:33 INFO - 'PWD': '/builds/slave/test', 01:22:33 INFO - 'SHELL': '/bin/bash', 01:22:33 INFO - 'SHLVL': '1', 01:22:33 INFO - 'TERM': 'linux', 01:22:33 INFO - 'TMOUT': '86400', 01:22:33 INFO - 'USER': 'cltbld', 01:22:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:33 INFO - '_': '/tools/buildbot/bin/python'} 01:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:22:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:22:35 INFO - Installing collected packages: mozsystemmonitor 01:22:35 INFO - Running setup.py install for mozsystemmonitor 01:22:35 INFO - Successfully installed mozsystemmonitor 01:22:35 INFO - Cleaning up... 01:22:35 INFO - Return code: 0 01:22:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:22: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')]} 01:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22: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')]} 01:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:35 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', '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 01:22:35 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 01:22:35 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 01:22:35 INFO - Using env: {'DISPLAY': ':0', 01:22:35 INFO - 'HOME': '/home/cltbld', 01:22:35 INFO - 'LANG': 'en_US.UTF-8', 01:22:35 INFO - 'LANGUAGE': 'en_US:en', 01:22:35 INFO - 'LOGNAME': 'cltbld', 01:22:35 INFO - 'MAIL': '/var/mail/cltbld', 01:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:35 INFO - 'MOZ_NO_REMOTE': '1', 01:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:35 INFO - 'NO_EM_RESTART': '1', 01:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:35 INFO - 'PWD': '/builds/slave/test', 01:22:35 INFO - 'SHELL': '/bin/bash', 01:22:35 INFO - 'SHLVL': '1', 01:22:35 INFO - 'TERM': 'linux', 01:22:35 INFO - 'TMOUT': '86400', 01:22:35 INFO - 'USER': 'cltbld', 01:22:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:35 INFO - '_': '/tools/buildbot/bin/python'} 01:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:36 INFO - Downloading/unpacking jsonschema==2.5.1 01:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:22:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:38 INFO - Downloading functools32-3.2.3-2.tar.gz 01:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:22:38 INFO - warning: no files found matching '*.txt' 01:22:38 INFO - no previously-included directories found matching 'build' 01:22:38 INFO - no previously-included directories found matching 'dist' 01:22:38 INFO - no previously-included directories found matching '.git*' 01:22:38 INFO - Installing collected packages: jsonschema, functools32 01:22:38 INFO - Running setup.py install for functools32 01:22:38 INFO - warning: no files found matching '*.txt' 01:22:38 INFO - no previously-included directories found matching 'build' 01:22:38 INFO - no previously-included directories found matching 'dist' 01:22:38 INFO - no previously-included directories found matching '.git*' 01:22:38 INFO - Successfully installed jsonschema functools32 01:22:38 INFO - Cleaning up... 01:22:38 INFO - Return code: 0 01:22:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:22: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')]} 01:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22: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')]} 01:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', '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 01:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:22:38 INFO - Using env: {'DISPLAY': ':0', 01:22:38 INFO - 'HOME': '/home/cltbld', 01:22:38 INFO - 'LANG': 'en_US.UTF-8', 01:22:38 INFO - 'LANGUAGE': 'en_US:en', 01:22:38 INFO - 'LOGNAME': 'cltbld', 01:22:38 INFO - 'MAIL': '/var/mail/cltbld', 01:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:38 INFO - 'MOZ_NO_REMOTE': '1', 01:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:38 INFO - 'NO_EM_RESTART': '1', 01:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:38 INFO - 'PWD': '/builds/slave/test', 01:22:38 INFO - 'SHELL': '/bin/bash', 01:22:38 INFO - 'SHLVL': '1', 01:22:38 INFO - 'TERM': 'linux', 01:22:38 INFO - 'TMOUT': '86400', 01:22:38 INFO - 'USER': 'cltbld', 01:22:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:38 INFO - '_': '/tools/buildbot/bin/python'} 01:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:22:38 INFO - Cleaning up... 01:22:38 INFO - Return code: 0 01:22:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:22: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')]} 01:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22: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')]} 01:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', '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 01:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:22:38 INFO - Using env: {'DISPLAY': ':0', 01:22:38 INFO - 'HOME': '/home/cltbld', 01:22:38 INFO - 'LANG': 'en_US.UTF-8', 01:22:38 INFO - 'LANGUAGE': 'en_US:en', 01:22:38 INFO - 'LOGNAME': 'cltbld', 01:22:38 INFO - 'MAIL': '/var/mail/cltbld', 01:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:38 INFO - 'MOZ_NO_REMOTE': '1', 01:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:38 INFO - 'NO_EM_RESTART': '1', 01:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:38 INFO - 'PWD': '/builds/slave/test', 01:22:38 INFO - 'SHELL': '/bin/bash', 01:22:38 INFO - 'SHLVL': '1', 01:22:38 INFO - 'TERM': 'linux', 01:22:38 INFO - 'TMOUT': '86400', 01:22:38 INFO - 'USER': 'cltbld', 01:22:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:38 INFO - '_': '/tools/buildbot/bin/python'} 01:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:38 INFO - Downloading/unpacking blobuploader==1.2.4 01:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:40 INFO - Downloading blobuploader-1.2.4.tar.gz 01:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:22:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:22:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:22:41 INFO - Downloading docopt-0.6.1.tar.gz 01:22:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:22:41 INFO - Installing collected packages: blobuploader, requests, docopt 01:22:41 INFO - Running setup.py install for blobuploader 01:22:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:22:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:22:41 INFO - Running setup.py install for requests 01:22:41 INFO - Running setup.py install for docopt 01:22:42 INFO - Successfully installed blobuploader requests docopt 01:22:42 INFO - Cleaning up... 01:22:42 INFO - Return code: 0 01:22:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:42 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', '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 01:22:42 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 01:22:42 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 01:22:42 INFO - Using env: {'DISPLAY': ':0', 01:22:42 INFO - 'HOME': '/home/cltbld', 01:22:42 INFO - 'LANG': 'en_US.UTF-8', 01:22:42 INFO - 'LANGUAGE': 'en_US:en', 01:22:42 INFO - 'LOGNAME': 'cltbld', 01:22:42 INFO - 'MAIL': '/var/mail/cltbld', 01:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:42 INFO - 'MOZ_NO_REMOTE': '1', 01:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:42 INFO - 'NO_EM_RESTART': '1', 01:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:42 INFO - 'PWD': '/builds/slave/test', 01:22:42 INFO - 'SHELL': '/bin/bash', 01:22:42 INFO - 'SHLVL': '1', 01:22:42 INFO - 'TERM': 'linux', 01:22:42 INFO - 'TMOUT': '86400', 01:22:42 INFO - 'USER': 'cltbld', 01:22:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:42 INFO - '_': '/tools/buildbot/bin/python'} 01:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:22:42 INFO - Running setup.py (path:/tmp/pip-HzK_Yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:22:42 INFO - Running setup.py (path:/tmp/pip-jqXYcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:22:42 INFO - Running setup.py (path:/tmp/pip-jtLntm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:22:42 INFO - Running setup.py (path:/tmp/pip-GuXIgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:22:42 INFO - Running setup.py (path:/tmp/pip-b1IYp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:22:42 INFO - Running setup.py (path:/tmp/pip-PKGadA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:22:42 INFO - Running setup.py (path:/tmp/pip-_GG32O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:22:42 INFO - Running setup.py (path:/tmp/pip-AUa28C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:22:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:22:42 INFO - Running setup.py (path:/tmp/pip-tmt0FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:22:43 INFO - Running setup.py (path:/tmp/pip-g0PY3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:22:43 INFO - Running setup.py (path:/tmp/pip-RNNUmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:22:43 INFO - Running setup.py (path:/tmp/pip-mCLVDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:22:43 INFO - Running setup.py (path:/tmp/pip-GJ1OhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:22:43 INFO - Running setup.py (path:/tmp/pip-a99Z3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:22:43 INFO - Running setup.py (path:/tmp/pip-_PFM6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:22:43 INFO - Running setup.py (path:/tmp/pip-9ykXXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:22:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:22:43 INFO - Running setup.py (path:/tmp/pip-BLZjy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:22:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:22:43 INFO - Running setup.py install for manifestparser 01:22:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:22:43 INFO - Running setup.py install for mozcrash 01:22:43 INFO - Running setup.py install for mozdebug 01:22:43 INFO - Running setup.py install for mozdevice 01:22:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:22:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Running setup.py install for mozfile 01:22:44 INFO - Running setup.py install for mozhttpd 01:22:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Running setup.py install for mozinfo 01:22:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Running setup.py install for mozInstall 01:22:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Running setup.py install for mozleak 01:22:44 INFO - Running setup.py install for mozlog 01:22:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Running setup.py install for moznetwork 01:22:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Running setup.py install for mozprocess 01:22:44 INFO - Running setup.py install for mozprofile 01:22:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:22:44 INFO - Running setup.py install for mozrunner 01:22:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:22:45 INFO - Running setup.py install for mozscreenshot 01:22:45 INFO - Running setup.py install for moztest 01:22:45 INFO - Running setup.py install for mozversion 01:22:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:22:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:22:45 INFO - Cleaning up... 01:22:45 INFO - Return code: 0 01:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:22:45 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')]} 01:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:45 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')]} 01:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:45 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', '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 01:22:45 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 01:22:45 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 01:22:45 INFO - Using env: {'DISPLAY': ':0', 01:22:45 INFO - 'HOME': '/home/cltbld', 01:22:45 INFO - 'LANG': 'en_US.UTF-8', 01:22:45 INFO - 'LANGUAGE': 'en_US:en', 01:22:45 INFO - 'LOGNAME': 'cltbld', 01:22:45 INFO - 'MAIL': '/var/mail/cltbld', 01:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:45 INFO - 'MOZ_NO_REMOTE': '1', 01:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:45 INFO - 'NO_EM_RESTART': '1', 01:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:45 INFO - 'PWD': '/builds/slave/test', 01:22:45 INFO - 'SHELL': '/bin/bash', 01:22:45 INFO - 'SHLVL': '1', 01:22:45 INFO - 'TERM': 'linux', 01:22:45 INFO - 'TMOUT': '86400', 01:22:45 INFO - 'USER': 'cltbld', 01:22:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:45 INFO - '_': '/tools/buildbot/bin/python'} 01:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:22:45 INFO - Running setup.py (path:/tmp/pip-oDjFBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:22:45 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)) 01:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:22:45 INFO - Running setup.py (path:/tmp/pip-s5p_Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:22:45 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)) 01:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:22:45 INFO - Running setup.py (path:/tmp/pip-zz2vza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:22:45 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)) 01:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:22:45 INFO - Running setup.py (path:/tmp/pip-PCdnaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:22:45 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)) 01:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:22:45 INFO - Running setup.py (path:/tmp/pip-kyIiQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:22:45 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)) 01:22:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:22:45 INFO - Running setup.py (path:/tmp/pip-CqffJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:22:46 INFO - Running setup.py (path:/tmp/pip-lTvxeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:22:46 INFO - Running setup.py (path:/tmp/pip-ZrE4xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:22:46 INFO - Running setup.py (path:/tmp/pip-j92J8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:22:46 INFO - Running setup.py (path:/tmp/pip-MmdBPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:22:46 INFO - Running setup.py (path:/tmp/pip-fTcTxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:22:46 INFO - Running setup.py (path:/tmp/pip-ShUUNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:22:46 INFO - Running setup.py (path:/tmp/pip-qq9gHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:22:46 INFO - Running setup.py (path:/tmp/pip-kjSWIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:22:46 INFO - Running setup.py (path:/tmp/pip-bqE33Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:22:46 INFO - Running setup.py (path:/tmp/pip-atAbUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:22:46 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)) 01:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:22:46 INFO - Running setup.py (path:/tmp/pip-yBMGbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:22:46 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)) 01:22:46 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)) 01:22:46 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)) 01:22:46 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)) 01:22:46 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)) 01:22:46 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)) 01:22:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:22: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 01:22: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 01:22: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 01:22: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 01:22: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 01:22: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 01:22:48 INFO - Downloading blessings-1.6.tar.gz 01:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:22:48 INFO - Installing collected packages: blessings 01:22:48 INFO - Running setup.py install for blessings 01:22:48 INFO - Successfully installed blessings 01:22:48 INFO - Cleaning up... 01:22:48 INFO - Return code: 0 01:22:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:22:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:22:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:22:49 INFO - Reading from file tmpfile_stdout 01:22:49 INFO - Current package versions: 01:22:49 INFO - argparse == 1.2.1 01:22:49 INFO - blessings == 1.6 01:22:49 INFO - blobuploader == 1.2.4 01:22:49 INFO - docopt == 0.6.1 01:22:49 INFO - functools32 == 3.2.3-2 01:22:49 INFO - jsonschema == 2.5.1 01:22:49 INFO - manifestparser == 1.1 01:22:49 INFO - mozInstall == 1.12 01:22:49 INFO - mozcrash == 0.17 01:22:49 INFO - mozdebug == 0.1 01:22:49 INFO - mozdevice == 0.48 01:22:49 INFO - mozfile == 1.2 01:22:49 INFO - mozhttpd == 0.7 01:22:49 INFO - mozinfo == 0.9 01:22:49 INFO - mozleak == 0.1 01:22:49 INFO - mozlog == 3.3 01:22:49 INFO - moznetwork == 0.27 01:22:49 INFO - mozprocess == 0.23 01:22:49 INFO - mozprofile == 0.28 01:22:49 INFO - mozrunner == 6.12 01:22:49 INFO - mozscreenshot == 0.1 01:22:49 INFO - mozsystemmonitor == 0.3 01:22:49 INFO - moztest == 0.7 01:22:49 INFO - mozversion == 1.4 01:22:49 INFO - psutil == 3.1.1 01:22:49 INFO - requests == 1.2.3 01:22:49 INFO - wsgiref == 0.1.2 01:22:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:22:49 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')]} 01:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:49 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')]} 01:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:49 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', '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 01:22:49 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 01:22:49 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 01:22:49 INFO - Using env: {'DISPLAY': ':0', 01:22:49 INFO - 'HOME': '/home/cltbld', 01:22:49 INFO - 'LANG': 'en_US.UTF-8', 01:22:49 INFO - 'LANGUAGE': 'en_US:en', 01:22:49 INFO - 'LOGNAME': 'cltbld', 01:22:49 INFO - 'MAIL': '/var/mail/cltbld', 01:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:49 INFO - 'MOZ_NO_REMOTE': '1', 01:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:49 INFO - 'NO_EM_RESTART': '1', 01:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:49 INFO - 'PWD': '/builds/slave/test', 01:22:49 INFO - 'SHELL': '/bin/bash', 01:22:49 INFO - 'SHLVL': '1', 01:22:49 INFO - 'TERM': 'linux', 01:22:49 INFO - 'TMOUT': '86400', 01:22:49 INFO - 'USER': 'cltbld', 01:22:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:49 INFO - '_': '/tools/buildbot/bin/python'} 01:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:49 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)) 01:22:49 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)) 01:22:49 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)) 01:22:49 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)) 01:22:49 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)) 01:22:49 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)) 01:22:49 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)) 01:22:49 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)) 01:22:49 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)) 01:22:49 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)) 01:22:49 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)) 01:22:49 INFO - Cleaning up... 01:22:49 INFO - Return code: 0 01:22:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:22:49 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')]} 01:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:49 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')]} 01:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:22:49 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 0x1ce5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fa6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', '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 01:22:49 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 01:22:49 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 01:22:49 INFO - Using env: {'DISPLAY': ':0', 01:22:49 INFO - 'HOME': '/home/cltbld', 01:22:49 INFO - 'LANG': 'en_US.UTF-8', 01:22:49 INFO - 'LANGUAGE': 'en_US:en', 01:22:49 INFO - 'LOGNAME': 'cltbld', 01:22:49 INFO - 'MAIL': '/var/mail/cltbld', 01:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:22:49 INFO - 'MOZ_NO_REMOTE': '1', 01:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:22:49 INFO - 'NO_EM_RESTART': '1', 01:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:22:49 INFO - 'PWD': '/builds/slave/test', 01:22:49 INFO - 'SHELL': '/bin/bash', 01:22:49 INFO - 'SHLVL': '1', 01:22:49 INFO - 'TERM': 'linux', 01:22:49 INFO - 'TMOUT': '86400', 01:22:49 INFO - 'USER': 'cltbld', 01:22:49 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:22:49 INFO - '_': '/tools/buildbot/bin/python'} 01:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:22:49 INFO - Cleaning up... 01:22:49 INFO - Return code: 0 01:22:49 INFO - Running post-action listener: _resource_record_post_action 01:22:49 INFO - Running post-action listener: _start_resource_monitoring 01:22:49 INFO - Starting resource monitoring. 01:22:49 INFO - [mozharness: 2016-08-01 08:22:49.652865Z] Finished create-virtualenv step (success) 01:22:49 INFO - [mozharness: 2016-08-01 08:22:49.653421Z] Running install step. 01:22:49 INFO - Running pre-action listener: _resource_record_pre_action 01:22:49 INFO - Running main action method: install 01:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:22:49 INFO - Reading from file tmpfile_stdout 01:22:49 INFO - Detecting whether we're running mozinstall >=1.0... 01:22:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:22:49 INFO - Reading from file tmpfile_stdout 01:22:49 INFO - Output received: 01:22:49 INFO - Usage: mozinstall [options] installer 01:22:49 INFO - Options: 01:22:49 INFO - -h, --help show this help message and exit 01:22:49 INFO - -d DEST, --destination=DEST 01:22:49 INFO - Directory to install application into. [default: 01:22:49 INFO - "/builds/slave/test"] 01:22:49 INFO - --app=APP Application being installed. [default: firefox] 01:22:49 INFO - mkdir: /builds/slave/test/build/application 01:22:49 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'] 01:22:49 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 01:23:06 INFO - Reading from file tmpfile_stdout 01:23:06 INFO - Output received: 01:23:06 INFO - /builds/slave/test/build/application/firefox/firefox 01:23:06 INFO - Running post-action listener: _resource_record_post_action 01:23:06 INFO - [mozharness: 2016-08-01 08:23:06.902164Z] Finished install step (success) 01:23:06 INFO - [mozharness: 2016-08-01 08:23:06.902438Z] Running run-tests step. 01:23:06 INFO - Running pre-action listener: _resource_record_pre_action 01:23:06 INFO - Running main action method: run_tests 01:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:23:06 INFO - Python 2.7.3 01:23:06 INFO - Return code: 0 01:23:06 INFO - grabbing minidump binary from tooltool 01:23:06 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')]} 01:23:06 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 0x1fa43b0>, '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 0x1fa52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fa5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:23:06 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 01:23:06 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 01:23:06 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 01:23:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:23:06 INFO - Return code: 0 01:23:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:23:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:23:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:23:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:23:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:23:06 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/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:23:06 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/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:23:06 INFO - Using env: {'DISPLAY': ':0', 01:23:06 INFO - 'HOME': '/home/cltbld', 01:23:06 INFO - 'LANG': 'en_US.UTF-8', 01:23:06 INFO - 'LANGUAGE': 'en_US:en', 01:23:06 INFO - 'LOGNAME': 'cltbld', 01:23:06 INFO - 'MAIL': '/var/mail/cltbld', 01:23:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:23:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:06 INFO - 'MOZ_NO_REMOTE': '1', 01:23:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:06 INFO - 'NO_EM_RESTART': '1', 01:23:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:06 INFO - 'PWD': '/builds/slave/test', 01:23:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:23:06 INFO - 'SHELL': '/bin/bash', 01:23:06 INFO - 'SHLVL': '1', 01:23:06 INFO - 'TERM': 'linux', 01:23:06 INFO - 'TMOUT': '86400', 01:23:06 INFO - 'USER': 'cltbld', 01:23:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623', 01:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:06 INFO - '_': '/tools/buildbot/bin/python'} 01:23:06 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/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:23:07 INFO - mozversion application_buildid: 20160731223027 01:23:07 INFO - mozversion application_changeset: a517dfb9fc0b8512fba4fa28da989758f9347dc6 01:23:07 INFO - mozversion application_display_name: Nightly 01:23:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:23:07 INFO - mozversion application_name: Firefox 01:23:07 INFO - mozversion application_remotingname: firefox 01:23:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:23:07 INFO - mozversion application_vendor: Mozilla 01:23:07 INFO - mozversion application_version: 50.0a1 01:23:07 INFO - mozversion platform_buildid: 20160731223027 01:23:07 INFO - mozversion platform_changeset: a517dfb9fc0b8512fba4fa28da989758f9347dc6 01:23:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:23:07 INFO - mozversion platform_version: 50.0a1 01:23:07 INFO - using testdate: 1470039787 01:23:07 INFO - actual date: 1470039787 01:23:07 INFO - starting webserver on 'localhost:47848' 01:23:07 INFO - SUITE-START | Running 2 tests 01:23:07 INFO - TEST-START | dromaeo_css 01:23:07 INFO - operating with platform_type : linux_ 01:23:07 INFO - Initialising browser for dromaeo_css test... 01:23:07 INFO - TEST-INFO | started process 8491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMLrvw/profile http://localhost:47848/getInfo.html) 01:23:11 INFO - PROCESS | 8491 | __metrics Screen width/height:1600/1200 01:23:11 INFO - PROCESS | 8491 | colorDepth:24 01:23:11 INFO - PROCESS | 8491 | Browser inner width/height: 1024/697 01:23:11 INFO - PROCESS | 8491 | __metrics 01:23:11 INFO - PROCESS | 8491 | 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" 01:23:11 INFO - PROCESS | 8491 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:23:12 INFO - PROCESS | 8491 | console.error: PushService: 01:23:12 INFO - PROCESS | 8491 | stateChangeProcessEnqueue: Error transitioning state 01:23:12 INFO - PROCESS | 8491 | UnknownError 01:23:12 INFO - TEST-INFO | 8491: exit 0 01:23:12 INFO - Browser initialized. 01:23:12 INFO - Running cycle 1/1 for dromaeo_css test... 01:23:12 INFO - TEST-INFO | started process 8570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwMLrvw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:23:24 INFO - PROCESS | 8570 | RSS: Main: 156696576 01:23:24 INFO - PROCESS | 8570 | 01:24:15 INFO - PROCESS | 8570 | 1470039855391 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] 01:26:24 INFO - PROCESS | 8570 | Cycle 1(1): loaded http://localhost:47848/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47848/tests/dromaeo/cssquery-ext.html) 01:26:25 INFO - PROCESS | 8570 | RSS: Main: 259375104 01:26:25 INFO - PROCESS | 8570 | 01:29:27 INFO - PROCESS | 8570 | Cycle 1(1): loaded http://localhost:47848/tests/dromaeo/cssquery-ext.html (next: http://localhost:47848/tests/dromaeo/cssquery-jquery.html) 01:29:28 INFO - PROCESS | 8570 | RSS: Main: 237305856 01:29:28 INFO - PROCESS | 8570 | 01:32:30 INFO - PROCESS | 8570 | Cycle 1(1): loaded http://localhost:47848/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47848/tests/dromaeo/cssquery-mootools.html) 01:32:30 INFO - PROCESS | 8570 | RSS: Main: 185401344 01:32:30 INFO - PROCESS | 8570 | 01:35:32 INFO - PROCESS | 8570 | Cycle 1(1): loaded http://localhost:47848/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47848/tests/dromaeo/cssquery-prototype.html) 01:35:33 INFO - PROCESS | 8570 | RSS: Main: 226062336 01:35:33 INFO - PROCESS | 8570 | 01:38:36 INFO - PROCESS | 8570 | Cycle 1(1): loaded http://localhost:47848/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47848/tests/dromaeo/cssquery-yui.html) 01:38:36 INFO - PROCESS | 8570 | RSS: Main: 184823808 01:38:36 INFO - PROCESS | 8570 | 01:41:39 INFO - PROCESS | 8570 | Cycle 1(1): loaded http://localhost:47848/tests/dromaeo/cssquery-yui.html (next: http://localhost:47848/tests/dromaeo/cssquery-dojo.html) 01:41:39 INFO - PROCESS | 8570 | RSS: Main: 277245952 01:41:39 INFO - PROCESS | 8570 | 01:41:39 INFO - PROCESS | 8570 | __start_tp_report 01:41:39 INFO - PROCESS | 8570 | _x_x_mozilla_page_load 01:41:39 INFO - PROCESS | 8570 | _x_x_mozilla_page_load_details 01:41:39 INFO - PROCESS | 8570 | |i|pagename|runs| 01:41:39 INFO - PROCESS | 8570 | |0;dojo.html;3019.2300963254365;3020.9848950755245;3038.817670939744;3056.129003234079;3076.200187951132;5035.773390197441;5072.74636268187;5187.844364669057;5239.292695486109;5255.658382205159;5178.559822415099;5265.104932161532;5270.868228294285;5287.233351164079;5327.174287985359;4719.69321994071;4743.76281185941;4805.807767689305;4824.927626085611;4915.950840491585;4845.442774080973;4877.70733755974;4896.265560165968;4911;4912.975435122819;4667.7199368037855;4722.433308003027;4728.054389122155;4791.041791641685;4847.587955023827;4731.077439899221;4736.692115012514;4748.145333839908;4753.120672675566;4843.152448321565;4679.110968915895;4701.271302948048;4703.7883295251795;4744.478107408182;4757;5023.271625614302;5166.199239117943;5200.479952004807;5222.529972302473;5237.6071794615555;5592.7762889484375;5635.267415236034;5638.295213098363;5642.294713160855;5642.802501912413;5663.8584035399035;5667.093265077609;5677.432256774331;5705.343885453184;5733.025385684444;5131;5199.0381779370555;5230.973845130826;5241.580673546107;5245.423003469616;5802.21670074543;5805.013147764806;5811.912821307684;5812.854678633068;5814.476697097197;5572.442755724395;5578.97210513953;5580.972095139579;5581.246531718247;5587.38538760736;5460.290162278958;5500.697461639568;5555.861103472445;5645;5652.463016013472;5575.52608028314;5578.609497335228;5580.35825880029;5619.6347237430255;5626.2685850839125;5543.805966791143;5586.050371436865;5593.356763972195;5597.272354593958;5600.803971860965;4228.767417792051;4263.829446822155;4265.168292182994;4283.164782867373;4364.62900653448;3812.542494900574;3863.74885632433;3868.96131038686;3873.283442563135;3947.684185265172;5348.893022139536;5350.839474815684;5352.116900711417;5353.4646535346155;5395.190721391823;5407.891842163135;5605.271314729059;5607.635503692247;5607.915881261784;5650.971745141248;5304.071787437183;5334.91997620036;5335.706536140472;5363.2759577456545;5422.8373148805595;4905.632077594195;4911.607071434277;4917.852464426073;4918.385201849769;4956.10790057793;5741.684207368635;5897.410258974154;5940.435658612425;5941.257342832146;5948.7323070461935;5604.719764011702;5631.690257035739;5639.88720225585;5655.660660360391;5758.510526605285;5890.676012819336;5924.437178468039;5941.702914854326;5954.19618351517;5956.851078723066;5341.65279256847;5512;5594.188842617879;5601.187827764869;5604.915926261191;5458.61789674719;5490.313710786152;5498.532624726943;5529.364123125731;5565.220869078414;5372.7582258797665;5411.512963833116;5414.648047876875;5416.539594134542;5423.62034657586;5377.435369286169;5389.51494365509;5392.08334583114;5395.163749618815;5441.7551210196425;5433.619646624698;5469.726513674221;5486.259354987025;5490.478404551562;5543.3902270751;5577.330720313588;5577.414371491097;5618.4662457066515;5625.184348269559;5638.069718496567;5182.404023537341;5429.294191755047;5434.456554344534;5436.3476382834315;5440.918386224131 01:41:39 INFO - PROCESS | 8570 | |1;ext.html;601.7803501721872;609.135028259871;618.193257798573;641.9775307864224;651.7360469010052;32198.195045123884;43375;44538.33192502115;44549.77725111378;44630.33054504177;45352.77323613386;45504.317435238496;45849.541504584944;45874.77062614682;45917.54082459174;9030.458172509638;9173.128552787475;9174.08259174084;9180.678676246333;9181.127792859668;8944.239739622108;9000.8649870252;9017.053209413016;9020.77448063797;9037.864432033524;9026.097390260988;9075.727728168165;9092.136247056553;9095.090490950919;9101.089891010912;8979.326550508706;8981.236594889442;9012.954935225282;9026.593803278869;9028.638854445815;8940.418872773249;8996.460212387277;9016.098390160996;9024;9025.729228123168;42377.36433953493;42695;42833.35749963753;42989;43109.13781724379;3546.8935931922083;3597.190632107781;3615.367310720613;3738.401855703102;4075.53131389891;33024.834875825465;33076;33372;33435.83282083598;34627.4805877912;4395.406620106277;4443.266860967937;4552.362669226311;4570.451545814523;4619.030003699228;346079;348458;349374;351590;352901.99999999744;51803.222951655756;58395.70802145962;58534.41465585375;58573.414265857646;58688.413115868294;59955;61423.6928815362;61503.384966149766;65726;65774;14692.853071469362;14835.03572267799;14837.10977341363;14838.258087095603;14853.183074930983;10755.784884302426;11338.206325557298;11396.658100257006;11429.428528573704;11429.828552571718;16745.916270418813;17306.394276200273;17369.13154342278;17407.73888391675;17705.557361065818;6587.29920732507;6610.570312929644;6745.628990405575;6823.33889782985;6885.1049363582415;954.231843366097;956.9425834449816;975.3221511049752;986.6743974488402;1088.0751361342955;32720.34559308848;32768.01695949125;32855.342893142006;32938.50592241118;33383.49924751131;1031.5358088860044;1118.5637601335486;1144.7367105565766;1171.3967306836985;1199.9520019199308;16157;17135.48593542196;17298.740518892228;17337;17476.82523174752;154136;154673;154890;155047;155826;59077.70461147753;59201.559883008944;59305;59312;59334;1313.4089659653002;1324.3907802410806;1366.0574203799347;1369.3153423288356;1376.3187222325014;30285.848570757003;31159.53260701046;31698;32096.518552222202;32546.511802323457;51624;52139.21791173059;52185.47814521806;52191.47808521866;52230.47769522256;502152;503014;504095;506095;506758;34059.65940340664;35596.82201588975;37500;42498.575014249465;42871.855377354914;47368.52631473779;47714.28428573644;48258.758706206245;48359;48520.75739621279;40722.389164163156;41573.792131039154;41824;42342;43659.56340436682;41062.79468602638;41105.588944110175;41692.791536042125;42453.57546424496;42870.35694464523;40389.19221615492;40749.38875916923;42693.35959960541;42720.14559708726;45137;33786;36887.26225475422;37066.62933370632;40068;40432.59567404406;27803.582946255417;28328.15015549537;28434.57348139821;28485.857570712014;28804.71195288104 01:41:39 INFO - PROCESS | 8570 | |2;jquery.html;364.22420244878407;386.68485184574587;392.79770917977237;399.5584878709026;419.1303046179177;14214.147151170937;16995.660086798256;19339.419817405465;19519.902400488012;19520.707189392135;19288.132034058464;19310.903445482752;19321.323753668625;19546.12042458089;19573.51066223345;3942.2706799242087;5497.670139791605;5680.119581464859;5697.6296540724725;5698.316202055759;6061.909071363933;6369.07648390983;6371.522135839808;6372.203474565679;6444.387783160592;6072.939270607304;6125.908111378333;6164.260288765332;6324.083007963843;6326.746930122813;6253.687315634223;6269.3730626937395;6280.309165991737;6287.874242515124;6290.213723284613;5317.2821669074565;5406.783728650849;5408;5424.647397919122;5440;19146.71279930802;19227;21759;22386.66420003685;22676.433089172737;2267.4218074391088;2406.602910519762;2656.8671566421795;2826.9717302826916;2945.26368407898;9733.951330243304;9976;10047.698569042941;10090.646827361006;10566.78866422675;1979.7624285085737;1983.3058429549687;1999.6400647883374;2022.130483891926;2023.696445533167;57985;74126;79179.20820791776;81748;82048.58975705084;9868.506574671237;9888.110070093582;10072.539481775102;10332.070113689804;10977.560897564168;14647.267636618126;14659.04716193444;14682.779758303634;14708.92645536787;14747.55757327282;7136.215016348197;7564;7584.2794934481135;7680.4623676343235;7685.5004424712215;7036.472264580075;7060.18807837095;7207.89188162178;7252.782416527512;7276.927230727731;4400.9119817604105;4501.279795232747;4522.479914809774;4652.55800698933;4668.673192876534;1879.8026207248315;1886.622675464885;1946.3674305850373;1957.5204075001716;2008.5581172142106;899.9325050621229;955.2167222877313;956.0582825916466;999.6351331763854;1057.8730552333768;18773.530661733294;19999.20007199359;20179.495512612302;20202;20535.794642053388;950.9144177024101;968.1528662420383;981.9116279534876;982.8181786369545;994.6170724271208;9180.540972951325;11013.2841365311;11071.280366776135;11178.552857885756;11185.888141118647;494282;511999;515334;515954;519197;88527.55736221277;89921;90972.54513727389;92504.53747731219;92525.53737231271;979.833428317202;1003.2124782046204;1028.861103750984;1035.4201647077662;1041.0422411381546;16635.584110397336;16813.327466901188;17477.737833932246;17718.734218986985;17814.732779008067;29742.851285743433;32344.83827580847;34426.31147377088;41890.58109418989;43495.565044349154;57153.71423143024;57183.71408143099;58467.70766146142;63369.683151583944;64652.67673661601;8062.55655938929;8136.918630813616;8347.916520834957;8442.957785211034;8483.74548763538;12162.391880405767;12828.486860525474;12849.550265740654;12999.675008124872;13167.47330106785;11117.94441027822;11468.254563453349;11536.25014374063;11537.88462115368;11712.531498740296;11080.168987325822;11356.375399353115;11583.942080289544;11803.114766392384;12061.577844775742;11335.829962550733;11364.43177841088;11524;11640.476178572155;12299.569515066929;8159.26566609008;8266.545340006358;8413.411061225901;8423;8728.3890127693;10512.737181570523;10968.396738179477;11035.337879727242;11348.432578371214;11997.460114294703 01:41:39 INFO - PROCESS | 8570 | |3;mootools.html;1346.7710489216845;1411.1757138155597;1487.1003043158887;1595.5771720494072;1745.0402278746685;8568.528730919797;8928.33037522186;8937.150970657793;9144.359894807367;9144.405613635108;8968.103189681045;9066.637334506628;9073.682421115262;9080.500572468512;9080.954595227015;2425.381527710436;2451.2156110044793;2451.742567030463;2452.6075827867544;2453.901843926241;2416.4200591857916;2418.8548687078833;2471.505698860226;2472.344828620417;2473.752624737521;2366.2309749331534;2374.584447721642;2437.2200895713377;2468.2348471973746;2474.4308808973947;2373.4303767095857;2377.9286621401297;2379.3575734551746;2381.130887226159;2416.6012607919674;2344.601417758985;2352.9411764705847;2368.6802281692094;2370.893309801063;2372.3476044087843;8717.30261579072;9019.684311049148;9032.277417806625;9103.726888193365;9118.77203069922;5216.739163041871;5369.865753356158;5437.483439073281;5437.700926449043;5439.048166570874;3441.9311613767836;3461.2558299965626;3472.149323415754;3505.071156143624;3540.13266749648;991.4101109839634;996.0537489385113;996.6113215845826;1003.6687892995367;1019.8980101989816;12472.376381180904;12654.430550625244;12688.175268607418;12709.491620335175;12713.872861271453;4597.908041839144;4636.235021221461;4765.785539650724;4849.660523763303;4850.6362022848425;10737.946310268555;10743.194260430499;10748.677539673823;10750.892491075145;10759.193060520493;5342;5364.597655175878;5370.979513892348;5386.757595908193;5392.91910621341;4346.543612920661;4681.602063824613;4871.269309603588;4905.5094490550655;4941.085899108676;4065.6340929316502;4094.5086589609436;4186.3092589722355;4241.597048280409;4242.53332133465;1293.6765808547864;1293.767121918045;1324.4106372664264;1332.180708864061;1336.3919416665394;879.9824003519893;1019.3170575714289;1027.0345874877592;1030.1552726764132;1044.237706474278;6080.027195648763;6142.477889379364;6230.096635987847;6295.779647712308;6491.8701625967215;439.73835567837085;449.4180036852284;451.911877183946;452.3260342090262;452.99773501132944;4059.918801623951;4192.182524407772;4196.790160491963;4222.134462435193;4223.535411104776;10667.413292269;11034.834477482844;11045.83431248532;11048.889511104946;11055.839136890672;10945.56217751297;10945.671629851116;10978.670639880816;10984;10990.065844403156;7973.322267607203;8283.420160588701;8357.414980951275;8363.749087527383;8363.790905227417;6216.067589861557;6313.684315784284;6376.171097757262;6384.361563843764;6458.838529036811;10166.72229057584;10283.691489255036;10427.478626068818;10451.163906887583;10519.053285204369;10548.578056877946;10579.206559507913;10657.626983055556;10677.09244714208;10679.412632305297;7359.595222262613;7941.404394670307;8031.959840200761;8225.753227403187;8525.573721313785;8568.228859402434;8816.559172041501;8839.027706952358;8840.160184782693;8841.911580884365;7601.695932162652;7897.842043158989;7910.604469776603;8027.076886157933;8111.06722726894;7780.144184139854;7804.336631386395;7858.13560508355;7924.881126783218;7990.161033091675;7118.85762284741;7218.494705370784;7220.819479513054;7221.566705997657;7223.566586004857;5053.343065401621;5133.486651334837;5163.509466600667;5200.45395233495;5423.2407462954425;5310.867228319323;5320.06898792702;5330.387005494418;5438.972805135949;5508.862278443071 01:41:39 INFO - PROCESS | 8570 | |4;prototype.html;322.8192212361078;324.63316452408776;336.382737676364;337.2294307507346;338.6884066658674;5073.543381095701;5125.1287281162195;5162.251473536339;5174.508421699932;5179.689218646879;4803.351547541081;4953.554180123788;4967.677100988433;4970.975145124269;5091.516305950929;3855.6529912307888;3959.6436320731127;3982.5220973483224;3983;3989.1822176453757;3976.940345894814;3992.3412636914873;3994.760314381132;4007.939880901789;4027.7784721840285;3891.5330160380795;3944.704147188958;3954.8615798446917;3991.2017596480673;3995.5604883462797;3985.322495175827;3993.700472464562;3995.440638310639;3999.6600288975474;4003.6596889264447;3519.560054993126;3526.453399723047;3528.4530897710897;3529.294141171776;3540.9108625910835;4897.804087836482;5025.899482010339;5033.421156567005;5034.899302013976;5044.369453818273;4506.7070640408265;4547.886302842422;4560.77196140195;4565.56627120423;4577.679562430631;5251.579873610141;5284.392294886099;5297.152455607084;5308.681479111227;5321.627486075976;3827.2919509890758;3848.1918797052654;3860.073582340246;3868.9806550967346;3874.089588946595;5307.814226502054;5474.534664553517;5484.780608775644;5493.972530137364;5498.45015498451;4048.817803198863;4063.3498640218013;4065.1869626074313;4071.491063617048;4073.6333729964445;4114.634085400907;4118.8673114893645;4122.711410201257;4133.4626498555;4134.1731653669385;4517.344984977226;4581.931271030937;4597.770111494478;4598.379218805485;4649.5350464953235;5291.894162116736;5307.48736610072;5310.814121505806;5312.707801070901;5317.1492561190025;1380.758367285721;1392.2412285304533;1397.4689617945116;1399.3842709207916;1405.3605609447677;880.6829541365104;949;968.8615876345266;985.3299756165733;993.438707130469;5153.716545589954;5159.380874295109;5162.483751624807;5183;5194.636375453682;5394.9460505394445;5398.24424580559;5407.83776486706;5417.052015897202;5437.700926449004;4946.208606622923;5115.335006449138;5134.229865520202;5176.7411629418375;5194.896102077937;2875.3674191678215;2888.2057434205763;2890.8554572271723;2895.5367141257298;2905.2568458924898;5443.646162999393;5650.604457688005;5668.489835914787;5713.942860571341;5717.514011309002;5569.693666848362;5586.497215250566;5588.580856435702;5592.664440133605;5603.775848966077;5733.226014488074;5742.196092547047;5748.511376532958;5834.970825145847;5845.357010728816;5193.3900490847955;5474.233607295061;5478.233047373291;5479.315085614298;5513.862153446196;5433.375161856437;5460.645058071213;5463.180522921593;5465.289512363367;5487.780488780404;5635.492805647347;5768.990426675399;5776.797812076726;5776.913346299725;5803.82588522345;3884;3913.6477717005605;3936.724429289922;3958.584348643466;3977.482927219443;5470.945290547203;5485.314335708036;5492.830332018751;5520;5532.30846144232;5218.321618189611;5345.9842629900195;5367.141257398797;5378.462153784591;5417.214503896992;5297.6291659585;5318.547923426398;5330.773921997885;5337.265388748595;5347.893042139213;5063.683442304953;5113.335266415343;5286.97356513215;5289.153735402318;5293.497117773805;5313.388960269618;5331.920021199608;5338.772082420987;5347.957148356033;5359;5185.896282074413;5207.29701490294;5209.697575606098;5229.163333866563;5236.502532259429 01:41:39 INFO - PROCESS | 8570 | |5;yui.html;741.7255615422298;775.9689612415503;791.8455901099285;826.8346330733852;838.7819167016573;15847.920760396197;16074.678506429864;16371.836281637181;16381.83618163818;17717.29130834768;15389.230538473088;15747.685046299095;15771.684566308666;15772.44796432125;15774.0535567866;640.5228105061735;763.2939530933892;808.6280311056921;809.3282575462352;821.6138414944996;809.6882700160422;816.8202995341015;817;817.358373676664;817.5258350156925;857.0700789643245;858.9613467393982;859.4714250735784;859.7463748194298;860.5525126933991;682.1745687717868;819.7090033038305;844.2148801614496;850.8681154421074;851.9488830670149;615.5168192968498;616.0113018605164;616.1189499016405;616.1989413762092;616.5252755378334;15284.847151528453;15286.541403757905;15460.922695386564;15482.5355239343;15661.451849185223;13318.933405332911;13781.173129612256;14027.64930876726;14261.073030253001;14268.072575282573;13310.334483275798;13424.798628020588;13506.392212350467;13542.526011589645;13785.586432406944;4297.4413326267695;4297.699161058727;4349.108432771274;4350.499692535335;4455.77721113943;75880;76994.84507732332;77315.6134219331;77386.22613773847;77471.22528774696;11241.887581124247;11481.540738370371;11710.414479276002;11980.101492388107;12058.939705301593;19615;21053.263135790174;21092;21106.78893211048;21110.683339749918;8423.536705481258;8440.240378365854;8519.914800852037;8529.95735021321;8537.74386768398;4690.906181876343;4811.903761924742;4849.75751212438;4918.385201849769;5040.79836806531;3515.6132825389186;3586.5474482834493;3601.2077342984503;3631.7094632429344;3643.7813731176216;613.8618810767541;624.3974564545144;625.537649112171;637.0921436952417;639.0573903492311;624.2664868779257;685.5441131647498;696.098552374676;707.9752208672671;713.2083387439937;9338.412469880137;9711.562979665932;9946.552405141785;10096.293259471913;10181.33821301613;642.7910928948111;655.5837043477426;685.1695546397875;686.8523267497512;695.9234484206734;4722.150012997625;4997.475265097112;5003.54968052877;5009.148444764399;5037.496250375007;72611;74194.6290268556;101027;102771;105081.47459262807;102736.48631756943;106604;107222.92777072286;107291.32299571142;108989;92817.53591232;95091.52454237685;96145.9999999986;98430;99549.50225248972;10313.9484302578;10336.276460647983;10664.146868250366;10682.519286631965;10908.072813810597;41554.37668435036;43670;44304.335434967856;45349.773251133534;55354.44645553654;74909.62545187239;76409;78778;79464;83257.58371208105;14629.561113166623;14708.632284192981;14735.55793326202;14784.556463306119;14860.851391485947;15961.920190398974;16006.279717412977;16106.919465403067;16187.352505900104;17183.398581050104;14777.482788102365;15021.324040417989;15274.236288185768;15407.537773866801;15743.842561574238;14627.19550424737;15300.311485982935;15354.078755274719;15478.767818482507;15871.68256634884;13673.31633418345;14714.411423542939;15073.170975596448;15295.847041529441;15780.210989450712;10819.242653014213;11406.372649504357;11489.310641361544;11497.770044598894;11638.451935081148;11378.31730096197;11829.97931164178;12165.635030949086;12639.747205055663;12690.936545317214 01:41:39 INFO - PROCESS | 8570 | __end_tp_report 01:41:39 INFO - PROCESS | 8570 | __start_cc_report 01:41:39 INFO - PROCESS | 8570 | _x_x_mozilla_cycle_collect,966 01:41:39 INFO - PROCESS | 8570 | __end_cc_report 01:41:39 INFO - PROCESS | 8570 | __startTimestamp1470040899534__endTimestamp 01:41:39 INFO - PROCESS | 8570 | 01:41:39 INFO - PROCESS | 8570 | ------- Summary: start ------- 01:41:39 INFO - PROCESS | 8570 | Number of tests: 6 01:41:39 INFO - PROCESS | 8570 | 01:41:39 INFO - PROCESS | 8570 | [#0] dojo.html Cycles:165 Average:5224.03 Median:5411.51 stddev:596.15 (11.0%) stddev-sans-first:572.34 01:41:39 INFO - PROCESS | 8570 | Values: 3019.2 3021.0 3038.8 3056.1 3076.2 5035.8 5072.7 5187.8 5239.3 5255.7 5178.6 5265.1 5270.9 5287.2 5327.2 4719.7 4743.8 4805.8 4824.9 4916.0 4845.4 4877.7 4896.3 4911.0 4913.0 4667.7 4722.4 4728.1 4791.0 4847.6 4731.1 4736.7 4748.1 4753.1 4843.2 4679.1 4701.3 4703.8 4744.5 4757.0 5023.3 5166.2 5200.5 5222.5 5237.6 5592.8 5635.3 5638.3 5642.3 5642.8 5663.9 5667.1 5677.4 5705.3 5733.0 5131.0 5199.0 5231.0 5241.6 5245.4 5802.2 5805.0 5811.9 5812.9 5814.5 5572.4 5579.0 5581.0 5581.2 5587.4 5460.3 5500.7 5555.9 5645.0 5652.5 5575.5 5578.6 5580.4 5619.6 5626.3 5543.8 5586.1 5593.4 5597.3 5600.8 4228.8 4263.8 4265.2 4283.2 4364.6 3812.5 3863.7 3869.0 3873.3 3947.7 5348.9 5350.8 5352.1 5353.5 5395.2 5407.9 5605.3 5607.6 5607.9 5651.0 5304.1 5334.9 5335.7 5363.3 5422.8 4905.6 4911.6 4917.9 4918.4 4956.1 5741.7 5897.4 5940.4 5941.3 5948.7 5604.7 5631.7 5639.9 5655.7 5758.5 5890.7 5924.4 5941.7 5954.2 5956.9 5341.7 5512.0 5594.2 5601.2 5604.9 5458.6 5490.3 5498.5 5529.4 5565.2 5372.8 5411.5 5414.6 5416.5 5423.6 5377.4 5389.5 5392.1 5395.2 5441.8 5433.6 5469.7 5486.3 5490.5 5543.4 5577.3 5577.4 5618.5 5625.2 5638.1 5182.4 5429.3 5434.5 5436.3 5440.9 01:41:39 INFO - PROCESS | 8570 | 01:41:39 INFO - PROCESS | 8570 | [#1] ext.html Cycles:180 Average:52008.47 Median:42851.86 stddev:97236.70 (226.9%) stddev-sans-first:97432.87 01:41:39 INFO - PROCESS | 8570 | Values: 601.8 609.1 618.2 642.0 651.7 32198.2 43375.0 44538.3 44549.8 44630.3 45352.8 45504.3 45849.5 45874.8 45917.5 9030.5 9173.1 9174.1 9180.7 9181.1 8944.2 9000.9 9017.1 9020.8 9037.9 9026.1 9075.7 9092.1 9095.1 9101.1 8979.3 8981.2 9013.0 9026.6 9028.6 8940.4 8996.5 9016.1 9024.0 9025.7 42377.4 42695.0 42833.4 42989.0 43109.1 3546.9 3597.2 3615.4 3738.4 4075.5 33024.8 33076.0 33372.0 33435.8 34627.5 4395.4 4443.3 4552.4 4570.5 4619.0 346079.0 348458.0 349374.0 351590.0 352902.0 51803.2 58395.7 58534.4 58573.4 58688.4 59955.0 61423.7 61503.4 65726.0 65774.0 14692.9 14835.0 14837.1 14838.3 14853.2 10755.8 11338.2 11396.7 11429.4 11429.8 16745.9 17306.4 17369.1 17407.7 17705.6 6587.3 6610.6 6745.6 6823.3 6885.1 954.2 956.9 975.3 986.7 1088.1 32720.3 32768.0 32855.3 32938.5 33383.5 1031.5 1118.6 1144.7 1171.4 1200.0 16157.0 17135.5 17298.7 17337.0 17476.8 154136.0 154673.0 154890.0 155047.0 155826.0 59077.7 59201.6 59305.0 59312.0 59334.0 1313.4 1324.4 1366.1 1369.3 1376.3 30285.8 31159.5 31698.0 32096.5 32546.5 51624.0 52139.2 52185.5 52191.5 52230.5 502152.0 503014.0 504095.0 506095.0 506758.0 34059.7 35596.8 37500.0 42498.6 42871.9 47368.5 47714.3 48258.8 48359.0 48520.8 40722.4 41573.8 41824.0 42342.0 43659.6 41062.8 41105.6 41692.8 42453.6 42870.4 40389.2 40749.4 42693.4 42720.1 45137.0 33786.0 36887.3 37066.6 40068.0 40432.6 27803.6 28328.2 28434.6 28485.9 28804.7 01:41:39 INFO - PROCESS | 8570 | 01:41:39 INFO - PROCESS | 8570 | [#2] jquery.html Cycles:180 Average:29143.00 Median:2167.53 stddev:84144.28 (3882.0%) stddev-sans-first:84352.58 01:41:39 INFO - PROCESS | 8570 | Values: 364.2 386.7 392.8 399.6 419.1 14214.1 16995.7 19339.4 19519.9 19520.7 19288.1 19310.9 19321.3 19546.1 19573.5 3942.3 5497.7 5680.1 5697.6 5698.3 6061.9 6369.1 6371.5 6372.2 6444.4 6072.9 6125.9 6164.3 6324.1 6326.7 6253.7 6269.4 6280.3 6287.9 6290.2 5317.3 5406.8 5408.0 5424.6 5440.0 19146.7 19227.0 21759.0 22386.7 22676.4 2267.4 2406.6 2656.9 2827.0 2945.3 9734.0 9976.0 10047.7 10090.6 10566.8 1979.8 1983.3 1999.6 2022.1 2023.7 57985.0 74126.0 79179.2 81748.0 82048.6 9868.5 9888.1 10072.5 10332.1 10977.6 14647.3 14659.0 14682.8 14708.9 14747.6 7136.2 7564.0 7584.3 7680.5 7685.5 7036.5 7060.2 7207.9 7252.8 7276.9 4400.9 4501.3 4522.5 4652.6 4668.7 1879.8 1886.6 1946.4 1957.5 2008.6 899.9 955.2 956.1 999.6 1057.9 18773.5 19999.2 20179.5 20202.0 20535.8 950.9 968.2 981.9 982.8 994.6 9180.5 11013.3 11071.3 11178.6 11185.9 494282.0 511999.0 515334.0 515954.0 519197.0 88527.6 89921.0 90972.5 92504.5 92525.5 979.8 1003.2 1028.9 1035.4 1041.0 16635.6 16813.3 17477.7 17718.7 17814.7 29742.9 32344.8 34426.3 41890.6 43495.6 57153.7 57183.7 58467.7 63369.7 64652.7 8062.6 8136.9 8347.9 8443.0 8483.7 12162.4 12828.5 12849.6 12999.7 13167.5 11117.9 11468.3 11536.3 11537.9 11712.5 11080.2 11356.4 11583.9 11803.1 12061.6 11335.8 11364.4 11524.0 11640.5 12299.6 8159.3 8266.5 8413.4 8423.0 8728.4 10512.7 10968.4 11035.3 11348.4 11997.5 01:41:39 INFO - PROCESS | 8570 | 01:41:39 INFO - PROCESS | 8570 | [#3] mootools.html Cycles:180 Average:5943.78 Median:452.66 stddev:3404.08 (752.0%) stddev-sans-first:3396.10 01:41:39 INFO - PROCESS | 8570 | Values: 1346.8 1411.2 1487.1 1595.6 1745.0 8568.5 8928.3 8937.2 9144.4 9144.4 8968.1 9066.6 9073.7 9080.5 9081.0 2425.4 2451.2 2451.7 2452.6 2453.9 2416.4 2418.9 2471.5 2472.3 2473.8 2366.2 2374.6 2437.2 2468.2 2474.4 2373.4 2377.9 2379.4 2381.1 2416.6 2344.6 2352.9 2368.7 2370.9 2372.3 8717.3 9019.7 9032.3 9103.7 9118.8 5216.7 5369.9 5437.5 5437.7 5439.0 3441.9 3461.3 3472.1 3505.1 3540.1 991.4 996.1 996.6 1003.7 1019.9 12472.4 12654.4 12688.2 12709.5 12713.9 4597.9 4636.2 4765.8 4849.7 4850.6 10737.9 10743.2 10748.7 10750.9 10759.2 5342.0 5364.6 5371.0 5386.8 5392.9 4346.5 4681.6 4871.3 4905.5 4941.1 4065.6 4094.5 4186.3 4241.6 4242.5 1293.7 1293.8 1324.4 1332.2 1336.4 880.0 1019.3 1027.0 1030.2 1044.2 6080.0 6142.5 6230.1 6295.8 6491.9 439.7 449.4 451.9 452.3 453.0 4059.9 4192.2 4196.8 4222.1 4223.5 10667.4 11034.8 11045.8 11048.9 11055.8 10945.6 10945.7 10978.7 10984.0 10990.1 7973.3 8283.4 8357.4 8363.7 8363.8 6216.1 6313.7 6376.2 6384.4 6458.8 10166.7 10283.7 10427.5 10451.2 10519.1 10548.6 10579.2 10657.6 10677.1 10679.4 7359.6 7941.4 8032.0 8225.8 8525.6 8568.2 8816.6 8839.0 8840.2 8841.9 7601.7 7897.8 7910.6 8027.1 8111.1 7780.1 7804.3 7858.1 7924.9 7990.2 7118.9 7218.5 7220.8 7221.6 7223.6 5053.3 5133.5 5163.5 5200.5 5423.2 5310.9 5320.1 5330.4 5439.0 5508.9 01:41:39 INFO - PROCESS | 8570 | 01:41:39 INFO - PROCESS | 8570 | [#4] prototype.html Cycles:180 Average:4515.74 Median:5168.50 stddev:1312.52 (25.4%) stddev-sans-first:1277.91 01:41:39 INFO - PROCESS | 8570 | Values: 322.8 324.6 336.4 337.2 338.7 5073.5 5125.1 5162.3 5174.5 5179.7 4803.4 4953.6 4967.7 4971.0 5091.5 3855.7 3959.6 3982.5 3983.0 3989.2 3976.9 3992.3 3994.8 4007.9 4027.8 3891.5 3944.7 3954.9 3991.2 3995.6 3985.3 3993.7 3995.4 3999.7 4003.7 3519.6 3526.5 3528.5 3529.3 3540.9 4897.8 5025.9 5033.4 5034.9 5044.4 4506.7 4547.9 4560.8 4565.6 4577.7 5251.6 5284.4 5297.2 5308.7 5321.6 3827.3 3848.2 3860.1 3869.0 3874.1 5307.8 5474.5 5484.8 5494.0 5498.5 4048.8 4063.3 4065.2 4071.5 4073.6 4114.6 4118.9 4122.7 4133.5 4134.2 4517.3 4581.9 4597.8 4598.4 4649.5 5291.9 5307.5 5310.8 5312.7 5317.1 1380.8 1392.2 1397.5 1399.4 1405.4 880.7 949.0 968.9 985.3 993.4 5153.7 5159.4 5162.5 5183.0 5194.6 5394.9 5398.2 5407.8 5417.1 5437.7 4946.2 5115.3 5134.2 5176.7 5194.9 2875.4 2888.2 2890.9 2895.5 2905.3 5443.6 5650.6 5668.5 5713.9 5717.5 5569.7 5586.5 5588.6 5592.7 5603.8 5733.2 5742.2 5748.5 5835.0 5845.4 5193.4 5474.2 5478.2 5479.3 5513.9 5433.4 5460.6 5463.2 5465.3 5487.8 5635.5 5769.0 5776.8 5776.9 5803.8 3884.0 3913.6 3936.7 3958.6 3977.5 5470.9 5485.3 5492.8 5520.0 5532.3 5218.3 5346.0 5367.1 5378.5 5417.2 5297.6 5318.5 5330.8 5337.3 5347.9 5063.7 5113.3 5287.0 5289.2 5293.5 5313.4 5331.9 5338.8 5348.0 5359.0 5185.9 5207.3 5209.7 5229.2 5236.5 01:41:39 INFO - PROCESS | 8570 | 01:41:39 INFO - PROCESS | 8570 | [#5] yui.html Cycles:180 Average:21017.64 Median:22925.91 stddev:29450.46 (128.5%) stddev-sans-first:29493.72 01:41:39 INFO - PROCESS | 8570 | Values: 741.7 776.0 791.8 826.8 838.8 15847.9 16074.7 16371.8 16381.8 17717.3 15389.2 15747.7 15771.7 15772.4 15774.1 640.5 763.3 808.6 809.3 821.6 809.7 816.8 817.0 817.4 817.5 857.1 859.0 859.5 859.7 860.6 682.2 819.7 844.2 850.9 851.9 615.5 616.0 616.1 616.2 616.5 15284.8 15286.5 15460.9 15482.5 15661.5 13318.9 13781.2 14027.6 14261.1 14268.1 13310.3 13424.8 13506.4 13542.5 13785.6 4297.4 4297.7 4349.1 4350.5 4455.8 75880.0 76994.8 77315.6 77386.2 77471.2 11241.9 11481.5 11710.4 11980.1 12058.9 19615.0 21053.3 21092.0 21106.8 21110.7 8423.5 8440.2 8519.9 8530.0 8537.7 4690.9 4811.9 4849.8 4918.4 5040.8 3515.6 3586.5 3601.2 3631.7 3643.8 613.9 624.4 625.5 637.1 639.1 624.3 685.5 696.1 708.0 713.2 9338.4 9711.6 9946.6 10096.3 10181.3 642.8 655.6 685.2 686.9 695.9 4722.2 4997.5 5003.5 5009.1 5037.5 72611.0 74194.6 101027.0 102771.0 105081.5 102736.5 106604.0 107222.9 107291.3 108989.0 92817.5 95091.5 96146.0 98430.0 99549.5 10313.9 10336.3 10664.1 10682.5 10908.1 41554.4 43670.0 44304.3 45349.8 55354.4 74909.6 76409.0 78778.0 79464.0 83257.6 14629.6 14708.6 14735.6 14784.6 14860.9 15961.9 16006.3 16106.9 16187.4 17183.4 14777.5 15021.3 15274.2 15407.5 15743.8 14627.2 15300.3 15354.1 15478.8 15871.7 13673.3 14714.4 15073.2 15295.8 15780.2 10819.2 11406.4 11489.3 11497.8 11638.5 11378.3 11830.0 12165.6 12639.7 12690.9 01:41:39 INFO - PROCESS | 8570 | -------- Summary: end -------- 01:41:39 INFO - PROCESS | 8570 | 01:41:40 INFO - TEST-INFO | 8570: exit 0 01:41:40 INFO - TEST-OK | dromaeo_css | took 1113064ms 01:41:40 INFO - TEST-START | kraken 01:41:40 INFO - operating with platform_type : linux_ 01:41:40 INFO - Initialising browser for kraken test... 01:41:40 INFO - TEST-INFO | started process 8762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlPOoY/profile http://localhost:47848/getInfo.html) 01:41:44 INFO - PROCESS | 8762 | __metrics Screen width/height:1600/1200 01:41:44 INFO - PROCESS | 8762 | colorDepth:24 01:41:44 INFO - PROCESS | 8762 | Browser inner width/height: 1024/697 01:41:44 INFO - PROCESS | 8762 | __metrics 01:41:45 INFO - PROCESS | 8762 | 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" 01:41:45 INFO - PROCESS | 8762 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:41:45 INFO - TEST-INFO | 8762: exit 0 01:41:45 INFO - Browser initialized. 01:41:45 INFO - Running cycle 1/1 for kraken test... 01:41:45 INFO - TEST-INFO | started process 8841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFlPOoY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:41:57 INFO - PROCESS | 8841 | RSS: Main: 156106752 01:41:57 INFO - PROCESS | 8841 | 01:42:00 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47848/tests/kraken/driver.html?testName=audio-beat-detection) 01:42:00 INFO - PROCESS | 8841 | RSS: Main: 212426752 01:42:00 INFO - PROCESS | 8841 | 01:42:03 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47848/tests/kraken/driver.html?testName=audio-dft) 01:42:04 INFO - PROCESS | 8841 | RSS: Main: 186089472 01:42:04 INFO - PROCESS | 8841 | 01:42:07 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47848/tests/kraken/driver.html?testName=audio-fft) 01:42:07 INFO - PROCESS | 8841 | RSS: Main: 269836288 01:42:07 INFO - PROCESS | 8841 | 01:42:10 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47848/tests/kraken/driver.html?testName=audio-oscillator) 01:42:10 INFO - PROCESS | 8841 | RSS: Main: 179564544 01:42:10 INFO - PROCESS | 8841 | 01:42:12 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47848/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:42:13 INFO - PROCESS | 8841 | RSS: Main: 184463360 01:42:13 INFO - PROCESS | 8841 | 01:42:16 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47848/tests/kraken/driver.html?testName=imaging-darkroom) 01:42:17 INFO - PROCESS | 8841 | RSS: Main: 218718208 01:42:17 INFO - PROCESS | 8841 | 01:42:20 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47848/tests/kraken/driver.html?testName=imaging-desaturate) 01:42:21 INFO - PROCESS | 8841 | RSS: Main: 219750400 01:42:21 INFO - PROCESS | 8841 | 01:42:23 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47848/tests/kraken/driver.html?testName=json-parse-financial) 01:42:24 INFO - PROCESS | 8841 | RSS: Main: 219291648 01:42:24 INFO - PROCESS | 8841 | 01:42:25 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47848/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:42:26 INFO - PROCESS | 8841 | RSS: Main: 183623680 01:42:26 INFO - PROCESS | 8841 | 01:42:28 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47848/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:42:28 INFO - PROCESS | 8841 | RSS: Main: 188850176 01:42:28 INFO - PROCESS | 8841 | 01:42:30 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47848/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:42:31 INFO - PROCESS | 8841 | RSS: Main: 194510848 01:42:31 INFO - PROCESS | 8841 | 01:42:34 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:42:34 INFO - PROCESS | 8841 | RSS: Main: 187912192 01:42:34 INFO - PROCESS | 8841 | 01:42:37 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:42:38 INFO - PROCESS | 8841 | RSS: Main: 192147456 01:42:38 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | Cycle 1(1): loaded http://localhost:47848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47848/tests/kraken/driver.html?testName=ai-astar) 01:42:39 INFO - PROCESS | 8841 | RSS: Main: 243687424 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | __start_tp_report 01:42:39 INFO - PROCESS | 8841 | _x_x_mozilla_page_load 01:42:39 INFO - PROCESS | 8841 | _x_x_mozilla_page_load_details 01:42:39 INFO - PROCESS | 8841 | |i|pagename|runs| 01:42:39 INFO - PROCESS | 8841 | |0;ai-astar;102;114;111;112;111;110;110;113;111;111 01:42:39 INFO - PROCESS | 8841 | |1;audio-beat-detection;153;118;124;179;119;123;140;116;164;117 01:42:39 INFO - PROCESS | 8841 | |2;audio-dft;160;161;160;160;160;163;161;161;161;163 01:42:39 INFO - PROCESS | 8841 | |3;audio-fft;74;75;75;119;76;75;73;74;118;75 01:42:39 INFO - PROCESS | 8841 | |4;audio-oscillator;83;83;114;84;84;83;117;84;83;135 01:42:39 INFO - PROCESS | 8841 | |5;imaging-gaussian-blur;117;117;116;117;118;117;117;117;117;116 01:42:39 INFO - PROCESS | 8841 | |6;imaging-darkroom;146;146;146;146;146;146;145;145;146;146 01:42:39 INFO - PROCESS | 8841 | |7;imaging-desaturate;95;94;95;95;94;95;95;95;94;95 01:42:39 INFO - PROCESS | 8841 | |8;json-parse-financial;54;53;52;52;51;53;52;52;52;52 01:42:39 INFO - PROCESS | 8841 | |9;json-stringify-tinderbox;62;62;62;61;62;62;61;61;62;63 01:42:39 INFO - PROCESS | 8841 | |10;stanford-crypto-aes;76;75;75;76;78;75;74;76;75;79 01:42:39 INFO - PROCESS | 8841 | |11;stanford-crypto-ccm;131;128;120;121;122;129;119;120;212;121 01:42:39 INFO - PROCESS | 8841 | |12;stanford-crypto-pbkdf2;160;160;161;156;156;159;158;158;161;156 01:42:39 INFO - PROCESS | 8841 | |13;stanford-crypto-sha256-iterative;64;63;63;64;64;64;62;61;64;63 01:42:39 INFO - PROCESS | 8841 | __end_tp_report 01:42:39 INFO - PROCESS | 8841 | __start_cc_report 01:42:39 INFO - PROCESS | 8841 | _x_x_mozilla_cycle_collect,1665 01:42:39 INFO - PROCESS | 8841 | __end_cc_report 01:42:39 INFO - PROCESS | 8841 | __startTimestamp1470040959975__endTimestamp 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | ------- Summary: start ------- 01:42:39 INFO - PROCESS | 8841 | Number of tests: 14 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:3.24 (2.9%) stddev-sans-first:1.33 01:42:39 INFO - PROCESS | 8841 | Values: 102.0 114.0 111.0 112.0 111.0 110.0 110.0 113.0 111.0 111.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:132.00 stddev:22.66 (17.2%) stddev-sans-first:23.11 01:42:39 INFO - PROCESS | 8841 | Values: 153.0 118.0 124.0 179.0 119.0 123.0 140.0 116.0 164.0 117.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 01:42:39 INFO - PROCESS | 8841 | Values: 160.0 161.0 160.0 160.0 160.0 163.0 161.0 161.0 161.0 163.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.00 stddev:18.52 (24.7%) stddev-sans-first:19.33 01:42:39 INFO - PROCESS | 8841 | Values: 74.0 75.0 75.0 119.0 76.0 75.0 73.0 74.0 118.0 75.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:83.00 stddev:19.39 (23.4%) stddev-sans-first:20.07 01:42:39 INFO - PROCESS | 8841 | Values: 83.0 83.0 114.0 84.0 84.0 83.0 117.0 84.0 83.0 135.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 01:42:39 INFO - PROCESS | 8841 | Values: 117.0 117.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 01:42:39 INFO - PROCESS | 8841 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:42:39 INFO - PROCESS | 8841 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.60 01:42:39 INFO - PROCESS | 8841 | Values: 54.0 53.0 52.0 52.0 51.0 53.0 52.0 52.0 52.0 52.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 01:42:39 INFO - PROCESS | 8841 | Values: 62.0 62.0 62.0 61.0 62.0 62.0 61.0 61.0 62.0 63.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:1.52 (2.0%) stddev-sans-first:1.62 01:42:39 INFO - PROCESS | 8841 | Values: 76.0 75.0 75.0 76.0 78.0 75.0 74.0 76.0 75.0 79.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:125.00 stddev:28.33 (22.7%) stddev-sans-first:30.05 01:42:39 INFO - PROCESS | 8841 | Values: 131.0 128.0 120.0 121.0 122.0 129.0 119.0 120.0 212.0 121.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.50 stddev:2.01 (1.3%) stddev-sans-first:2.06 01:42:39 INFO - PROCESS | 8841 | Values: 160.0 160.0 161.0 156.0 156.0 159.0 158.0 158.0 161.0 156.0 01:42:39 INFO - PROCESS | 8841 | 01:42:39 INFO - PROCESS | 8841 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 01:42:39 INFO - PROCESS | 8841 | Values: 64.0 63.0 63.0 64.0 64.0 64.0 62.0 61.0 64.0 63.0 01:42:39 INFO - PROCESS | 8841 | -------- Summary: end -------- 01:42:39 INFO - PROCESS | 8841 | 01:42:40 INFO - TEST-INFO | 8841: exit 0 01:42:40 INFO - TEST-OK | kraken | took 60746ms 01:42:40 INFO - SUITE-END | took 1173s 01:42:41 INFO - Completed test suite (00:19:33) 01:42:41 INFO - javascript benchmark 01:42:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.2300963254365, 3020.9848950755245, 3038.817670939744, 3056.129003234079, 3076.200187951132, 5035.773390197441, 5072.74636268187, 5187.844364669057, 5239.292695486109, 5255.658382205159, 5178.559822415099, 5265.104932161532, 5270.868228294285, 5287.233351164079, 5327.174287985359, 4719.69321994071, 4743.76281185941, 4805.807767689305, 4824.927626085611, 4915.950840491585, 4845.442774080973, 4877.70733755974, 4896.265560165968, 4911.0, 4912.975435122819, 4667.7199368037855, 4722.433308003027, 4728.054389122155, 4791.041791641685, 4847.587955023827, 4731.077439899221, 4736.692115012514, 4748.145333839908, 4753.120672675566, 4843.152448321565, 4679.110968915895, 4701.271302948048, 4703.7883295251795, 4744.478107408182, 4757.0, 5023.271625614302, 5166.199239117943, 5200.479952004807, 5222.529972302473, 5237.6071794615555, 5592.7762889484375, 5635.267415236034, 5638.295213098363, 5642.294713160855, 5642.802501912413, 5663.8584035399035, 5667.093265077609, 5677.432256774331, 5705.343885453184, 5733.025385684444, 5131.0, 5199.0381779370555, 5230.973845130826, 5241.580673546107, 5245.423003469616, 5802.21670074543, 5805.013147764806, 5811.912821307684, 5812.854678633068, 5814.476697097197, 5572.442755724395, 5578.97210513953, 5580.972095139579, 5581.246531718247, 5587.38538760736, 5460.290162278958, 5500.697461639568, 5555.861103472445, 5645.0, 5652.463016013472, 5575.52608028314, 5578.609497335228, 5580.35825880029, 5619.6347237430255, 5626.2685850839125, 5543.805966791143, 5586.050371436865, 5593.356763972195, 5597.272354593958, 5600.803971860965, 4228.767417792051, 4263.829446822155, 4265.168292182994, 4283.164782867373, 4364.62900653448, 3812.542494900574, 3863.74885632433, 3868.96131038686, 3873.283442563135, 3947.684185265172, 5348.893022139536, 5350.839474815684, 5352.116900711417, 5353.4646535346155, 5395.190721391823, 5407.891842163135, 5605.271314729059, 5607.635503692247, 5607.915881261784, 5650.971745141248, 5304.071787437183, 5334.91997620036, 5335.706536140472, 5363.2759577456545, 5422.8373148805595, 4905.632077594195, 4911.607071434277, 4917.852464426073, 4918.385201849769, 4956.10790057793, 5741.684207368635, 5897.410258974154, 5940.435658612425, 5941.257342832146, 5948.7323070461935, 5604.719764011702, 5631.690257035739, 5639.88720225585, 5655.660660360391, 5758.510526605285, 5890.676012819336, 5924.437178468039, 5941.702914854326, 5954.19618351517, 5956.851078723066, 5341.65279256847, 5512.0, 5594.188842617879, 5601.187827764869, 5604.915926261191, 5458.61789674719, 5490.313710786152, 5498.532624726943, 5529.364123125731, 5565.220869078414, 5372.7582258797665, 5411.512963833116, 5414.648047876875, 5416.539594134542, 5423.62034657586, 5377.435369286169, 5389.51494365509, 5392.08334583114, 5395.163749618815, 5441.7551210196425, 5433.619646624698, 5469.726513674221, 5486.259354987025, 5490.478404551562, 5543.3902270751, 5577.330720313588, 5577.414371491097, 5618.4662457066515, 5625.184348269559, 5638.069718496567, 5182.404023537341, 5429.294191755047, 5434.456554344534, 5436.3476382834315, 5440.918386224131], "value": 5183.784670842702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.7803501721872, 609.135028259871, 618.193257798573, 641.9775307864224, 651.7360469010052, 32198.195045123884, 43375.0, 44538.33192502115, 44549.77725111378, 44630.33054504177, 45352.77323613386, 45504.317435238496, 45849.541504584944, 45874.77062614682, 45917.54082459174, 9030.458172509638, 9173.128552787475, 9174.08259174084, 9180.678676246333, 9181.127792859668, 8944.239739622108, 9000.8649870252, 9017.053209413016, 9020.77448063797, 9037.864432033524, 9026.097390260988, 9075.727728168165, 9092.136247056553, 9095.090490950919, 9101.089891010912, 8979.326550508706, 8981.236594889442, 9012.954935225282, 9026.593803278869, 9028.638854445815, 8940.418872773249, 8996.460212387277, 9016.098390160996, 9024.0, 9025.729228123168, 42377.36433953493, 42695.0, 42833.35749963753, 42989.0, 43109.13781724379, 3546.8935931922083, 3597.190632107781, 3615.367310720613, 3738.401855703102, 4075.53131389891, 33024.834875825465, 33076.0, 33372.0, 33435.83282083598, 34627.4805877912, 4395.406620106277, 4443.266860967937, 4552.362669226311, 4570.451545814523, 4619.030003699228, 346079.0, 348458.0, 349374.0, 351590.0, 352901.99999999744, 51803.222951655756, 58395.70802145962, 58534.41465585375, 58573.414265857646, 58688.413115868294, 59955.0, 61423.6928815362, 61503.384966149766, 65726.0, 65774.0, 14692.853071469362, 14835.03572267799, 14837.10977341363, 14838.258087095603, 14853.183074930983, 10755.784884302426, 11338.206325557298, 11396.658100257006, 11429.428528573704, 11429.828552571718, 16745.916270418813, 17306.394276200273, 17369.13154342278, 17407.73888391675, 17705.557361065818, 6587.29920732507, 6610.570312929644, 6745.628990405575, 6823.33889782985, 6885.1049363582415, 954.231843366097, 956.9425834449816, 975.3221511049752, 986.6743974488402, 1088.0751361342955, 32720.34559308848, 32768.01695949125, 32855.342893142006, 32938.50592241118, 33383.49924751131, 1031.5358088860044, 1118.5637601335486, 1144.7367105565766, 1171.3967306836985, 1199.9520019199308, 16157.0, 17135.48593542196, 17298.740518892228, 17337.0, 17476.82523174752, 154136.0, 154673.0, 154890.0, 155047.0, 155826.0, 59077.70461147753, 59201.559883008944, 59305.0, 59312.0, 59334.0, 1313.4089659653002, 1324.3907802410806, 1366.0574203799347, 1369.3153423288356, 1376.3187222325014, 30285.848570757003, 31159.53260701046, 31698.0, 32096.518552222202, 32546.511802323457, 51624.0, 52139.21791173059, 52185.47814521806, 52191.47808521866, 52230.47769522256, 502152.0, 503014.0, 504095.0, 506095.0, 506758.0, 34059.65940340664, 35596.82201588975, 37500.0, 42498.575014249465, 42871.855377354914, 47368.52631473779, 47714.28428573644, 48258.758706206245, 48359.0, 48520.75739621279, 40722.389164163156, 41573.792131039154, 41824.0, 42342.0, 43659.56340436682, 41062.79468602638, 41105.588944110175, 41692.791536042125, 42453.57546424496, 42870.35694464523, 40389.19221615492, 40749.38875916923, 42693.35959960541, 42720.14559708726, 45137.0, 33786.0, 36887.26225475422, 37066.62933370632, 40068.0, 40432.59567404406, 27803.582946255417, 28328.15015549537, 28434.57348139821, 28485.857570712014, 28804.71195288104], "value": 19713.524347564453, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.22420244878407, 386.68485184574587, 392.79770917977237, 399.5584878709026, 419.1303046179177, 14214.147151170937, 16995.660086798256, 19339.419817405465, 19519.902400488012, 19520.707189392135, 19288.132034058464, 19310.903445482752, 19321.323753668625, 19546.12042458089, 19573.51066223345, 3942.2706799242087, 5497.670139791605, 5680.119581464859, 5697.6296540724725, 5698.316202055759, 6061.909071363933, 6369.07648390983, 6371.522135839808, 6372.203474565679, 6444.387783160592, 6072.939270607304, 6125.908111378333, 6164.260288765332, 6324.083007963843, 6326.746930122813, 6253.687315634223, 6269.3730626937395, 6280.309165991737, 6287.874242515124, 6290.213723284613, 5317.2821669074565, 5406.783728650849, 5408.0, 5424.647397919122, 5440.0, 19146.71279930802, 19227.0, 21759.0, 22386.66420003685, 22676.433089172737, 2267.4218074391088, 2406.602910519762, 2656.8671566421795, 2826.9717302826916, 2945.26368407898, 9733.951330243304, 9976.0, 10047.698569042941, 10090.646827361006, 10566.78866422675, 1979.7624285085737, 1983.3058429549687, 1999.6400647883374, 2022.130483891926, 2023.696445533167, 57985.0, 74126.0, 79179.20820791776, 81748.0, 82048.58975705084, 9868.506574671237, 9888.110070093582, 10072.539481775102, 10332.070113689804, 10977.560897564168, 14647.267636618126, 14659.04716193444, 14682.779758303634, 14708.92645536787, 14747.55757327282, 7136.215016348197, 7564.0, 7584.2794934481135, 7680.4623676343235, 7685.5004424712215, 7036.472264580075, 7060.18807837095, 7207.89188162178, 7252.782416527512, 7276.927230727731, 4400.9119817604105, 4501.279795232747, 4522.479914809774, 4652.55800698933, 4668.673192876534, 1879.8026207248315, 1886.622675464885, 1946.3674305850373, 1957.5204075001716, 2008.5581172142106, 899.9325050621229, 955.2167222877313, 956.0582825916466, 999.6351331763854, 1057.8730552333768, 18773.530661733294, 19999.20007199359, 20179.495512612302, 20202.0, 20535.794642053388, 950.9144177024101, 968.1528662420383, 981.9116279534876, 982.8181786369545, 994.6170724271208, 9180.540972951325, 11013.2841365311, 11071.280366776135, 11178.552857885756, 11185.888141118647, 494282.0, 511999.0, 515334.0, 515954.0, 519197.0, 88527.55736221277, 89921.0, 90972.54513727389, 92504.53747731219, 92525.53737231271, 979.833428317202, 1003.2124782046204, 1028.861103750984, 1035.4201647077662, 1041.0422411381546, 16635.584110397336, 16813.327466901188, 17477.737833932246, 17718.734218986985, 17814.732779008067, 29742.851285743433, 32344.83827580847, 34426.31147377088, 41890.58109418989, 43495.565044349154, 57153.71423143024, 57183.71408143099, 58467.70766146142, 63369.683151583944, 64652.67673661601, 8062.55655938929, 8136.918630813616, 8347.916520834957, 8442.957785211034, 8483.74548763538, 12162.391880405767, 12828.486860525474, 12849.550265740654, 12999.675008124872, 13167.47330106785, 11117.94441027822, 11468.254563453349, 11536.25014374063, 11537.88462115368, 11712.531498740296, 11080.168987325822, 11356.375399353115, 11583.942080289544, 11803.114766392384, 12061.577844775742, 11335.829962550733, 11364.43177841088, 11524.0, 11640.476178572155, 12299.569515066929, 8159.26566609008, 8266.545340006358, 8413.411061225901, 8423.0, 8728.3890127693, 10512.737181570523, 10968.396738179477, 11035.337879727242, 11348.432578371214, 11997.460114294703], "value": 9090.516972415924, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.7710489216845, 1411.1757138155597, 1487.1003043158887, 1595.5771720494072, 1745.0402278746685, 8568.528730919797, 8928.33037522186, 8937.150970657793, 9144.359894807367, 9144.405613635108, 8968.103189681045, 9066.637334506628, 9073.682421115262, 9080.500572468512, 9080.954595227015, 2425.381527710436, 2451.2156110044793, 2451.742567030463, 2452.6075827867544, 2453.901843926241, 2416.4200591857916, 2418.8548687078833, 2471.505698860226, 2472.344828620417, 2473.752624737521, 2366.2309749331534, 2374.584447721642, 2437.2200895713377, 2468.2348471973746, 2474.4308808973947, 2373.4303767095857, 2377.9286621401297, 2379.3575734551746, 2381.130887226159, 2416.6012607919674, 2344.601417758985, 2352.9411764705847, 2368.6802281692094, 2370.893309801063, 2372.3476044087843, 8717.30261579072, 9019.684311049148, 9032.277417806625, 9103.726888193365, 9118.77203069922, 5216.739163041871, 5369.865753356158, 5437.483439073281, 5437.700926449043, 5439.048166570874, 3441.9311613767836, 3461.2558299965626, 3472.149323415754, 3505.071156143624, 3540.13266749648, 991.4101109839634, 996.0537489385113, 996.6113215845826, 1003.6687892995367, 1019.8980101989816, 12472.376381180904, 12654.430550625244, 12688.175268607418, 12709.491620335175, 12713.872861271453, 4597.908041839144, 4636.235021221461, 4765.785539650724, 4849.660523763303, 4850.6362022848425, 10737.946310268555, 10743.194260430499, 10748.677539673823, 10750.892491075145, 10759.193060520493, 5342.0, 5364.597655175878, 5370.979513892348, 5386.757595908193, 5392.91910621341, 4346.543612920661, 4681.602063824613, 4871.269309603588, 4905.5094490550655, 4941.085899108676, 4065.6340929316502, 4094.5086589609436, 4186.3092589722355, 4241.597048280409, 4242.53332133465, 1293.6765808547864, 1293.767121918045, 1324.4106372664264, 1332.180708864061, 1336.3919416665394, 879.9824003519893, 1019.3170575714289, 1027.0345874877592, 1030.1552726764132, 1044.237706474278, 6080.027195648763, 6142.477889379364, 6230.096635987847, 6295.779647712308, 6491.8701625967215, 439.73835567837085, 449.4180036852284, 451.911877183946, 452.3260342090262, 452.99773501132944, 4059.918801623951, 4192.182524407772, 4196.790160491963, 4222.134462435193, 4223.535411104776, 10667.413292269, 11034.834477482844, 11045.83431248532, 11048.889511104946, 11055.839136890672, 10945.56217751297, 10945.671629851116, 10978.670639880816, 10984.0, 10990.065844403156, 7973.322267607203, 8283.420160588701, 8357.414980951275, 8363.749087527383, 8363.790905227417, 6216.067589861557, 6313.684315784284, 6376.171097757262, 6384.361563843764, 6458.838529036811, 10166.72229057584, 10283.691489255036, 10427.478626068818, 10451.163906887583, 10519.053285204369, 10548.578056877946, 10579.206559507913, 10657.626983055556, 10677.09244714208, 10679.412632305297, 7359.595222262613, 7941.404394670307, 8031.959840200761, 8225.753227403187, 8525.573721313785, 8568.228859402434, 8816.559172041501, 8839.027706952358, 8840.160184782693, 8841.911580884365, 7601.695932162652, 7897.842043158989, 7910.604469776603, 8027.076886157933, 8111.06722726894, 7780.144184139854, 7804.336631386395, 7858.13560508355, 7924.881126783218, 7990.161033091675, 7118.85762284741, 7218.494705370784, 7220.819479513054, 7221.566705997657, 7223.566586004857, 5053.343065401621, 5133.486651334837, 5163.509466600667, 5200.45395233495, 5423.2407462954425, 5310.867228319323, 5320.06898792702, 5330.387005494418, 5438.972805135949, 5508.862278443071], "value": 4654.913878233767, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.8192212361078, 324.63316452408776, 336.382737676364, 337.2294307507346, 338.6884066658674, 5073.543381095701, 5125.1287281162195, 5162.251473536339, 5174.508421699932, 5179.689218646879, 4803.351547541081, 4953.554180123788, 4967.677100988433, 4970.975145124269, 5091.516305950929, 3855.6529912307888, 3959.6436320731127, 3982.5220973483224, 3983.0, 3989.1822176453757, 3976.940345894814, 3992.3412636914873, 3994.760314381132, 4007.939880901789, 4027.7784721840285, 3891.5330160380795, 3944.704147188958, 3954.8615798446917, 3991.2017596480673, 3995.5604883462797, 3985.322495175827, 3993.700472464562, 3995.440638310639, 3999.6600288975474, 4003.6596889264447, 3519.560054993126, 3526.453399723047, 3528.4530897710897, 3529.294141171776, 3540.9108625910835, 4897.804087836482, 5025.899482010339, 5033.421156567005, 5034.899302013976, 5044.369453818273, 4506.7070640408265, 4547.886302842422, 4560.77196140195, 4565.56627120423, 4577.679562430631, 5251.579873610141, 5284.392294886099, 5297.152455607084, 5308.681479111227, 5321.627486075976, 3827.2919509890758, 3848.1918797052654, 3860.073582340246, 3868.9806550967346, 3874.089588946595, 5307.814226502054, 5474.534664553517, 5484.780608775644, 5493.972530137364, 5498.45015498451, 4048.817803198863, 4063.3498640218013, 4065.1869626074313, 4071.491063617048, 4073.6333729964445, 4114.634085400907, 4118.8673114893645, 4122.711410201257, 4133.4626498555, 4134.1731653669385, 4517.344984977226, 4581.931271030937, 4597.770111494478, 4598.379218805485, 4649.5350464953235, 5291.894162116736, 5307.48736610072, 5310.814121505806, 5312.707801070901, 5317.1492561190025, 1380.758367285721, 1392.2412285304533, 1397.4689617945116, 1399.3842709207916, 1405.3605609447677, 880.6829541365104, 949.0, 968.8615876345266, 985.3299756165733, 993.438707130469, 5153.716545589954, 5159.380874295109, 5162.483751624807, 5183.0, 5194.636375453682, 5394.9460505394445, 5398.24424580559, 5407.83776486706, 5417.052015897202, 5437.700926449004, 4946.208606622923, 5115.335006449138, 5134.229865520202, 5176.7411629418375, 5194.896102077937, 2875.3674191678215, 2888.2057434205763, 2890.8554572271723, 2895.5367141257298, 2905.2568458924898, 5443.646162999393, 5650.604457688005, 5668.489835914787, 5713.942860571341, 5717.514011309002, 5569.693666848362, 5586.497215250566, 5588.580856435702, 5592.664440133605, 5603.775848966077, 5733.226014488074, 5742.196092547047, 5748.511376532958, 5834.970825145847, 5845.357010728816, 5193.3900490847955, 5474.233607295061, 5478.233047373291, 5479.315085614298, 5513.862153446196, 5433.375161856437, 5460.645058071213, 5463.180522921593, 5465.289512363367, 5487.780488780404, 5635.492805647347, 5768.990426675399, 5776.797812076726, 5776.913346299725, 5803.82588522345, 3884.0, 3913.6477717005605, 3936.724429289922, 3958.584348643466, 3977.482927219443, 5470.945290547203, 5485.314335708036, 5492.830332018751, 5520.0, 5532.30846144232, 5218.321618189611, 5345.9842629900195, 5367.141257398797, 5378.462153784591, 5417.214503896992, 5297.6291659585, 5318.547923426398, 5330.773921997885, 5337.265388748595, 5347.893042139213, 5063.683442304953, 5113.335266415343, 5286.97356513215, 5289.153735402318, 5293.497117773805, 5313.388960269618, 5331.920021199608, 5338.772082420987, 5347.957148356033, 5359.0, 5185.896282074413, 5207.29701490294, 5209.697575606098, 5229.163333866563, 5236.502532259429], "value": 4103.668401430923, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.7255615422298, 775.9689612415503, 791.8455901099285, 826.8346330733852, 838.7819167016573, 15847.920760396197, 16074.678506429864, 16371.836281637181, 16381.83618163818, 17717.29130834768, 15389.230538473088, 15747.685046299095, 15771.684566308666, 15772.44796432125, 15774.0535567866, 640.5228105061735, 763.2939530933892, 808.6280311056921, 809.3282575462352, 821.6138414944996, 809.6882700160422, 816.8202995341015, 817.0, 817.358373676664, 817.5258350156925, 857.0700789643245, 858.9613467393982, 859.4714250735784, 859.7463748194298, 860.5525126933991, 682.1745687717868, 819.7090033038305, 844.2148801614496, 850.8681154421074, 851.9488830670149, 615.5168192968498, 616.0113018605164, 616.1189499016405, 616.1989413762092, 616.5252755378334, 15284.847151528453, 15286.541403757905, 15460.922695386564, 15482.5355239343, 15661.451849185223, 13318.933405332911, 13781.173129612256, 14027.64930876726, 14261.073030253001, 14268.072575282573, 13310.334483275798, 13424.798628020588, 13506.392212350467, 13542.526011589645, 13785.586432406944, 4297.4413326267695, 4297.699161058727, 4349.108432771274, 4350.499692535335, 4455.77721113943, 75880.0, 76994.84507732332, 77315.6134219331, 77386.22613773847, 77471.22528774696, 11241.887581124247, 11481.540738370371, 11710.414479276002, 11980.101492388107, 12058.939705301593, 19615.0, 21053.263135790174, 21092.0, 21106.78893211048, 21110.683339749918, 8423.536705481258, 8440.240378365854, 8519.914800852037, 8529.95735021321, 8537.74386768398, 4690.906181876343, 4811.903761924742, 4849.75751212438, 4918.385201849769, 5040.79836806531, 3515.6132825389186, 3586.5474482834493, 3601.2077342984503, 3631.7094632429344, 3643.7813731176216, 613.8618810767541, 624.3974564545144, 625.537649112171, 637.0921436952417, 639.0573903492311, 624.2664868779257, 685.5441131647498, 696.098552374676, 707.9752208672671, 713.2083387439937, 9338.412469880137, 9711.562979665932, 9946.552405141785, 10096.293259471913, 10181.33821301613, 642.7910928948111, 655.5837043477426, 685.1695546397875, 686.8523267497512, 695.9234484206734, 4722.150012997625, 4997.475265097112, 5003.54968052877, 5009.148444764399, 5037.496250375007, 72611.0, 74194.6290268556, 101027.0, 102771.0, 105081.47459262807, 102736.48631756943, 106604.0, 107222.92777072286, 107291.32299571142, 108989.0, 92817.53591232, 95091.52454237685, 96145.9999999986, 98430.0, 99549.50225248972, 10313.9484302578, 10336.276460647983, 10664.146868250366, 10682.519286631965, 10908.072813810597, 41554.37668435036, 43670.0, 44304.335434967856, 45349.773251133534, 55354.44645553654, 74909.62545187239, 76409.0, 78778.0, 79464.0, 83257.58371208105, 14629.561113166623, 14708.632284192981, 14735.55793326202, 14784.556463306119, 14860.851391485947, 15961.920190398974, 16006.279717412977, 16106.919465403067, 16187.352505900104, 17183.398581050104, 14777.482788102365, 15021.324040417989, 15274.236288185768, 15407.537773866801, 15743.842561574238, 14627.19550424737, 15300.311485982935, 15354.078755274719, 15478.767818482507, 15871.68256634884, 13673.31633418345, 14714.411423542939, 15073.170975596448, 15295.847041529441, 15780.210989450712, 10819.242653014213, 11406.372649504357, 11489.310641361544, 11497.770044598894, 11638.451935081148, 11378.31730096197, 11829.97931164178, 12165.635030949086, 12639.747205055663, 12690.936545317214], "value": 7772.432456103321, "unit": "score"}], "name": "dromaeo_css", "value": 7188.105736875379, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 111.0, 112.0, 111.0, 110.0, 110.0, 113.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 124.0, 179.0, 119.0, 123.0, 140.0, 116.0, 164.0, 117.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 163.0, 161.0, 161.0, 161.0, 163.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 119.0, 76.0, 75.0, 73.0, 74.0, 118.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 84.0, 84.0, 83.0, 117.0, 84.0, 83.0, 135.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 52.0, 51.0, 53.0, 52.0, 52.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 63.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 76.0, 78.0, 75.0, 74.0, 76.0, 75.0, 79.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 120.0, 121.0, 122.0, 129.0, 119.0, 120.0, 212.0, 121.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 156.0, 156.0, 159.0, 158.0, 158.0, 161.0, 156.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 64.0, 64.0, 62.0, 61.0, 64.0, 63.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1486.6000000000001, "alertThreshold": 2.0}]} 01:42:41 INFO - Return code: 0 01:42:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:42:41 INFO - # TBPL SUCCESS # 01:42:41 INFO - Running post-action listener: _resource_record_post_action 01:42:41 INFO - [mozharness: 2016-08-01 08:42:41.276415Z] Finished run-tests step (success) 01:42:41 INFO - Running post-run listener: _resource_record_post_run 01:42:41 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 541270016; Read time: 20; Write time: 471328 01:42:41 INFO - TinderboxPrint: CPU usage
12.9% 01:42:41 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 01:42:41 INFO - TinderboxPrint: I/O write bytes / time
541,270,016 / 471,328 01:42:41 INFO - TinderboxPrint: CPU idle
8,275.3 (87.0%) 01:42:41 INFO - TinderboxPrint: CPU user
1,186.3 (12.5%) 01:42:41 INFO - TinderboxPrint: Swap in / out
0 / 0 01:42:41 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247496704; Read time: 0; Write time: 260824 01:42:41 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293208064; Read time: 12; Write time: 210452 01:42:41 INFO - Running post-run listener: _upload_blobber_files 01:42:41 INFO - Blob upload gear active. 01:42:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:42:41 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 01:42:41 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'] 01:42:41 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 01:42:42 INFO - (blobuploader) - INFO - Open directory for files ... 01:42:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:42:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:42:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:42:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:42:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:42:43 INFO - (blobuploader) - INFO - Done attempting. 01:42:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:42:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:42:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:42:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:42:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:42:46 INFO - (blobuploader) - INFO - Done attempting. 01:42:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:42:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:42:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:42:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:42:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:42:47 INFO - (blobuploader) - INFO - Done attempting. 01:42:47 INFO - (blobuploader) - INFO - Iteration through files over. 01:42:47 INFO - Return code: 0 01:42:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:42:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:42:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/235c11ae2f204d5394c97f21f00b8e53b9b36bce8abfce31f85eb4a0a388d6ade3a7095cc82dbb244705da7252d6197f4980096973198c214f2239602af948b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99e5ae0a6e7af6d3014067b1788999e033bf843e89f4b4adb909f7c3c76acc930636bcb17800483fd1a6756195f3485e3baabae392dc6d63bc85ff7f4549c48c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a728c5e025e9cb0cb987b1a5ca240ea557e4456eb675e0f2fe0cf9a1f7b0b4582701b1875bb0a672e7413ae44d4a5f2309889949c4700aabb3f2fed73a5f796c"} 01:42:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:42:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:42:47 INFO - Contents: 01:42:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/235c11ae2f204d5394c97f21f00b8e53b9b36bce8abfce31f85eb4a0a388d6ade3a7095cc82dbb244705da7252d6197f4980096973198c214f2239602af948b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99e5ae0a6e7af6d3014067b1788999e033bf843e89f4b4adb909f7c3c76acc930636bcb17800483fd1a6756195f3485e3baabae392dc6d63bc85ff7f4549c48c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a728c5e025e9cb0cb987b1a5ca240ea557e4456eb675e0f2fe0cf9a1f7b0b4582701b1875bb0a672e7413ae44d4a5f2309889949c4700aabb3f2fed73a5f796c"} 01:42:47 INFO - Running post-run listener: copy_logs_to_upload_dir 01:42:47 INFO - Copying logs to upload dir... 01:42:47 INFO - mkdir: /builds/slave/test/build/upload/logs 01:42:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.672465 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-01 01:42:46.023527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 01:42:46.026733) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623 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/235c11ae2f204d5394c97f21f00b8e53b9b36bce8abfce31f85eb4a0a388d6ade3a7095cc82dbb244705da7252d6197f4980096973198c214f2239602af948b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99e5ae0a6e7af6d3014067b1788999e033bf843e89f4b4adb909f7c3c76acc930636bcb17800483fd1a6756195f3485e3baabae392dc6d63bc85ff7f4549c48c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a728c5e025e9cb0cb987b1a5ca240ea557e4456eb675e0f2fe0cf9a1f7b0b4582701b1875bb0a672e7413ae44d4a5f2309889949c4700aabb3f2fed73a5f796c"} build_url:https://queue.taskcluster.net/v1/task/WmelMcykQgaVmt6s_FeSyA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/WmelMcykQgaVmt6s_FeSyA/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/235c11ae2f204d5394c97f21f00b8e53b9b36bce8abfce31f85eb4a0a388d6ade3a7095cc82dbb244705da7252d6197f4980096973198c214f2239602af948b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/99e5ae0a6e7af6d3014067b1788999e033bf843e89f4b4adb909f7c3c76acc930636bcb17800483fd1a6756195f3485e3baabae392dc6d63bc85ff7f4549c48c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a728c5e025e9cb0cb987b1a5ca240ea557e4456eb675e0f2fe0cf9a1f7b0b4582701b1875bb0a672e7413ae44d4a5f2309889949c4700aabb3f2fed73a5f796c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 01:42:46.057055) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 01:42:46.057815) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1470038986.827752-1983602623 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 01:42:46.141396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 01:42:46.142161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 01:42:46.142881) ========= ========= Total master_lag: 0.19 =========