builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1470061250.71 results: success (0) buildid: 20160801072026 builduid: e70c5b1d486544c6959343a3fdd388dc revision: c0c16cea7afa66c59d18a6b88cfc95274599a1c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:50.705883) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:50.706246) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:50.706510) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:50.731433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:50.731670) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 07:20:51-- 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% 46.5M=0s 2016-08-01 07:20:51 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:50.850669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:50.850974) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:50.899972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:50.900284) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c0c16cea7afa66c59d18a6b88cfc95274599a1c7 --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 c0c16cea7afa66c59d18a6b88cfc95274599a1c7 --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=97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 07:20:51,448 truncating revision to first 12 chars 2016-08-01 07:20:51,449 Setting DEBUG logging. 2016-08-01 07:20:51,449 attempt 1/10 2016-08-01 07:20:51,449 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c0c16cea7afa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 07:20:51,757 unpacking tar archive at: mozilla-inbound-c0c16cea7afa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:51.538233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:51.538533) ========= script_repo_revision: c0c16cea7afa66c59d18a6b88cfc95274599a1c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:51.538925) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:51.539191) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 07:20:51.551345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 51 secs) (at 2016-08-01 07:20:51.551733) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:20:52 INFO - MultiFileLogger online at 20160801 07:20:52 in /builds/slave/test 07:20:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:20:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:20:52 INFO - {'append_to_log': False, 07:20:52 INFO - 'base_work_dir': '/builds/slave/test', 07:20:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:20:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:20:52 INFO - 'branch': 'Mozilla-Inbound', 07:20:52 INFO - 'buildbot_json_path': 'buildprops.json', 07:20:52 INFO - 'config_files': ('talos/linux_config.py',), 07:20:52 INFO - 'default_actions': ('clobber', 07:20:52 INFO - 'read-buildbot-config', 07:20:52 INFO - 'download-and-extract', 07:20:52 INFO - 'populate-webroot', 07:20:52 INFO - 'create-virtualenv', 07:20:52 INFO - 'install', 07:20:52 INFO - 'run-tests'), 07:20:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:20:52 INFO - 'download_minidump_stackwalk': True, 07:20:52 INFO - 'download_symbols': 'ondemand', 07:20:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:20:52 INFO - 'tooltool.py': '/tools/tooltool.py', 07:20:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:20:52 INFO - '/tools/misc-python/virtualenv.py')}, 07:20:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:20:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:20:52 INFO - 'installer_path': 'installer.exe', 07:20:52 INFO - 'log_level': 'info', 07:20:52 INFO - 'log_name': 'talos', 07:20:52 INFO - 'log_to_console': True, 07:20:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:20:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:20:52 INFO - 'opt_config_files': (), 07:20:52 INFO - 'pip_index': False, 07:20:52 INFO - 'sps_profile': False, 07:20:52 INFO - 'sps_profile_interval': 0, 07:20:52 INFO - 'suite': 'dromaeojs-e10s', 07:20:52 INFO - 'system_bits': '32', 07:20:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:20:52 INFO - 'title': 'talos-linux64-ix-068', 07:20:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:20:52 INFO - 'use_talos_json': True, 07:20:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:20:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:20:52 INFO - 'work_dir': 'build'} 07:20:52 INFO - [mozharness: 2016-08-01 14:20:52.203254Z] Running clobber step. 07:20:52 INFO - Running pre-action listener: _resource_record_pre_action 07:20:52 INFO - Running main action method: clobber 07:20:52 INFO - rmtree: /builds/slave/test/build 07:20:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:20:52 INFO - Running post-action listener: _resource_record_post_action 07:20:52 INFO - [mozharness: 2016-08-01 14:20:52.660412Z] Finished clobber step (success) 07:20:52 INFO - [mozharness: 2016-08-01 14:20:52.660513Z] Running read-buildbot-config step. 07:20:52 INFO - Running pre-action listener: _resource_record_pre_action 07:20:52 INFO - Running main action method: read_buildbot_config 07:20:52 INFO - Using buildbot properties: 07:20:52 INFO - { 07:20:52 INFO - "project": "", 07:20:52 INFO - "product": "firefox", 07:20:52 INFO - "script_repo_revision": "production", 07:20:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:20:52 INFO - "repository": "", 07:20:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:20:52 INFO - "buildid": "20160801072026", 07:20:52 INFO - "stage_platform": "linux64-pgo", 07:20:52 INFO - "basedir": "/builds/slave/test", 07:20:52 INFO - "buildnumber": 934, 07:20:52 INFO - "platform": "ubuntu64_hw", 07:20:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:20:52 INFO - "slavebuilddir": "test", 07:20:52 INFO - "branch": "mozilla-inbound", 07:20:52 INFO - "revision": "c0c16cea7afa66c59d18a6b88cfc95274599a1c7", 07:20:52 INFO - "slavename": "talos-linux64-ix-068", 07:20:52 INFO - "builduid": "e70c5b1d486544c6959343a3fdd388dc", 07:20:52 INFO - "repo_path": "integration/mozilla-inbound" 07:20:52 INFO - } 07:20:52 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:20:52 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.test_packages.json. 07:20:52 INFO - Running post-action listener: _resource_record_post_action 07:20:52 INFO - [mozharness: 2016-08-01 14:20:52.662882Z] Finished read-buildbot-config step (success) 07:20:52 INFO - [mozharness: 2016-08-01 14:20:52.662972Z] Running download-and-extract step. 07:20:52 INFO - Running pre-action listener: _resource_record_pre_action 07:20:52 INFO - Running main action method: download_and_extract 07:20:52 INFO - mkdir: /builds/slave/test/build/tests 07:20:52 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')]} 07:20:52 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:20:52 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/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 07:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/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 07:20:52 INFO - Downloaded 1361 bytes. 07:20:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:20:52 INFO - Using the following test package requirements: 07:20:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:20:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:20:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:20:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:52 INFO - u'jsshell-linux-x86_64.zip'], 07:20:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:20:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:20:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:20:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:20:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:20:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:20:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:20:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:20:52 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')]} 07:20:52 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:20:52 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/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 07:20:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/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 07:20:53 INFO - Downloaded 21808441 bytes. 07:20:53 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'] 07:20:53 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 07:20:54 INFO - Return code: 0 07:20:54 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 07:20:54 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')]} 07:20:54 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:20:54 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/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 07:20:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/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 07:20:54 INFO - Downloaded 21808441 bytes. 07:20:54 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'] 07:20:54 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 07:20:55 INFO - Return code: 0 07:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:20:55 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:20:55 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/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 07:20:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/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 07:20:56 INFO - Downloaded 14413723 bytes. 07:20:56 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'] 07:20:56 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 07:20:56 INFO - Return code: 0 07:20:56 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')]} 07:20:56 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:20:56 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/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 07:20:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/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 07:20:57 INFO - Downloaded 59376699 bytes. 07:20:57 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:20:57 INFO - mkdir: /builds/slave/test/properties 07:20:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:20:57 INFO - Writing to file /builds/slave/test/properties/build_url 07:20:57 INFO - Contents: 07:20:57 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:20:57 INFO - Running post-action listener: _resource_record_post_action 07:20:57 INFO - Running post-action listener: set_extra_try_arguments 07:20:57 INFO - [mozharness: 2016-08-01 14:20:57.274971Z] Finished download-and-extract step (success) 07:20:57 INFO - [mozharness: 2016-08-01 14:20:57.275204Z] Running populate-webroot step. 07:20:57 INFO - Running pre-action listener: _resource_record_pre_action 07:20:57 INFO - Running main action method: populate_webroot 07:20:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:20:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:20:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:20:57 INFO - '--tppagecycles', 07:20:57 INFO - '7'], 07:20:57 INFO - 'tests': ['tsvgm']}}, 07:20:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:20:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:20:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:20:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:20:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:57 INFO - 'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:20:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:20:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:57 INFO - 'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['damp', 'tps']}, 07:20:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:57 INFO - 'tests': ['damp', 'tps']}, 07:20:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['dromaeo_dom']}, 07:20:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:20:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['basic_compositor_video']}, 07:20:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:20:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['a11yr', 07:20:57 INFO - 'ts_paint', 07:20:57 INFO - 'tpaint', 07:20:57 INFO - 'sessionrestore', 07:20:57 INFO - 'sessionrestore_no_auto_restore', 07:20:57 INFO - 'tabpaint']}, 07:20:57 INFO - 'other-e10s': {'tests': ['a11yr', 07:20:57 INFO - 'ts_paint', 07:20:57 INFO - 'tpaint', 07:20:57 INFO - 'sessionrestore', 07:20:57 INFO - 'sessionrestore_no_auto_restore', 07:20:57 INFO - 'tabpaint']}, 07:20:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:20:57 INFO - 'ts_paint', 07:20:57 INFO - 'tpaint', 07:20:57 INFO - 'sessionrestore', 07:20:57 INFO - 'sessionrestore_no_auto_restore', 07:20:57 INFO - 'tabpaint']}, 07:20:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:20:57 INFO - 'ts_paint', 07:20:57 INFO - 'tpaint', 07:20:57 INFO - 'sessionrestore', 07:20:57 INFO - 'sessionrestore_no_auto_restore', 07:20:57 INFO - 'tabpaint']}, 07:20:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['a11yr', 07:20:57 INFO - 'ts_paint', 07:20:57 INFO - 'tpaint', 07:20:57 INFO - 'sessionrestore', 07:20:57 INFO - 'sessionrestore_no_auto_restore', 07:20:57 INFO - 'tabpaint']}, 07:20:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['a11yr', 07:20:57 INFO - 'ts_paint', 07:20:57 INFO - 'tpaint', 07:20:57 INFO - 'sessionrestore', 07:20:57 INFO - 'sessionrestore_no_auto_restore', 07:20:57 INFO - 'tabpaint']}, 07:20:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['tsvgx', 07:20:57 INFO - 'tsvgr_opacity', 07:20:57 INFO - 'tart', 07:20:57 INFO - 'tscrollx', 07:20:57 INFO - 'cart']}, 07:20:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:20:57 INFO - 'tsvgr_opacity', 07:20:57 INFO - 'tart', 07:20:57 INFO - 'tscrollx', 07:20:57 INFO - 'cart']}, 07:20:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:57 INFO - 'talos_options': ['--disable-e10s'], 07:20:57 INFO - 'tests': ['tp5o']}, 07:20:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:57 INFO - 'tests': ['tp5o']}, 07:20:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:57 INFO - 'talos_options': ['--disable-e10s', 07:20:57 INFO - '--xperf_path', 07:20:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:20:57 INFO - 'tests': ['tp5n']}, 07:20:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:20:57 INFO - 'talos_options': ['--xperf_path', 07:20:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:20:57 INFO - 'tests': ['tp5n']}}, 07:20:57 INFO - 'talos.zip': {'path': '', 07:20:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:20:57 INFO - Running post-action listener: _resource_record_post_action 07:20:57 INFO - [mozharness: 2016-08-01 14:20:57.299301Z] Finished populate-webroot step (success) 07:20:57 INFO - [mozharness: 2016-08-01 14:20:57.299411Z] Running create-virtualenv step. 07:20:57 INFO - Running pre-action listener: _resource_record_pre_action 07:20:57 INFO - Running main action method: create_virtualenv 07:20:57 INFO - Creating virtualenv /builds/slave/test/build/venv 07:20:57 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 07:20:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:20:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:20:57 INFO - Using real prefix '/usr' 07:20:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:20:57 INFO - Installing distribute.............................................................................................................................................................................................done. 07:20:59 INFO - Installing pip.................done. 07:20:59 INFO - Return code: 0 07:20:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:20: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')]} 07:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20: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')]} 07:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:20:59 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 0x1d2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', '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 07:20:59 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 07:20:59 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 07:20:59 INFO - Using env: {'DISPLAY': ':0', 07:20:59 INFO - 'HOME': '/home/cltbld', 07:20:59 INFO - 'LANG': 'en_US.UTF-8', 07:20:59 INFO - 'LANGUAGE': 'en_US:en', 07:20:59 INFO - 'LOGNAME': 'cltbld', 07:20:59 INFO - 'MAIL': '/var/mail/cltbld', 07:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:20:59 INFO - 'MOZ_NO_REMOTE': '1', 07:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:20:59 INFO - 'NO_EM_RESTART': '1', 07:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:20:59 INFO - 'PWD': '/builds/slave/test', 07:20:59 INFO - 'SHELL': '/bin/bash', 07:20:59 INFO - 'SHLVL': '1', 07:20:59 INFO - 'TERM': 'linux', 07:20:59 INFO - 'TMOUT': '86400', 07:20:59 INFO - 'USER': 'cltbld', 07:20:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:20:59 INFO - '_': '/tools/buildbot/bin/python'} 07:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:00 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 07:21:00 INFO - Cleaning up... 07:21:00 INFO - Return code: 0 07:21:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:00 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 0x1d2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', '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 07:21:00 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 07:21:00 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 07:21:00 INFO - Using env: {'DISPLAY': ':0', 07:21:00 INFO - 'HOME': '/home/cltbld', 07:21:00 INFO - 'LANG': 'en_US.UTF-8', 07:21:00 INFO - 'LANGUAGE': 'en_US:en', 07:21:00 INFO - 'LOGNAME': 'cltbld', 07:21:00 INFO - 'MAIL': '/var/mail/cltbld', 07:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:00 INFO - 'MOZ_NO_REMOTE': '1', 07:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:00 INFO - 'NO_EM_RESTART': '1', 07:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:00 INFO - 'PWD': '/builds/slave/test', 07:21:00 INFO - 'SHELL': '/bin/bash', 07:21:00 INFO - 'SHLVL': '1', 07:21:00 INFO - 'TERM': 'linux', 07:21:00 INFO - 'TMOUT': '86400', 07:21:00 INFO - 'USER': 'cltbld', 07:21:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:00 INFO - '_': '/tools/buildbot/bin/python'} 07:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:00 INFO - Downloading/unpacking psutil>=3.1.1 07:21:00 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 07:21:00 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 07:21:00 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 07:21:00 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 07:21:00 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 07:21:00 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 07:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:21:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:21:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:21:02 INFO - Installing collected packages: psutil 07:21:02 INFO - Running setup.py install for psutil 07:21:02 INFO - building 'psutil._psutil_linux' extension 07:21:02 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 07:21:02 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 07:21:02 INFO - building 'psutil._psutil_posix' extension 07:21:02 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 07:21:02 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 07:21:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:21:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:21:02 INFO - Successfully installed psutil 07:21:02 INFO - Cleaning up... 07:21:02 INFO - Return code: 0 07:21:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', '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 07:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:21:02 INFO - Using env: {'DISPLAY': ':0', 07:21:02 INFO - 'HOME': '/home/cltbld', 07:21:02 INFO - 'LANG': 'en_US.UTF-8', 07:21:02 INFO - 'LANGUAGE': 'en_US:en', 07:21:02 INFO - 'LOGNAME': 'cltbld', 07:21:02 INFO - 'MAIL': '/var/mail/cltbld', 07:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:02 INFO - 'MOZ_NO_REMOTE': '1', 07:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:02 INFO - 'NO_EM_RESTART': '1', 07:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:02 INFO - 'PWD': '/builds/slave/test', 07:21:02 INFO - 'SHELL': '/bin/bash', 07:21:02 INFO - 'SHLVL': '1', 07:21:02 INFO - 'TERM': 'linux', 07:21:02 INFO - 'TMOUT': '86400', 07:21:02 INFO - 'USER': 'cltbld', 07:21:02 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:02 INFO - '_': '/tools/buildbot/bin/python'} 07:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:21:03 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 07:21:03 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 07:21:03 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 07:21:03 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 07:21:03 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 07:21:03 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 07:21:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:21:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:21:05 INFO - Installing collected packages: mozsystemmonitor 07:21:05 INFO - Running setup.py install for mozsystemmonitor 07:21:05 INFO - Successfully installed mozsystemmonitor 07:21:05 INFO - Cleaning up... 07:21:05 INFO - Return code: 0 07:21:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:05 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 0x1d2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', '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 07:21:05 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 07:21:05 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 07:21:05 INFO - Using env: {'DISPLAY': ':0', 07:21:05 INFO - 'HOME': '/home/cltbld', 07:21:05 INFO - 'LANG': 'en_US.UTF-8', 07:21:05 INFO - 'LANGUAGE': 'en_US:en', 07:21:05 INFO - 'LOGNAME': 'cltbld', 07:21:05 INFO - 'MAIL': '/var/mail/cltbld', 07:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:05 INFO - 'MOZ_NO_REMOTE': '1', 07:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:05 INFO - 'NO_EM_RESTART': '1', 07:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:05 INFO - 'PWD': '/builds/slave/test', 07:21:05 INFO - 'SHELL': '/bin/bash', 07:21:05 INFO - 'SHLVL': '1', 07:21:05 INFO - 'TERM': 'linux', 07:21:05 INFO - 'TMOUT': '86400', 07:21:05 INFO - 'USER': 'cltbld', 07:21:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:05 INFO - '_': '/tools/buildbot/bin/python'} 07:21:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:05 INFO - Downloading/unpacking jsonschema==2.5.1 07:21:05 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 07:21:05 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 07:21:05 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 07:21:05 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 07:21:05 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 07:21:05 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 07:21:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:21:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:21:07 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 07:21:07 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 07:21:07 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 07:21:07 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 07:21:07 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 07:21:07 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 07:21:07 INFO - Downloading functools32-3.2.3-2.tar.gz 07:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:21:07 INFO - warning: no files found matching '*.txt' 07:21:07 INFO - no previously-included directories found matching 'build' 07:21:07 INFO - no previously-included directories found matching 'dist' 07:21:07 INFO - no previously-included directories found matching '.git*' 07:21:07 INFO - Installing collected packages: jsonschema, functools32 07:21:07 INFO - Running setup.py install for functools32 07:21:07 INFO - warning: no files found matching '*.txt' 07:21:07 INFO - no previously-included directories found matching 'build' 07:21:07 INFO - no previously-included directories found matching 'dist' 07:21:07 INFO - no previously-included directories found matching '.git*' 07:21:07 INFO - Successfully installed jsonschema functools32 07:21:07 INFO - Cleaning up... 07:21:07 INFO - Return code: 0 07:21:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:21:07 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')]} 07:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:07 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')]} 07:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:07 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 0x1d2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', '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 07:21:07 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 07:21:07 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 07:21:07 INFO - Using env: {'DISPLAY': ':0', 07:21:07 INFO - 'HOME': '/home/cltbld', 07:21:07 INFO - 'LANG': 'en_US.UTF-8', 07:21:07 INFO - 'LANGUAGE': 'en_US:en', 07:21:07 INFO - 'LOGNAME': 'cltbld', 07:21:07 INFO - 'MAIL': '/var/mail/cltbld', 07:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:07 INFO - 'MOZ_NO_REMOTE': '1', 07:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:07 INFO - 'NO_EM_RESTART': '1', 07:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:07 INFO - 'PWD': '/builds/slave/test', 07:21:07 INFO - 'SHELL': '/bin/bash', 07:21:07 INFO - 'SHLVL': '1', 07:21:07 INFO - 'TERM': 'linux', 07:21:07 INFO - 'TMOUT': '86400', 07:21:07 INFO - 'USER': 'cltbld', 07:21:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:07 INFO - '_': '/tools/buildbot/bin/python'} 07:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:21:07 INFO - Cleaning up... 07:21:08 INFO - Return code: 0 07:21:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:08 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 0x1d2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', '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 07:21:08 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 07:21:08 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 07:21:08 INFO - Using env: {'DISPLAY': ':0', 07:21:08 INFO - 'HOME': '/home/cltbld', 07:21:08 INFO - 'LANG': 'en_US.UTF-8', 07:21:08 INFO - 'LANGUAGE': 'en_US:en', 07:21:08 INFO - 'LOGNAME': 'cltbld', 07:21:08 INFO - 'MAIL': '/var/mail/cltbld', 07:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:08 INFO - 'MOZ_NO_REMOTE': '1', 07:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:08 INFO - 'NO_EM_RESTART': '1', 07:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:08 INFO - 'PWD': '/builds/slave/test', 07:21:08 INFO - 'SHELL': '/bin/bash', 07:21:08 INFO - 'SHLVL': '1', 07:21:08 INFO - 'TERM': 'linux', 07:21:08 INFO - 'TMOUT': '86400', 07:21:08 INFO - 'USER': 'cltbld', 07:21:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:08 INFO - '_': '/tools/buildbot/bin/python'} 07:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:08 INFO - Downloading/unpacking blobuploader==1.2.4 07:21:08 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 07:21:08 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 07:21:08 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 07:21:08 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 07:21:08 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 07:21:08 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 07:21:10 INFO - Downloading blobuploader-1.2.4.tar.gz 07:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:21:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:21:10 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 07:21:10 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 07:21:10 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 07:21:10 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 07:21:10 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 07:21:10 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 07:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:21:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:21:10 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 07:21:10 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 07:21:10 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 07:21:10 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 07:21:10 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 07:21:10 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 07:21:10 INFO - Downloading docopt-0.6.1.tar.gz 07:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:21:10 INFO - Installing collected packages: blobuploader, requests, docopt 07:21:10 INFO - Running setup.py install for blobuploader 07:21:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:21:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:21:10 INFO - Running setup.py install for requests 07:21:11 INFO - Running setup.py install for docopt 07:21:11 INFO - Successfully installed blobuploader requests docopt 07:21:11 INFO - Cleaning up... 07:21:11 INFO - Return code: 0 07:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:11 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 0x1d2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', '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 07:21:11 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 07:21:11 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 07:21:11 INFO - Using env: {'DISPLAY': ':0', 07:21:11 INFO - 'HOME': '/home/cltbld', 07:21:11 INFO - 'LANG': 'en_US.UTF-8', 07:21:11 INFO - 'LANGUAGE': 'en_US:en', 07:21:11 INFO - 'LOGNAME': 'cltbld', 07:21:11 INFO - 'MAIL': '/var/mail/cltbld', 07:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:11 INFO - 'MOZ_NO_REMOTE': '1', 07:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:11 INFO - 'NO_EM_RESTART': '1', 07:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:11 INFO - 'PWD': '/builds/slave/test', 07:21:11 INFO - 'SHELL': '/bin/bash', 07:21:11 INFO - 'SHLVL': '1', 07:21:11 INFO - 'TERM': 'linux', 07:21:11 INFO - 'TMOUT': '86400', 07:21:11 INFO - 'USER': 'cltbld', 07:21:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:11 INFO - '_': '/tools/buildbot/bin/python'} 07:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:21:11 INFO - Running setup.py (path:/tmp/pip-bDJnPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:21:11 INFO - Running setup.py (path:/tmp/pip-Iunf36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:21:11 INFO - Running setup.py (path:/tmp/pip-prCCIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:21:11 INFO - Running setup.py (path:/tmp/pip-jyKjNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:21:11 INFO - Running setup.py (path:/tmp/pip-56JTn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:21:12 INFO - Running setup.py (path:/tmp/pip-mLNPGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:21:12 INFO - Running setup.py (path:/tmp/pip-Pi4Cqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:21:12 INFO - Running setup.py (path:/tmp/pip-MyyooO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:21:12 INFO - Running setup.py (path:/tmp/pip-ESEA2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:21:12 INFO - Running setup.py (path:/tmp/pip-2Iyv_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:21:12 INFO - Running setup.py (path:/tmp/pip-jSDPl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:21:12 INFO - Running setup.py (path:/tmp/pip-aImpku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:21:12 INFO - Running setup.py (path:/tmp/pip-CreiEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:21:12 INFO - Running setup.py (path:/tmp/pip-V0JEJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:21:12 INFO - Running setup.py (path:/tmp/pip-OhcFmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:21:12 INFO - Running setup.py (path:/tmp/pip-N5WpN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:21:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:21:12 INFO - Running setup.py (path:/tmp/pip-TTBXWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:21:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:21:12 INFO - Running setup.py install for manifestparser 07:21:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:21:13 INFO - Running setup.py install for mozcrash 07:21:13 INFO - Running setup.py install for mozdebug 07:21:13 INFO - Running setup.py install for mozdevice 07:21:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:21:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:21:13 INFO - Running setup.py install for mozfile 07:21:13 INFO - Running setup.py install for mozhttpd 07:21:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:21:13 INFO - Running setup.py install for mozinfo 07:21:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:21:13 INFO - Running setup.py install for mozInstall 07:21:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:21:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:21:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:21:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:21:13 INFO - Running setup.py install for mozleak 07:21:13 INFO - Running setup.py install for mozlog 07:21:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:21:13 INFO - Running setup.py install for moznetwork 07:21:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:21:14 INFO - Running setup.py install for mozprocess 07:21:14 INFO - Running setup.py install for mozprofile 07:21:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:21:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:21:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:21:14 INFO - Running setup.py install for mozrunner 07:21:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:21:14 INFO - Running setup.py install for mozscreenshot 07:21:14 INFO - Running setup.py install for moztest 07:21:14 INFO - Running setup.py install for mozversion 07:21:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:21:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:21:14 INFO - Cleaning up... 07:21:14 INFO - Return code: 0 07:21:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:14 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 0x1d2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', '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 07:21:14 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 07:21:14 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 07:21:14 INFO - Using env: {'DISPLAY': ':0', 07:21:14 INFO - 'HOME': '/home/cltbld', 07:21:14 INFO - 'LANG': 'en_US.UTF-8', 07:21:14 INFO - 'LANGUAGE': 'en_US:en', 07:21:14 INFO - 'LOGNAME': 'cltbld', 07:21:14 INFO - 'MAIL': '/var/mail/cltbld', 07:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:14 INFO - 'MOZ_NO_REMOTE': '1', 07:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:14 INFO - 'NO_EM_RESTART': '1', 07:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:14 INFO - 'PWD': '/builds/slave/test', 07:21:14 INFO - 'SHELL': '/bin/bash', 07:21:14 INFO - 'SHLVL': '1', 07:21:14 INFO - 'TERM': 'linux', 07:21:14 INFO - 'TMOUT': '86400', 07:21:14 INFO - 'USER': 'cltbld', 07:21:14 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:14 INFO - '_': '/tools/buildbot/bin/python'} 07:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:21:14 INFO - Running setup.py (path:/tmp/pip-Bw8Nwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:21:15 INFO - Running setup.py (path:/tmp/pip-Ri_eYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:21:15 INFO - Running setup.py (path:/tmp/pip-L9eoBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:21:15 INFO - Running setup.py (path:/tmp/pip-NgLZ7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:21:15 INFO - Running setup.py (path:/tmp/pip-V96mB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:21:15 INFO - Running setup.py (path:/tmp/pip-51xu7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:21:15 INFO - Running setup.py (path:/tmp/pip-wa4sPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:21:15 INFO - Running setup.py (path:/tmp/pip-KUKuKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:21:15 INFO - Running setup.py (path:/tmp/pip-JSL6dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:21:15 INFO - Running setup.py (path:/tmp/pip-vLokVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:21:15 INFO - Running setup.py (path:/tmp/pip-mpiBv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:21:15 INFO - Running setup.py (path:/tmp/pip-QXia0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:21:15 INFO - Running setup.py (path:/tmp/pip-bT1NRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:21:15 INFO - Running setup.py (path:/tmp/pip-6v3kLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:21:15 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)) 07:21:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:21:15 INFO - Running setup.py (path:/tmp/pip-d1k6uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:21:16 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)) 07:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:21:16 INFO - Running setup.py (path:/tmp/pip-fuJo9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:21:16 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)) 07:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:21:16 INFO - Running setup.py (path:/tmp/pip-q3KrqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:21:16 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)) 07:21:16 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)) 07:21:16 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)) 07:21:16 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)) 07:21:16 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)) 07:21:16 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)) 07:21:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:21:16 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 07:21:16 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 07:21:16 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 07:21:16 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 07:21:16 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 07:21:16 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 07:21:18 INFO - Downloading blessings-1.6.tar.gz 07:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:21:18 INFO - Installing collected packages: blessings 07:21:18 INFO - Running setup.py install for blessings 07:21:18 INFO - Successfully installed blessings 07:21:18 INFO - Cleaning up... 07:21:18 INFO - Return code: 0 07:21:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:21:18 INFO - Reading from file tmpfile_stdout 07:21:18 INFO - Current package versions: 07:21:18 INFO - argparse == 1.2.1 07:21:18 INFO - blessings == 1.6 07:21:18 INFO - blobuploader == 1.2.4 07:21:18 INFO - docopt == 0.6.1 07:21:18 INFO - functools32 == 3.2.3-2 07:21:18 INFO - jsonschema == 2.5.1 07:21:18 INFO - manifestparser == 1.1 07:21:18 INFO - mozInstall == 1.12 07:21:18 INFO - mozcrash == 0.17 07:21:18 INFO - mozdebug == 0.1 07:21:18 INFO - mozdevice == 0.48 07:21:18 INFO - mozfile == 1.2 07:21:18 INFO - mozhttpd == 0.7 07:21:18 INFO - mozinfo == 0.9 07:21:18 INFO - mozleak == 0.1 07:21:18 INFO - mozlog == 3.3 07:21:18 INFO - moznetwork == 0.27 07:21:18 INFO - mozprocess == 0.23 07:21:18 INFO - mozprofile == 0.28 07:21:18 INFO - mozrunner == 6.12 07:21:18 INFO - mozscreenshot == 0.1 07:21:18 INFO - mozsystemmonitor == 0.3 07:21:18 INFO - moztest == 0.7 07:21:18 INFO - mozversion == 1.4 07:21:18 INFO - psutil == 3.1.1 07:21:18 INFO - requests == 1.2.3 07:21:18 INFO - wsgiref == 0.1.2 07:21:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:18 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 0x1d2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', '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 07:21:18 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 07:21:18 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 07:21:18 INFO - Using env: {'DISPLAY': ':0', 07:21:18 INFO - 'HOME': '/home/cltbld', 07:21:18 INFO - 'LANG': 'en_US.UTF-8', 07:21:18 INFO - 'LANGUAGE': 'en_US:en', 07:21:18 INFO - 'LOGNAME': 'cltbld', 07:21:18 INFO - 'MAIL': '/var/mail/cltbld', 07:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:18 INFO - 'MOZ_NO_REMOTE': '1', 07:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:18 INFO - 'NO_EM_RESTART': '1', 07:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:18 INFO - 'PWD': '/builds/slave/test', 07:21:18 INFO - 'SHELL': '/bin/bash', 07:21:18 INFO - 'SHLVL': '1', 07:21:18 INFO - 'TERM': 'linux', 07:21:18 INFO - 'TMOUT': '86400', 07:21:18 INFO - 'USER': 'cltbld', 07:21:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:18 INFO - '_': '/tools/buildbot/bin/python'} 07:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:18 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)) 07:21:18 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)) 07:21:18 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)) 07:21:18 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)) 07:21:18 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)) 07:21:18 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)) 07:21:18 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)) 07:21:18 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)) 07:21:18 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)) 07:21:18 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)) 07:21:18 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)) 07:21:18 INFO - Cleaning up... 07:21:18 INFO - Return code: 0 07:21:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:21: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')]} 07:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21: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')]} 07:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:21:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, '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': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', '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 07:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:21:18 INFO - Using env: {'DISPLAY': ':0', 07:21:18 INFO - 'HOME': '/home/cltbld', 07:21:18 INFO - 'LANG': 'en_US.UTF-8', 07:21:18 INFO - 'LANGUAGE': 'en_US:en', 07:21:18 INFO - 'LOGNAME': 'cltbld', 07:21:18 INFO - 'MAIL': '/var/mail/cltbld', 07:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:18 INFO - 'MOZ_NO_REMOTE': '1', 07:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:18 INFO - 'NO_EM_RESTART': '1', 07:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:18 INFO - 'PWD': '/builds/slave/test', 07:21:18 INFO - 'SHELL': '/bin/bash', 07:21:18 INFO - 'SHLVL': '1', 07:21:18 INFO - 'TERM': 'linux', 07:21:18 INFO - 'TMOUT': '86400', 07:21:18 INFO - 'USER': 'cltbld', 07:21:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:18 INFO - '_': '/tools/buildbot/bin/python'} 07:21:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:21:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:21:19 INFO - Cleaning up... 07:21:19 INFO - Return code: 0 07:21:19 INFO - Running post-action listener: _resource_record_post_action 07:21:19 INFO - Running post-action listener: _start_resource_monitoring 07:21:19 INFO - Starting resource monitoring. 07:21:19 INFO - [mozharness: 2016-08-01 14:21:19.062987Z] Finished create-virtualenv step (success) 07:21:19 INFO - [mozharness: 2016-08-01 14:21:19.063568Z] Running install step. 07:21:19 INFO - Running pre-action listener: _resource_record_pre_action 07:21:19 INFO - Running main action method: install 07:21:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:21:19 INFO - Reading from file tmpfile_stdout 07:21:19 INFO - Detecting whether we're running mozinstall >=1.0... 07:21:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:21:19 INFO - Reading from file tmpfile_stdout 07:21:19 INFO - Output received: 07:21:19 INFO - Usage: mozinstall [options] installer 07:21:19 INFO - Options: 07:21:19 INFO - -h, --help show this help message and exit 07:21:19 INFO - -d DEST, --destination=DEST 07:21:19 INFO - Directory to install application into. [default: 07:21:19 INFO - "/builds/slave/test"] 07:21:19 INFO - --app=APP Application being installed. [default: firefox] 07:21:19 INFO - mkdir: /builds/slave/test/build/application 07:21:19 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'] 07:21:19 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 07:21:36 INFO - Reading from file tmpfile_stdout 07:21:36 INFO - Output received: 07:21:36 INFO - /builds/slave/test/build/application/firefox/firefox 07:21:36 INFO - Running post-action listener: _resource_record_post_action 07:21:36 INFO - [mozharness: 2016-08-01 14:21:36.248467Z] Finished install step (success) 07:21:36 INFO - [mozharness: 2016-08-01 14:21:36.248806Z] Running run-tests step. 07:21:36 INFO - Running pre-action listener: _resource_record_pre_action 07:21:36 INFO - Running main action method: run_tests 07:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:21:36 INFO - Python 2.7.3 07:21:36 INFO - Return code: 0 07:21:36 INFO - grabbing minidump binary from tooltool 07:21: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')]} 07:21:36 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 0x1fe9570>, '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 0x1fea470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fea900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:21:36 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 07:21:36 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 07:21:36 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 07:21:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:21:36 INFO - Return code: 0 07:21:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:21:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:21:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:21:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:21:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:21:36 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:21:36 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:21:36 INFO - Using env: {'DISPLAY': ':0', 07:21:36 INFO - 'HOME': '/home/cltbld', 07:21:36 INFO - 'LANG': 'en_US.UTF-8', 07:21:36 INFO - 'LANGUAGE': 'en_US:en', 07:21:36 INFO - 'LOGNAME': 'cltbld', 07:21:36 INFO - 'MAIL': '/var/mail/cltbld', 07:21:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:21:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:21:36 INFO - 'MOZ_NO_REMOTE': '1', 07:21:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:21:36 INFO - 'NO_EM_RESTART': '1', 07:21:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:21:36 INFO - 'PWD': '/builds/slave/test', 07:21:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:21:36 INFO - 'SHELL': '/bin/bash', 07:21:36 INFO - 'SHLVL': '1', 07:21:36 INFO - 'TERM': 'linux', 07:21:36 INFO - 'TMOUT': '86400', 07:21:36 INFO - 'USER': 'cltbld', 07:21:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975', 07:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:21:36 INFO - '_': '/tools/buildbot/bin/python'} 07:21:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:21:36 INFO - mozversion application_buildid: 20160801043002 07:21:36 INFO - mozversion application_changeset: c0c16cea7afa66c59d18a6b88cfc95274599a1c7 07:21:36 INFO - mozversion application_display_name: Nightly 07:21:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:21:36 INFO - mozversion application_name: Firefox 07:21:36 INFO - mozversion application_remotingname: firefox 07:21:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:21:36 INFO - mozversion application_vendor: Mozilla 07:21:36 INFO - mozversion application_version: 50.0a1 07:21:36 INFO - mozversion platform_buildid: 20160801043002 07:21:36 INFO - mozversion platform_changeset: c0c16cea7afa66c59d18a6b88cfc95274599a1c7 07:21:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:21:36 INFO - mozversion platform_version: 50.0a1 07:21:36 INFO - using testdate: 1470061296 07:21:36 INFO - actual date: 1470061296 07:21:36 INFO - starting webserver on 'localhost:37027' 07:21:36 INFO - SUITE-START | Running 2 tests 07:21:36 INFO - TEST-START | dromaeo_css 07:21:36 INFO - operating with platform_type : linux_ 07:21:36 INFO - Initialising browser for dromaeo_css test... 07:21:36 INFO - TEST-INFO | started process 23426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkCJHRJ/profile http://localhost:37027/getInfo.html) 07:21:41 INFO - PROCESS | 23426 | __metrics Screen width/height:1600/1200 07:21:41 INFO - PROCESS | 23426 | colorDepth:24 07:21:41 INFO - PROCESS | 23426 | Browser inner width/height: 1024/697 07:21:41 INFO - PROCESS | 23426 | __metrics 07:21:41 ERROR - PROCESS | 23426 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:21:42 INFO - TEST-INFO | 23426: exit 0 07:21:42 INFO - Browser initialized. 07:21:42 INFO - Running cycle 1/1 for dromaeo_css test... 07:21:42 INFO - TEST-INFO | started process 23544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkCJHRJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:21:54 INFO - PROCESS | 23544 | RSS: Main: 163127296 07:21:54 INFO - PROCESS | 23544 | 07:22:44 INFO - PROCESS | 23544 | 1470061364203 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] 07:24:52 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37027/tests/dromaeo/cssquery-ext.html) 07:24:53 INFO - PROCESS | 23544 | RSS: Main: 168853504 07:24:53 INFO - PROCESS | 23544 | 07:27:55 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-ext.html (next: http://localhost:37027/tests/dromaeo/cssquery-jquery.html) 07:27:56 INFO - PROCESS | 23544 | RSS: Main: 166813696 07:27:56 INFO - PROCESS | 23544 | 07:30:58 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37027/tests/dromaeo/cssquery-mootools.html) 07:30:58 INFO - PROCESS | 23544 | RSS: Main: 169000960 07:30:58 INFO - PROCESS | 23544 | 07:34:00 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37027/tests/dromaeo/cssquery-prototype.html) 07:34:01 INFO - PROCESS | 23544 | RSS: Main: 163717120 07:34:01 INFO - PROCESS | 23544 | 07:37:03 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37027/tests/dromaeo/cssquery-yui.html) 07:37:04 INFO - PROCESS | 23544 | RSS: Main: 166158336 07:37:04 INFO - PROCESS | 23544 | 07:40:06 INFO - PROCESS | 23544 | Cycle 1(1): loaded http://localhost:37027/tests/dromaeo/cssquery-yui.html (next: http://localhost:37027/tests/dromaeo/cssquery-dojo.html) 07:40:07 INFO - PROCESS | 23544 | RSS: Main: 169844736 07:40:07 INFO - PROCESS | 23544 | 07:40:07 INFO - PROCESS | 23544 | __start_tp_report 07:40:07 INFO - PROCESS | 23544 | _x_x_mozilla_page_load 07:40:07 INFO - PROCESS | 23544 | _x_x_mozilla_page_load_details 07:40:07 INFO - PROCESS | 23544 | |i|pagename|runs| 07:40:07 INFO - PROCESS | 23544 | |0;dojo.html;3075.2773098321895;3094.7214750672447;3100.3334283129125;3127.296358319377;3135.8710864088926;5385.272988146608;5445.373782015069;5489.533389661873;5529.032419326617;5543.889122217553;5395.973020134894;5418.349798024233;5430.75561599728;5449.291592093023;5518.972405137979;4871.829485967983;4923.852284431473;4927.679700819435;4969.180085285923;4977.7262250576205;4945.307656928033;4978.751062446881;5082.822101226458;5098.311727916721;5146.5110814472755;4904.926426103611;4922.089413458521;4976.452590215092;4978.452370239271;5017.473165317626;4868.537488938545;4869.074875773592;4884.389451318585;4913.950860491385;4962.578180854632;4895.657303988723;4899.240617704261;4902.2156454967035;4904.068227036852;4953.702777833306;5296.788128474856;5334.146536554172;5334.946650533484;5343.759530821122;5383.2732581101445;5728.799492017801;5749.252597162384;5775.537956963475;5812.3025236971835;5813.505852002585;5785;5789.9710501447225;5790.855228619276;5802.245708057925;5802.245708057968;5359.651622644516;5368.892622147574;5390.568754499631;5398.4871437213405;5415.323084614423;5890.087036509348;5977.910331345033;5987.461128498369;6016.578839481194;6059.60612560191;5748.597598168171;5750.856228594235;5753.108268218432;5757.337906140848;5761.423857614205;5600.467955544217;5739.368669446358;5831.2127862738835;5838.416158384128;5840.737166827503;5593.440655934374;5732.799352022743;5736.225609542742;5767.769289228384;5783.450572195635;5574.665520068809;5637.68992705397;5680.318361796611;5737.282839645044;5763.164341170507;4432.822687092545;4437.334399839985;4441.267190913528;4444.28891377378;4467.039586488855;3880.9223815523533;3914.0606254498716;3919.8824035278985;3949.3681011038097;3997.8400863965117;5472.7263636818;5513.255710479114;5533;5539.778408863681;5545.584081193927;5842.328132264844;5851.561132915049;5853.414658534198;5858.619189752738;5899.498542623839;5399.676019438846;5482.424345443751;5508.586855985817;5511.724413779295;5613.971930140323;4981.701097934136;5006.749662516932;5022.59819214462;5023.2214006829;5059.97470012655;6065.5450841187085;6070.757169713251;6082.60463069899;6088.178095956989;6090.3605121461605;5613.915791263053;5792.247007888947;5807.709614519173;5856.824295271149;5944.375840536682;6019.337872834072;6074.088886667036;6075.605085669417;6088.299845517822;6106.69466526663;5757.798477053283;5759;5761.711914404347;5787.276590426197;5788.27646544182;5626.915596266142;5832.650040997384;5870.002099642986;5889;5984.1921340618455;5737.741801618854;5749.91375129365;5764.6829424380385;5769.134629805562;5774.855628609318;5732.856678582902;5746.42535746422;5756.740946657326;5760.913586296125;5767.5674324425;5479.835604931858;5515.834524964257;5592.245046918777;5601.187827764869;5617.5505959522325;5550.27846379968;5637.8590535236945;5646.040173170653;5706.42935706426;5731.140328950691;5462.934727728055;5467.535259502987;5473.917891231555;5552.722363881709;5556.805511807229 07:40:07 INFO - PROCESS | 23544 | |1;ext.html;552.5717568884114;596.1683451585037;603.3574243430743;619.944205021548;648.4552975500578;43009.35485967713;43647.56352436475;43724.72064595156;43904.3414348785;43991.56008439915;44704.55295447045;44820.551794482126;44876;45570.316445253266;45592.632221033426;8880.467171969687;8972.192502674758;8983.371164018521;9002.819943601124;9011.414258073204;8705.129487051308;8818.514981676006;8888.333374996868;8889.822203555925;8891.288696904265;8915;8950.820983580325;8976.147266009752;8986.955065224665;8997.865032024492;8848.424852384607;8861.202491775739;8922.86615700765;8927.151920567536;8938.64245430182;8786.604602792826;8856.690015849414;8872.157145071207;8893.644254229823;8901.243394311492;42031.579684203076;42207.36688949668;42474;42481;42849;3461.653834616518;3609.2240168363664;3795.886123416274;4048.8987775305854;4132.152908653718;33837;33987;34110.31779364424;34304.14239644004;34346.31307373864;4371.934420983688;4383.211022016036;4491.056878055612;4543.977280113611;4579.404677391951;260371;260931;263021;264417;264574.6771266151;34109.658903411146;60920.47698807476;61097.38902611006;61222.38777612256;61300;35791.64208357883;37587;37606;37626.24747505089;37686;12473.688157796129;12551.372431378395;12620.053495987653;12630.305333206761;12636.494540218473;10322.48387580618;10337.328073675188;10372.585096596202;10377.117944974761;10377.533011014522;8324.875126873101;8399.62201700925;8447.619857106445;8480.660773568989;8488.702895398632;3231.6768323167494;3245.5780748502543;3274.809427058092;3294.0447270291825;3304.8182349970502;1052.4007893005937;1078.2721662877527;1104.9558017679203;1109.778044391125;1194.4147367789722;32328;32382.83808580942;33988;33988.18765944879;34792.82603586966;1093.5024563823442;1099.3074363151163;1113.716002419394;1134.075728281448;1153.6769704482758;17560.473185804447;17608.207630656652;17731.645367092588;17879.73180402295;17940.91029544844;74526;74646.62676686581;74824;75419.62290188514;75740;61888.071678924854;62334.37665623376;62534.0619890702;62541;62649.06026409607;1350.8851747601368;1354.9187048777105;1364.5428781358355;1371.4788380415378;1384.8892088632886;31004;31217.53173702351;31335.529967050057;31965.442764578314;32586.34827303488;55169.724151378985;55294;55405;55476.16785748136;55715;446950;449604.75988100556;449828;450145;450325;28915.421691566473;29080.7091929078;29337.853310734165;29384.706152938197;29488.262793430335;50364.74817626035;50496.24255636095;51180.48819511906;51537.22694159666;51577.22634160566;41610.79194604007;43380;43763.343549847414;44158.11683766371;44643.776781115885;42928.78535607302;43403;43653.34519982267;44358.778206108764;45366.77316613396;43212.567874320855;43683.56316436795;44024.55975440333;44429.555704442544;45139.54860451353;34940.65059349374;36752;37790.244195116495;40405.79797100995;40576.59423405728;29729.904143522035;30017;30153.396932060798;30560.694393055786;30705.38589228158 07:40:07 INFO - PROCESS | 23544 | |2;jquery.html;375.14467015205344;378.5117198813531;400.75353657500636;401.74689945334444;419.35210100394886;18258.634827303445;19650.347203127574;19690.507737306576;19724.91512966788;20082.196712131532;19166.137523811427;19361.322353717624;19582.804171958276;19600.80399196011;19654.606907861835;5726.141078838176;5855.61938474;5888.764449422018;5890.234269544953;5963.761449542013;5732.111522713965;5928.436798504157;5934.495567876736;5936.198613187207;5949.910751338712;5765.7981970631035;5821.50517206038;5843.766249350021;5896.469317761401;5911.822645320647;5839.795607153729;5848.619839710426;5873.089671100986;5892.086726557412;5906.645601263916;5102.617303702237;5169.819056333048;5224.39919409269;5229.581633469352;5243.292155559027;23128.306150815504;23315.883420582788;23459.178928737412;23532.411689707722;23607.40981475477;2271.8636881787147;2568.4349443122483;2952.247176969859;3182.2203560127687;3199.568058312145;14372.137671739729;14481.203533805636;14498.05762625426;14712.485063022743;15132.848671513255;1946.2993322403922;1995.2218634732467;2023.5244717491378;2057.362217712514;2066.183857376343;77823.22176778216;78483.21516784816;78491;79146.20853791446;80179;10265.332753371007;10327.535260913277;10407.721567706149;10736.731581710363;10816.67549973502;14603.707925841423;14626.707465850623;14675.77986330206;14699.853001470063;14746.926265368818;7359.632018399058;7544.509606875536;7616.80957976055;7766.456348055694;7811.140774514913;7044.471664625174;7086.18508871476;7128.28717128283;7391.2978267064545;7396.482246242711;6382.20222472191;6431.6462594556815;6496.545241833121;6569.704363303663;6587.242467116343;1946.3382449966796;1973.3685220729228;1987.7614686237744;1989.3733473955947;2002.0390212697987;990.1237404896718;1001.3090967232587;1011.4335971855784;1024.8411496218098;1083.030687534652;19513.31703390403;20107.698384524243;20147.194112235346;20251.696224556643;20312.593748124953;1017.6336518853207;1033.788073444957;1035.1977217656377;1054.7204990677476;1116.771061932302;10707.625233116803;11458.083353331713;11460.426978651034;11519.942400287944;11621.186516943902;495706.6931988069;501746;507206;509912;541797;77292;78798.21201788023;79256.20743792603;79788;81338;1027.2347101409348;1069.9411532365796;1099.769048499824;1108.5953626926114;1109.2180013090751;17013.57466063358;17675.292988280326;17679.116044197483;17764.401552084266;18075;36834.71078512239;37241.25517489689;37386.43920341251;37599.248015040095;38413.61586384212;48159.75920120377;49468.75265623649;49955.50044499509;50153.24770128378;50293;7211.747588834365;7447.143578488543;7497.887531687138;7555.773326799985;7561.852148860918;11721.062315014608;11827.231229970024;11920.846297448663;11969.401529923294;12371;10225.693229203136;10377.9481102594;10423;10795.676129716121;11424.82862757076;10070.647527336509;10461.581536738446;10475.476226188812;10522;10675.679729608124;9921.40471571708;10074.597016119273;11009.779804404026;11012.889871101186;11301.378424186749;8071.596420179085;8274.089850116363;8336.62485188156;8360.958195208985;8407.579621019047;9382.437053776795;9776;10151.187904967437;10562.419066951392;10599.470026498799 07:40:07 INFO - PROCESS | 23544 | |3;mootools.html;1382.115446114487;1508.992455037725;1659.3362654938023;1792.9282828686862;1816.5004623728482;8038.9196108038905;8682;8827.249683776887;9376.109269619392;9380;8878.067802880685;9225.861612075807;9263.166315031645;9294.209992150658;9324.347295689304;2428.0530593068715;2478.1698131126095;2484.1553871683623;2490.5018996200743;2492.289697436222;2423.236680445663;2474.8391354561895;2495.8252922295446;2498.9375265618414;2503.9749602504016;2457;2460.225029115823;2495.3512086857368;2497.787688046509;2501.9374515637073;2433.926982190546;2438.987805060981;2444.523317953;2445.3275349279093;2461.1509029384833;2361.2089949866813;2364.3143488388346;2372.0630351011255;2372.2171683344454;2414.4446777241333;9271.675491357837;9291.396059256194;9317.767055823591;9382.906170938271;9387;5466.644668096561;5571.498565129117;5571.749271282802;5601.579881508903;5618.4662457066515;3469.3581687387914;3596.280743851214;3653.8903832885057;3669.94495082574;3678.337899178147;1117.67587399654;1127.385574861694;1131.264677959333;1182.24927171246;1199.4542483170137;13190.34048297591;13228.669283267898;13234;13273.137246078973;13279.53521626748;4743.739094349844;4802.423709154924;4836.975815120902;4889.437714662859;5020.648554601143;10997.230193886351;11019.283746556448;11020.118390528738;11021.889781102247;11034.282771619979;5477.178423236467;5533.612647114664;5568.9443105568425;5592.245046918695;5598.3282006159525;4465.799039043251;4924.975375123173;5018.222175562793;5047.798088076509;5108.948910510921;4171.8957026074595;4177.206330797138;4279.507856596531;4291.527931927485;4359.782010899442;1309.2471828698347;1318.6176008957295;1320.8018797180307;1323.9602811915659;1339.799030145486;858.3176374782063;993.438707130469;993.6770549571419;993.7018894331671;1013.229945241607;5977.193078934288;6075.179850720185;6096.664683442454;6179.721912513947;6220.315765265817;443.7027191781514;449.22060225508716;453.7657571405771;457.0584595732801;458.62392837872625;4296.935545966813;4405.3612226227015;4464.718431952512;4481.327800829901;4588.2888152336445;10933.343999360064;11138.554457821596;11578.536858525733;11599.594014209462;11651.825222621668;11491.42542872853;11509.424528773528;11532.25040372373;11565.537378504934;11619.76760464786;8056.194380562014;8433.536155511383;8447.155284471504;8478.703245386381;8683.175098365646;6359.236891573041;6441.516886233645;6490.286068532363;6633.9668301658185;6654.966725166343;10531.842022369823;10538.525766340686;10688.786224275316;10713.517891695048;10939.343639381663;10652.307600005975;10853.782924341627;10872.728181795203;10949.671509854717;11045.889541104487;7867.331276841533;8464.238218560113;8715.08491608372;8791.384603077724;9008.41445306053;8682.088380720186;8707.956460217913;8708.956455217936;8805.823883522422;8829.735107946515;8136.552489612891;8177;8261.545614990993;8328.750137495885;8484.787880303042;7891.289783919475;8031.879521807295;8060.395470339865;8114.229148230908;8223.301019413417;7493.850122997401;7504.6247687614305;7631.084269887649;7632.542047477169;7743.032120984877;5344.518993290622;5426.620136590559;5446.700431476307;5498.092814685532;5514.503694667499;5345.78616855337;5352.330958630171;5385.838424847104;5465.344158700981;5469.75386107634 07:40:07 INFO - PROCESS | 23544 | |4;prototype.html;328.2152069770298;339.64846383992557;340.9846556904939;345.94464885618305;348.1609321535101;5443.482869127427;5482.136073734934;5530.529904958078;5547.944520554794;5564.8330550083565;5455.372632147304;5459.945400545993;5512.4211957744465;5514.92458970501;5517;4289.721168124062;4306.655467562603;4311.396404503372;4313.460817397825;4333.674974376919;3860.2279544091152;4234.9364759528635;4237.936430953539;4258.53156152823;4258.9148217035645;4208.494980602317;4222.556631553689;4232.788360581974;4248.341507066394;4252.596003379689;4227.344761561947;4251.277282861921;4261.169072030955;4265.637420819249;4287.142571485715;3539.50446937429;3680.4663323818163;3715.826241648612;3740.1023754299044;3838.8848334550007;5273.841784746463;5275.815346462894;5292.894142117136;5300.628955973083;5310.548603368718;4839.395075615548;4862.3922009748785;4869.853904382874;4896.975515122402;4917.532834380764;5522.171674248854;5679.886402271932;5692.715364231772;5702.374823175375;5758.107493338539;4079.8164082616354;4086.795660217007;4091.713580049398;4092.202020605983;4107.363358679409;5896.852578685524;5925.081612350093;5934.43622855828;5957.165996760414;6000.96999515004;4095.3856921461424;4191.8742437726305;4198.64311533517;4215.114825886537;4234.941264683829;4236.809343579546;4269.719084274705;4276.2089013532595;4279.079997800425;4279.443672322641;4830.6135509159885;4867.9269810952865;4871.293662419001;4887.535684110004;4912.5333093356785;5484.232207490954;5700.828975130753;5708.514776244066;5740.6268592541355;5770.826875193751;1444.4655477473402;1464.9633759156106;1470.9485168019069;1472.2417954753312;1482.2514630111941;910.4537277633367;943.5188054092463;945.8723072385139;964.2093483343591;967.7193613852045;4852.878678033077;4855.708657480492;4981.327520784647;5386.272853164851;5553.389127196006;5865.912011319833;5919.585629005928;5927.288725352985;5988.3113441953865;5995.850103747442;5568.888622227532;5578.721063946787;5587.184165146344;5587.38538760736;5595.18869763882;3044.6955304469375;3126.4372412965886;3128.593282873212;3138.7489000879873;3139.6232452105437;6097.829128852972;6102.450779429784;6109.930762116612;6132.50939924805;6160.568760186744;5818.970905145447;5986.467983889526;6027.638341699512;6040.637561746309;6048.879022419527;6107.755689772359;6116.3577824328695;6184.907226391608;6191.938080619136;6199.442050215412;5676.602637815478;5845;5868.853278668067;5930.169776231245;5932.406759324205;5786.61121330886;5787.971060144672;5788.855278618068;5795.043817770021;5812.244408226903;6063.969680151571;6102.206713127265;6108.297545782292;6126.835901178762;6139.3553676863285;3997.6402123809;4057.5739547347102;4069.9796501017304;4129.359949207877;4203.55862634419;5840.970795145997;5844.94155058461;5850.53195744348;5853.400158902329;5862.794802181903;5682.261306030189;5692.203091567267;5726.5418766499415;5726.768744719905;5781.913271300849;5547.44525547442;5669.376368599368;5689.943100568941;5690.914636280542;5714.514266287412;5609.158626206102;5644.717764111696;5665.858353541194;5682.886342273048;5693.743781529924;5191.352410270713;5763.221965034667;5790.826275211751;5791.82624521265;5845.473907348359;5559.694216817952;5567.359753628384;5572;5574.219609254788;5592.468715472024 07:40:07 INFO - PROCESS | 23544 | |5;yui.html;750.2347605442449;755.5126943121687;779.9844003119941;807.1686163251849;859.2524503681798;14563.854361456382;15386.923065384657;15398.230088495586;15404.152771597557;15620.76568851468;15023.098614083163;15081.62295942602;15255.160966146857;15271.312790924407;15278.923605381957;674.4334758802605;798.1978111997435;805.6092794994423;823.1850468036661;837.6146972392676;814.5031530766228;816.4162623724036;818.5784321074622;819.5246756880995;819.7868554175898;875.8598624220126;877.6533269358599;882.6072397782989;883.0860059838069;886.0696268917643;871.6077765005741;879.5030807593753;880.7798050487378;881.1496905486205;882.7704796752827;642.3095172689377;642.5149012495536;643.0482885329739;643.4434214404506;645.3804347826093;15091.622709432242;15105.47130850426;15116.244187790566;15169.848301517064;15283.847161528354;14987.625309367244;15193.164375959317;15448;16073.196340183062;16198.514044578682;13516.256605886672;14239.50161744334;14262.857371426257;14387.640308992255;14542.200178990151;4802.471728109905;4814.325994360793;4818.759062046884;4832.565069143759;4834.685745426536;81775;82304;83258.58370708108;84687.5765621174;86106.56946715289;12437.93781031089;12474.937625311997;12491.375431228402;12542.24746515212;12606.180598261084;23134.537309254058;23292.534149316918;23342.066317347115;23428;23633.52732945366;9092.59083341238;9198.908010919939;9515.809683806423;9529.714108576754;9542.761430964281;4925.40895092584;5131.281620573122;5252.711100889488;5255.605829562722;5271.341082364705;3871.457995880579;4039.525573165832;4056.9391459128137;4070.2876996526084;4089.97955010229;705.0411440440996;711.4770643576967;713.4256923176893;722.0468980945102;726.8037629839913;744.1962680305257;753.7512620835112;763.4541302968404;813.4631143445298;819.2135549872189;10587.629432969808;10720.693779904183;10730.946345268223;11179.720506987227;11567.88432115685;621.8787336469436;659.7591878964143;674.8144260328351;759.8062494063978;770.2413123073768;5169.147090730063;5204.219367094966;5376.220448035013;5409.350877894678;5419.83740487786;127360.36319818342;128174;133157;134720;135688;113729;117429;118482.99999999828;119096.40451797686;120801.39599302123;100028;102536.48731756293;104045.47977260065;105231;106702;9778.65774697882;9902.900970990198;9937.304388693012;10002.699919002442;10120.746981325527;45669.314960274955;53513.464865352405;57536.42463575311;57962.7101864488;59306.703466482395;50073.74963125161;60431;66193.66903165646;76029;77311.61344193244;13552.661183470098;13558.525451609541;13589.52436664712;13893;14129.222892740998;14047;14448;14632.780508292597;15932.442364517186;16781.748273776146;14260.643483912985;14562.563123106323;14843.332050057988;15285;15472.458463953708;13844;14780.408783648534;14811.851881481047;14871.702565948404;15119.622009449851;13781.173129612256;13892.166470011427;13931.721365572834;14191.64520886986;15699;12560.811587826372;12575.622731318075;12621;12683.80974285405;13742.587722368346;12618.369081545703;12813.871861281268;12940.547080852126;13100.541481048118;13282.203067815963 07:40:07 INFO - PROCESS | 23544 | __end_tp_report 07:40:07 INFO - PROCESS | 23544 | __start_cc_report 07:40:07 INFO - PROCESS | 23544 | _x_x_mozilla_cycle_collect,346 07:40:07 INFO - PROCESS | 23544 | __end_cc_report 07:40:07 INFO - PROCESS | 23544 | __startTimestamp1470062407085__endTimestamp 07:40:07 INFO - PROCESS | 23544 | 07:40:07 INFO - PROCESS | 23544 | ------- Summary: start ------- 07:40:07 INFO - PROCESS | 23544 | Number of tests: 6 07:40:07 INFO - PROCESS | 23544 | 07:40:07 INFO - PROCESS | 23544 | [#0] dojo.html Cycles:165 Average:5396.01 Median:5574.67 stddev:621.62 (11.2%) stddev-sans-first:596.27 07:40:07 INFO - PROCESS | 23544 | Values: 3075.3 3094.7 3100.3 3127.3 3135.9 5385.3 5445.4 5489.5 5529.0 5543.9 5396.0 5418.3 5430.8 5449.3 5519.0 4871.8 4923.9 4927.7 4969.2 4977.7 4945.3 4978.8 5082.8 5098.3 5146.5 4904.9 4922.1 4976.5 4978.5 5017.5 4868.5 4869.1 4884.4 4914.0 4962.6 4895.7 4899.2 4902.2 4904.1 4953.7 5296.8 5334.1 5334.9 5343.8 5383.3 5728.8 5749.3 5775.5 5812.3 5813.5 5785.0 5790.0 5790.9 5802.2 5802.2 5359.7 5368.9 5390.6 5398.5 5415.3 5890.1 5977.9 5987.5 6016.6 6059.6 5748.6 5750.9 5753.1 5757.3 5761.4 5600.5 5739.4 5831.2 5838.4 5840.7 5593.4 5732.8 5736.2 5767.8 5783.5 5574.7 5637.7 5680.3 5737.3 5763.2 4432.8 4437.3 4441.3 4444.3 4467.0 3880.9 3914.1 3919.9 3949.4 3997.8 5472.7 5513.3 5533.0 5539.8 5545.6 5842.3 5851.6 5853.4 5858.6 5899.5 5399.7 5482.4 5508.6 5511.7 5614.0 4981.7 5006.7 5022.6 5023.2 5060.0 6065.5 6070.8 6082.6 6088.2 6090.4 5613.9 5792.2 5807.7 5856.8 5944.4 6019.3 6074.1 6075.6 6088.3 6106.7 5757.8 5759.0 5761.7 5787.3 5788.3 5626.9 5832.7 5870.0 5889.0 5984.2 5737.7 5749.9 5764.7 5769.1 5774.9 5732.9 5746.4 5756.7 5760.9 5767.6 5479.8 5515.8 5592.2 5601.2 5617.6 5550.3 5637.9 5646.0 5706.4 5731.1 5462.9 5467.5 5473.9 5552.7 5556.8 07:40:07 INFO - PROCESS | 23544 | 07:40:07 INFO - PROCESS | 23544 | [#1] ext.html Cycles:180 Average:44939.31 Median:43391.50 stddev:81391.00 (187.6%) stddev-sans-first:81551.09 07:40:07 INFO - PROCESS | 23544 | Values: 552.6 596.2 603.4 619.9 648.5 43009.4 43647.6 43724.7 43904.3 43991.6 44704.6 44820.6 44876.0 45570.3 45592.6 8880.5 8972.2 8983.4 9002.8 9011.4 8705.1 8818.5 8888.3 8889.8 8891.3 8915.0 8950.8 8976.1 8987.0 8997.9 8848.4 8861.2 8922.9 8927.2 8938.6 8786.6 8856.7 8872.2 8893.6 8901.2 42031.6 42207.4 42474.0 42481.0 42849.0 3461.7 3609.2 3795.9 4048.9 4132.2 33837.0 33987.0 34110.3 34304.1 34346.3 4371.9 4383.2 4491.1 4544.0 4579.4 260371.0 260931.0 263021.0 264417.0 264574.7 34109.7 60920.5 61097.4 61222.4 61300.0 35791.6 37587.0 37606.0 37626.2 37686.0 12473.7 12551.4 12620.1 12630.3 12636.5 10322.5 10337.3 10372.6 10377.1 10377.5 8324.9 8399.6 8447.6 8480.7 8488.7 3231.7 3245.6 3274.8 3294.0 3304.8 1052.4 1078.3 1105.0 1109.8 1194.4 32328.0 32382.8 33988.0 33988.2 34792.8 1093.5 1099.3 1113.7 1134.1 1153.7 17560.5 17608.2 17731.6 17879.7 17940.9 74526.0 74646.6 74824.0 75419.6 75740.0 61888.1 62334.4 62534.1 62541.0 62649.1 1350.9 1354.9 1364.5 1371.5 1384.9 31004.0 31217.5 31335.5 31965.4 32586.3 55169.7 55294.0 55405.0 55476.2 55715.0 446950.0 449604.8 449828.0 450145.0 450325.0 28915.4 29080.7 29337.9 29384.7 29488.3 50364.7 50496.2 51180.5 51537.2 51577.2 41610.8 43380.0 43763.3 44158.1 44643.8 42928.8 43403.0 43653.3 44358.8 45366.8 43212.6 43683.6 44024.6 44429.6 45139.5 34940.7 36752.0 37790.2 40405.8 40576.6 29729.9 30017.0 30153.4 30560.7 30705.4 07:40:07 INFO - PROCESS | 23544 | 07:40:07 INFO - PROCESS | 23544 | [#2] jquery.html Cycles:180 Average:28824.34 Median:23569.91 stddev:83874.59 (355.9%) stddev-sans-first:84082.68 07:40:07 INFO - PROCESS | 23544 | Values: 375.1 378.5 400.8 401.7 419.4 18258.6 19650.3 19690.5 19724.9 20082.2 19166.1 19361.3 19582.8 19600.8 19654.6 5726.1 5855.6 5888.8 5890.2 5963.8 5732.1 5928.4 5934.5 5936.2 5949.9 5765.8 5821.5 5843.8 5896.5 5911.8 5839.8 5848.6 5873.1 5892.1 5906.6 5102.6 5169.8 5224.4 5229.6 5243.3 23128.3 23315.9 23459.2 23532.4 23607.4 2271.9 2568.4 2952.2 3182.2 3199.6 14372.1 14481.2 14498.1 14712.5 15132.8 1946.3 1995.2 2023.5 2057.4 2066.2 77823.2 78483.2 78491.0 79146.2 80179.0 10265.3 10327.5 10407.7 10736.7 10816.7 14603.7 14626.7 14675.8 14699.9 14746.9 7359.6 7544.5 7616.8 7766.5 7811.1 7044.5 7086.2 7128.3 7391.3 7396.5 6382.2 6431.6 6496.5 6569.7 6587.2 1946.3 1973.4 1987.8 1989.4 2002.0 990.1 1001.3 1011.4 1024.8 1083.0 19513.3 20107.7 20147.2 20251.7 20312.6 1017.6 1033.8 1035.2 1054.7 1116.8 10707.6 11458.1 11460.4 11519.9 11621.2 495706.7 501746.0 507206.0 509912.0 541797.0 77292.0 78798.2 79256.2 79788.0 81338.0 1027.2 1069.9 1099.8 1108.6 1109.2 17013.6 17675.3 17679.1 17764.4 18075.0 36834.7 37241.3 37386.4 37599.2 38413.6 48159.8 49468.8 49955.5 50153.2 50293.0 7211.7 7447.1 7497.9 7555.8 7561.9 11721.1 11827.2 11920.8 11969.4 12371.0 10225.7 10377.9 10423.0 10795.7 11424.8 10070.6 10461.6 10475.5 10522.0 10675.7 9921.4 10074.6 11009.8 11012.9 11301.4 8071.6 8274.1 8336.6 8361.0 8407.6 9382.4 9776.0 10151.2 10562.4 10599.5 07:40:07 INFO - PROCESS | 23544 | 07:40:07 INFO - PROCESS | 23544 | [#3] mootools.html Cycles:180 Average:6118.88 Median:2523.46 stddev:3518.65 (139.4%) stddev-sans-first:3510.51 07:40:07 INFO - PROCESS | 23544 | Values: 1382.1 1509.0 1659.3 1792.9 1816.5 8038.9 8682.0 8827.2 9376.1 9380.0 8878.1 9225.9 9263.2 9294.2 9324.3 2428.1 2478.2 2484.2 2490.5 2492.3 2423.2 2474.8 2495.8 2498.9 2504.0 2457.0 2460.2 2495.4 2497.8 2501.9 2433.9 2439.0 2444.5 2445.3 2461.2 2361.2 2364.3 2372.1 2372.2 2414.4 9271.7 9291.4 9317.8 9382.9 9387.0 5466.6 5571.5 5571.7 5601.6 5618.5 3469.4 3596.3 3653.9 3669.9 3678.3 1117.7 1127.4 1131.3 1182.2 1199.5 13190.3 13228.7 13234.0 13273.1 13279.5 4743.7 4802.4 4837.0 4889.4 5020.6 10997.2 11019.3 11020.1 11021.9 11034.3 5477.2 5533.6 5568.9 5592.2 5598.3 4465.8 4925.0 5018.2 5047.8 5108.9 4171.9 4177.2 4279.5 4291.5 4359.8 1309.2 1318.6 1320.8 1324.0 1339.8 858.3 993.4 993.7 993.7 1013.2 5977.2 6075.2 6096.7 6179.7 6220.3 443.7 449.2 453.8 457.1 458.6 4296.9 4405.4 4464.7 4481.3 4588.3 10933.3 11138.6 11578.5 11599.6 11651.8 11491.4 11509.4 11532.3 11565.5 11619.8 8056.2 8433.5 8447.2 8478.7 8683.2 6359.2 6441.5 6490.3 6634.0 6655.0 10531.8 10538.5 10688.8 10713.5 10939.3 10652.3 10853.8 10872.7 10949.7 11045.9 7867.3 8464.2 8715.1 8791.4 9008.4 8682.1 8708.0 8709.0 8805.8 8829.7 8136.6 8177.0 8261.5 8328.8 8484.8 7891.3 8031.9 8060.4 8114.2 8223.3 7493.9 7504.6 7631.1 7632.5 7743.0 5344.5 5426.6 5446.7 5498.1 5514.5 5345.8 5352.3 5385.8 5465.3 5469.8 07:40:07 INFO - PROCESS | 23544 | 07:40:07 INFO - PROCESS | 23544 | [#4] prototype.html Cycles:180 Average:4814.92 Median:5547.69 stddev:1425.33 (25.7%) stddev-sans-first:1388.97 07:40:07 INFO - PROCESS | 23544 | Values: 328.2 339.6 341.0 345.9 348.2 5443.5 5482.1 5530.5 5547.9 5564.8 5455.4 5459.9 5512.4 5514.9 5517.0 4289.7 4306.7 4311.4 4313.5 4333.7 3860.2 4234.9 4237.9 4258.5 4258.9 4208.5 4222.6 4232.8 4248.3 4252.6 4227.3 4251.3 4261.2 4265.6 4287.1 3539.5 3680.5 3715.8 3740.1 3838.9 5273.8 5275.8 5292.9 5300.6 5310.5 4839.4 4862.4 4869.9 4897.0 4917.5 5522.2 5679.9 5692.7 5702.4 5758.1 4079.8 4086.8 4091.7 4092.2 4107.4 5896.9 5925.1 5934.4 5957.2 6001.0 4095.4 4191.9 4198.6 4215.1 4234.9 4236.8 4269.7 4276.2 4279.1 4279.4 4830.6 4867.9 4871.3 4887.5 4912.5 5484.2 5700.8 5708.5 5740.6 5770.8 1444.5 1465.0 1470.9 1472.2 1482.3 910.5 943.5 945.9 964.2 967.7 4852.9 4855.7 4981.3 5386.3 5553.4 5865.9 5919.6 5927.3 5988.3 5995.9 5568.9 5578.7 5587.2 5587.4 5595.2 3044.7 3126.4 3128.6 3138.7 3139.6 6097.8 6102.5 6109.9 6132.5 6160.6 5819.0 5986.5 6027.6 6040.6 6048.9 6107.8 6116.4 6184.9 6191.9 6199.4 5676.6 5845.0 5868.9 5930.2 5932.4 5786.6 5788.0 5788.9 5795.0 5812.2 6064.0 6102.2 6108.3 6126.8 6139.4 3997.6 4057.6 4070.0 4129.4 4203.6 5841.0 5844.9 5850.5 5853.4 5862.8 5682.3 5692.2 5726.5 5726.8 5781.9 5547.4 5669.4 5689.9 5690.9 5714.5 5609.2 5644.7 5665.9 5682.9 5693.7 5191.4 5763.2 5790.8 5791.8 5845.5 5559.7 5567.4 5572.0 5574.2 5592.5 07:40:07 INFO - PROCESS | 23544 | 07:40:07 INFO - PROCESS | 23544 | [#5] yui.html Cycles:180 Average:22897.15 Median:23530.76 stddev:33968.68 (144.4%) stddev-sans-first:34023.27 07:40:07 INFO - PROCESS | 23544 | Values: 750.2 755.5 780.0 807.2 859.3 14563.9 15386.9 15398.2 15404.2 15620.8 15023.1 15081.6 15255.2 15271.3 15278.9 674.4 798.2 805.6 823.2 837.6 814.5 816.4 818.6 819.5 819.8 875.9 877.7 882.6 883.1 886.1 871.6 879.5 880.8 881.1 882.8 642.3 642.5 643.0 643.4 645.4 15091.6 15105.5 15116.2 15169.8 15283.8 14987.6 15193.2 15448.0 16073.2 16198.5 13516.3 14239.5 14262.9 14387.6 14542.2 4802.5 4814.3 4818.8 4832.6 4834.7 81775.0 82304.0 83258.6 84687.6 86106.6 12437.9 12474.9 12491.4 12542.2 12606.2 23134.5 23292.5 23342.1 23428.0 23633.5 9092.6 9198.9 9515.8 9529.7 9542.8 4925.4 5131.3 5252.7 5255.6 5271.3 3871.5 4039.5 4056.9 4070.3 4090.0 705.0 711.5 713.4 722.0 726.8 744.2 753.8 763.5 813.5 819.2 10587.6 10720.7 10730.9 11179.7 11567.9 621.9 659.8 674.8 759.8 770.2 5169.1 5204.2 5376.2 5409.4 5419.8 127360.4 128174.0 133157.0 134720.0 135688.0 113729.0 117429.0 118483.0 119096.4 120801.4 100028.0 102536.5 104045.5 105231.0 106702.0 9778.7 9902.9 9937.3 10002.7 10120.7 45669.3 53513.5 57536.4 57962.7 59306.7 50073.7 60431.0 66193.7 76029.0 77311.6 13552.7 13558.5 13589.5 13893.0 14129.2 14047.0 14448.0 14632.8 15932.4 16781.7 14260.6 14562.6 14843.3 15285.0 15472.5 13844.0 14780.4 14811.9 14871.7 15119.6 13781.2 13892.2 13931.7 14191.6 15699.0 12560.8 12575.6 12621.0 12683.8 13742.6 12618.4 12813.9 12940.5 13100.5 13282.2 07:40:07 INFO - PROCESS | 23544 | -------- Summary: end -------- 07:40:07 INFO - PROCESS | 23544 | 07:40:07 INFO - TEST-INFO | 23544: exit 0 07:40:07 INFO - TEST-OK | dromaeo_css | took 1111294ms 07:40:07 INFO - TEST-START | kraken 07:40:07 INFO - operating with platform_type : linux_ 07:40:07 INFO - Initialising browser for kraken test... 07:40:07 INFO - TEST-INFO | started process 23794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcqATjo/profile http://localhost:37027/getInfo.html) 07:40:12 INFO - PROCESS | 23794 | __metrics Screen width/height:1600/1200 07:40:12 INFO - PROCESS | 23794 | colorDepth:24 07:40:12 INFO - PROCESS | 23794 | Browser inner width/height: 1024/697 07:40:12 INFO - PROCESS | 23794 | __metrics 07:40:13 ERROR - PROCESS | 23794 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:40:14 INFO - TEST-INFO | 23794: exit 0 07:40:14 INFO - Browser initialized. 07:40:14 INFO - Running cycle 1/1 for kraken test... 07:40:14 INFO - TEST-INFO | started process 23909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcqATjo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:40:25 INFO - PROCESS | 23909 | RSS: Main: 162680832 07:40:25 INFO - PROCESS | 23909 | 07:40:28 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-beat-detection) 07:40:29 INFO - PROCESS | 23909 | RSS: Main: 168554496 07:40:29 INFO - PROCESS | 23909 | 07:40:31 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-dft) 07:40:32 INFO - PROCESS | 23909 | RSS: Main: 167190528 07:40:32 INFO - PROCESS | 23909 | 07:40:35 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-fft) 07:40:36 INFO - PROCESS | 23909 | RSS: Main: 163205120 07:40:36 INFO - PROCESS | 23909 | 07:40:38 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37027/tests/kraken/driver.html?testName=audio-oscillator) 07:40:38 INFO - PROCESS | 23909 | RSS: Main: 164188160 07:40:38 INFO - PROCESS | 23909 | 07:40:40 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:40:41 INFO - PROCESS | 23909 | RSS: Main: 164909056 07:40:41 INFO - PROCESS | 23909 | 07:40:44 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37027/tests/kraken/driver.html?testName=imaging-darkroom) 07:40:45 INFO - PROCESS | 23909 | RSS: Main: 164110336 07:40:45 INFO - PROCESS | 23909 | 07:40:48 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37027/tests/kraken/driver.html?testName=imaging-desaturate) 07:40:49 INFO - PROCESS | 23909 | RSS: Main: 162459648 07:40:49 INFO - PROCESS | 23909 | 07:40:52 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37027/tests/kraken/driver.html?testName=json-parse-financial) 07:40:52 INFO - PROCESS | 23909 | RSS: Main: 164278272 07:40:52 INFO - PROCESS | 23909 | 07:40:54 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:40:55 INFO - PROCESS | 23909 | RSS: Main: 164286464 07:40:55 INFO - PROCESS | 23909 | 07:40:56 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:40:57 INFO - PROCESS | 23909 | RSS: Main: 164888576 07:40:57 INFO - PROCESS | 23909 | 07:40:59 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:41:00 INFO - PROCESS | 23909 | RSS: Main: 165228544 07:41:00 INFO - PROCESS | 23909 | 07:41:02 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:41:03 INFO - PROCESS | 23909 | RSS: Main: 165494784 07:41:03 INFO - PROCESS | 23909 | 07:41:06 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:41:06 INFO - PROCESS | 23909 | RSS: Main: 165756928 07:41:06 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | Cycle 1(1): loaded http://localhost:37027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37027/tests/kraken/driver.html?testName=ai-astar) 07:41:08 INFO - PROCESS | 23909 | RSS: Main: 166555648 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | __start_tp_report 07:41:08 INFO - PROCESS | 23909 | _x_x_mozilla_page_load 07:41:08 INFO - PROCESS | 23909 | _x_x_mozilla_page_load_details 07:41:08 INFO - PROCESS | 23909 | |i|pagename|runs| 07:41:08 INFO - PROCESS | 23909 | |0;ai-astar;102;115;109;113;115;112;113;112;112;111 07:41:08 INFO - PROCESS | 23909 | |1;audio-beat-detection;151;118;160;180;120;155;148;125;177;119 07:41:08 INFO - PROCESS | 23909 | |2;audio-dft;163;164;163;163;162;166;172;163;162;161 07:41:08 INFO - PROCESS | 23909 | |3;audio-fft;74;77;77;181;75;77;74;75;163;76 07:41:08 INFO - PROCESS | 23909 | |4;audio-oscillator;84;83;141;84;85;92;142;88;84;141 07:41:08 INFO - PROCESS | 23909 | |5;imaging-gaussian-blur;118;118;119;117;117;119;118;117;117;120 07:41:08 INFO - PROCESS | 23909 | |6;imaging-darkroom;148;148;148;147;147;148;147;148;148;148 07:41:08 INFO - PROCESS | 23909 | |7;imaging-desaturate;96;97;96;95;97;96;96;96;96;100 07:41:08 INFO - PROCESS | 23909 | |8;json-parse-financial;59;54;53;53;55;54;53;52;53;53 07:41:08 INFO - PROCESS | 23909 | |9;json-stringify-tinderbox;61;63;63;61;61;60;61;61;61;61 07:41:08 INFO - PROCESS | 23909 | |10;stanford-crypto-aes;78;77;77;77;77;76;83;77;82;77 07:41:08 INFO - PROCESS | 23909 | |11;stanford-crypto-ccm;122;131;125;121;126;125;127;121;167;141 07:41:08 INFO - PROCESS | 23909 | |12;stanford-crypto-pbkdf2;164;164;159;173;159;163;163;158;161;161 07:41:08 INFO - PROCESS | 23909 | |13;stanford-crypto-sha256-iterative;65;69;64;64;67;63;64;64;69;63 07:41:08 INFO - PROCESS | 23909 | __end_tp_report 07:41:08 INFO - PROCESS | 23909 | __start_cc_report 07:41:08 INFO - PROCESS | 23909 | _x_x_mozilla_cycle_collect,871 07:41:08 INFO - PROCESS | 23909 | __end_cc_report 07:41:08 INFO - PROCESS | 23909 | __startTimestamp1470062468797__endTimestamp 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | ------- Summary: start ------- 07:41:08 INFO - PROCESS | 23909 | Number of tests: 14 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.75 (3.3%) stddev-sans-first:1.88 07:41:08 INFO - PROCESS | 23909 | Values: 102.0 115.0 109.0 113.0 115.0 112.0 113.0 112.0 112.0 111.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:153.00 stddev:23.68 (15.5%) stddev-sans-first:25.03 07:41:08 INFO - PROCESS | 23909 | Values: 151.0 118.0 160.0 180.0 120.0 155.0 148.0 125.0 177.0 119.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.14 (1.9%) stddev-sans-first:3.32 07:41:08 INFO - PROCESS | 23909 | Values: 163.0 164.0 163.0 163.0 162.0 166.0 172.0 163.0 162.0 161.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.50 stddev:40.87 (54.1%) stddev-sans-first:42.65 07:41:08 INFO - PROCESS | 23909 | Values: 74.0 77.0 77.0 181.0 75.0 77.0 74.0 75.0 163.0 76.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:84.00 stddev:26.99 (32.1%) stddev-sans-first:27.80 07:41:08 INFO - PROCESS | 23909 | Values: 84.0 83.0 141.0 84.0 85.0 92.0 142.0 88.0 84.0 141.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.05 (0.9%) stddev-sans-first:1.12 07:41:08 INFO - PROCESS | 23909 | Values: 118.0 118.0 119.0 117.0 117.0 119.0 118.0 117.0 117.0 120.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:41:08 INFO - PROCESS | 23909 | Values: 148.0 148.0 148.0 147.0 147.0 148.0 147.0 148.0 148.0 148.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 07:41:08 INFO - PROCESS | 23909 | Values: 96.0 97.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 100.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.50 stddev:1.97 (3.7%) stddev-sans-first:0.87 07:41:08 INFO - PROCESS | 23909 | Values: 59.0 54.0 53.0 53.0 55.0 54.0 53.0 52.0 53.0 53.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.95 (1.6%) stddev-sans-first:1.00 07:41:08 INFO - PROCESS | 23909 | Values: 61.0 63.0 63.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.00 stddev:2.38 (3.1%) stddev-sans-first:2.52 07:41:08 INFO - PROCESS | 23909 | Values: 78.0 77.0 77.0 77.0 77.0 76.0 83.0 77.0 82.0 77.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:126.50 stddev:14.10 (11.1%) stddev-sans-first:14.60 07:41:08 INFO - PROCESS | 23909 | Values: 122.0 131.0 125.0 121.0 126.0 125.0 127.0 121.0 167.0 141.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.00 stddev:4.28 (2.6%) stddev-sans-first:4.50 07:41:08 INFO - PROCESS | 23909 | Values: 164.0 164.0 159.0 173.0 159.0 163.0 163.0 158.0 161.0 161.0 07:41:08 INFO - PROCESS | 23909 | 07:41:08 INFO - PROCESS | 23909 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:64.50 stddev:2.30 (3.6%) stddev-sans-first:2.44 07:41:08 INFO - PROCESS | 23909 | Values: 65.0 69.0 64.0 64.0 67.0 63.0 64.0 64.0 69.0 63.0 07:41:08 INFO - PROCESS | 23909 | -------- Summary: end -------- 07:41:08 INFO - PROCESS | 23909 | 07:41:09 INFO - TEST-INFO | 23909: exit 0 07:41:09 INFO - TEST-OK | kraken | took 62049ms 07:41:09 INFO - SUITE-END | took 1173s 07:41:09 INFO - Completed test suite (00:19:33) 07:41:09 INFO - javascript benchmark 07:41:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7300.531703734005, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.2773098321895, 3094.7214750672447, 3100.3334283129125, 3127.296358319377, 3135.8710864088926, 5385.272988146608, 5445.373782015069, 5489.533389661873, 5529.032419326617, 5543.889122217553, 5395.973020134894, 5418.349798024233, 5430.75561599728, 5449.291592093023, 5518.972405137979, 4871.829485967983, 4923.852284431473, 4927.679700819435, 4969.180085285923, 4977.7262250576205, 4945.307656928033, 4978.751062446881, 5082.822101226458, 5098.311727916721, 5146.5110814472755, 4904.926426103611, 4922.089413458521, 4976.452590215092, 4978.452370239271, 5017.473165317626, 4868.537488938545, 4869.074875773592, 4884.389451318585, 4913.950860491385, 4962.578180854632, 4895.657303988723, 4899.240617704261, 4902.2156454967035, 4904.068227036852, 4953.702777833306, 5296.788128474856, 5334.146536554172, 5334.946650533484, 5343.759530821122, 5383.2732581101445, 5728.799492017801, 5749.252597162384, 5775.537956963475, 5812.3025236971835, 5813.505852002585, 5785.0, 5789.9710501447225, 5790.855228619276, 5802.245708057925, 5802.245708057968, 5359.651622644516, 5368.892622147574, 5390.568754499631, 5398.4871437213405, 5415.323084614423, 5890.087036509348, 5977.910331345033, 5987.461128498369, 6016.578839481194, 6059.60612560191, 5748.597598168171, 5750.856228594235, 5753.108268218432, 5757.337906140848, 5761.423857614205, 5600.467955544217, 5739.368669446358, 5831.2127862738835, 5838.416158384128, 5840.737166827503, 5593.440655934374, 5732.799352022743, 5736.225609542742, 5767.769289228384, 5783.450572195635, 5574.665520068809, 5637.68992705397, 5680.318361796611, 5737.282839645044, 5763.164341170507, 4432.822687092545, 4437.334399839985, 4441.267190913528, 4444.28891377378, 4467.039586488855, 3880.9223815523533, 3914.0606254498716, 3919.8824035278985, 3949.3681011038097, 3997.8400863965117, 5472.7263636818, 5513.255710479114, 5533.0, 5539.778408863681, 5545.584081193927, 5842.328132264844, 5851.561132915049, 5853.414658534198, 5858.619189752738, 5899.498542623839, 5399.676019438846, 5482.424345443751, 5508.586855985817, 5511.724413779295, 5613.971930140323, 4981.701097934136, 5006.749662516932, 5022.59819214462, 5023.2214006829, 5059.97470012655, 6065.5450841187085, 6070.757169713251, 6082.60463069899, 6088.178095956989, 6090.3605121461605, 5613.915791263053, 5792.247007888947, 5807.709614519173, 5856.824295271149, 5944.375840536682, 6019.337872834072, 6074.088886667036, 6075.605085669417, 6088.299845517822, 6106.69466526663, 5757.798477053283, 5759.0, 5761.711914404347, 5787.276590426197, 5788.27646544182, 5626.915596266142, 5832.650040997384, 5870.002099642986, 5889.0, 5984.1921340618455, 5737.741801618854, 5749.91375129365, 5764.6829424380385, 5769.134629805562, 5774.855628609318, 5732.856678582902, 5746.42535746422, 5756.740946657326, 5760.913586296125, 5767.5674324425, 5479.835604931858, 5515.834524964257, 5592.245046918777, 5601.187827764869, 5617.5505959522325, 5550.27846379968, 5637.8590535236945, 5646.040173170653, 5706.42935706426, 5731.140328950691, 5462.934727728055, 5467.535259502987, 5473.917891231555, 5552.722363881709, 5556.805511807229], "value": 5353.241774743352, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.5717568884114, 596.1683451585037, 603.3574243430743, 619.944205021548, 648.4552975500578, 43009.35485967713, 43647.56352436475, 43724.72064595156, 43904.3414348785, 43991.56008439915, 44704.55295447045, 44820.551794482126, 44876.0, 45570.316445253266, 45592.632221033426, 8880.467171969687, 8972.192502674758, 8983.371164018521, 9002.819943601124, 9011.414258073204, 8705.129487051308, 8818.514981676006, 8888.333374996868, 8889.822203555925, 8891.288696904265, 8915.0, 8950.820983580325, 8976.147266009752, 8986.955065224665, 8997.865032024492, 8848.424852384607, 8861.202491775739, 8922.86615700765, 8927.151920567536, 8938.64245430182, 8786.604602792826, 8856.690015849414, 8872.157145071207, 8893.644254229823, 8901.243394311492, 42031.579684203076, 42207.36688949668, 42474.0, 42481.0, 42849.0, 3461.653834616518, 3609.2240168363664, 3795.886123416274, 4048.8987775305854, 4132.152908653718, 33837.0, 33987.0, 34110.31779364424, 34304.14239644004, 34346.31307373864, 4371.934420983688, 4383.211022016036, 4491.056878055612, 4543.977280113611, 4579.404677391951, 260371.0, 260931.0, 263021.0, 264417.0, 264574.6771266151, 34109.658903411146, 60920.47698807476, 61097.38902611006, 61222.38777612256, 61300.0, 35791.64208357883, 37587.0, 37606.0, 37626.24747505089, 37686.0, 12473.688157796129, 12551.372431378395, 12620.053495987653, 12630.305333206761, 12636.494540218473, 10322.48387580618, 10337.328073675188, 10372.585096596202, 10377.117944974761, 10377.533011014522, 8324.875126873101, 8399.62201700925, 8447.619857106445, 8480.660773568989, 8488.702895398632, 3231.6768323167494, 3245.5780748502543, 3274.809427058092, 3294.0447270291825, 3304.8182349970502, 1052.4007893005937, 1078.2721662877527, 1104.9558017679203, 1109.778044391125, 1194.4147367789722, 32328.0, 32382.83808580942, 33988.0, 33988.18765944879, 34792.82603586966, 1093.5024563823442, 1099.3074363151163, 1113.716002419394, 1134.075728281448, 1153.6769704482758, 17560.473185804447, 17608.207630656652, 17731.645367092588, 17879.73180402295, 17940.91029544844, 74526.0, 74646.62676686581, 74824.0, 75419.62290188514, 75740.0, 61888.071678924854, 62334.37665623376, 62534.0619890702, 62541.0, 62649.06026409607, 1350.8851747601368, 1354.9187048777105, 1364.5428781358355, 1371.4788380415378, 1384.8892088632886, 31004.0, 31217.53173702351, 31335.529967050057, 31965.442764578314, 32586.34827303488, 55169.724151378985, 55294.0, 55405.0, 55476.16785748136, 55715.0, 446950.0, 449604.75988100556, 449828.0, 450145.0, 450325.0, 28915.421691566473, 29080.7091929078, 29337.853310734165, 29384.706152938197, 29488.262793430335, 50364.74817626035, 50496.24255636095, 51180.48819511906, 51537.22694159666, 51577.22634160566, 41610.79194604007, 43380.0, 43763.343549847414, 44158.11683766371, 44643.776781115885, 42928.78535607302, 43403.0, 43653.34519982267, 44358.778206108764, 45366.77316613396, 43212.567874320855, 43683.56316436795, 44024.55975440333, 44429.555704442544, 45139.54860451353, 34940.65059349374, 36752.0, 37790.244195116495, 40405.79797100995, 40576.59423405728, 29729.904143522035, 30017.0, 30153.396932060798, 30560.694393055786, 30705.38589228158], "value": 18058.133884466988, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.14467015205344, 378.5117198813531, 400.75353657500636, 401.74689945334444, 419.35210100394886, 18258.634827303445, 19650.347203127574, 19690.507737306576, 19724.91512966788, 20082.196712131532, 19166.137523811427, 19361.322353717624, 19582.804171958276, 19600.80399196011, 19654.606907861835, 5726.141078838176, 5855.61938474, 5888.764449422018, 5890.234269544953, 5963.761449542013, 5732.111522713965, 5928.436798504157, 5934.495567876736, 5936.198613187207, 5949.910751338712, 5765.7981970631035, 5821.50517206038, 5843.766249350021, 5896.469317761401, 5911.822645320647, 5839.795607153729, 5848.619839710426, 5873.089671100986, 5892.086726557412, 5906.645601263916, 5102.617303702237, 5169.819056333048, 5224.39919409269, 5229.581633469352, 5243.292155559027, 23128.306150815504, 23315.883420582788, 23459.178928737412, 23532.411689707722, 23607.40981475477, 2271.8636881787147, 2568.4349443122483, 2952.247176969859, 3182.2203560127687, 3199.568058312145, 14372.137671739729, 14481.203533805636, 14498.05762625426, 14712.485063022743, 15132.848671513255, 1946.2993322403922, 1995.2218634732467, 2023.5244717491378, 2057.362217712514, 2066.183857376343, 77823.22176778216, 78483.21516784816, 78491.0, 79146.20853791446, 80179.0, 10265.332753371007, 10327.535260913277, 10407.721567706149, 10736.731581710363, 10816.67549973502, 14603.707925841423, 14626.707465850623, 14675.77986330206, 14699.853001470063, 14746.926265368818, 7359.632018399058, 7544.509606875536, 7616.80957976055, 7766.456348055694, 7811.140774514913, 7044.471664625174, 7086.18508871476, 7128.28717128283, 7391.2978267064545, 7396.482246242711, 6382.20222472191, 6431.6462594556815, 6496.545241833121, 6569.704363303663, 6587.242467116343, 1946.3382449966796, 1973.3685220729228, 1987.7614686237744, 1989.3733473955947, 2002.0390212697987, 990.1237404896718, 1001.3090967232587, 1011.4335971855784, 1024.8411496218098, 1083.030687534652, 19513.31703390403, 20107.698384524243, 20147.194112235346, 20251.696224556643, 20312.593748124953, 1017.6336518853207, 1033.788073444957, 1035.1977217656377, 1054.7204990677476, 1116.771061932302, 10707.625233116803, 11458.083353331713, 11460.426978651034, 11519.942400287944, 11621.186516943902, 495706.6931988069, 501746.0, 507206.0, 509912.0, 541797.0, 77292.0, 78798.21201788023, 79256.20743792603, 79788.0, 81338.0, 1027.2347101409348, 1069.9411532365796, 1099.769048499824, 1108.5953626926114, 1109.2180013090751, 17013.57466063358, 17675.292988280326, 17679.116044197483, 17764.401552084266, 18075.0, 36834.71078512239, 37241.25517489689, 37386.43920341251, 37599.248015040095, 38413.61586384212, 48159.75920120377, 49468.75265623649, 49955.50044499509, 50153.24770128378, 50293.0, 7211.747588834365, 7447.143578488543, 7497.887531687138, 7555.773326799985, 7561.852148860918, 11721.062315014608, 11827.231229970024, 11920.846297448663, 11969.401529923294, 12371.0, 10225.693229203136, 10377.9481102594, 10423.0, 10795.676129716121, 11424.82862757076, 10070.647527336509, 10461.581536738446, 10475.476226188812, 10522.0, 10675.679729608124, 9921.40471571708, 10074.597016119273, 11009.779804404026, 11012.889871101186, 11301.378424186749, 8071.596420179085, 8274.089850116363, 8336.62485188156, 8360.958195208985, 8407.579621019047, 9382.437053776795, 9776.0, 10151.187904967437, 10562.419066951392, 10599.470026498799], "value": 9195.446623510068, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.115446114487, 1508.992455037725, 1659.3362654938023, 1792.9282828686862, 1816.5004623728482, 8038.9196108038905, 8682.0, 8827.249683776887, 9376.109269619392, 9380.0, 8878.067802880685, 9225.861612075807, 9263.166315031645, 9294.209992150658, 9324.347295689304, 2428.0530593068715, 2478.1698131126095, 2484.1553871683623, 2490.5018996200743, 2492.289697436222, 2423.236680445663, 2474.8391354561895, 2495.8252922295446, 2498.9375265618414, 2503.9749602504016, 2457.0, 2460.225029115823, 2495.3512086857368, 2497.787688046509, 2501.9374515637073, 2433.926982190546, 2438.987805060981, 2444.523317953, 2445.3275349279093, 2461.1509029384833, 2361.2089949866813, 2364.3143488388346, 2372.0630351011255, 2372.2171683344454, 2414.4446777241333, 9271.675491357837, 9291.396059256194, 9317.767055823591, 9382.906170938271, 9387.0, 5466.644668096561, 5571.498565129117, 5571.749271282802, 5601.579881508903, 5618.4662457066515, 3469.3581687387914, 3596.280743851214, 3653.8903832885057, 3669.94495082574, 3678.337899178147, 1117.67587399654, 1127.385574861694, 1131.264677959333, 1182.24927171246, 1199.4542483170137, 13190.34048297591, 13228.669283267898, 13234.0, 13273.137246078973, 13279.53521626748, 4743.739094349844, 4802.423709154924, 4836.975815120902, 4889.437714662859, 5020.648554601143, 10997.230193886351, 11019.283746556448, 11020.118390528738, 11021.889781102247, 11034.282771619979, 5477.178423236467, 5533.612647114664, 5568.9443105568425, 5592.245046918695, 5598.3282006159525, 4465.799039043251, 4924.975375123173, 5018.222175562793, 5047.798088076509, 5108.948910510921, 4171.8957026074595, 4177.206330797138, 4279.507856596531, 4291.527931927485, 4359.782010899442, 1309.2471828698347, 1318.6176008957295, 1320.8018797180307, 1323.9602811915659, 1339.799030145486, 858.3176374782063, 993.438707130469, 993.6770549571419, 993.7018894331671, 1013.229945241607, 5977.193078934288, 6075.179850720185, 6096.664683442454, 6179.721912513947, 6220.315765265817, 443.7027191781514, 449.22060225508716, 453.7657571405771, 457.0584595732801, 458.62392837872625, 4296.935545966813, 4405.3612226227015, 4464.718431952512, 4481.327800829901, 4588.2888152336445, 10933.343999360064, 11138.554457821596, 11578.536858525733, 11599.594014209462, 11651.825222621668, 11491.42542872853, 11509.424528773528, 11532.25040372373, 11565.537378504934, 11619.76760464786, 8056.194380562014, 8433.536155511383, 8447.155284471504, 8478.703245386381, 8683.175098365646, 6359.236891573041, 6441.516886233645, 6490.286068532363, 6633.9668301658185, 6654.966725166343, 10531.842022369823, 10538.525766340686, 10688.786224275316, 10713.517891695048, 10939.343639381663, 10652.307600005975, 10853.782924341627, 10872.728181795203, 10949.671509854717, 11045.889541104487, 7867.331276841533, 8464.238218560113, 8715.08491608372, 8791.384603077724, 9008.41445306053, 8682.088380720186, 8707.956460217913, 8708.956455217936, 8805.823883522422, 8829.735107946515, 8136.552489612891, 8177.0, 8261.545614990993, 8328.750137495885, 8484.787880303042, 7891.289783919475, 8031.879521807295, 8060.395470339865, 8114.229148230908, 8223.301019413417, 7493.850122997401, 7504.6247687614305, 7631.084269887649, 7632.542047477169, 7743.032120984877, 5344.518993290622, 5426.620136590559, 5446.700431476307, 5498.092814685532, 5514.503694667499, 5345.78616855337, 5352.330958630171, 5385.838424847104, 5465.344158700981, 5469.75386107634], "value": 4790.147600085092, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.2152069770298, 339.64846383992557, 340.9846556904939, 345.94464885618305, 348.1609321535101, 5443.482869127427, 5482.136073734934, 5530.529904958078, 5547.944520554794, 5564.8330550083565, 5455.372632147304, 5459.945400545993, 5512.4211957744465, 5514.92458970501, 5517.0, 4289.721168124062, 4306.655467562603, 4311.396404503372, 4313.460817397825, 4333.674974376919, 3860.2279544091152, 4234.9364759528635, 4237.936430953539, 4258.53156152823, 4258.9148217035645, 4208.494980602317, 4222.556631553689, 4232.788360581974, 4248.341507066394, 4252.596003379689, 4227.344761561947, 4251.277282861921, 4261.169072030955, 4265.637420819249, 4287.142571485715, 3539.50446937429, 3680.4663323818163, 3715.826241648612, 3740.1023754299044, 3838.8848334550007, 5273.841784746463, 5275.815346462894, 5292.894142117136, 5300.628955973083, 5310.548603368718, 4839.395075615548, 4862.3922009748785, 4869.853904382874, 4896.975515122402, 4917.532834380764, 5522.171674248854, 5679.886402271932, 5692.715364231772, 5702.374823175375, 5758.107493338539, 4079.8164082616354, 4086.795660217007, 4091.713580049398, 4092.202020605983, 4107.363358679409, 5896.852578685524, 5925.081612350093, 5934.43622855828, 5957.165996760414, 6000.96999515004, 4095.3856921461424, 4191.8742437726305, 4198.64311533517, 4215.114825886537, 4234.941264683829, 4236.809343579546, 4269.719084274705, 4276.2089013532595, 4279.079997800425, 4279.443672322641, 4830.6135509159885, 4867.9269810952865, 4871.293662419001, 4887.535684110004, 4912.5333093356785, 5484.232207490954, 5700.828975130753, 5708.514776244066, 5740.6268592541355, 5770.826875193751, 1444.4655477473402, 1464.9633759156106, 1470.9485168019069, 1472.2417954753312, 1482.2514630111941, 910.4537277633367, 943.5188054092463, 945.8723072385139, 964.2093483343591, 967.7193613852045, 4852.878678033077, 4855.708657480492, 4981.327520784647, 5386.272853164851, 5553.389127196006, 5865.912011319833, 5919.585629005928, 5927.288725352985, 5988.3113441953865, 5995.850103747442, 5568.888622227532, 5578.721063946787, 5587.184165146344, 5587.38538760736, 5595.18869763882, 3044.6955304469375, 3126.4372412965886, 3128.593282873212, 3138.7489000879873, 3139.6232452105437, 6097.829128852972, 6102.450779429784, 6109.930762116612, 6132.50939924805, 6160.568760186744, 5818.970905145447, 5986.467983889526, 6027.638341699512, 6040.637561746309, 6048.879022419527, 6107.755689772359, 6116.3577824328695, 6184.907226391608, 6191.938080619136, 6199.442050215412, 5676.602637815478, 5845.0, 5868.853278668067, 5930.169776231245, 5932.406759324205, 5786.61121330886, 5787.971060144672, 5788.855278618068, 5795.043817770021, 5812.244408226903, 6063.969680151571, 6102.206713127265, 6108.297545782292, 6126.835901178762, 6139.3553676863285, 3997.6402123809, 4057.5739547347102, 4069.9796501017304, 4129.359949207877, 4203.55862634419, 5840.970795145997, 5844.94155058461, 5850.53195744348, 5853.400158902329, 5862.794802181903, 5682.261306030189, 5692.203091567267, 5726.5418766499415, 5726.768744719905, 5781.913271300849, 5547.44525547442, 5669.376368599368, 5689.943100568941, 5690.914636280542, 5714.514266287412, 5609.158626206102, 5644.717764111696, 5665.858353541194, 5682.886342273048, 5693.743781529924, 5191.352410270713, 5763.221965034667, 5790.826275211751, 5791.82624521265, 5845.473907348359, 5559.694216817952, 5567.359753628384, 5572.0, 5574.219609254788, 5592.468715472024], "value": 4359.058638079666, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2347605442449, 755.5126943121687, 779.9844003119941, 807.1686163251849, 859.2524503681798, 14563.854361456382, 15386.923065384657, 15398.230088495586, 15404.152771597557, 15620.76568851468, 15023.098614083163, 15081.62295942602, 15255.160966146857, 15271.312790924407, 15278.923605381957, 674.4334758802605, 798.1978111997435, 805.6092794994423, 823.1850468036661, 837.6146972392676, 814.5031530766228, 816.4162623724036, 818.5784321074622, 819.5246756880995, 819.7868554175898, 875.8598624220126, 877.6533269358599, 882.6072397782989, 883.0860059838069, 886.0696268917643, 871.6077765005741, 879.5030807593753, 880.7798050487378, 881.1496905486205, 882.7704796752827, 642.3095172689377, 642.5149012495536, 643.0482885329739, 643.4434214404506, 645.3804347826093, 15091.622709432242, 15105.47130850426, 15116.244187790566, 15169.848301517064, 15283.847161528354, 14987.625309367244, 15193.164375959317, 15448.0, 16073.196340183062, 16198.514044578682, 13516.256605886672, 14239.50161744334, 14262.857371426257, 14387.640308992255, 14542.200178990151, 4802.471728109905, 4814.325994360793, 4818.759062046884, 4832.565069143759, 4834.685745426536, 81775.0, 82304.0, 83258.58370708108, 84687.5765621174, 86106.56946715289, 12437.93781031089, 12474.937625311997, 12491.375431228402, 12542.24746515212, 12606.180598261084, 23134.537309254058, 23292.534149316918, 23342.066317347115, 23428.0, 23633.52732945366, 9092.59083341238, 9198.908010919939, 9515.809683806423, 9529.714108576754, 9542.761430964281, 4925.40895092584, 5131.281620573122, 5252.711100889488, 5255.605829562722, 5271.341082364705, 3871.457995880579, 4039.525573165832, 4056.9391459128137, 4070.2876996526084, 4089.97955010229, 705.0411440440996, 711.4770643576967, 713.4256923176893, 722.0468980945102, 726.8037629839913, 744.1962680305257, 753.7512620835112, 763.4541302968404, 813.4631143445298, 819.2135549872189, 10587.629432969808, 10720.693779904183, 10730.946345268223, 11179.720506987227, 11567.88432115685, 621.8787336469436, 659.7591878964143, 674.8144260328351, 759.8062494063978, 770.2413123073768, 5169.147090730063, 5204.219367094966, 5376.220448035013, 5409.350877894678, 5419.83740487786, 127360.36319818342, 128174.0, 133157.0, 134720.0, 135688.0, 113729.0, 117429.0, 118482.99999999828, 119096.40451797686, 120801.39599302123, 100028.0, 102536.48731756293, 104045.47977260065, 105231.0, 106702.0, 9778.65774697882, 9902.900970990198, 9937.304388693012, 10002.699919002442, 10120.746981325527, 45669.314960274955, 53513.464865352405, 57536.42463575311, 57962.7101864488, 59306.703466482395, 50073.74963125161, 60431.0, 66193.66903165646, 76029.0, 77311.61344193244, 13552.661183470098, 13558.525451609541, 13589.52436664712, 13893.0, 14129.222892740998, 14047.0, 14448.0, 14632.780508292597, 15932.442364517186, 16781.748273776146, 14260.643483912985, 14562.563123106323, 14843.332050057988, 15285.0, 15472.458463953708, 13844.0, 14780.408783648534, 14811.851881481047, 14871.702565948404, 15119.622009449851, 13781.173129612256, 13892.166470011427, 13931.721365572834, 14191.64520886986, 15699.0, 12560.811587826372, 12575.622731318075, 12621.0, 12683.80974285405, 13742.587722368346, 12618.369081545703, 12813.871861281268, 12940.547080852126, 13100.541481048118, 13282.203067815963], "value": 8156.123185084322, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 109.0, 113.0, 115.0, 112.0, 113.0, 112.0, 112.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 160.0, 180.0, 120.0, 155.0, 148.0, 125.0, 177.0, 119.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 162.0, 166.0, 172.0, 163.0, 162.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 181.0, 75.0, 77.0, 74.0, 75.0, 163.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 141.0, 84.0, 85.0, 92.0, 142.0, 88.0, 84.0, 141.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 117.0, 117.0, 119.0, 118.0, 117.0, 117.0, 120.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 100.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 54.0, 53.0, 53.0, 55.0, 54.0, 53.0, 52.0, 53.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 77.0, 77.0, 76.0, 83.0, 77.0, 82.0, 77.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 125.0, 121.0, 126.0, 125.0, 127.0, 121.0, 167.0, 141.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 159.0, 173.0, 159.0, 163.0, 163.0, 158.0, 161.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 64.0, 64.0, 67.0, 63.0, 64.0, 64.0, 69.0, 63.0], "value": 65.2, "unit": "score"}]}]} 07:41:10 INFO - Return code: 0 07:41:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:41:10 ERROR - # TBPL SUCCESS # 07:41:10 INFO - Running post-action listener: _resource_record_post_action 07:41:10 INFO - [mozharness: 2016-08-01 14:41:10.096134Z] Finished run-tests step (success) 07:41:10 INFO - Running post-run listener: _resource_record_post_run 07:41:10 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550133760; Read time: 104; Write time: 839324 07:41:10 INFO - TinderboxPrint: CPU usage
13.3% 07:41:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 104 07:41:10 INFO - TinderboxPrint: I/O write bytes / time
550,133,760 / 839,324 07:41:10 INFO - TinderboxPrint: CPU idle
8,227.6 (86.6%) 07:41:10 INFO - TinderboxPrint: CPU user
1,205.6 (12.7%) 07:41:10 INFO - TinderboxPrint: Swap in / out
0 / 0 07:41:10 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 258093056; Read time: 0; Write time: 500832 07:41:10 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291647488; Read time: 104; Write time: 338416 07:41:10 INFO - Running post-run listener: _upload_blobber_files 07:41:10 INFO - Blob upload gear active. 07:41:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:41:10 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 07:41:10 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'] 07:41:10 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 07:41:11 INFO - (blobuploader) - INFO - Open directory for files ... 07:41:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:41:11 INFO - (blobuploader) - INFO - Done attempting. 07:41:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:41:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:41:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:41:15 INFO - (blobuploader) - INFO - Done attempting. 07:41:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:41:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:41:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:41:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:41:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:41:16 INFO - (blobuploader) - INFO - Done attempting. 07:41:16 INFO - (blobuploader) - INFO - Iteration through files over. 07:41:16 INFO - Return code: 0 07:41:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:41:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:41:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/72650269bb5b964bf3e6e72ac6b0f255f1e7319e8b2049061e4706982d08f49acc003e7c17805c91ffe2eab4a1dead3c569d7d7eae205ccd46b3e44c35dbd9de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f00d997772bdde7a22242a23709cea3921c448b392a009e93deb47070629a7913a7c125986c9cbcd8641f22148f95bb2012415c4561af94bcd14f3865115d213", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b75bbb294d29641afd3bda07f9228e34538d5d7b8cd0bc598c8e325accc13760b0cf497383709820fd47cc72517a5236c5b4feaa9763bff731a180eb44b5a8a3"} 07:41:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:41:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:41:16 INFO - Contents: 07:41:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/72650269bb5b964bf3e6e72ac6b0f255f1e7319e8b2049061e4706982d08f49acc003e7c17805c91ffe2eab4a1dead3c569d7d7eae205ccd46b3e44c35dbd9de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f00d997772bdde7a22242a23709cea3921c448b392a009e93deb47070629a7913a7c125986c9cbcd8641f22148f95bb2012415c4561af94bcd14f3865115d213", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b75bbb294d29641afd3bda07f9228e34538d5d7b8cd0bc598c8e325accc13760b0cf497383709820fd47cc72517a5236c5b4feaa9763bff731a180eb44b5a8a3"} 07:41:16 INFO - Running post-run listener: copy_logs_to_upload_dir 07:41:16 INFO - Copying logs to upload dir... 07:41:16 INFO - mkdir: /builds/slave/test/build/upload/logs 07:41:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.297158 ========= master_lag: 146.89 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 51 secs) (at 2016-08-01 07:43:42.735056) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 mins, 3 secs) (at 2016-08-01 07:43:42.738634) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/72650269bb5b964bf3e6e72ac6b0f255f1e7319e8b2049061e4706982d08f49acc003e7c17805c91ffe2eab4a1dead3c569d7d7eae205ccd46b3e44c35dbd9de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f00d997772bdde7a22242a23709cea3921c448b392a009e93deb47070629a7913a7c125986c9cbcd8641f22148f95bb2012415c4561af94bcd14f3865115d213", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b75bbb294d29641afd3bda07f9228e34538d5d7b8cd0bc598c8e325accc13760b0cf497383709820fd47cc72517a5236c5b4feaa9763bff731a180eb44b5a8a3"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470051002/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/72650269bb5b964bf3e6e72ac6b0f255f1e7319e8b2049061e4706982d08f49acc003e7c17805c91ffe2eab4a1dead3c569d7d7eae205ccd46b3e44c35dbd9de", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f00d997772bdde7a22242a23709cea3921c448b392a009e93deb47070629a7913a7c125986c9cbcd8641f22148f95bb2012415c4561af94bcd14f3865115d213", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b75bbb294d29641afd3bda07f9228e34538d5d7b8cd0bc598c8e325accc13760b0cf497383709820fd47cc72517a5236c5b4feaa9763bff731a180eb44b5a8a3"}' ========= master_lag: 123.23 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 mins, 3 secs) (at 2016-08-01 07:45:45.976709) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 07:45:45.977024) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1470060765.156253-41366975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004733 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 07:45:46.090467) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-08-01 07:45:46.090748) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-08-01 07:45:47.667944) ========= ========= Total master_lag: 270.28 =========