builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1469930877.12 results: success (0) buildid: 20160730163003 builduid: aa2dfe8c516e4ddaa1893d519a697a9a revision: 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:57.123751) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:57.124846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:57.125607) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:57.178460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:57.178753) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 19:07:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-07-30 19:07:57 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107015 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:57.307726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:57.308064) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022417 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:57.360178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:57.360559) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 --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 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 --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=20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 19:07:57,837 truncating revision to first 12 chars 2016-07-30 19:07:57,837 Setting DEBUG logging. 2016-07-30 19:07:57,837 attempt 1/10 2016-07-30 19:07:57,837 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0e1f1a9c666d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 19:07:58,158 unpacking tar archive at: mozilla-inbound-0e1f1a9c666d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645245 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:58.031301) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:58.031671) ========= script_repo_revision: 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:58.032113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:58.032492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 19:07:58.056972) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-30 19:07:58.057286) ========= /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=20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:07:58 INFO - MultiFileLogger online at 20160730 19:07:58 in /builds/slave/test 19:07:58 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 19:07:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:07:58 INFO - {'append_to_log': False, 19:07:58 INFO - 'base_work_dir': '/builds/slave/test', 19:07:58 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:07:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:07:58 INFO - 'branch': 'Mozilla-Inbound', 19:07:58 INFO - 'buildbot_json_path': 'buildprops.json', 19:07:58 INFO - 'config_files': ('talos/linux_config.py',), 19:07:58 INFO - 'default_actions': ('clobber', 19:07:58 INFO - 'read-buildbot-config', 19:07:58 INFO - 'download-and-extract', 19:07:58 INFO - 'populate-webroot', 19:07:58 INFO - 'create-virtualenv', 19:07:58 INFO - 'install', 19:07:58 INFO - 'run-tests'), 19:07:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:07:58 INFO - 'download_minidump_stackwalk': True, 19:07:58 INFO - 'download_symbols': 'ondemand', 19:07:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:07:58 INFO - 'tooltool.py': '/tools/tooltool.py', 19:07:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:07:58 INFO - '/tools/misc-python/virtualenv.py')}, 19:07:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:07:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:07:58 INFO - 'installer_path': 'installer.exe', 19:07:58 INFO - 'log_level': 'info', 19:07:58 INFO - 'log_name': 'talos', 19:07:58 INFO - 'log_to_console': True, 19:07:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:07:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:07:58 INFO - 'opt_config_files': (), 19:07:58 INFO - 'pip_index': False, 19:07:58 INFO - 'sps_profile': False, 19:07:58 INFO - 'sps_profile_interval': 0, 19:07:58 INFO - 'suite': 'dromaeojs', 19:07:58 INFO - 'system_bits': '32', 19:07:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:07:58 INFO - 'title': 'talos-linux64-ix-015', 19:07:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:07:58 INFO - 'use_talos_json': True, 19:07:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:07:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:07:58 INFO - 'work_dir': 'build'} 19:07:58 INFO - [mozharness: 2016-07-31 02:07:58.630715Z] Running clobber step. 19:07:58 INFO - Running pre-action listener: _resource_record_pre_action 19:07:58 INFO - Running main action method: clobber 19:07:58 INFO - rmtree: /builds/slave/test/build 19:07:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:07:59 INFO - Running post-action listener: _resource_record_post_action 19:07:59 INFO - [mozharness: 2016-07-31 02:07:59.088997Z] Finished clobber step (success) 19:07:59 INFO - [mozharness: 2016-07-31 02:07:59.089108Z] Running read-buildbot-config step. 19:07:59 INFO - Running pre-action listener: _resource_record_pre_action 19:07:59 INFO - Running main action method: read_buildbot_config 19:07:59 INFO - Using buildbot properties: 19:07:59 INFO - { 19:07:59 INFO - "project": "", 19:07:59 INFO - "product": "firefox", 19:07:59 INFO - "script_repo_revision": "production", 19:07:59 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:07:59 INFO - "repository": "", 19:07:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:07:59 INFO - "buildid": "20160730163003", 19:07:59 INFO - "pgo_build": "True", 19:07:59 INFO - "basedir": "/builds/slave/test", 19:07:59 INFO - "buildnumber": 2165, 19:07:59 INFO - "slavename": "talos-linux64-ix-015", 19:07:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:07:59 INFO - "platform": "ubuntu64_hw", 19:07:59 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:07:59 INFO - "branch": "mozilla-inbound", 19:07:59 INFO - "repo_path": "integration/mozilla-inbound", 19:07:59 INFO - "revision": "0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4", 19:07:59 INFO - "stage_platform": "linux64-pgo", 19:07:59 INFO - "builduid": "aa2dfe8c516e4ddaa1893d519a697a9a", 19:07:59 INFO - "slavebuilddir": "test" 19:07:59 INFO - } 19:07:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:07:59 INFO - Running post-action listener: _resource_record_post_action 19:07:59 INFO - [mozharness: 2016-07-31 02:07:59.091530Z] Finished read-buildbot-config step (success) 19:07:59 INFO - [mozharness: 2016-07-31 02:07:59.091619Z] Running download-and-extract step. 19:07:59 INFO - Running pre-action listener: _resource_record_pre_action 19:07:59 INFO - Running main action method: download_and_extract 19:07:59 INFO - mkdir: /builds/slave/test/build/tests 19:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:59 INFO - https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:07:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:07:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:07:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:08:05 INFO - Downloaded 1361 bytes. 19:08:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:08:05 INFO - Using the following test package requirements: 19:08:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:08:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:08:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:05 INFO - u'jsshell-linux-x86_64.zip'], 19:08:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:08:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:08:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:08:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:08:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:08:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:08:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:08:05 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')]} 19:08:05 INFO - https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:08:10 INFO - Downloaded 21803709 bytes. 19:08:10 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'] 19:08:10 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 19:08:11 INFO - Return code: 0 19:08:11 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 19:08:11 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')]} 19:08:11 INFO - https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:08:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:08:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:08:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:08:17 INFO - Downloaded 21803709 bytes. 19:08:17 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'] 19:08:17 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 19:08:18 INFO - Return code: 0 19:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:18 INFO - https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:08:19 INFO - Downloaded 14413723 bytes. 19:08:19 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'] 19:08:19 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 19:08:19 INFO - Return code: 0 19:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:19 INFO - https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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 19:08:21 INFO - Downloaded 59367804 bytes. 19:08:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:21 INFO - mkdir: /builds/slave/test/properties 19:08:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:08:21 INFO - Writing to file /builds/slave/test/properties/build_url 19:08:21 INFO - Contents: 19:08:21 INFO - build_url:https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:08:21 INFO - Running post-action listener: _resource_record_post_action 19:08:21 INFO - Running post-action listener: set_extra_try_arguments 19:08:21 INFO - [mozharness: 2016-07-31 02:08:21.860563Z] Finished download-and-extract step (success) 19:08:21 INFO - [mozharness: 2016-07-31 02:08:21.860794Z] Running populate-webroot step. 19:08:21 INFO - Running pre-action listener: _resource_record_pre_action 19:08:21 INFO - Running main action method: populate_webroot 19:08:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:08:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:08:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:08:21 INFO - '--tppagecycles', 19:08:21 INFO - '7'], 19:08:21 INFO - 'tests': ['tsvgm']}}, 19:08:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:08:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:08:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:08:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:08:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:08:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['damp', 'tps']}, 19:08:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'tests': ['damp', 'tps']}, 19:08:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['dromaeo_dom']}, 19:08:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:08:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['basic_compositor_video']}, 19:08:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:08:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'other-e10s': {'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['a11yr', 19:08:21 INFO - 'ts_paint', 19:08:21 INFO - 'tpaint', 19:08:21 INFO - 'sessionrestore', 19:08:21 INFO - 'sessionrestore_no_auto_restore', 19:08:21 INFO - 'tabpaint']}, 19:08:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['tsvgx', 19:08:21 INFO - 'tsvgr_opacity', 19:08:21 INFO - 'tart', 19:08:21 INFO - 'tscrollx', 19:08:21 INFO - 'cart']}, 19:08:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:08:21 INFO - 'tsvgr_opacity', 19:08:21 INFO - 'tart', 19:08:21 INFO - 'tscrollx', 19:08:21 INFO - 'cart']}, 19:08:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'talos_options': ['--disable-e10s'], 19:08:21 INFO - 'tests': ['tp5o']}, 19:08:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'tests': ['tp5o']}, 19:08:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'talos_options': ['--disable-e10s', 19:08:21 INFO - '--xperf_path', 19:08:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:21 INFO - 'tests': ['tp5n']}, 19:08:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:08:21 INFO - 'talos_options': ['--xperf_path', 19:08:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:08:21 INFO - 'tests': ['tp5n']}}, 19:08:21 INFO - 'talos.zip': {'path': '', 19:08:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:08:21 INFO - Running post-action listener: _resource_record_post_action 19:08:21 INFO - [mozharness: 2016-07-31 02:08:21.881851Z] Finished populate-webroot step (success) 19:08:21 INFO - [mozharness: 2016-07-31 02:08:21.881940Z] Running create-virtualenv step. 19:08:21 INFO - Running pre-action listener: _resource_record_pre_action 19:08:21 INFO - Running main action method: create_virtualenv 19:08:21 INFO - Creating virtualenv /builds/slave/test/build/venv 19:08:21 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 19:08:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:08:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:08:22 INFO - Using real prefix '/usr' 19:08:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:08:22 INFO - Installing distribute.............................................................................................................................................................................................done. 19:08:24 INFO - Installing pip.................done. 19:08:24 INFO - Return code: 0 19:08:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', '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 19:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:08:24 INFO - Using env: {'DISPLAY': ':0', 19:08:24 INFO - 'HOME': '/home/cltbld', 19:08:24 INFO - 'LANG': 'en_US.UTF-8', 19:08:24 INFO - 'LANGUAGE': 'en_US:en', 19:08:24 INFO - 'LOGNAME': 'cltbld', 19:08:24 INFO - 'MAIL': '/var/mail/cltbld', 19:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:24 INFO - 'MOZ_NO_REMOTE': '1', 19:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:24 INFO - 'NO_EM_RESTART': '1', 19:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:24 INFO - 'PWD': '/builds/slave/test', 19:08:24 INFO - 'SHELL': '/bin/bash', 19:08:24 INFO - 'SHLVL': '1', 19:08:24 INFO - 'TERM': 'linux', 19:08:24 INFO - 'TMOUT': '86400', 19:08:24 INFO - 'USER': 'cltbld', 19:08:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:24 INFO - '_': '/tools/buildbot/bin/python'} 19:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:24 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 19:08:24 INFO - Cleaning up... 19:08:24 INFO - Return code: 0 19:08:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', '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 19:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:08:24 INFO - Using env: {'DISPLAY': ':0', 19:08:24 INFO - 'HOME': '/home/cltbld', 19:08:24 INFO - 'LANG': 'en_US.UTF-8', 19:08:24 INFO - 'LANGUAGE': 'en_US:en', 19:08:24 INFO - 'LOGNAME': 'cltbld', 19:08:24 INFO - 'MAIL': '/var/mail/cltbld', 19:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:24 INFO - 'MOZ_NO_REMOTE': '1', 19:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:24 INFO - 'NO_EM_RESTART': '1', 19:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:24 INFO - 'PWD': '/builds/slave/test', 19:08:24 INFO - 'SHELL': '/bin/bash', 19:08:24 INFO - 'SHLVL': '1', 19:08:24 INFO - 'TERM': 'linux', 19:08:24 INFO - 'TMOUT': '86400', 19:08:24 INFO - 'USER': 'cltbld', 19:08:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:24 INFO - '_': '/tools/buildbot/bin/python'} 19:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:24 INFO - Downloading/unpacking psutil>=3.1.1 19:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:08:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:26 INFO - Installing collected packages: psutil 19:08:26 INFO - Running setup.py install for psutil 19:08:27 INFO - building 'psutil._psutil_linux' extension 19:08:27 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 19:08:27 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 19:08:27 INFO - building 'psutil._psutil_posix' extension 19:08:27 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 19:08:27 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 19:08:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:27 INFO - Successfully installed psutil 19:08:27 INFO - Cleaning up... 19:08:27 INFO - Return code: 0 19:08:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:27 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 0xd37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', '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 19:08:27 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 19:08:27 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 19:08:27 INFO - Using env: {'DISPLAY': ':0', 19:08:27 INFO - 'HOME': '/home/cltbld', 19:08:27 INFO - 'LANG': 'en_US.UTF-8', 19:08:27 INFO - 'LANGUAGE': 'en_US:en', 19:08:27 INFO - 'LOGNAME': 'cltbld', 19:08:27 INFO - 'MAIL': '/var/mail/cltbld', 19:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:27 INFO - 'MOZ_NO_REMOTE': '1', 19:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:27 INFO - 'NO_EM_RESTART': '1', 19:08:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:27 INFO - 'PWD': '/builds/slave/test', 19:08:27 INFO - 'SHELL': '/bin/bash', 19:08:27 INFO - 'SHLVL': '1', 19:08:27 INFO - 'TERM': 'linux', 19:08:27 INFO - 'TMOUT': '86400', 19:08:27 INFO - 'USER': 'cltbld', 19:08:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:27 INFO - '_': '/tools/buildbot/bin/python'} 19:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:08:29 INFO - Installing collected packages: mozsystemmonitor 19:08:29 INFO - Running setup.py install for mozsystemmonitor 19:08:29 INFO - Successfully installed mozsystemmonitor 19:08:29 INFO - Cleaning up... 19:08:29 INFO - Return code: 0 19:08:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:08:29 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')]} 19:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:29 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')]} 19:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:29 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 0xd37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', '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 19:08:29 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 19:08:29 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 19:08:29 INFO - Using env: {'DISPLAY': ':0', 19:08:29 INFO - 'HOME': '/home/cltbld', 19:08:29 INFO - 'LANG': 'en_US.UTF-8', 19:08:29 INFO - 'LANGUAGE': 'en_US:en', 19:08:29 INFO - 'LOGNAME': 'cltbld', 19:08:29 INFO - 'MAIL': '/var/mail/cltbld', 19:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:29 INFO - 'MOZ_NO_REMOTE': '1', 19:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:29 INFO - 'NO_EM_RESTART': '1', 19:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:29 INFO - 'PWD': '/builds/slave/test', 19:08:29 INFO - 'SHELL': '/bin/bash', 19:08:29 INFO - 'SHLVL': '1', 19:08:29 INFO - 'TERM': 'linux', 19:08:29 INFO - 'TMOUT': '86400', 19:08:29 INFO - 'USER': 'cltbld', 19:08:29 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:29 INFO - '_': '/tools/buildbot/bin/python'} 19:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:30 INFO - Downloading/unpacking jsonschema==2.5.1 19:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:32 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:32 INFO - warning: no files found matching '*.txt' 19:08:32 INFO - no previously-included directories found matching 'build' 19:08:32 INFO - no previously-included directories found matching 'dist' 19:08:32 INFO - no previously-included directories found matching '.git*' 19:08:32 INFO - Installing collected packages: jsonschema, functools32 19:08:32 INFO - Running setup.py install for functools32 19:08:32 INFO - warning: no files found matching '*.txt' 19:08:32 INFO - no previously-included directories found matching 'build' 19:08:32 INFO - no previously-included directories found matching 'dist' 19:08:32 INFO - no previously-included directories found matching '.git*' 19:08:32 INFO - Successfully installed jsonschema functools32 19:08:32 INFO - Cleaning up... 19:08:32 INFO - Return code: 0 19:08:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:32 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 0xd37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', '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 19:08:32 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 19:08:32 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 19:08:32 INFO - Using env: {'DISPLAY': ':0', 19:08:32 INFO - 'HOME': '/home/cltbld', 19:08:32 INFO - 'LANG': 'en_US.UTF-8', 19:08:32 INFO - 'LANGUAGE': 'en_US:en', 19:08:32 INFO - 'LOGNAME': 'cltbld', 19:08:32 INFO - 'MAIL': '/var/mail/cltbld', 19:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:32 INFO - 'MOZ_NO_REMOTE': '1', 19:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:32 INFO - 'NO_EM_RESTART': '1', 19:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:32 INFO - 'PWD': '/builds/slave/test', 19:08:32 INFO - 'SHELL': '/bin/bash', 19:08:32 INFO - 'SHLVL': '1', 19:08:32 INFO - 'TERM': 'linux', 19:08:32 INFO - 'TMOUT': '86400', 19:08:32 INFO - 'USER': 'cltbld', 19:08:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:32 INFO - '_': '/tools/buildbot/bin/python'} 19:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:08:32 INFO - Cleaning up... 19:08:32 INFO - Return code: 0 19:08:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:32 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 0xd37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', '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 19:08:32 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 19:08:32 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 19:08:32 INFO - Using env: {'DISPLAY': ':0', 19:08:32 INFO - 'HOME': '/home/cltbld', 19:08:32 INFO - 'LANG': 'en_US.UTF-8', 19:08:32 INFO - 'LANGUAGE': 'en_US:en', 19:08:32 INFO - 'LOGNAME': 'cltbld', 19:08:32 INFO - 'MAIL': '/var/mail/cltbld', 19:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:32 INFO - 'MOZ_NO_REMOTE': '1', 19:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:32 INFO - 'NO_EM_RESTART': '1', 19:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:32 INFO - 'PWD': '/builds/slave/test', 19:08:32 INFO - 'SHELL': '/bin/bash', 19:08:32 INFO - 'SHLVL': '1', 19:08:32 INFO - 'TERM': 'linux', 19:08:32 INFO - 'TMOUT': '86400', 19:08:32 INFO - 'USER': 'cltbld', 19:08:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:32 INFO - '_': '/tools/buildbot/bin/python'} 19:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:32 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:32 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 19:08:32 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 19:08:32 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 19:08:32 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 19:08:32 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 19:08:32 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 19:08:34 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:34 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 19:08:34 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 19:08:34 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 19:08:34 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 19:08:34 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 19:08:34 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 19:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:35 INFO - Downloading docopt-0.6.1.tar.gz 19:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:35 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:35 INFO - Running setup.py install for blobuploader 19:08:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:35 INFO - Running setup.py install for requests 19:08:35 INFO - Running setup.py install for docopt 19:08:35 INFO - Successfully installed blobuploader requests docopt 19:08:35 INFO - Cleaning up... 19:08:36 INFO - Return code: 0 19:08:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:36 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 0xd37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', '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 19:08:36 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 19:08:36 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 19:08:36 INFO - Using env: {'DISPLAY': ':0', 19:08:36 INFO - 'HOME': '/home/cltbld', 19:08:36 INFO - 'LANG': 'en_US.UTF-8', 19:08:36 INFO - 'LANGUAGE': 'en_US:en', 19:08:36 INFO - 'LOGNAME': 'cltbld', 19:08:36 INFO - 'MAIL': '/var/mail/cltbld', 19:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:36 INFO - 'MOZ_NO_REMOTE': '1', 19:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:36 INFO - 'NO_EM_RESTART': '1', 19:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:36 INFO - 'PWD': '/builds/slave/test', 19:08:36 INFO - 'SHELL': '/bin/bash', 19:08:36 INFO - 'SHLVL': '1', 19:08:36 INFO - 'TERM': 'linux', 19:08:36 INFO - 'TMOUT': '86400', 19:08:36 INFO - 'USER': 'cltbld', 19:08:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:36 INFO - '_': '/tools/buildbot/bin/python'} 19:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:36 INFO - Running setup.py (path:/tmp/pip-wrrSmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:36 INFO - Running setup.py (path:/tmp/pip-3IYKHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:36 INFO - Running setup.py (path:/tmp/pip-vPFZs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:36 INFO - Running setup.py (path:/tmp/pip-pHCyht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:36 INFO - Running setup.py (path:/tmp/pip-sz0_H2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:36 INFO - Running setup.py (path:/tmp/pip-6gLeRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:36 INFO - Running setup.py (path:/tmp/pip-4bCZZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:36 INFO - Running setup.py (path:/tmp/pip-PsyK50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:36 INFO - Running setup.py (path:/tmp/pip-Blz0QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:36 INFO - Running setup.py (path:/tmp/pip-CznAXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:36 INFO - Running setup.py (path:/tmp/pip-dfzAt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:37 INFO - Running setup.py (path:/tmp/pip-xkmdik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:37 INFO - Running setup.py (path:/tmp/pip-Q0JOeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:37 INFO - Running setup.py (path:/tmp/pip-52erkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:37 INFO - Running setup.py (path:/tmp/pip-_ZHBEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:37 INFO - Running setup.py (path:/tmp/pip-Ah8ESC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:37 INFO - Running setup.py (path:/tmp/pip-Jgj6R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:37 INFO - Running setup.py install for manifestparser 19:08:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozcrash 19:08:37 INFO - Running setup.py install for mozdebug 19:08:37 INFO - Running setup.py install for mozdevice 19:08:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:37 INFO - Running setup.py install for mozfile 19:08:38 INFO - Running setup.py install for mozhttpd 19:08:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Running setup.py install for mozinfo 19:08:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Running setup.py install for mozInstall 19:08:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Running setup.py install for mozleak 19:08:38 INFO - Running setup.py install for mozlog 19:08:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Running setup.py install for moznetwork 19:08:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Running setup.py install for mozprocess 19:08:38 INFO - Running setup.py install for mozprofile 19:08:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Running setup.py install for mozrunner 19:08:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:38 INFO - Running setup.py install for mozscreenshot 19:08:39 INFO - Running setup.py install for moztest 19:08:39 INFO - Running setup.py install for mozversion 19:08:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:39 INFO - Cleaning up... 19:08:39 INFO - Return code: 0 19:08:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:39 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')]} 19:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:39 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')]} 19:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:39 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 0xd37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', '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 19:08:39 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 19:08:39 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 19:08:39 INFO - Using env: {'DISPLAY': ':0', 19:08:39 INFO - 'HOME': '/home/cltbld', 19:08:39 INFO - 'LANG': 'en_US.UTF-8', 19:08:39 INFO - 'LANGUAGE': 'en_US:en', 19:08:39 INFO - 'LOGNAME': 'cltbld', 19:08:39 INFO - 'MAIL': '/var/mail/cltbld', 19:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:39 INFO - 'MOZ_NO_REMOTE': '1', 19:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:39 INFO - 'NO_EM_RESTART': '1', 19:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:39 INFO - 'PWD': '/builds/slave/test', 19:08:39 INFO - 'SHELL': '/bin/bash', 19:08:39 INFO - 'SHLVL': '1', 19:08:39 INFO - 'TERM': 'linux', 19:08:39 INFO - 'TMOUT': '86400', 19:08:39 INFO - 'USER': 'cltbld', 19:08:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:39 INFO - '_': '/tools/buildbot/bin/python'} 19:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:39 INFO - Running setup.py (path:/tmp/pip-PpPcVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:39 INFO - Running setup.py (path:/tmp/pip-3FSeSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:39 INFO - Running setup.py (path:/tmp/pip-r4qCa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:39 INFO - Running setup.py (path:/tmp/pip-z0T8Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:39 INFO - Running setup.py (path:/tmp/pip-mdq2E7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:39 INFO - Running setup.py (path:/tmp/pip-whs9mB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:39 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)) 19:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:39 INFO - Running setup.py (path:/tmp/pip-NnGW_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:40 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)) 19:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:40 INFO - Running setup.py (path:/tmp/pip-_scblu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:40 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)) 19:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:40 INFO - Running setup.py (path:/tmp/pip-FXTgEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:40 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)) 19:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:40 INFO - Running setup.py (path:/tmp/pip-x9EDMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:40 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)) 19:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:40 INFO - Running setup.py (path:/tmp/pip-NgWYYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:40 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)) 19:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:40 INFO - Running setup.py (path:/tmp/pip-qEbmNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:40 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)) 19:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:40 INFO - Running setup.py (path:/tmp/pip-bo9yhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:40 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)) 19:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:40 INFO - Running setup.py (path:/tmp/pip-iCYI2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:40 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)) 19:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:40 INFO - Running setup.py (path:/tmp/pip-YqPzF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:40 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)) 19:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:40 INFO - Running setup.py (path:/tmp/pip-nB1dgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:40 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)) 19:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:40 INFO - Running setup.py (path:/tmp/pip-Vcejqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:40 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)) 19:08:40 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)) 19:08:40 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)) 19:08:40 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)) 19:08:40 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)) 19:08:40 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)) 19:08:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:42 INFO - Downloading blessings-1.6.tar.gz 19:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:42 INFO - Installing collected packages: blessings 19:08:42 INFO - Running setup.py install for blessings 19:08:42 INFO - Successfully installed blessings 19:08:42 INFO - Cleaning up... 19:08:42 INFO - Return code: 0 19:08:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:43 INFO - Reading from file tmpfile_stdout 19:08:43 INFO - Current package versions: 19:08:43 INFO - argparse == 1.2.1 19:08:43 INFO - blessings == 1.6 19:08:43 INFO - blobuploader == 1.2.4 19:08:43 INFO - docopt == 0.6.1 19:08:43 INFO - functools32 == 3.2.3-2 19:08:43 INFO - jsonschema == 2.5.1 19:08:43 INFO - manifestparser == 1.1 19:08:43 INFO - mozInstall == 1.12 19:08:43 INFO - mozcrash == 0.17 19:08:43 INFO - mozdebug == 0.1 19:08:43 INFO - mozdevice == 0.48 19:08:43 INFO - mozfile == 1.2 19:08:43 INFO - mozhttpd == 0.7 19:08:43 INFO - mozinfo == 0.9 19:08:43 INFO - mozleak == 0.1 19:08:43 INFO - mozlog == 3.3 19:08:43 INFO - moznetwork == 0.27 19:08:43 INFO - mozprocess == 0.23 19:08:43 INFO - mozprofile == 0.28 19:08:43 INFO - mozrunner == 6.12 19:08:43 INFO - mozscreenshot == 0.1 19:08:43 INFO - mozsystemmonitor == 0.3 19:08:43 INFO - moztest == 0.7 19:08:43 INFO - mozversion == 1.4 19:08:43 INFO - psutil == 3.1.1 19:08:43 INFO - requests == 1.2.3 19:08:43 INFO - wsgiref == 0.1.2 19:08:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:43 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 0xd37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', '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 19:08:43 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 19:08:43 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 19:08:43 INFO - Using env: {'DISPLAY': ':0', 19:08:43 INFO - 'HOME': '/home/cltbld', 19:08:43 INFO - 'LANG': 'en_US.UTF-8', 19:08:43 INFO - 'LANGUAGE': 'en_US:en', 19:08:43 INFO - 'LOGNAME': 'cltbld', 19:08:43 INFO - 'MAIL': '/var/mail/cltbld', 19:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:43 INFO - 'MOZ_NO_REMOTE': '1', 19:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:43 INFO - 'NO_EM_RESTART': '1', 19:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:43 INFO - 'PWD': '/builds/slave/test', 19:08:43 INFO - 'SHELL': '/bin/bash', 19:08:43 INFO - 'SHLVL': '1', 19:08:43 INFO - 'TERM': 'linux', 19:08:43 INFO - 'TMOUT': '86400', 19:08:43 INFO - 'USER': 'cltbld', 19:08:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:43 INFO - '_': '/tools/buildbot/bin/python'} 19:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:43 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)) 19:08:43 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)) 19:08:43 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)) 19:08:43 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)) 19:08:43 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)) 19:08:43 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)) 19:08:43 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)) 19:08:43 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)) 19:08:43 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)) 19:08:43 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)) 19:08:43 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)) 19:08:43 INFO - Cleaning up... 19:08:43 INFO - Return code: 0 19:08:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, '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': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', '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 19:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:08:43 INFO - Using env: {'DISPLAY': ':0', 19:08:43 INFO - 'HOME': '/home/cltbld', 19:08:43 INFO - 'LANG': 'en_US.UTF-8', 19:08:43 INFO - 'LANGUAGE': 'en_US:en', 19:08:43 INFO - 'LOGNAME': 'cltbld', 19:08:43 INFO - 'MAIL': '/var/mail/cltbld', 19:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:43 INFO - 'MOZ_NO_REMOTE': '1', 19:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:43 INFO - 'NO_EM_RESTART': '1', 19:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:43 INFO - 'PWD': '/builds/slave/test', 19:08:43 INFO - 'SHELL': '/bin/bash', 19:08:43 INFO - 'SHLVL': '1', 19:08:43 INFO - 'TERM': 'linux', 19:08:43 INFO - 'TMOUT': '86400', 19:08:43 INFO - 'USER': 'cltbld', 19:08:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:43 INFO - '_': '/tools/buildbot/bin/python'} 19:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:08:43 INFO - Cleaning up... 19:08:43 INFO - Return code: 0 19:08:43 INFO - Running post-action listener: _resource_record_post_action 19:08:43 INFO - Running post-action listener: _start_resource_monitoring 19:08:43 INFO - Starting resource monitoring. 19:08:43 INFO - [mozharness: 2016-07-31 02:08:43.574623Z] Finished create-virtualenv step (success) 19:08:43 INFO - [mozharness: 2016-07-31 02:08:43.575101Z] Running install step. 19:08:43 INFO - Running pre-action listener: _resource_record_pre_action 19:08:43 INFO - Running main action method: install 19:08:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:43 INFO - Reading from file tmpfile_stdout 19:08:43 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:43 INFO - Reading from file tmpfile_stdout 19:08:43 INFO - Output received: 19:08:43 INFO - Usage: mozinstall [options] installer 19:08:43 INFO - Options: 19:08:43 INFO - -h, --help show this help message and exit 19:08:43 INFO - -d DEST, --destination=DEST 19:08:43 INFO - Directory to install application into. [default: 19:08:43 INFO - "/builds/slave/test"] 19:08:43 INFO - --app=APP Application being installed. [default: firefox] 19:08:43 INFO - mkdir: /builds/slave/test/build/application 19:08:43 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'] 19:08:43 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 19:09:00 INFO - Reading from file tmpfile_stdout 19:09:00 INFO - Output received: 19:09:00 INFO - /builds/slave/test/build/application/firefox/firefox 19:09:00 INFO - Running post-action listener: _resource_record_post_action 19:09:00 INFO - [mozharness: 2016-07-31 02:09:00.787682Z] Finished install step (success) 19:09:00 INFO - [mozharness: 2016-07-31 02:09:00.787932Z] Running run-tests step. 19:09:00 INFO - Running pre-action listener: _resource_record_pre_action 19:09:00 INFO - Running main action method: run_tests 19:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:09:00 INFO - Python 2.7.3 19:09:00 INFO - Return code: 0 19:09:00 INFO - grabbing minidump binary from tooltool 19:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:00 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 0xff63b0>, '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 0xff72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xff7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:09:00 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 19:09:00 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 19:09:00 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 19:09:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:09:00 INFO - Return code: 0 19:09:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:09:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:09:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:09:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:09:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:09:00 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/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 19:09:00 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/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 19:09:00 INFO - Using env: {'DISPLAY': ':0', 19:09:00 INFO - 'HOME': '/home/cltbld', 19:09:00 INFO - 'LANG': 'en_US.UTF-8', 19:09:00 INFO - 'LANGUAGE': 'en_US:en', 19:09:00 INFO - 'LOGNAME': 'cltbld', 19:09:00 INFO - 'MAIL': '/var/mail/cltbld', 19:09:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:09:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:09:00 INFO - 'MOZ_NO_REMOTE': '1', 19:09:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:09:00 INFO - 'NO_EM_RESTART': '1', 19:09:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:09:00 INFO - 'PWD': '/builds/slave/test', 19:09:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:09:00 INFO - 'SHELL': '/bin/bash', 19:09:00 INFO - 'SHLVL': '1', 19:09:00 INFO - 'TERM': 'linux', 19:09:00 INFO - 'TMOUT': '86400', 19:09:00 INFO - 'USER': 'cltbld', 19:09:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632', 19:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:09:00 INFO - '_': '/tools/buildbot/bin/python'} 19:09:00 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/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 19:09:01 INFO - mozversion application_buildid: 20160730163003 19:09:01 INFO - mozversion application_changeset: 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 19:09:01 INFO - mozversion application_display_name: Nightly 19:09:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:09:01 INFO - mozversion application_name: Firefox 19:09:01 INFO - mozversion application_remotingname: firefox 19:09:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:09:01 INFO - mozversion application_vendor: Mozilla 19:09:01 INFO - mozversion application_version: 50.0a1 19:09:01 INFO - mozversion platform_buildid: 20160730163003 19:09:01 INFO - mozversion platform_changeset: 0e1f1a9c666d2ba8ddba5246fb4e705244edbeb4 19:09:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:09:01 INFO - mozversion platform_version: 50.0a1 19:09:01 INFO - using testdate: 1469930941 19:09:01 INFO - actual date: 1469930941 19:09:01 INFO - starting webserver on 'localhost:48263' 19:09:01 INFO - SUITE-START | Running 2 tests 19:09:01 INFO - TEST-START | dromaeo_css 19:09:01 INFO - operating with platform_type : linux_ 19:09:01 INFO - Initialising browser for dromaeo_css test... 19:09:01 INFO - TEST-INFO | started process 28593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdtxIxA/profile http://localhost:48263/getInfo.html) 19:09:04 INFO - PROCESS | 28593 | __metrics Screen width/height:1600/1200 19:09:04 INFO - PROCESS | 28593 | colorDepth:24 19:09:04 INFO - PROCESS | 28593 | Browser inner width/height: 1024/697 19:09:04 INFO - PROCESS | 28593 | __metrics 19:09:05 INFO - PROCESS | 28593 | 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" 19:09:05 INFO - PROCESS | 28593 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:09:06 INFO - PROCESS | 28593 | console.error: PushService: 19:09:06 INFO - PROCESS | 28593 | stateChangeProcessEnqueue: Error transitioning state 19:09:06 INFO - PROCESS | 28593 | UnknownError 19:09:06 INFO - TEST-INFO | 28593: exit 0 19:09:06 INFO - Browser initialized. 19:09:06 INFO - Running cycle 1/1 for dromaeo_css test... 19:09:06 INFO - TEST-INFO | started process 28673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdtxIxA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:18 INFO - PROCESS | 28673 | RSS: Main: 155705344 19:09:18 INFO - PROCESS | 28673 | 19:10:09 INFO - PROCESS | 28673 | 1469931009325 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] 19:12:18 INFO - PROCESS | 28673 | Cycle 1(1): loaded http://localhost:48263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48263/tests/dromaeo/cssquery-ext.html) 19:12:19 INFO - PROCESS | 28673 | RSS: Main: 267632640 19:12:19 INFO - PROCESS | 28673 | 19:15:21 INFO - PROCESS | 28673 | Cycle 1(1): loaded http://localhost:48263/tests/dromaeo/cssquery-ext.html (next: http://localhost:48263/tests/dromaeo/cssquery-jquery.html) 19:15:22 INFO - PROCESS | 28673 | RSS: Main: 242126848 19:15:22 INFO - PROCESS | 28673 | 19:18:24 INFO - PROCESS | 28673 | Cycle 1(1): loaded http://localhost:48263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48263/tests/dromaeo/cssquery-mootools.html) 19:18:25 INFO - PROCESS | 28673 | RSS: Main: 188862464 19:18:25 INFO - PROCESS | 28673 | 19:21:26 INFO - PROCESS | 28673 | Cycle 1(1): loaded http://localhost:48263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48263/tests/dromaeo/cssquery-prototype.html) 19:21:27 INFO - PROCESS | 28673 | RSS: Main: 184266752 19:21:27 INFO - PROCESS | 28673 | 19:24:30 INFO - PROCESS | 28673 | Cycle 1(1): loaded http://localhost:48263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48263/tests/dromaeo/cssquery-yui.html) 19:24:30 INFO - PROCESS | 28673 | RSS: Main: 185237504 19:24:30 INFO - PROCESS | 28673 | 19:27:33 INFO - PROCESS | 28673 | Cycle 1(1): loaded http://localhost:48263/tests/dromaeo/cssquery-yui.html (next: http://localhost:48263/tests/dromaeo/cssquery-dojo.html) 19:27:33 INFO - PROCESS | 28673 | RSS: Main: 277708800 19:27:33 INFO - PROCESS | 28673 | 19:27:33 INFO - PROCESS | 28673 | __start_tp_report 19:27:33 INFO - PROCESS | 28673 | _x_x_mozilla_page_load 19:27:33 INFO - PROCESS | 28673 | _x_x_mozilla_page_load_details 19:27:33 INFO - PROCESS | 28673 | |i|pagename|runs| 19:27:33 INFO - PROCESS | 28673 | |0;dojo.html;3079.030105516762;3084.7377972872305;3099.783015188937;3124.843757812109;3148.3073723780776;5214.400343960446;5234.476552344764;5323.201519772031;5430.53840423564;5452.536534394571;5319.388270348911;5381;5382.38102618199;5411.756470958807;5452.781888724447;4852.02959408118;4916.631252656065;4928.236123400879;4938.2098864181735;5057.03916255912;4970.105381031413;5007.173816320303;5017.523335283142;5027.899442011158;5032.0690672225755;4774.283857421397;4780.139574876521;4816.4220293564995;4840.782164802592;4928.482509336522;4853.3690620219495;4867.148249056401;4868.9269660955115;4904.926426103611;4920.75396230187;4832.879178020543;4863.319135321058;4865.221564549655;4889.853304400874;4902.264660300948;5128.820491282787;5328.360596728378;5404.081306177959;5439.755211015514;5444.074507333723;5780.3063632363965;5828.3297420796725;5831.329397119301;5832.6500409975115;5837.182794408786;5811.767529298823;5835.941640583582;5847.3275573308765;5901.822945311647;5902.173695682565;5233.136532472099;5282.920756188661;5283.6037297202865;5435.864103397407;5442.9727851360885;5917.408259174048;5919.052951527821;5927.762889484458;5954.8809023819285;5979.133025711334;5662.971685141548;5667.773289068474;5709.65742055478;5713.657180569179;5715.399883012307;5495.587830912697;5746.02317606008;5801.593888427854;5806.622569533051;5832.941670583325;5753.252077229933;5755.827325180251;5757.769689212469;5795.1886735857015;5813.6221145625395;5712.65724056558;5745.368009518949;5753.453421924911;5761.85595360111;5763.942360576424;4337.804798783999;4377.999999999936;4403.295472724413;4431.8448854289945;4433.4236549249035;3935.0555866592385;3940.15286713358;3958.4062390641056;3965.643092121723;3991.560928297885;5460.5085542301385;5463.863403414867;5470;5473.0969390050195;5479.835604931858;5585.245991791056;5697.544196464273;5735.569832262597;5799;5839.883202335929;5435.293411856513;5457.7271136443815;5463.644863083887;5491.148871924858;5500.28496295479;5012.24816277554;5022.4977502249485;5023.246513023003;5033.295338652591;5073.315102461194;5877.353491115974;5986.700664966821;6004.849878753066;6014.428629280212;6036.7585296589405;5812.651240925558;5820.185174075548;5822.010258256191;5845.795397161079;5870.236869206976;6060.2424696912885;6071.878562428815;6073.362296958756;6074.696265186812;6087.512998960161;5548.0845660465575;5556.861078473071;5557.805476808292;5642.153676948491;5705.201271821865;5689.77240910359;5726.455986681259;5730.111832665943;5762.769489220552;5770.711464426678;5587.497125258747;5592.356878958972;5592.552595792408;5593.440655934374;5608.579356548356;5490.396056433709;5566.359868614999;5566.805161819317;5642.520385767091;5672;5644;5648.293963254593;5654.406287339934;5667.20659107717;5706.372299047184;5730.885382292414;5741.655500669973;5791.189233507396;5798.304203495608;5806.970965145148;5355.812546560852;5563.7496312666835;5597.720113994203;5608.046632072476;5612.130119831432 19:27:33 INFO - PROCESS | 28673 | |1;ext.html;570.8672000625608;581.5899790647594;589.6521052578978;596.9462748352647;603.0652488642605;30362;30763.538546921813;33682.66317336826;44238;45146.548534514644;46037.079258414895;46350.536494635046;46359.30461043087;46428.53571464284;46478.76760616192;8926.46441213526;9074.546272686372;9076.22852057576;9086.727398178065;9088.818223635524;8901.821963560726;8986.730398088068;8994.460332380046;8994.68518601849;8995.550222488882;9008.639654413848;9050;9052.275817934582;9053.728388148365;9057;8952.239059679934;8969.820603587892;8999.685011024649;9003.549822508849;9004.144606262395;8919.108089191093;8979;8984.236339911115;8984.371094023356;8984.416012959202;43087.35368969468;43249.91875203114;43475.34786978198;43513.78243108796;43536.78231608822;3431.879884204066;3581.6776490116013;3585.318789430026;3628.219932714479;3822.311983842907;33450;33799.155021124425;34082.318353632785;34448.59598625168;34573.827130864185;4528.8867778305475;4606.838760643362;4666.183417901853;4748.382710247645;4757.429108507002;359291;364287;364833;365565.1721741401;367100;60156.691381974415;60527;60532.394676052674;60588;60591.69704151451;36390.818045909604;36653.26693466169;36952.44571331432;38764.80617596894;63653.36346636567;15997.520074397788;16017.279222435018;16103.597410064842;16151.515454536382;16225.51323460298;11212.607558735404;11255.099592032782;11268.661940141808;11365.204435689588;11398.601048963412;19658.41024769259;19793.802061979197;19877.925025370052;19907.701384479245;19976.60046799056;7035.1909530404655;7100.68046937889;7143.464155206656;7389.704411823574;7397;983.2920297385871;1043.968680939573;1101.9916776149894;1125.2685754259796;1126.5831642292405;33439.56043956044;33934;33962.49056264158;34002;34220.65779342175;1097.226455348977;1100.6202860013282;1124.2242852431796;1174.7356844710043;1221.3526830779701;17367.91585009807;18452.630947380978;18588.44234672962;19425;19430.514237143903;509611;519212;523772;851215;855181;61323;61976;62018.37981620216;62058;62090.37909620936;1279.1046267612708;1308.4504508106618;1352.2562590575144;1376.5870238928283;1394.9721005579831;32521.674783251863;34034;34038.48942265818;34233.82883085569;34540.13649658678;52216.47783522268;52509;52964.470355295955;52981.7350913243;52988.470115298354;436532;439593;439855;440694;441401;25416.110436134648;29559.408811824072;46077.078458429976;46143.3078503816;46968.06063878635;47268;50888.745556271984;51433.48566514287;51716;52181.7390913043;38982.80508597439;39417.60582394139;39999;40531;41058.384124237564;42842.35736464018;43310;43792.34311485394;44627.55372446234;44704.55295447004;43182;43653.56346436495;43664.56335436605;43883.78058109689;44254.77872610616;35723.82138089293;38909.6109038906;39027.219455611295;39458.60541394549;39482;29112;29194.7080529192;29196.744815734663;29312.120636380943;29483.85258073696 19:27:33 INFO - PROCESS | 28673 | |2;jquery.html;364.31690580162194;384.35812193636633;385.41609461665564;385.9228154369126;401.22363227155455;14449.277536123205;16483;17587.47237582873;19228.61542769144;20155.697664535026;16961.151942402892;17531.298748050096;17973.7303940441;18866.71699924502;18932.905335473304;5562.221289019541;5700.087985922253;5703.344115426717;5727.312722473309;5734.598578099534;5546.334439867222;5589.133684278923;5695.316562012565;5712.800051998181;5751.683657398841;5583.35791383992;5661.8584535386735;5664.320281566218;5664.490195882369;5669.744861481243;5681.233033540481;5705.486506214419;5711.914321285184;5712.971435142839;5719.542436605062;4915.48387419323;5061.924071138936;5093.057784309877;5106.259592359124;5107.61692873036;22166;22607.434814129614;22649.98075086625;22800;22922.65616015761;2339.82451316152;2347.9882600587057;2492.9376765580823;3066.509358502651;3193.552902593639;14156.433742650283;14370.92814535931;14430.567082987527;14655.70688586233;14668.779968300483;1880.2009146112848;1898.686716691744;1911.1877452082808;1943.9416817495498;2001.259533972425;79026.20973790246;80260;80562;81158.9999999994;81520;10144.644937427154;10216.438095904796;10498.527566259383;10594.31136976094;10682.465876706288;14255.215963122128;14284.357203925849;14383.856161438252;14423.49517766873;14452;7267.927320726831;7345.449091318173;7364.0426744522865;7405.20652276188;7804.921950780419;7290.161631412349;7582.279683430065;7647.885281720779;7883.6058197089915;7888.566128862853;6318.810435686937;6364.427201551883;6376.521760867953;6396.232452105777;6440.61356318613;1793.0496836676582;1889.4331700489797;1899.392194497775;1927.633749587574;1947.269773834812;965.2953344058876;979.2704435195825;989.5596459575564;1040.8490768838476;1094.5567045346647;19261.96938117577;19601.21595136207;19760.60478790416;19770.11034503422;20097.899510502353;979.0601023017982;995.1740055753708;1013.7566983923953;1020.9234307426824;1055.1189756553365;9235.815283694288;11003.449827508593;11287.717807054889;11303.830442543369;11352.716182095513;469478;477461;477606;482644;487378;83594;84351.5782421084;84668;84810.57594711987;84955;1000.7448100734412;1076.8115579773507;1092.1590375411047;1102.7132945434246;1108.3682301088463;16385.91807040957;17630.294788208328;17820.643587128445;17864.285428582712;17893.73159402584;40587;40614.59385406108;40837;41103.38344924888;42777;51385;52013.7399313001;52380.73809630927;52753.20870186874;54098.45901541092;8108.986376702912;8146.348292136497;8177.468464550023;8281.461704989157;8339.666413343399;12425.13024088305;12515.186512876633;12573.182743122034;12678.936605316914;12679.366031698562;11054.889451105386;11264.549418023187;11289.435528223721;11496.425178741198;11640.35978021217;10035.799284014425;10102.141317988053;11090.390028548507;11218.66344009681;11606.361650109326;10555.841662374916;11322.830157547478;11470.942645286721;11694.239874408137;11786.823197651871;7959.562224077731;7978.122406535161;8003.879941800994;8023.598820058857;8496.915030849612;11343.829842552534;11360.431978401211;11478.311301321948;11525.654230373102;11606.535738570701 19:27:33 INFO - PROCESS | 28673 | |3;mootools.html;1300.9739805203901;1455.2796365798931;1525.5652139140343;1648.1017845274325;1776.9911150444245;8387.538685372301;8768.167024132714;8784.16550427709;8984.371094023421;8991.415557988727;8643.611037503311;8698.869516957235;8720.476771393722;8722.953245610519;8733.388662793606;2288.141946769965;2305.7002589663402;2308.6306191009444;2309.722833260011;2315.5600435917204;2268.5803126421583;2322.6980492535945;2328.2084091409;2333.1717240379676;2335.252719129879;2354.82338824588;2361.126383238204;2361.8228632852606;2366.668666386707;2393.3896856301617;2295.070496448941;2306.2504685977124;2308.722953245613;2325.767423257678;2328.9301320960312;2259.9548009039727;2267.6031694453404;2274.4882401459704;2275.24916777463;2276.9544609107725;8474.364422668325;8595.785105372353;8647.65409383624;8748.34387420946;8794.912050879473;5117.8464646060675;5259.947400525984;5260.210968354739;5261.552768014723;5269.262303277545;3429.5027221053056;3457.9827100864336;3500.5099286099967;3503.91240218994;3556.7154627629984;1156.5836298932377;1158.6987383280323;1158.8377627132209;1173.8180582009802;1174.7944109780753;11911.821322680167;11917.22538035025;11949.94025029878;11954.880451195551;11987.880121198676;4269.295566231537;4401;4531.320301954667;4558.88602784933;4559.110973360229;9440.858387124199;9492.098250666175;9514.524273786421;9686.418814871131;9766.95116524427;5188.143956247252;5237.3453318335205;5238.92141617876;5244.947550524446;5246.422893481714;4149.564295748964;4243.702940794176;4322.502912165079;4636.4899861015265;4930.063287975273;3791.829367678461;3810.466534685146;3872.3997780344093;3934.075492259317;3938.586448422874;1097.6761855252719;1143.388287266325;1145.1411441418936;1149.2529855593764;1153.0084127650214;908.5003248213457;961.6730311694058;963.1091240602415;988.4909271725068;992.5434300221979;5813;5848.356680765112;5903.232579764689;5943.55423343251;6247.312795592481;422.2167878585242;425.7296616648389;428.82715772362565;442.9778511074498;447.6754353093981;3817.7136714746507;3883.980580097081;3914.6868250539887;3939.8424063037733;4049.595040495986;10840.566377344976;11126.833097503544;11193.66419007431;11207.383593902414;11240.718982025352;11064.336139831636;11107.333559986266;11190.160737944523;11191.496382662637;11210.103191744642;8297.294729947902;8364.498130112213;8382.413231073766;8444;8463.53450560225;5720.456556627114;5809.709514524341;5896.852578685395;5934.317553481233;6090.573659843945;9718.271129665161;9922;9992.050755178247;10118.797624047626;10171;9867.654632087842;9906.157976572073;10000.099991000845;10006.949965250127;10389.116925061455;7023.789286321418;7620.466567340233;7770.261825126604;7927.801804954922;7973.242541958504;8356;8541.145885411657;8561.657533698582;8608.139186081342;8610.225079742853;7624.428167887319;7871.134175240604;7904.920950790649;7940.761777146695;7997.1203167652675;7466.701331946661;7522.774316770506;7631.961840190764;7635.198304178203;7735.574543400167;6715.227748808949;6801.421879140328;6807.659617019228;6819.659017049227;6845.589264644137;4997.450280469218;5056.721880296619;5128.666636668605;5199.168133098686;5252.527272545336;4986.102501549756;5099.490050994871;5118.436971933159;5236.790528378822;5238.266642669953 19:27:33 INFO - PROCESS | 28673 | |4;prototype.html;312.93741251749657;316.33885179973856;316.6074068155487;320.9967900320996;321.89055721054865;5234.790608375665;5272.420033796284;5273.943162166748;5287.968846075017;5293.497117773815;5175.767090480928;5194.091034069042;5270.420253772082;5279.366476022883;5303.787848486056;4093.16090201508;4108.77401742904;4110.157417729359;4123.525794533637;4190.120074784299;3900.8049597520153;4121.5878412158845;4129.2360913231;4145.626893579577;4154.210699967011;4011.9799401002956;4072.124493233954;4088.550259471456;4099.426080348739;4105.096878686684;3803.695704343646;3927.9018024549327;4016.979915100435;4033.495813023372;4069.680282239125;3529.3823580873245;3532.04634748619;3538.9115272118147;3545.8227088645463;3547.485614585896;5090.160123579605;5106.08090543702;5110.514501122425;5116.181410974264;5140.408852981917;4385.429894113745;4464.241079016575;4577.359169716243;4587.334836448729;4623.537646235383;5371.623986320959;5373.838784836422;5374.946250537484;5405.540529055035;5420.322459692538;3899.6490315871706;3901.239258344624;3912.139329347539;3913.2956067907767;3938.330483817758;5598.188262701926;5638.210650508932;5654.604177707521;5717.199592057115;5748.2527271454865;3952.960470395317;3953.8616148435244;3960.881173564798;3962.5046869141356;3989.6409323161056;4006.8397264109694;4025.91948161041;4036.8990775230855;4040.212158629039;4052.878413647595;4503.977480112644;4595.931061034087;4603.941093548436;4614.792334344896;4616.584507394284;5435.42927992563;5437.83686489398;5450.427705090988;5472.890542189134;5500.092484740053;1367.6375760423496;1377.738229736347;1381.1851007905384;1384.3701115992199;1387.7918312253041;853.6414705823445;888.311558542122;903.0427746588637;908.8545832666741;911.6763548940163;4643.814247430132;4723.811047558128;4733.195356789354;4736.834210802605;4782.808687652455;4877.658563900563;4949.727764972889;4954.058728841508;4985.626078044161;5001.474550262205;4745.667803253739;4753.833615823499;4766.332713420124;4766.833160839424;5012.323336349619;2864.6848846626854;2905.8547072646284;2933.120063980797;2962.0965605490533;2984.7612191024664;5802.767889284381;5817.389174136655;5821.446962538552;5829.358770535237;5841.853953651193;5602.467765562265;5694.715264236772;5707.571932105026;5737.196792449061;5744.1096630021575;5734.197212390352;5792.247007889032;5798.304203495523;5813.767449302065;5823.767049318065;5571.554275657856;5590.86022849432;5595.5803314752375;5622.634528755618;5644.689542075061;5328.200769884394;5511.889762204653;5527.474889885454;5532.197831314517;5572.4148964358155;5786.594938354275;5788.479036886701;5797.826065218051;5809.692819115665;5828.271466066742;3957.22834047358;4010.438538604539;4015.7389769666047;4023.597640235953;4031.7580945143386;5384.811531596375;5507.311586051744;5512.834614961557;5565.1095824667855;5621.437856214509;5429.891402172014;5431.185322201702;5440.374356949002;5462.9726851365485;5466.781328746805;5457.781688732565;5460.5085542301385;5461.235427040138;5463.726813659222;5472.604485856081;5220.582353411642;5452.345718513804;5492.972535137458;5494.5054945055135;5514.862128446821;5578.888422231614;5594;5604.523615492729;5632.718364081861;5642.435756424489;5201.973990130025;5381.677099373894;5424.5660347172925;5438.4561543846885;5445.863853403696 19:27:33 INFO - PROCESS | 28673 | |5;yui.html;813.312750725637;835.6949713354626;848.5969164646798;851.8253757979614;870.6604424274531;15177.16525591092;16496.422625208106;16503.504894853173;16510.587235319123;16516.174191290433;14641.633959151026;14740.85259147411;14775.926120369382;14977.400903963828;15005.324760385782;785.4501848705886;803.6785285885663;812.5327936436572;815.5881279953616;816.0859836982588;673.5251647588439;673.6631684157921;824.5547404401646;826.5908375354178;827.2472050434106;732.7508647059999;733.8972543843839;829.1087081387533;833.5957060825494;853.5774791478196;871.4640496094888;873.3057219510505;874.5627186406797;874.8119154381807;875.7679215008028;633.6071635585967;633.790849019827;633.9873202535923;634.3751404866204;634.4036605590776;12046.096542759327;14175.291235438186;14602.26988650574;15007.474738384213;15136.243187840673;15238.46665366718;15535.766963495444;15585.142817145052;15657;16097.517074487783;11935.701607459796;11988.760224795455;12012.459439325252;12274.263544187377;12632.431540580696;3728.1611637381643;3748.9437658435145;3790.7915064671433;3826.9617303826885;3840.558335791392;69608.6519567404;72602.63698681525;73012.63493682498;77849;78079.60960195163;11780.293182409083;11887.10846686502;12126.818097728541;12263.816042759367;12336.691582710324;21807.127714891543;21866.89066554689;21908.561828763653;21953.67069493959;22518.549629007328;8880.51157186348;8935.642574297086;8965.865512017324;8998.460092394478;9130.908690913138;4738.928916066262;4757.904841903142;4791.856244312677;4879.121758083508;4933.28467372229;3519.788812671197;3575.3028159509167;3583.8387272572277;3586.8385922633543;3915.667168290727;699.1470406104544;703.0368395298372;712.7327252280395;721.1598487761804;729.6716477585107;662.8299265727308;663.3764261594087;706.809161526385;708.0618180910315;762.622501861571;9938.552765125587;10250.897491024994;10511.421871796972;10516.26386152962;10800.848213401054;621.6425555305717;695.5409429776323;730.9853802923911;754.9396048316122;764.2513471422681;4783.354247176656;5279.709615971158;5310.9734451327495;5317.813876514303;5339.3058902342445;110924.4453777742;114750;124494;134489.3275533616;136006;108330.45834770775;109643.45178274058;113179;114510;119188;80808;82446;96953;99720.50139749255;100437;9828.557714902989;9928.305018648625;10186.898131018892;10231.232657550565;10563.918602269117;37573.43639845459;42246.155076898904;47121.76439117782;48183.759081205775;55111.72444137753;53120.46879531155;56967.14549281847;75537.62231188809;77266;78404;13229.385307346327;13768;13774.586762397144;13927.23400212998;14570.562883113524;14955.40178392852;15485.148316842682;15518.689626207639;15537.922310388376;15579.844201557838;14313.141211527342;14474;14480.637984050483;14549.85450145485;15343.923280383528;14821.184834834188;14869.776953345492;14910.179940102964;15129.319180636678;15150.16674082936;14258.42966281337;14401.63995900111;14988.400463981754;15224.543263702106;15485.612859678598;10732.248742587944;11174.385408802595;11562.88437115618;11619.419029048682;11993.580224692094;11368.715782105513;11661.416929153678;11837.11322822699;12118.697032574257;12158.817617735564 19:27:33 INFO - PROCESS | 28673 | __end_tp_report 19:27:33 INFO - PROCESS | 28673 | __start_cc_report 19:27:33 INFO - PROCESS | 28673 | _x_x_mozilla_cycle_collect,1025 19:27:33 INFO - PROCESS | 28673 | __end_cc_report 19:27:33 INFO - PROCESS | 28673 | __startTimestamp1469932053871__endTimestamp 19:27:33 INFO - PROCESS | 28673 | 19:27:33 INFO - PROCESS | 28673 | ------- Summary: start ------- 19:27:33 INFO - PROCESS | 28673 | Number of tests: 6 19:27:33 INFO - PROCESS | 28673 | 19:27:33 INFO - PROCESS | 28673 | [#0] dojo.html Cycles:165 Average:5365.88 Median:5566.36 stddev:617.00 (11.1%) stddev-sans-first:592.24 19:27:33 INFO - PROCESS | 28673 | Values: 3079.0 3084.7 3099.8 3124.8 3148.3 5214.4 5234.5 5323.2 5430.5 5452.5 5319.4 5381.0 5382.4 5411.8 5452.8 4852.0 4916.6 4928.2 4938.2 5057.0 4970.1 5007.2 5017.5 5027.9 5032.1 4774.3 4780.1 4816.4 4840.8 4928.5 4853.4 4867.1 4868.9 4904.9 4920.8 4832.9 4863.3 4865.2 4889.9 4902.3 5128.8 5328.4 5404.1 5439.8 5444.1 5780.3 5828.3 5831.3 5832.7 5837.2 5811.8 5835.9 5847.3 5901.8 5902.2 5233.1 5282.9 5283.6 5435.9 5443.0 5917.4 5919.1 5927.8 5954.9 5979.1 5663.0 5667.8 5709.7 5713.7 5715.4 5495.6 5746.0 5801.6 5806.6 5832.9 5753.3 5755.8 5757.8 5795.2 5813.6 5712.7 5745.4 5753.5 5761.9 5763.9 4337.8 4378.0 4403.3 4431.8 4433.4 3935.1 3940.2 3958.4 3965.6 3991.6 5460.5 5463.9 5470.0 5473.1 5479.8 5585.2 5697.5 5735.6 5799.0 5839.9 5435.3 5457.7 5463.6 5491.1 5500.3 5012.2 5022.5 5023.2 5033.3 5073.3 5877.4 5986.7 6004.8 6014.4 6036.8 5812.7 5820.2 5822.0 5845.8 5870.2 6060.2 6071.9 6073.4 6074.7 6087.5 5548.1 5556.9 5557.8 5642.2 5705.2 5689.8 5726.5 5730.1 5762.8 5770.7 5587.5 5592.4 5592.6 5593.4 5608.6 5490.4 5566.4 5566.8 5642.5 5672.0 5644.0 5648.3 5654.4 5667.2 5706.4 5730.9 5741.7 5791.2 5798.3 5807.0 5355.8 5563.7 5597.7 5608.0 5612.1 19:27:33 INFO - PROCESS | 28673 | 19:27:33 INFO - PROCESS | 28673 | [#1] ext.html Cycles:180 Average:64362.81 Median:43595.17 stddev:136121.72 (312.2%) stddev-sans-first:136419.32 19:27:33 INFO - PROCESS | 28673 | Values: 570.9 581.6 589.7 596.9 603.1 30362.0 30763.5 33682.7 44238.0 45146.5 46037.1 46350.5 46359.3 46428.5 46478.8 8926.5 9074.5 9076.2 9086.7 9088.8 8901.8 8986.7 8994.5 8994.7 8995.6 9008.6 9050.0 9052.3 9053.7 9057.0 8952.2 8969.8 8999.7 9003.5 9004.1 8919.1 8979.0 8984.2 8984.4 8984.4 43087.4 43249.9 43475.3 43513.8 43536.8 3431.9 3581.7 3585.3 3628.2 3822.3 33450.0 33799.2 34082.3 34448.6 34573.8 4528.9 4606.8 4666.2 4748.4 4757.4 359291.0 364287.0 364833.0 365565.2 367100.0 60156.7 60527.0 60532.4 60588.0 60591.7 36390.8 36653.3 36952.4 38764.8 63653.4 15997.5 16017.3 16103.6 16151.5 16225.5 11212.6 11255.1 11268.7 11365.2 11398.6 19658.4 19793.8 19877.9 19907.7 19976.6 7035.2 7100.7 7143.5 7389.7 7397.0 983.3 1044.0 1102.0 1125.3 1126.6 33439.6 33934.0 33962.5 34002.0 34220.7 1097.2 1100.6 1124.2 1174.7 1221.4 17367.9 18452.6 18588.4 19425.0 19430.5 509611.0 519212.0 523772.0 851215.0 855181.0 61323.0 61976.0 62018.4 62058.0 62090.4 1279.1 1308.5 1352.3 1376.6 1395.0 32521.7 34034.0 34038.5 34233.8 34540.1 52216.5 52509.0 52964.5 52981.7 52988.5 436532.0 439593.0 439855.0 440694.0 441401.0 25416.1 29559.4 46077.1 46143.3 46968.1 47268.0 50888.7 51433.5 51716.0 52181.7 38982.8 39417.6 39999.0 40531.0 41058.4 42842.4 43310.0 43792.3 44627.6 44704.6 43182.0 43653.6 43664.6 43883.8 44254.8 35723.8 38909.6 39027.2 39458.6 39482.0 29112.0 29194.7 29196.7 29312.1 29483.9 19:27:33 INFO - PROCESS | 28673 | 19:27:33 INFO - PROCESS | 28673 | [#2] jquery.html Cycles:180 Average:28229.37 Median:2420.46 stddev:78817.14 (3256.3%) stddev-sans-first:79010.48 19:27:33 INFO - PROCESS | 28673 | Values: 364.3 384.4 385.4 385.9 401.2 14449.3 16483.0 17587.5 19228.6 20155.7 16961.2 17531.3 17973.7 18866.7 18932.9 5562.2 5700.1 5703.3 5727.3 5734.6 5546.3 5589.1 5695.3 5712.8 5751.7 5583.4 5661.9 5664.3 5664.5 5669.7 5681.2 5705.5 5711.9 5713.0 5719.5 4915.5 5061.9 5093.1 5106.3 5107.6 22166.0 22607.4 22650.0 22800.0 22922.7 2339.8 2348.0 2492.9 3066.5 3193.6 14156.4 14370.9 14430.6 14655.7 14668.8 1880.2 1898.7 1911.2 1943.9 2001.3 79026.2 80260.0 80562.0 81159.0 81520.0 10144.6 10216.4 10498.5 10594.3 10682.5 14255.2 14284.4 14383.9 14423.5 14452.0 7267.9 7345.4 7364.0 7405.2 7804.9 7290.2 7582.3 7647.9 7883.6 7888.6 6318.8 6364.4 6376.5 6396.2 6440.6 1793.0 1889.4 1899.4 1927.6 1947.3 965.3 979.3 989.6 1040.8 1094.6 19262.0 19601.2 19760.6 19770.1 20097.9 979.1 995.2 1013.8 1020.9 1055.1 9235.8 11003.4 11287.7 11303.8 11352.7 469478.0 477461.0 477606.0 482644.0 487378.0 83594.0 84351.6 84668.0 84810.6 84955.0 1000.7 1076.8 1092.2 1102.7 1108.4 16385.9 17630.3 17820.6 17864.3 17893.7 40587.0 40614.6 40837.0 41103.4 42777.0 51385.0 52013.7 52380.7 52753.2 54098.5 8109.0 8146.3 8177.5 8281.5 8339.7 12425.1 12515.2 12573.2 12678.9 12679.4 11054.9 11264.5 11289.4 11496.4 11640.4 10035.8 10102.1 11090.4 11218.7 11606.4 10555.8 11322.8 11470.9 11694.2 11786.8 7959.6 7978.1 8003.9 8023.6 8496.9 11343.8 11360.4 11478.3 11525.7 11606.5 19:27:33 INFO - PROCESS | 28673 | 19:27:33 INFO - PROCESS | 28673 | [#3] mootools.html Cycles:180 Average:5733.16 Median:4991.78 stddev:3294.19 (66.0%) stddev-sans-first:3286.59 19:27:33 INFO - PROCESS | 28673 | Values: 1301.0 1455.3 1525.6 1648.1 1777.0 8387.5 8768.2 8784.2 8984.4 8991.4 8643.6 8698.9 8720.5 8723.0 8733.4 2288.1 2305.7 2308.6 2309.7 2315.6 2268.6 2322.7 2328.2 2333.2 2335.3 2354.8 2361.1 2361.8 2366.7 2393.4 2295.1 2306.3 2308.7 2325.8 2328.9 2260.0 2267.6 2274.5 2275.2 2277.0 8474.4 8595.8 8647.7 8748.3 8794.9 5117.8 5259.9 5260.2 5261.6 5269.3 3429.5 3458.0 3500.5 3503.9 3556.7 1156.6 1158.7 1158.8 1173.8 1174.8 11911.8 11917.2 11949.9 11954.9 11987.9 4269.3 4401.0 4531.3 4558.9 4559.1 9440.9 9492.1 9514.5 9686.4 9767.0 5188.1 5237.3 5238.9 5244.9 5246.4 4149.6 4243.7 4322.5 4636.5 4930.1 3791.8 3810.5 3872.4 3934.1 3938.6 1097.7 1143.4 1145.1 1149.3 1153.0 908.5 961.7 963.1 988.5 992.5 5813.0 5848.4 5903.2 5943.6 6247.3 422.2 425.7 428.8 443.0 447.7 3817.7 3884.0 3914.7 3939.8 4049.6 10840.6 11126.8 11193.7 11207.4 11240.7 11064.3 11107.3 11190.2 11191.5 11210.1 8297.3 8364.5 8382.4 8444.0 8463.5 5720.5 5809.7 5896.9 5934.3 6090.6 9718.3 9922.0 9992.1 10118.8 10171.0 9867.7 9906.2 10000.1 10006.9 10389.1 7023.8 7620.5 7770.3 7927.8 7973.2 8356.0 8541.1 8561.7 8608.1 8610.2 7624.4 7871.1 7904.9 7940.8 7997.1 7466.7 7522.8 7632.0 7635.2 7735.6 6715.2 6801.4 6807.7 6819.7 6845.6 4997.5 5056.7 5128.7 5199.2 5252.5 4986.1 5099.5 5118.4 5236.8 5238.3 19:27:33 INFO - PROCESS | 28673 | 19:27:33 INFO - PROCESS | 28673 | [#4] prototype.html Cycles:180 Average:4557.08 Median:5184.93 stddev:1346.75 (26.0%) stddev-sans-first:1312.32 19:27:33 INFO - PROCESS | 28673 | Values: 312.9 316.3 316.6 321.0 321.9 5234.8 5272.4 5273.9 5288.0 5293.5 5175.8 5194.1 5270.4 5279.4 5303.8 4093.2 4108.8 4110.2 4123.5 4190.1 3900.8 4121.6 4129.2 4145.6 4154.2 4012.0 4072.1 4088.6 4099.4 4105.1 3803.7 3927.9 4017.0 4033.5 4069.7 3529.4 3532.0 3538.9 3545.8 3547.5 5090.2 5106.1 5110.5 5116.2 5140.4 4385.4 4464.2 4577.4 4587.3 4623.5 5371.6 5373.8 5374.9 5405.5 5420.3 3899.6 3901.2 3912.1 3913.3 3938.3 5598.2 5638.2 5654.6 5717.2 5748.3 3953.0 3953.9 3960.9 3962.5 3989.6 4006.8 4025.9 4036.9 4040.2 4052.9 4504.0 4595.9 4603.9 4614.8 4616.6 5435.4 5437.8 5450.4 5472.9 5500.1 1367.6 1377.7 1381.2 1384.4 1387.8 853.6 888.3 903.0 908.9 911.7 4643.8 4723.8 4733.2 4736.8 4782.8 4877.7 4949.7 4954.1 4985.6 5001.5 4745.7 4753.8 4766.3 4766.8 5012.3 2864.7 2905.9 2933.1 2962.1 2984.8 5802.8 5817.4 5821.4 5829.4 5841.9 5602.5 5694.7 5707.6 5737.2 5744.1 5734.2 5792.2 5798.3 5813.8 5823.8 5571.6 5590.9 5595.6 5622.6 5644.7 5328.2 5511.9 5527.5 5532.2 5572.4 5786.6 5788.5 5797.8 5809.7 5828.3 3957.2 4010.4 4015.7 4023.6 4031.8 5384.8 5507.3 5512.8 5565.1 5621.4 5429.9 5431.2 5440.4 5463.0 5466.8 5457.8 5460.5 5461.2 5463.7 5472.6 5220.6 5452.3 5493.0 5494.5 5514.9 5578.9 5594.0 5604.5 5632.7 5642.4 5202.0 5381.7 5424.6 5438.5 5445.9 19:27:33 INFO - PROCESS | 28673 | 19:27:33 INFO - PROCESS | 28673 | [#5] yui.html Cycles:180 Average:21546.75 Median:3585.34 stddev:31722.23 (884.8%) stddev-sans-first:31773.02 19:27:33 INFO - PROCESS | 28673 | Values: 813.3 835.7 848.6 851.8 870.7 15177.2 16496.4 16503.5 16510.6 16516.2 14641.6 14740.9 14775.9 14977.4 15005.3 785.5 803.7 812.5 815.6 816.1 673.5 673.7 824.6 826.6 827.2 732.8 733.9 829.1 833.6 853.6 871.5 873.3 874.6 874.8 875.8 633.6 633.8 634.0 634.4 634.4 12046.1 14175.3 14602.3 15007.5 15136.2 15238.5 15535.8 15585.1 15657.0 16097.5 11935.7 11988.8 12012.5 12274.3 12632.4 3728.2 3748.9 3790.8 3827.0 3840.6 69608.7 72602.6 73012.6 77849.0 78079.6 11780.3 11887.1 12126.8 12263.8 12336.7 21807.1 21866.9 21908.6 21953.7 22518.5 8880.5 8935.6 8965.9 8998.5 9130.9 4738.9 4757.9 4791.9 4879.1 4933.3 3519.8 3575.3 3583.8 3586.8 3915.7 699.1 703.0 712.7 721.2 729.7 662.8 663.4 706.8 708.1 762.6 9938.6 10250.9 10511.4 10516.3 10800.8 621.6 695.5 731.0 754.9 764.3 4783.4 5279.7 5311.0 5317.8 5339.3 110924.4 114750.0 124494.0 134489.3 136006.0 108330.5 109643.5 113179.0 114510.0 119188.0 80808.0 82446.0 96953.0 99720.5 100437.0 9828.6 9928.3 10186.9 10231.2 10563.9 37573.4 42246.2 47121.8 48183.8 55111.7 53120.5 56967.1 75537.6 77266.0 78404.0 13229.4 13768.0 13774.6 13927.2 14570.6 14955.4 15485.1 15518.7 15537.9 15579.8 14313.1 14474.0 14480.6 14549.9 15343.9 14821.2 14869.8 14910.2 15129.3 15150.2 14258.4 14401.6 14988.4 15224.5 15485.6 10732.2 11174.4 11562.9 11619.4 11993.6 11368.7 11661.4 11837.1 12118.7 12158.8 19:27:33 INFO - PROCESS | 28673 | -------- Summary: end -------- 19:27:33 INFO - PROCESS | 28673 | 19:27:34 INFO - TEST-INFO | 28673: exit 0 19:27:34 INFO - TEST-OK | dromaeo_css | took 1113591ms 19:27:34 INFO - TEST-START | kraken 19:27:34 INFO - operating with platform_type : linux_ 19:27:34 INFO - Initialising browser for kraken test... 19:27:34 INFO - TEST-INFO | started process 28869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr437WP/profile http://localhost:48263/getInfo.html) 19:27:38 INFO - PROCESS | 28869 | __metrics Screen width/height:1600/1200 19:27:38 INFO - PROCESS | 28869 | colorDepth:24 19:27:38 INFO - PROCESS | 28869 | Browser inner width/height: 1024/697 19:27:38 INFO - PROCESS | 28869 | __metrics 19:27:39 INFO - PROCESS | 28869 | 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" 19:27:39 INFO - PROCESS | 28869 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:27:40 INFO - TEST-INFO | 28869: exit 0 19:27:40 INFO - Browser initialized. 19:27:40 INFO - Running cycle 1/1 for kraken test... 19:27:40 INFO - TEST-INFO | started process 28949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr437WP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:51 INFO - PROCESS | 28949 | RSS: Main: 155942912 19:27:51 INFO - PROCESS | 28949 | 19:27:54 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48263/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:55 INFO - PROCESS | 28949 | RSS: Main: 212635648 19:27:55 INFO - PROCESS | 28949 | 19:27:57 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48263/tests/kraken/driver.html?testName=audio-dft) 19:27:58 INFO - PROCESS | 28949 | RSS: Main: 190943232 19:27:58 INFO - PROCESS | 28949 | 19:28:01 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48263/tests/kraken/driver.html?testName=audio-fft) 19:28:01 INFO - PROCESS | 28949 | RSS: Main: 268271616 19:28:01 INFO - PROCESS | 28949 | 19:28:03 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48263/tests/kraken/driver.html?testName=audio-oscillator) 19:28:04 INFO - PROCESS | 28949 | RSS: Main: 179458048 19:28:04 INFO - PROCESS | 28949 | 19:28:06 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:28:07 INFO - PROCESS | 28949 | RSS: Main: 184303616 19:28:07 INFO - PROCESS | 28949 | 19:28:10 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48263/tests/kraken/driver.html?testName=imaging-darkroom) 19:28:10 INFO - PROCESS | 28949 | RSS: Main: 219766784 19:28:10 INFO - PROCESS | 28949 | 19:28:14 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48263/tests/kraken/driver.html?testName=imaging-desaturate) 19:28:14 INFO - PROCESS | 28949 | RSS: Main: 219656192 19:28:14 INFO - PROCESS | 28949 | 19:28:17 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48263/tests/kraken/driver.html?testName=json-parse-financial) 19:28:18 INFO - PROCESS | 28949 | RSS: Main: 219492352 19:28:18 INFO - PROCESS | 28949 | 19:28:19 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:28:20 INFO - PROCESS | 28949 | RSS: Main: 183758848 19:28:20 INFO - PROCESS | 28949 | 19:28:22 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48263/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:22 INFO - PROCESS | 28949 | RSS: Main: 189693952 19:28:22 INFO - PROCESS | 28949 | 19:28:24 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:25 INFO - PROCESS | 28949 | RSS: Main: 193794048 19:28:25 INFO - PROCESS | 28949 | 19:28:27 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:28 INFO - PROCESS | 28949 | RSS: Main: 187068416 19:28:28 INFO - PROCESS | 28949 | 19:28:31 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:31 INFO - PROCESS | 28949 | RSS: Main: 192819200 19:28:31 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | Cycle 1(1): loaded http://localhost:48263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48263/tests/kraken/driver.html?testName=ai-astar) 19:28:33 INFO - PROCESS | 28949 | RSS: Main: 242999296 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | __start_tp_report 19:28:33 INFO - PROCESS | 28949 | _x_x_mozilla_page_load 19:28:33 INFO - PROCESS | 28949 | _x_x_mozilla_page_load_details 19:28:33 INFO - PROCESS | 28949 | |i|pagename|runs| 19:28:33 INFO - PROCESS | 28949 | |0;ai-astar;101;110;110;109;110;111;110;110;109;111 19:28:33 INFO - PROCESS | 28949 | |1;audio-beat-detection;145;116;118;189;123;118;145;125;150;118 19:28:33 INFO - PROCESS | 28949 | |2;audio-dft;161;161;161;160;160;161;161;162;162;161 19:28:33 INFO - PROCESS | 28949 | |3;audio-fft;75;76;74;132;76;76;74;75;106;74 19:28:33 INFO - PROCESS | 28949 | |4;audio-oscillator;84;84;115;84;84;92;124;83;84;126 19:28:33 INFO - PROCESS | 28949 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;117;117 19:28:33 INFO - PROCESS | 28949 | |6;imaging-darkroom;146;145;146;146;146;146;146;146;146;145 19:28:33 INFO - PROCESS | 28949 | |7;imaging-desaturate;95;96;95;94;95;95;95;94;95;95 19:28:33 INFO - PROCESS | 28949 | |8;json-parse-financial;52;50;52;51;57;50;49;50;50;49 19:28:33 INFO - PROCESS | 28949 | |9;json-stringify-tinderbox;62;61;62;61;61;61;61;61;61;61 19:28:33 INFO - PROCESS | 28949 | |10;stanford-crypto-aes;82;76;81;76;78;75;75;75;75;84 19:28:33 INFO - PROCESS | 28949 | |11;stanford-crypto-ccm;122;122;127;123;133;119;127;123;217;120 19:28:33 INFO - PROCESS | 28949 | |12;stanford-crypto-pbkdf2;161;159;158;155;156;157;157;161;161;159 19:28:33 INFO - PROCESS | 28949 | |13;stanford-crypto-sha256-iterative;68;63;64;63;62;64;62;62;62;65 19:28:33 INFO - PROCESS | 28949 | __end_tp_report 19:28:33 INFO - PROCESS | 28949 | __start_cc_report 19:28:33 INFO - PROCESS | 28949 | _x_x_mozilla_cycle_collect,1690 19:28:33 INFO - PROCESS | 28949 | __end_cc_report 19:28:33 INFO - PROCESS | 28949 | __startTimestamp1469932113709__endTimestamp 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | ------- Summary: start ------- 19:28:33 INFO - PROCESS | 28949 | Number of tests: 14 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.92 (2.7%) stddev-sans-first:0.71 19:28:33 INFO - PROCESS | 28949 | Values: 101.0 110.0 110.0 109.0 110.0 111.0 110.0 110.0 109.0 111.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:135.00 stddev:23.12 (17.1%) stddev-sans-first:24.22 19:28:33 INFO - PROCESS | 28949 | Values: 145.0 116.0 118.0 189.0 123.0 118.0 145.0 125.0 150.0 118.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 19:28:33 INFO - PROCESS | 28949 | Values: 161.0 161.0 161.0 160.0 160.0 161.0 161.0 162.0 162.0 161.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#3] audio-fft Cycles:10 Average:83.80 Median:75.00 stddev:19.56 (26.1%) stddev-sans-first:20.48 19:28:33 INFO - PROCESS | 28949 | Values: 75.0 76.0 74.0 132.0 76.0 76.0 74.0 75.0 106.0 74.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:84.00 stddev:18.10 (21.6%) stddev-sans-first:18.67 19:28:33 INFO - PROCESS | 28949 | Values: 84.0 84.0 115.0 84.0 84.0 92.0 124.0 83.0 84.0 126.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:28:33 INFO - PROCESS | 28949 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 19:28:33 INFO - PROCESS | 28949 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 19:28:33 INFO - PROCESS | 28949 | Values: 95.0 96.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:50.50 stddev:2.36 (4.7%) stddev-sans-first:2.47 19:28:33 INFO - PROCESS | 28949 | Values: 52.0 50.0 52.0 51.0 57.0 50.0 49.0 50.0 50.0 49.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 19:28:33 INFO - PROCESS | 28949 | Values: 62.0 61.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.00 stddev:3.40 (4.4%) stddev-sans-first:3.23 19:28:33 INFO - PROCESS | 28949 | Values: 82.0 76.0 81.0 76.0 78.0 75.0 75.0 75.0 75.0 84.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:125.00 stddev:29.69 (23.8%) stddev-sans-first:31.21 19:28:33 INFO - PROCESS | 28949 | Values: 122.0 122.0 127.0 123.0 133.0 119.0 127.0 123.0 217.0 120.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:159.00 stddev:2.17 (1.4%) stddev-sans-first:2.09 19:28:33 INFO - PROCESS | 28949 | Values: 161.0 159.0 158.0 155.0 156.0 157.0 157.0 161.0 161.0 159.0 19:28:33 INFO - PROCESS | 28949 | 19:28:33 INFO - PROCESS | 28949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.90 (3.0%) stddev-sans-first:1.12 19:28:33 INFO - PROCESS | 28949 | Values: 68.0 63.0 64.0 63.0 62.0 64.0 62.0 62.0 62.0 65.0 19:28:33 INFO - PROCESS | 28949 | -------- Summary: end -------- 19:28:33 INFO - PROCESS | 28949 | 19:28:34 INFO - TEST-INFO | 28949: exit 0 19:28:34 INFO - TEST-OK | kraken | took 60094ms 19:28:34 INFO - SUITE-END | took 1173s 19:28:34 INFO - Completed test suite (00:19:33) 19:28:34 INFO - javascript benchmark 19:28:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.030105516762, 3084.7377972872305, 3099.783015188937, 3124.843757812109, 3148.3073723780776, 5214.400343960446, 5234.476552344764, 5323.201519772031, 5430.53840423564, 5452.536534394571, 5319.388270348911, 5381.0, 5382.38102618199, 5411.756470958807, 5452.781888724447, 4852.02959408118, 4916.631252656065, 4928.236123400879, 4938.2098864181735, 5057.03916255912, 4970.105381031413, 5007.173816320303, 5017.523335283142, 5027.899442011158, 5032.0690672225755, 4774.283857421397, 4780.139574876521, 4816.4220293564995, 4840.782164802592, 4928.482509336522, 4853.3690620219495, 4867.148249056401, 4868.9269660955115, 4904.926426103611, 4920.75396230187, 4832.879178020543, 4863.319135321058, 4865.221564549655, 4889.853304400874, 4902.264660300948, 5128.820491282787, 5328.360596728378, 5404.081306177959, 5439.755211015514, 5444.074507333723, 5780.3063632363965, 5828.3297420796725, 5831.329397119301, 5832.6500409975115, 5837.182794408786, 5811.767529298823, 5835.941640583582, 5847.3275573308765, 5901.822945311647, 5902.173695682565, 5233.136532472099, 5282.920756188661, 5283.6037297202865, 5435.864103397407, 5442.9727851360885, 5917.408259174048, 5919.052951527821, 5927.762889484458, 5954.8809023819285, 5979.133025711334, 5662.971685141548, 5667.773289068474, 5709.65742055478, 5713.657180569179, 5715.399883012307, 5495.587830912697, 5746.02317606008, 5801.593888427854, 5806.622569533051, 5832.941670583325, 5753.252077229933, 5755.827325180251, 5757.769689212469, 5795.1886735857015, 5813.6221145625395, 5712.65724056558, 5745.368009518949, 5753.453421924911, 5761.85595360111, 5763.942360576424, 4337.804798783999, 4377.999999999936, 4403.295472724413, 4431.8448854289945, 4433.4236549249035, 3935.0555866592385, 3940.15286713358, 3958.4062390641056, 3965.643092121723, 3991.560928297885, 5460.5085542301385, 5463.863403414867, 5470.0, 5473.0969390050195, 5479.835604931858, 5585.245991791056, 5697.544196464273, 5735.569832262597, 5799.0, 5839.883202335929, 5435.293411856513, 5457.7271136443815, 5463.644863083887, 5491.148871924858, 5500.28496295479, 5012.24816277554, 5022.4977502249485, 5023.246513023003, 5033.295338652591, 5073.315102461194, 5877.353491115974, 5986.700664966821, 6004.849878753066, 6014.428629280212, 6036.7585296589405, 5812.651240925558, 5820.185174075548, 5822.010258256191, 5845.795397161079, 5870.236869206976, 6060.2424696912885, 6071.878562428815, 6073.362296958756, 6074.696265186812, 6087.512998960161, 5548.0845660465575, 5556.861078473071, 5557.805476808292, 5642.153676948491, 5705.201271821865, 5689.77240910359, 5726.455986681259, 5730.111832665943, 5762.769489220552, 5770.711464426678, 5587.497125258747, 5592.356878958972, 5592.552595792408, 5593.440655934374, 5608.579356548356, 5490.396056433709, 5566.359868614999, 5566.805161819317, 5642.520385767091, 5672.0, 5644.0, 5648.293963254593, 5654.406287339934, 5667.20659107717, 5706.372299047184, 5730.885382292414, 5741.655500669973, 5791.189233507396, 5798.304203495608, 5806.970965145148, 5355.812546560852, 5563.7496312666835, 5597.720113994203, 5608.046632072476, 5612.130119831432], "value": 5323.793876236404, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.8672000625608, 581.5899790647594, 589.6521052578978, 596.9462748352647, 603.0652488642605, 30362.0, 30763.538546921813, 33682.66317336826, 44238.0, 45146.548534514644, 46037.079258414895, 46350.536494635046, 46359.30461043087, 46428.53571464284, 46478.76760616192, 8926.46441213526, 9074.546272686372, 9076.22852057576, 9086.727398178065, 9088.818223635524, 8901.821963560726, 8986.730398088068, 8994.460332380046, 8994.68518601849, 8995.550222488882, 9008.639654413848, 9050.0, 9052.275817934582, 9053.728388148365, 9057.0, 8952.239059679934, 8969.820603587892, 8999.685011024649, 9003.549822508849, 9004.144606262395, 8919.108089191093, 8979.0, 8984.236339911115, 8984.371094023356, 8984.416012959202, 43087.35368969468, 43249.91875203114, 43475.34786978198, 43513.78243108796, 43536.78231608822, 3431.879884204066, 3581.6776490116013, 3585.318789430026, 3628.219932714479, 3822.311983842907, 33450.0, 33799.155021124425, 34082.318353632785, 34448.59598625168, 34573.827130864185, 4528.8867778305475, 4606.838760643362, 4666.183417901853, 4748.382710247645, 4757.429108507002, 359291.0, 364287.0, 364833.0, 365565.1721741401, 367100.0, 60156.691381974415, 60527.0, 60532.394676052674, 60588.0, 60591.69704151451, 36390.818045909604, 36653.26693466169, 36952.44571331432, 38764.80617596894, 63653.36346636567, 15997.520074397788, 16017.279222435018, 16103.597410064842, 16151.515454536382, 16225.51323460298, 11212.607558735404, 11255.099592032782, 11268.661940141808, 11365.204435689588, 11398.601048963412, 19658.41024769259, 19793.802061979197, 19877.925025370052, 19907.701384479245, 19976.60046799056, 7035.1909530404655, 7100.68046937889, 7143.464155206656, 7389.704411823574, 7397.0, 983.2920297385871, 1043.968680939573, 1101.9916776149894, 1125.2685754259796, 1126.5831642292405, 33439.56043956044, 33934.0, 33962.49056264158, 34002.0, 34220.65779342175, 1097.226455348977, 1100.6202860013282, 1124.2242852431796, 1174.7356844710043, 1221.3526830779701, 17367.91585009807, 18452.630947380978, 18588.44234672962, 19425.0, 19430.514237143903, 509611.0, 519212.0, 523772.0, 851215.0, 855181.0, 61323.0, 61976.0, 62018.37981620216, 62058.0, 62090.37909620936, 1279.1046267612708, 1308.4504508106618, 1352.2562590575144, 1376.5870238928283, 1394.9721005579831, 32521.674783251863, 34034.0, 34038.48942265818, 34233.82883085569, 34540.13649658678, 52216.47783522268, 52509.0, 52964.470355295955, 52981.7350913243, 52988.470115298354, 436532.0, 439593.0, 439855.0, 440694.0, 441401.0, 25416.110436134648, 29559.408811824072, 46077.078458429976, 46143.3078503816, 46968.06063878635, 47268.0, 50888.745556271984, 51433.48566514287, 51716.0, 52181.7390913043, 38982.80508597439, 39417.60582394139, 39999.0, 40531.0, 41058.384124237564, 42842.35736464018, 43310.0, 43792.34311485394, 44627.55372446234, 44704.55295447004, 43182.0, 43653.56346436495, 43664.56335436605, 43883.78058109689, 44254.77872610616, 35723.82138089293, 38909.6109038906, 39027.219455611295, 39458.60541394549, 39482.0, 29112.0, 29194.7080529192, 29196.744815734663, 29312.120636380943, 29483.85258073696], "value": 20613.490456936866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.31690580162194, 384.35812193636633, 385.41609461665564, 385.9228154369126, 401.22363227155455, 14449.277536123205, 16483.0, 17587.47237582873, 19228.61542769144, 20155.697664535026, 16961.151942402892, 17531.298748050096, 17973.7303940441, 18866.71699924502, 18932.905335473304, 5562.221289019541, 5700.087985922253, 5703.344115426717, 5727.312722473309, 5734.598578099534, 5546.334439867222, 5589.133684278923, 5695.316562012565, 5712.800051998181, 5751.683657398841, 5583.35791383992, 5661.8584535386735, 5664.320281566218, 5664.490195882369, 5669.744861481243, 5681.233033540481, 5705.486506214419, 5711.914321285184, 5712.971435142839, 5719.542436605062, 4915.48387419323, 5061.924071138936, 5093.057784309877, 5106.259592359124, 5107.61692873036, 22166.0, 22607.434814129614, 22649.98075086625, 22800.0, 22922.65616015761, 2339.82451316152, 2347.9882600587057, 2492.9376765580823, 3066.509358502651, 3193.552902593639, 14156.433742650283, 14370.92814535931, 14430.567082987527, 14655.70688586233, 14668.779968300483, 1880.2009146112848, 1898.686716691744, 1911.1877452082808, 1943.9416817495498, 2001.259533972425, 79026.20973790246, 80260.0, 80562.0, 81158.9999999994, 81520.0, 10144.644937427154, 10216.438095904796, 10498.527566259383, 10594.31136976094, 10682.465876706288, 14255.215963122128, 14284.357203925849, 14383.856161438252, 14423.49517766873, 14452.0, 7267.927320726831, 7345.449091318173, 7364.0426744522865, 7405.20652276188, 7804.921950780419, 7290.161631412349, 7582.279683430065, 7647.885281720779, 7883.6058197089915, 7888.566128862853, 6318.810435686937, 6364.427201551883, 6376.521760867953, 6396.232452105777, 6440.61356318613, 1793.0496836676582, 1889.4331700489797, 1899.392194497775, 1927.633749587574, 1947.269773834812, 965.2953344058876, 979.2704435195825, 989.5596459575564, 1040.8490768838476, 1094.5567045346647, 19261.96938117577, 19601.21595136207, 19760.60478790416, 19770.11034503422, 20097.899510502353, 979.0601023017982, 995.1740055753708, 1013.7566983923953, 1020.9234307426824, 1055.1189756553365, 9235.815283694288, 11003.449827508593, 11287.717807054889, 11303.830442543369, 11352.716182095513, 469478.0, 477461.0, 477606.0, 482644.0, 487378.0, 83594.0, 84351.5782421084, 84668.0, 84810.57594711987, 84955.0, 1000.7448100734412, 1076.8115579773507, 1092.1590375411047, 1102.7132945434246, 1108.3682301088463, 16385.91807040957, 17630.294788208328, 17820.643587128445, 17864.285428582712, 17893.73159402584, 40587.0, 40614.59385406108, 40837.0, 41103.38344924888, 42777.0, 51385.0, 52013.7399313001, 52380.73809630927, 52753.20870186874, 54098.45901541092, 8108.986376702912, 8146.348292136497, 8177.468464550023, 8281.461704989157, 8339.666413343399, 12425.13024088305, 12515.186512876633, 12573.182743122034, 12678.936605316914, 12679.366031698562, 11054.889451105386, 11264.549418023187, 11289.435528223721, 11496.425178741198, 11640.35978021217, 10035.799284014425, 10102.141317988053, 11090.390028548507, 11218.66344009681, 11606.361650109326, 10555.841662374916, 11322.830157547478, 11470.942645286721, 11694.239874408137, 11786.823197651871, 7959.562224077731, 7978.122406535161, 8003.879941800994, 8023.598820058857, 8496.915030849612, 11343.829842552534, 11360.431978401211, 11478.311301321948, 11525.654230373102, 11606.535738570701], "value": 9166.721440340854, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.9739805203901, 1455.2796365798931, 1525.5652139140343, 1648.1017845274325, 1776.9911150444245, 8387.538685372301, 8768.167024132714, 8784.16550427709, 8984.371094023421, 8991.415557988727, 8643.611037503311, 8698.869516957235, 8720.476771393722, 8722.953245610519, 8733.388662793606, 2288.141946769965, 2305.7002589663402, 2308.6306191009444, 2309.722833260011, 2315.5600435917204, 2268.5803126421583, 2322.6980492535945, 2328.2084091409, 2333.1717240379676, 2335.252719129879, 2354.82338824588, 2361.126383238204, 2361.8228632852606, 2366.668666386707, 2393.3896856301617, 2295.070496448941, 2306.2504685977124, 2308.722953245613, 2325.767423257678, 2328.9301320960312, 2259.9548009039727, 2267.6031694453404, 2274.4882401459704, 2275.24916777463, 2276.9544609107725, 8474.364422668325, 8595.785105372353, 8647.65409383624, 8748.34387420946, 8794.912050879473, 5117.8464646060675, 5259.947400525984, 5260.210968354739, 5261.552768014723, 5269.262303277545, 3429.5027221053056, 3457.9827100864336, 3500.5099286099967, 3503.91240218994, 3556.7154627629984, 1156.5836298932377, 1158.6987383280323, 1158.8377627132209, 1173.8180582009802, 1174.7944109780753, 11911.821322680167, 11917.22538035025, 11949.94025029878, 11954.880451195551, 11987.880121198676, 4269.295566231537, 4401.0, 4531.320301954667, 4558.88602784933, 4559.110973360229, 9440.858387124199, 9492.098250666175, 9514.524273786421, 9686.418814871131, 9766.95116524427, 5188.143956247252, 5237.3453318335205, 5238.92141617876, 5244.947550524446, 5246.422893481714, 4149.564295748964, 4243.702940794176, 4322.502912165079, 4636.4899861015265, 4930.063287975273, 3791.829367678461, 3810.466534685146, 3872.3997780344093, 3934.075492259317, 3938.586448422874, 1097.6761855252719, 1143.388287266325, 1145.1411441418936, 1149.2529855593764, 1153.0084127650214, 908.5003248213457, 961.6730311694058, 963.1091240602415, 988.4909271725068, 992.5434300221979, 5813.0, 5848.356680765112, 5903.232579764689, 5943.55423343251, 6247.312795592481, 422.2167878585242, 425.7296616648389, 428.82715772362565, 442.9778511074498, 447.6754353093981, 3817.7136714746507, 3883.980580097081, 3914.6868250539887, 3939.8424063037733, 4049.595040495986, 10840.566377344976, 11126.833097503544, 11193.66419007431, 11207.383593902414, 11240.718982025352, 11064.336139831636, 11107.333559986266, 11190.160737944523, 11191.496382662637, 11210.103191744642, 8297.294729947902, 8364.498130112213, 8382.413231073766, 8444.0, 8463.53450560225, 5720.456556627114, 5809.709514524341, 5896.852578685395, 5934.317553481233, 6090.573659843945, 9718.271129665161, 9922.0, 9992.050755178247, 10118.797624047626, 10171.0, 9867.654632087842, 9906.157976572073, 10000.099991000845, 10006.949965250127, 10389.116925061455, 7023.789286321418, 7620.466567340233, 7770.261825126604, 7927.801804954922, 7973.242541958504, 8356.0, 8541.145885411657, 8561.657533698582, 8608.139186081342, 8610.225079742853, 7624.428167887319, 7871.134175240604, 7904.920950790649, 7940.761777146695, 7997.1203167652675, 7466.701331946661, 7522.774316770506, 7631.961840190764, 7635.198304178203, 7735.574543400167, 6715.227748808949, 6801.421879140328, 6807.659617019228, 6819.659017049227, 6845.589264644137, 4997.450280469218, 5056.721880296619, 5128.666636668605, 5199.168133098686, 5252.527272545336, 4986.102501549756, 5099.490050994871, 5118.436971933159, 5236.790528378822, 5238.266642669953], "value": 4495.991659035025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.93741251749657, 316.33885179973856, 316.6074068155487, 320.9967900320996, 321.89055721054865, 5234.790608375665, 5272.420033796284, 5273.943162166748, 5287.968846075017, 5293.497117773815, 5175.767090480928, 5194.091034069042, 5270.420253772082, 5279.366476022883, 5303.787848486056, 4093.16090201508, 4108.77401742904, 4110.157417729359, 4123.525794533637, 4190.120074784299, 3900.8049597520153, 4121.5878412158845, 4129.2360913231, 4145.626893579577, 4154.210699967011, 4011.9799401002956, 4072.124493233954, 4088.550259471456, 4099.426080348739, 4105.096878686684, 3803.695704343646, 3927.9018024549327, 4016.979915100435, 4033.495813023372, 4069.680282239125, 3529.3823580873245, 3532.04634748619, 3538.9115272118147, 3545.8227088645463, 3547.485614585896, 5090.160123579605, 5106.08090543702, 5110.514501122425, 5116.181410974264, 5140.408852981917, 4385.429894113745, 4464.241079016575, 4577.359169716243, 4587.334836448729, 4623.537646235383, 5371.623986320959, 5373.838784836422, 5374.946250537484, 5405.540529055035, 5420.322459692538, 3899.6490315871706, 3901.239258344624, 3912.139329347539, 3913.2956067907767, 3938.330483817758, 5598.188262701926, 5638.210650508932, 5654.604177707521, 5717.199592057115, 5748.2527271454865, 3952.960470395317, 3953.8616148435244, 3960.881173564798, 3962.5046869141356, 3989.6409323161056, 4006.8397264109694, 4025.91948161041, 4036.8990775230855, 4040.212158629039, 4052.878413647595, 4503.977480112644, 4595.931061034087, 4603.941093548436, 4614.792334344896, 4616.584507394284, 5435.42927992563, 5437.83686489398, 5450.427705090988, 5472.890542189134, 5500.092484740053, 1367.6375760423496, 1377.738229736347, 1381.1851007905384, 1384.3701115992199, 1387.7918312253041, 853.6414705823445, 888.311558542122, 903.0427746588637, 908.8545832666741, 911.6763548940163, 4643.814247430132, 4723.811047558128, 4733.195356789354, 4736.834210802605, 4782.808687652455, 4877.658563900563, 4949.727764972889, 4954.058728841508, 4985.626078044161, 5001.474550262205, 4745.667803253739, 4753.833615823499, 4766.332713420124, 4766.833160839424, 5012.323336349619, 2864.6848846626854, 2905.8547072646284, 2933.120063980797, 2962.0965605490533, 2984.7612191024664, 5802.767889284381, 5817.389174136655, 5821.446962538552, 5829.358770535237, 5841.853953651193, 5602.467765562265, 5694.715264236772, 5707.571932105026, 5737.196792449061, 5744.1096630021575, 5734.197212390352, 5792.247007889032, 5798.304203495523, 5813.767449302065, 5823.767049318065, 5571.554275657856, 5590.86022849432, 5595.5803314752375, 5622.634528755618, 5644.689542075061, 5328.200769884394, 5511.889762204653, 5527.474889885454, 5532.197831314517, 5572.4148964358155, 5786.594938354275, 5788.479036886701, 5797.826065218051, 5809.692819115665, 5828.271466066742, 3957.22834047358, 4010.438538604539, 4015.7389769666047, 4023.597640235953, 4031.7580945143386, 5384.811531596375, 5507.311586051744, 5512.834614961557, 5565.1095824667855, 5621.437856214509, 5429.891402172014, 5431.185322201702, 5440.374356949002, 5462.9726851365485, 5466.781328746805, 5457.781688732565, 5460.5085542301385, 5461.235427040138, 5463.726813659222, 5472.604485856081, 5220.582353411642, 5452.345718513804, 5492.972535137458, 5494.5054945055135, 5514.862128446821, 5578.888422231614, 5594.0, 5604.523615492729, 5632.718364081861, 5642.435756424489, 5201.973990130025, 5381.677099373894, 5424.5660347172925, 5438.4561543846885, 5445.863853403696], "value": 4124.300526236149, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.312750725637, 835.6949713354626, 848.5969164646798, 851.8253757979614, 870.6604424274531, 15177.16525591092, 16496.422625208106, 16503.504894853173, 16510.587235319123, 16516.174191290433, 14641.633959151026, 14740.85259147411, 14775.926120369382, 14977.400903963828, 15005.324760385782, 785.4501848705886, 803.6785285885663, 812.5327936436572, 815.5881279953616, 816.0859836982588, 673.5251647588439, 673.6631684157921, 824.5547404401646, 826.5908375354178, 827.2472050434106, 732.7508647059999, 733.8972543843839, 829.1087081387533, 833.5957060825494, 853.5774791478196, 871.4640496094888, 873.3057219510505, 874.5627186406797, 874.8119154381807, 875.7679215008028, 633.6071635585967, 633.790849019827, 633.9873202535923, 634.3751404866204, 634.4036605590776, 12046.096542759327, 14175.291235438186, 14602.26988650574, 15007.474738384213, 15136.243187840673, 15238.46665366718, 15535.766963495444, 15585.142817145052, 15657.0, 16097.517074487783, 11935.701607459796, 11988.760224795455, 12012.459439325252, 12274.263544187377, 12632.431540580696, 3728.1611637381643, 3748.9437658435145, 3790.7915064671433, 3826.9617303826885, 3840.558335791392, 69608.6519567404, 72602.63698681525, 73012.63493682498, 77849.0, 78079.60960195163, 11780.293182409083, 11887.10846686502, 12126.818097728541, 12263.816042759367, 12336.691582710324, 21807.127714891543, 21866.89066554689, 21908.561828763653, 21953.67069493959, 22518.549629007328, 8880.51157186348, 8935.642574297086, 8965.865512017324, 8998.460092394478, 9130.908690913138, 4738.928916066262, 4757.904841903142, 4791.856244312677, 4879.121758083508, 4933.28467372229, 3519.788812671197, 3575.3028159509167, 3583.8387272572277, 3586.8385922633543, 3915.667168290727, 699.1470406104544, 703.0368395298372, 712.7327252280395, 721.1598487761804, 729.6716477585107, 662.8299265727308, 663.3764261594087, 706.809161526385, 708.0618180910315, 762.622501861571, 9938.552765125587, 10250.897491024994, 10511.421871796972, 10516.26386152962, 10800.848213401054, 621.6425555305717, 695.5409429776323, 730.9853802923911, 754.9396048316122, 764.2513471422681, 4783.354247176656, 5279.709615971158, 5310.9734451327495, 5317.813876514303, 5339.3058902342445, 110924.4453777742, 114750.0, 124494.0, 134489.3275533616, 136006.0, 108330.45834770775, 109643.45178274058, 113179.0, 114510.0, 119188.0, 80808.0, 82446.0, 96953.0, 99720.50139749255, 100437.0, 9828.557714902989, 9928.305018648625, 10186.898131018892, 10231.232657550565, 10563.918602269117, 37573.43639845459, 42246.155076898904, 47121.76439117782, 48183.759081205775, 55111.72444137753, 53120.46879531155, 56967.14549281847, 75537.62231188809, 77266.0, 78404.0, 13229.385307346327, 13768.0, 13774.586762397144, 13927.23400212998, 14570.562883113524, 14955.40178392852, 15485.148316842682, 15518.689626207639, 15537.922310388376, 15579.844201557838, 14313.141211527342, 14474.0, 14480.637984050483, 14549.85450145485, 15343.923280383528, 14821.184834834188, 14869.776953345492, 14910.179940102964, 15129.319180636678, 15150.16674082936, 14258.42966281337, 14401.63995900111, 14988.400463981754, 15224.543263702106, 15485.612859678598, 10732.248742587944, 11174.385408802595, 11562.88437115618, 11619.419029048682, 11993.580224692094, 11368.715782105513, 11661.416929153678, 11837.11322822699, 12118.697032574257, 12158.817617735564], "value": 7803.728318635576, "unit": "score"}], "name": "dromaeo_css", "value": 7253.019405757662, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 109.0, 110.0, 111.0, 110.0, 110.0, 109.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 118.0, 189.0, 123.0, 118.0, 145.0, 125.0, 150.0, 118.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 132.0, 76.0, 76.0, 74.0, 75.0, 106.0, 74.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 115.0, 84.0, 84.0, 92.0, 124.0, 83.0, 84.0, 126.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 52.0, 51.0, 57.0, 50.0, 49.0, 50.0, 50.0, 49.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 81.0, 76.0, 78.0, 75.0, 75.0, 75.0, 75.0, 84.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 127.0, 123.0, 133.0, 119.0, 127.0, 123.0, 217.0, 120.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 158.0, 155.0, 156.0, 157.0, 157.0, 161.0, 161.0, 159.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 64.0, 63.0, 62.0, 64.0, 62.0, 62.0, 62.0, 65.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1487.1999999999998, "alertThreshold": 2.0}]} 19:28:34 INFO - Return code: 0 19:28:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:28:35 INFO - # TBPL SUCCESS # 19:28:35 INFO - Running post-action listener: _resource_record_post_action 19:28:35 INFO - [mozharness: 2016-07-31 02:28:35.014520Z] Finished run-tests step (success) 19:28:35 INFO - Running post-run listener: _resource_record_post_run 19:28:35 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544313344; Read time: 24; Write time: 421520 19:28:35 INFO - TinderboxPrint: CPU usage
13.0% 19:28:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 19:28:35 INFO - TinderboxPrint: I/O write bytes / time
544,313,344 / 421,520 19:28:35 INFO - TinderboxPrint: CPU idle
8,265.6 (86.9%) 19:28:35 INFO - TinderboxPrint: CPU user
1,196.3 (12.6%) 19:28:35 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247558144; Read time: 0; Write time: 218456 19:28:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 296239104; Read time: 0; Write time: 203024 19:28:35 INFO - Running post-run listener: _upload_blobber_files 19:28:35 INFO - Blob upload gear active. 19:28:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:35 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 19:28:35 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'] 19:28:35 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 19:28:36 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:28:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:40 INFO - (blobuploader) - INFO - Done attempting. 19:28:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:28:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:41 INFO - (blobuploader) - INFO - Done attempting. 19:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:42 INFO - (blobuploader) - INFO - Done attempting. 19:28:42 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:42 INFO - Return code: 0 19:28:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b71c408698b18b2ba7ad78665ad5be6e815fcd757b6124690e163e94da5990a3259733b7cc241396e294daec88aeee727e39cad2ff14917278a327a6ce35ad41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0a158935e8879664556331eede71255fc23e8e10ab19aefc5f2aa5f174a341868fca2b3fa4c4fc31b720037f90603c06bd6a94d0cebe6ff244b26f527047114a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a18df5b55642e3dd039f6fbc35b4f4c3e7623e49d22dc21bf2ec00f1e5809e1049ba532d3e36b9b79ef5cc7c795353e0e39d6a3163f5fa8faa46f23523ab033"} 19:28:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:42 INFO - Contents: 19:28:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b71c408698b18b2ba7ad78665ad5be6e815fcd757b6124690e163e94da5990a3259733b7cc241396e294daec88aeee727e39cad2ff14917278a327a6ce35ad41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0a158935e8879664556331eede71255fc23e8e10ab19aefc5f2aa5f174a341868fca2b3fa4c4fc31b720037f90603c06bd6a94d0cebe6ff244b26f527047114a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a18df5b55642e3dd039f6fbc35b4f4c3e7623e49d22dc21bf2ec00f1e5809e1049ba532d3e36b9b79ef5cc7c795353e0e39d6a3163f5fa8faa46f23523ab033"} 19:28:42 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:42 INFO - Copying logs to upload dir... 19:28:42 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.108412 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-30 19:28:42.207871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 19:28:42.212770) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632 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/b71c408698b18b2ba7ad78665ad5be6e815fcd757b6124690e163e94da5990a3259733b7cc241396e294daec88aeee727e39cad2ff14917278a327a6ce35ad41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0a158935e8879664556331eede71255fc23e8e10ab19aefc5f2aa5f174a341868fca2b3fa4c4fc31b720037f90603c06bd6a94d0cebe6ff244b26f527047114a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a18df5b55642e3dd039f6fbc35b4f4c3e7623e49d22dc21bf2ec00f1e5809e1049ba532d3e36b9b79ef5cc7c795353e0e39d6a3163f5fa8faa46f23523ab033"} build_url:https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/aNj-Bub-QymG7ofBPZZ0Gg/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/b71c408698b18b2ba7ad78665ad5be6e815fcd757b6124690e163e94da5990a3259733b7cc241396e294daec88aeee727e39cad2ff14917278a327a6ce35ad41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0a158935e8879664556331eede71255fc23e8e10ab19aefc5f2aa5f174a341868fca2b3fa4c4fc31b720037f90603c06bd6a94d0cebe6ff244b26f527047114a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a18df5b55642e3dd039f6fbc35b4f4c3e7623e49d22dc21bf2ec00f1e5809e1049ba532d3e36b9b79ef5cc7c795353e0e39d6a3163f5fa8faa46f23523ab033"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 19:28:42.240930) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:28:42.241275) ========= 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=20e666a3d4cfbb71505a330e000001b4-1469924639.885401-2099212632 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 19:28:42.291158) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 19:28:42.294532) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 19:28:42.294865) ========= ========= Total master_lag: 0.18 =========