builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1469608394.77 results: success (0) buildid: 20160727013221 builduid: be63bd3934884701a01dafe2c3a83b56 revision: 5070b24e986b66f3a2576111b545972e052b841f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:14.773761) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:14.774756) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:14.775426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:14.799257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:14.799574) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 01:33:15-- 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% 45.8M=0s 2016-07-27 01:33:15 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159483 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:14.977790) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:14.978128) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014919 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:15.028399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 01:33:15.028809) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5070b24e986b66f3a2576111b545972e052b841f --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 5070b24e986b66f3a2576111b545972e052b841f --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=8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 01:33:15,483 truncating revision to first 12 chars 2016-07-27 01:33:15,483 Setting DEBUG logging. 2016-07-27 01:33:15,483 attempt 1/10 2016-07-27 01:33:15,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5070b24e986b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 01:33:16,303 unpacking tar archive at: mozilla-inbound-5070b24e986b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.284070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 01:33:16.326890) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:16.327325) ========= script_repo_revision: 5070b24e986b66f3a2576111b545972e052b841f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:16.327820) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:16.328179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 01:33:16.340327) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-27 01:33:16.340760) ========= /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=8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:33:16 INFO - MultiFileLogger online at 20160727 01:33:16 in /builds/slave/test 01:33:16 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 01:33:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:33:16 INFO - {'append_to_log': False, 01:33:16 INFO - 'base_work_dir': '/builds/slave/test', 01:33:16 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:33:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:33:16 INFO - 'branch': 'Mozilla-Inbound', 01:33:16 INFO - 'buildbot_json_path': 'buildprops.json', 01:33:16 INFO - 'config_files': ('talos/linux_config.py',), 01:33:16 INFO - 'default_actions': ('clobber', 01:33:16 INFO - 'read-buildbot-config', 01:33:16 INFO - 'download-and-extract', 01:33:16 INFO - 'populate-webroot', 01:33:16 INFO - 'create-virtualenv', 01:33:16 INFO - 'install', 01:33:16 INFO - 'run-tests'), 01:33:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:33:16 INFO - 'download_minidump_stackwalk': True, 01:33:16 INFO - 'download_symbols': 'ondemand', 01:33:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:33:16 INFO - 'tooltool.py': '/tools/tooltool.py', 01:33:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:33:16 INFO - '/tools/misc-python/virtualenv.py')}, 01:33:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:33:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:33:16 INFO - 'installer_path': 'installer.exe', 01:33:16 INFO - 'log_level': 'info', 01:33:16 INFO - 'log_name': 'talos', 01:33:16 INFO - 'log_to_console': True, 01:33:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:33:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:33:16 INFO - 'opt_config_files': (), 01:33:16 INFO - 'pip_index': False, 01:33:16 INFO - 'sps_profile': False, 01:33:16 INFO - 'sps_profile_interval': 0, 01:33:16 INFO - 'suite': 'dromaeojs-e10s', 01:33:16 INFO - 'system_bits': '32', 01:33:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:33:16 INFO - 'title': 'talos-linux64-ix-001', 01:33:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:33:16 INFO - 'use_talos_json': True, 01:33:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:33:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:33:16 INFO - 'work_dir': 'build'} 01:33:16 INFO - [mozharness: 2016-07-27 08:33:16.890684Z] Running clobber step. 01:33:16 INFO - Running pre-action listener: _resource_record_pre_action 01:33:16 INFO - Running main action method: clobber 01:33:16 INFO - rmtree: /builds/slave/test/build 01:33:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:33:17 INFO - Running post-action listener: _resource_record_post_action 01:33:17 INFO - [mozharness: 2016-07-27 08:33:17.892004Z] Finished clobber step (success) 01:33:17 INFO - [mozharness: 2016-07-27 08:33:17.892105Z] Running read-buildbot-config step. 01:33:17 INFO - Running pre-action listener: _resource_record_pre_action 01:33:17 INFO - Running main action method: read_buildbot_config 01:33:17 INFO - Using buildbot properties: 01:33:17 INFO - { 01:33:17 INFO - "project": "", 01:33:17 INFO - "product": "firefox", 01:33:17 INFO - "script_repo_revision": "production", 01:33:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:33:17 INFO - "repository": "", 01:33:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:33:17 INFO - "buildid": "20160727013221", 01:33:17 INFO - "stage_platform": "linux64-pgo", 01:33:17 INFO - "basedir": "/builds/slave/test", 01:33:17 INFO - "buildnumber": 1086, 01:33:17 INFO - "platform": "ubuntu64_hw", 01:33:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:33:17 INFO - "slavebuilddir": "test", 01:33:17 INFO - "branch": "mozilla-inbound", 01:33:17 INFO - "revision": "5070b24e986b66f3a2576111b545972e052b841f", 01:33:17 INFO - "slavename": "talos-linux64-ix-001", 01:33:17 INFO - "builduid": "be63bd3934884701a01dafe2c3a83b56", 01:33:17 INFO - "repo_path": "integration/mozilla-inbound" 01:33:17 INFO - } 01:33:17 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:33:17 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.test_packages.json. 01:33:17 INFO - Running post-action listener: _resource_record_post_action 01:33:17 INFO - [mozharness: 2016-07-27 08:33:17.894494Z] Finished read-buildbot-config step (success) 01:33:17 INFO - [mozharness: 2016-07-27 08:33:17.894583Z] Running download-and-extract step. 01:33:17 INFO - Running pre-action listener: _resource_record_pre_action 01:33:17 INFO - Running main action method: download_and_extract 01:33:17 INFO - mkdir: /builds/slave/test/build/tests 01:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:33:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:33:17 INFO - Downloaded 1361 bytes. 01:33:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:33:17 INFO - Using the following test package requirements: 01:33:17 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:33:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:33:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:33:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:33:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:33:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:33:17 INFO - u'jsshell-linux-x86_64.zip'], 01:33:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:33:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:33:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:33:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:33:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:33:17 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:33:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:33:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:33:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:33:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:33:17 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:33:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:33:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:33:18 INFO - Downloaded 24315791 bytes. 01:33:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:33:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:33:19 INFO - Return code: 0 01:33:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:19 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:33:19 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:33:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:33:24 INFO - Downloaded 24315791 bytes. 01:33:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:33:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:33:25 INFO - Return code: 0 01:33:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:25 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:33:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:33:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:33:26 INFO - Downloaded 14413725 bytes. 01:33:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:33:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:33:26 INFO - Return code: 0 01:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:33:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:33:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:33:32 INFO - Downloaded 61006262 bytes. 01:33:32 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:33:32 INFO - mkdir: /builds/slave/test/properties 01:33:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:33:32 INFO - Writing to file /builds/slave/test/properties/build_url 01:33:32 INFO - Contents: 01:33:32 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:33:32 INFO - Running post-action listener: _resource_record_post_action 01:33:32 INFO - Running post-action listener: set_extra_try_arguments 01:33:32 INFO - [mozharness: 2016-07-27 08:33:32.457369Z] Finished download-and-extract step (success) 01:33:32 INFO - [mozharness: 2016-07-27 08:33:32.457609Z] Running populate-webroot step. 01:33:32 INFO - Running pre-action listener: _resource_record_pre_action 01:33:32 INFO - Running main action method: populate_webroot 01:33:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:33:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:33:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:33:32 INFO - '--tppagecycles', 01:33:32 INFO - '7'], 01:33:32 INFO - 'tests': ['tsvgm']}}, 01:33:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:33:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:33:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:33:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:33:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:32 INFO - 'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:32 INFO - 'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['damp', 'tps']}, 01:33:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:32 INFO - 'tests': ['damp', 'tps']}, 01:33:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['dromaeo_dom']}, 01:33:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:33:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['basic_compositor_video']}, 01:33:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:33:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['a11yr', 01:33:32 INFO - 'ts_paint', 01:33:32 INFO - 'tpaint', 01:33:32 INFO - 'sessionrestore', 01:33:32 INFO - 'sessionrestore_no_auto_restore', 01:33:32 INFO - 'tabpaint']}, 01:33:32 INFO - 'other-e10s': {'tests': ['a11yr', 01:33:32 INFO - 'ts_paint', 01:33:32 INFO - 'tpaint', 01:33:32 INFO - 'sessionrestore', 01:33:32 INFO - 'sessionrestore_no_auto_restore', 01:33:32 INFO - 'tabpaint']}, 01:33:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:33:32 INFO - 'ts_paint', 01:33:32 INFO - 'tpaint', 01:33:32 INFO - 'sessionrestore', 01:33:32 INFO - 'sessionrestore_no_auto_restore', 01:33:32 INFO - 'tabpaint']}, 01:33:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:33:32 INFO - 'ts_paint', 01:33:32 INFO - 'tpaint', 01:33:32 INFO - 'sessionrestore', 01:33:32 INFO - 'sessionrestore_no_auto_restore', 01:33:32 INFO - 'tabpaint']}, 01:33:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['a11yr', 01:33:32 INFO - 'ts_paint', 01:33:32 INFO - 'tpaint', 01:33:32 INFO - 'sessionrestore', 01:33:32 INFO - 'sessionrestore_no_auto_restore', 01:33:32 INFO - 'tabpaint']}, 01:33:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['a11yr', 01:33:32 INFO - 'ts_paint', 01:33:32 INFO - 'tpaint', 01:33:32 INFO - 'sessionrestore', 01:33:32 INFO - 'sessionrestore_no_auto_restore', 01:33:32 INFO - 'tabpaint']}, 01:33:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['tsvgx', 01:33:32 INFO - 'tsvgr_opacity', 01:33:32 INFO - 'tart', 01:33:32 INFO - 'tscrollx', 01:33:32 INFO - 'cart']}, 01:33:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:33:32 INFO - 'tsvgr_opacity', 01:33:32 INFO - 'tart', 01:33:32 INFO - 'tscrollx', 01:33:32 INFO - 'cart']}, 01:33:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:32 INFO - 'talos_options': ['--disable-e10s'], 01:33:32 INFO - 'tests': ['tp5o']}, 01:33:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:32 INFO - 'tests': ['tp5o']}, 01:33:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:32 INFO - 'talos_options': ['--disable-e10s', 01:33:32 INFO - '--xperf_path', 01:33:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:32 INFO - 'tests': ['tp5n']}, 01:33:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:32 INFO - 'talos_options': ['--xperf_path', 01:33:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:32 INFO - 'tests': ['tp5n']}}, 01:33:32 INFO - 'talos.zip': {'path': '', 01:33:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:33:32 INFO - Running post-action listener: _resource_record_post_action 01:33:32 INFO - [mozharness: 2016-07-27 08:33:32.475873Z] Finished populate-webroot step (success) 01:33:32 INFO - [mozharness: 2016-07-27 08:33:32.475962Z] Running create-virtualenv step. 01:33:32 INFO - Running pre-action listener: _resource_record_pre_action 01:33:32 INFO - Running main action method: create_virtualenv 01:33:32 INFO - Creating virtualenv /builds/slave/test/build/venv 01:33:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:33:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:33:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:33:32 INFO - Using real prefix '/usr' 01:33:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:33:33 INFO - Installing distribute.............................................................................................................................................................................................done. 01:33:35 INFO - Installing pip.................done. 01:33:35 INFO - Return code: 0 01:33:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:33:35 INFO - Using env: {'DISPLAY': ':0', 01:33:35 INFO - 'HOME': '/home/cltbld', 01:33:35 INFO - 'LANG': 'en_US.UTF-8', 01:33:35 INFO - 'LANGUAGE': 'en_US:en', 01:33:35 INFO - 'LOGNAME': 'cltbld', 01:33:35 INFO - 'MAIL': '/var/mail/cltbld', 01:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:35 INFO - 'MOZ_NO_REMOTE': '1', 01:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:35 INFO - 'NO_EM_RESTART': '1', 01:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:35 INFO - 'PWD': '/builds/slave/test', 01:33:35 INFO - 'SHELL': '/bin/bash', 01:33:35 INFO - 'SHLVL': '1', 01:33:35 INFO - 'TERM': 'linux', 01:33:35 INFO - 'TMOUT': '86400', 01:33:35 INFO - 'USER': 'cltbld', 01:33:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:35 INFO - '_': '/tools/buildbot/bin/python'} 01:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:33:35 INFO - Cleaning up... 01:33:35 INFO - Return code: 0 01:33:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:33:35 INFO - Using env: {'DISPLAY': ':0', 01:33:35 INFO - 'HOME': '/home/cltbld', 01:33:35 INFO - 'LANG': 'en_US.UTF-8', 01:33:35 INFO - 'LANGUAGE': 'en_US:en', 01:33:35 INFO - 'LOGNAME': 'cltbld', 01:33:35 INFO - 'MAIL': '/var/mail/cltbld', 01:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:35 INFO - 'MOZ_NO_REMOTE': '1', 01:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:35 INFO - 'NO_EM_RESTART': '1', 01:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:35 INFO - 'PWD': '/builds/slave/test', 01:33:35 INFO - 'SHELL': '/bin/bash', 01:33:35 INFO - 'SHLVL': '1', 01:33:35 INFO - 'TERM': 'linux', 01:33:35 INFO - 'TMOUT': '86400', 01:33:35 INFO - 'USER': 'cltbld', 01:33:35 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:35 INFO - '_': '/tools/buildbot/bin/python'} 01:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:35 INFO - Downloading/unpacking psutil>=3.1.1 01:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:33:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:37 INFO - Installing collected packages: psutil 01:33:37 INFO - Running setup.py install for psutil 01:33:37 INFO - building 'psutil._psutil_linux' extension 01:33:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:33:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:33:37 INFO - building 'psutil._psutil_posix' extension 01:33:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:33:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:33:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:38 INFO - Successfully installed psutil 01:33:38 INFO - Cleaning up... 01:33:38 INFO - Return code: 0 01:33:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:33:38 INFO - Using env: {'DISPLAY': ':0', 01:33:38 INFO - 'HOME': '/home/cltbld', 01:33:38 INFO - 'LANG': 'en_US.UTF-8', 01:33:38 INFO - 'LANGUAGE': 'en_US:en', 01:33:38 INFO - 'LOGNAME': 'cltbld', 01:33:38 INFO - 'MAIL': '/var/mail/cltbld', 01:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:38 INFO - 'MOZ_NO_REMOTE': '1', 01:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:38 INFO - 'NO_EM_RESTART': '1', 01:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:38 INFO - 'PWD': '/builds/slave/test', 01:33:38 INFO - 'SHELL': '/bin/bash', 01:33:38 INFO - 'SHLVL': '1', 01:33:38 INFO - 'TERM': 'linux', 01:33:38 INFO - 'TMOUT': '86400', 01:33:38 INFO - 'USER': 'cltbld', 01:33:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:38 INFO - '_': '/tools/buildbot/bin/python'} 01:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:33:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:33:40 INFO - Installing collected packages: mozsystemmonitor 01:33:40 INFO - Running setup.py install for mozsystemmonitor 01:33:40 INFO - Successfully installed mozsystemmonitor 01:33:40 INFO - Cleaning up... 01:33:40 INFO - Return code: 0 01:33:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:40 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 0x1bf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:33:40 INFO - Using env: {'DISPLAY': ':0', 01:33:40 INFO - 'HOME': '/home/cltbld', 01:33:40 INFO - 'LANG': 'en_US.UTF-8', 01:33:40 INFO - 'LANGUAGE': 'en_US:en', 01:33:40 INFO - 'LOGNAME': 'cltbld', 01:33:40 INFO - 'MAIL': '/var/mail/cltbld', 01:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:40 INFO - 'MOZ_NO_REMOTE': '1', 01:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:40 INFO - 'NO_EM_RESTART': '1', 01:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:40 INFO - 'PWD': '/builds/slave/test', 01:33:40 INFO - 'SHELL': '/bin/bash', 01:33:40 INFO - 'SHLVL': '1', 01:33:40 INFO - 'TERM': 'linux', 01:33:40 INFO - 'TMOUT': '86400', 01:33:40 INFO - 'USER': 'cltbld', 01:33:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:40 INFO - '_': '/tools/buildbot/bin/python'} 01:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:40 INFO - Downloading/unpacking jsonschema==2.5.1 01:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:33:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:42 INFO - Downloading functools32-3.2.3-2.tar.gz 01:33:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:33:42 INFO - warning: no files found matching '*.txt' 01:33:42 INFO - no previously-included directories found matching 'build' 01:33:42 INFO - no previously-included directories found matching 'dist' 01:33:42 INFO - no previously-included directories found matching '.git*' 01:33:42 INFO - Installing collected packages: jsonschema, functools32 01:33:42 INFO - Running setup.py install for functools32 01:33:42 INFO - warning: no files found matching '*.txt' 01:33:42 INFO - no previously-included directories found matching 'build' 01:33:42 INFO - no previously-included directories found matching 'dist' 01:33:42 INFO - no previously-included directories found matching '.git*' 01:33:42 INFO - Successfully installed jsonschema functools32 01:33:42 INFO - Cleaning up... 01:33:43 INFO - Return code: 0 01:33:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:33:43 INFO - Using env: {'DISPLAY': ':0', 01:33:43 INFO - 'HOME': '/home/cltbld', 01:33:43 INFO - 'LANG': 'en_US.UTF-8', 01:33:43 INFO - 'LANGUAGE': 'en_US:en', 01:33:43 INFO - 'LOGNAME': 'cltbld', 01:33:43 INFO - 'MAIL': '/var/mail/cltbld', 01:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:43 INFO - 'MOZ_NO_REMOTE': '1', 01:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:43 INFO - 'NO_EM_RESTART': '1', 01:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:43 INFO - 'PWD': '/builds/slave/test', 01:33:43 INFO - 'SHELL': '/bin/bash', 01:33:43 INFO - 'SHLVL': '1', 01:33:43 INFO - 'TERM': 'linux', 01:33:43 INFO - 'TMOUT': '86400', 01:33:43 INFO - 'USER': 'cltbld', 01:33:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:43 INFO - '_': '/tools/buildbot/bin/python'} 01:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:33:43 INFO - Cleaning up... 01:33:43 INFO - Return code: 0 01:33:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:33:43 INFO - Using env: {'DISPLAY': ':0', 01:33:43 INFO - 'HOME': '/home/cltbld', 01:33:43 INFO - 'LANG': 'en_US.UTF-8', 01:33:43 INFO - 'LANGUAGE': 'en_US:en', 01:33:43 INFO - 'LOGNAME': 'cltbld', 01:33:43 INFO - 'MAIL': '/var/mail/cltbld', 01:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:43 INFO - 'MOZ_NO_REMOTE': '1', 01:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:43 INFO - 'NO_EM_RESTART': '1', 01:33:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:43 INFO - 'PWD': '/builds/slave/test', 01:33:43 INFO - 'SHELL': '/bin/bash', 01:33:43 INFO - 'SHLVL': '1', 01:33:43 INFO - 'TERM': 'linux', 01:33:43 INFO - 'TMOUT': '86400', 01:33:43 INFO - 'USER': 'cltbld', 01:33:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:43 INFO - '_': '/tools/buildbot/bin/python'} 01:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:43 INFO - Downloading/unpacking blobuploader==1.2.4 01:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:45 INFO - Downloading blobuploader-1.2.4.tar.gz 01:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:33:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:33:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:46 INFO - Downloading docopt-0.6.1.tar.gz 01:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:33:46 INFO - Installing collected packages: blobuploader, requests, docopt 01:33:46 INFO - Running setup.py install for blobuploader 01:33:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:33:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:33:46 INFO - Running setup.py install for requests 01:33:46 INFO - Running setup.py install for docopt 01:33:46 INFO - Successfully installed blobuploader requests docopt 01:33:46 INFO - Cleaning up... 01:33:46 INFO - Return code: 0 01:33:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:46 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 0x1bf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:33:46 INFO - Using env: {'DISPLAY': ':0', 01:33:46 INFO - 'HOME': '/home/cltbld', 01:33:46 INFO - 'LANG': 'en_US.UTF-8', 01:33:46 INFO - 'LANGUAGE': 'en_US:en', 01:33:46 INFO - 'LOGNAME': 'cltbld', 01:33:46 INFO - 'MAIL': '/var/mail/cltbld', 01:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:46 INFO - 'MOZ_NO_REMOTE': '1', 01:33:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:46 INFO - 'NO_EM_RESTART': '1', 01:33:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:46 INFO - 'PWD': '/builds/slave/test', 01:33:46 INFO - 'SHELL': '/bin/bash', 01:33:46 INFO - 'SHLVL': '1', 01:33:46 INFO - 'TERM': 'linux', 01:33:46 INFO - 'TMOUT': '86400', 01:33:46 INFO - 'USER': 'cltbld', 01:33:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:46 INFO - '_': '/tools/buildbot/bin/python'} 01:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:33:47 INFO - Running setup.py (path:/tmp/pip-lOxxLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:33:47 INFO - Running setup.py (path:/tmp/pip-oh7xhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:33:47 INFO - Running setup.py (path:/tmp/pip-2vtpWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:33:47 INFO - Running setup.py (path:/tmp/pip-Fyu4dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:33:47 INFO - Running setup.py (path:/tmp/pip-_2EVjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:33:47 INFO - Running setup.py (path:/tmp/pip-DV2q7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:33:47 INFO - Running setup.py (path:/tmp/pip-g_pDRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:33:47 INFO - Running setup.py (path:/tmp/pip-xmtz_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:33:47 INFO - Running setup.py (path:/tmp/pip-dM5JWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:33:47 INFO - Running setup.py (path:/tmp/pip-Egqdhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:33:47 INFO - Running setup.py (path:/tmp/pip-u_9RFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:33:47 INFO - Running setup.py (path:/tmp/pip-kzBcTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:33:47 INFO - Running setup.py (path:/tmp/pip-ZkTluj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:33:48 INFO - Running setup.py (path:/tmp/pip-Xp19vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:48 INFO - Running setup.py (path:/tmp/pip-Ms__2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:33:48 INFO - Running setup.py (path:/tmp/pip-uLUh3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:33:48 INFO - Running setup.py (path:/tmp/pip-GUhJLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:33:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:33:48 INFO - Running setup.py install for manifestparser 01:33:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:33:48 INFO - Running setup.py install for mozcrash 01:33:48 INFO - Running setup.py install for mozdebug 01:33:48 INFO - Running setup.py install for mozdevice 01:33:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:33:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:33:48 INFO - Running setup.py install for mozfile 01:33:48 INFO - Running setup.py install for mozhttpd 01:33:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:33:48 INFO - Running setup.py install for mozinfo 01:33:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Running setup.py install for mozInstall 01:33:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Running setup.py install for mozleak 01:33:49 INFO - Running setup.py install for mozlog 01:33:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Running setup.py install for moznetwork 01:33:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Running setup.py install for mozprocess 01:33:49 INFO - Running setup.py install for mozprofile 01:33:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Running setup.py install for mozrunner 01:33:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:33:49 INFO - Running setup.py install for mozscreenshot 01:33:49 INFO - Running setup.py install for moztest 01:33:49 INFO - Running setup.py install for mozversion 01:33:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:33:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:33:50 INFO - Cleaning up... 01:33:50 INFO - Return code: 0 01:33:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:50 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 0x1bf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:33:50 INFO - Using env: {'DISPLAY': ':0', 01:33:50 INFO - 'HOME': '/home/cltbld', 01:33:50 INFO - 'LANG': 'en_US.UTF-8', 01:33:50 INFO - 'LANGUAGE': 'en_US:en', 01:33:50 INFO - 'LOGNAME': 'cltbld', 01:33:50 INFO - 'MAIL': '/var/mail/cltbld', 01:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:50 INFO - 'MOZ_NO_REMOTE': '1', 01:33:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:50 INFO - 'NO_EM_RESTART': '1', 01:33:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:50 INFO - 'PWD': '/builds/slave/test', 01:33:50 INFO - 'SHELL': '/bin/bash', 01:33:50 INFO - 'SHLVL': '1', 01:33:50 INFO - 'TERM': 'linux', 01:33:50 INFO - 'TMOUT': '86400', 01:33:50 INFO - 'USER': 'cltbld', 01:33:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:50 INFO - '_': '/tools/buildbot/bin/python'} 01:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:33:50 INFO - Running setup.py (path:/tmp/pip-fDE6WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:33:50 INFO - Running setup.py (path:/tmp/pip-iUQcfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:33:50 INFO - Running setup.py (path:/tmp/pip-bZ7lAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:33:50 INFO - Running setup.py (path:/tmp/pip-rejGfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:33:50 INFO - Running setup.py (path:/tmp/pip-5ZaL6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:33:50 INFO - Running setup.py (path:/tmp/pip-tBe95m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:33:50 INFO - Running setup.py (path:/tmp/pip-7EfObw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:33:50 INFO - Running setup.py (path:/tmp/pip-qAajFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:33:50 INFO - Running setup.py (path:/tmp/pip-88fSVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:33:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:33:50 INFO - Running setup.py (path:/tmp/pip-ZoohbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:33:51 INFO - Running setup.py (path:/tmp/pip-UfZ8g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:33:51 INFO - Running setup.py (path:/tmp/pip-qoyYiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:33:51 INFO - Running setup.py (path:/tmp/pip-uP6II7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:33:51 INFO - Running setup.py (path:/tmp/pip-5y0M0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:51 INFO - Running setup.py (path:/tmp/pip-eJEmII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:33:51 INFO - Running setup.py (path:/tmp/pip-astPFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:33:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:33:51 INFO - Running setup.py (path:/tmp/pip-gLeoE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:33:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:53 INFO - Downloading blessings-1.6.tar.gz 01:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:33:53 INFO - Installing collected packages: blessings 01:33:53 INFO - Running setup.py install for blessings 01:33:53 INFO - Successfully installed blessings 01:33:53 INFO - Cleaning up... 01:33:53 INFO - Return code: 0 01:33:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:33:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:53 INFO - Reading from file tmpfile_stdout 01:33:53 INFO - Current package versions: 01:33:53 INFO - argparse == 1.2.1 01:33:53 INFO - blessings == 1.6 01:33:53 INFO - blobuploader == 1.2.4 01:33:53 INFO - docopt == 0.6.1 01:33:53 INFO - functools32 == 3.2.3-2 01:33:53 INFO - jsonschema == 2.5.1 01:33:53 INFO - manifestparser == 1.1 01:33:53 INFO - mozInstall == 1.12 01:33:53 INFO - mozcrash == 0.17 01:33:53 INFO - mozdebug == 0.1 01:33:53 INFO - mozdevice == 0.48 01:33:53 INFO - mozfile == 1.2 01:33:53 INFO - mozhttpd == 0.7 01:33:53 INFO - mozinfo == 0.9 01:33:53 INFO - mozleak == 0.1 01:33:53 INFO - mozlog == 3.3 01:33:53 INFO - moznetwork == 0.27 01:33:53 INFO - mozprocess == 0.23 01:33:53 INFO - mozprofile == 0.28 01:33:53 INFO - mozrunner == 6.12 01:33:53 INFO - mozscreenshot == 0.1 01:33:53 INFO - mozsystemmonitor == 0.3 01:33:53 INFO - moztest == 0.7 01:33:53 INFO - mozversion == 1.4 01:33:53 INFO - psutil == 3.1.1 01:33:53 INFO - requests == 1.2.3 01:33:53 INFO - wsgiref == 0.1.2 01:33:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:53 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 0x1bf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:33:53 INFO - Using env: {'DISPLAY': ':0', 01:33:53 INFO - 'HOME': '/home/cltbld', 01:33:53 INFO - 'LANG': 'en_US.UTF-8', 01:33:53 INFO - 'LANGUAGE': 'en_US:en', 01:33:53 INFO - 'LOGNAME': 'cltbld', 01:33:53 INFO - 'MAIL': '/var/mail/cltbld', 01:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:53 INFO - 'MOZ_NO_REMOTE': '1', 01:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:53 INFO - 'NO_EM_RESTART': '1', 01:33:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:53 INFO - 'PWD': '/builds/slave/test', 01:33:53 INFO - 'SHELL': '/bin/bash', 01:33:53 INFO - 'SHLVL': '1', 01:33:53 INFO - 'TERM': 'linux', 01:33:53 INFO - 'TMOUT': '86400', 01:33:53 INFO - 'USER': 'cltbld', 01:33:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:53 INFO - '_': '/tools/buildbot/bin/python'} 01:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:33:54 INFO - Cleaning up... 01:33:54 INFO - Return code: 0 01:33:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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')]} 01:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:54 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 0x1bf1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e20400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, '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': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:33:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:33:54 INFO - Using env: {'DISPLAY': ':0', 01:33:54 INFO - 'HOME': '/home/cltbld', 01:33:54 INFO - 'LANG': 'en_US.UTF-8', 01:33:54 INFO - 'LANGUAGE': 'en_US:en', 01:33:54 INFO - 'LOGNAME': 'cltbld', 01:33:54 INFO - 'MAIL': '/var/mail/cltbld', 01:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:54 INFO - 'MOZ_NO_REMOTE': '1', 01:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:54 INFO - 'NO_EM_RESTART': '1', 01:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:54 INFO - 'PWD': '/builds/slave/test', 01:33:54 INFO - 'SHELL': '/bin/bash', 01:33:54 INFO - 'SHLVL': '1', 01:33:54 INFO - 'TERM': 'linux', 01:33:54 INFO - 'TMOUT': '86400', 01:33:54 INFO - 'USER': 'cltbld', 01:33:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:54 INFO - '_': '/tools/buildbot/bin/python'} 01:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:33:54 INFO - Cleaning up... 01:33:54 INFO - Return code: 0 01:33:54 INFO - Running post-action listener: _resource_record_post_action 01:33:54 INFO - Running post-action listener: _start_resource_monitoring 01:33:54 INFO - Starting resource monitoring. 01:33:54 INFO - [mozharness: 2016-07-27 08:33:54.370154Z] Finished create-virtualenv step (success) 01:33:54 INFO - [mozharness: 2016-07-27 08:33:54.370586Z] Running install step. 01:33:54 INFO - Running pre-action listener: _resource_record_pre_action 01:33:54 INFO - Running main action method: install 01:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:54 INFO - Reading from file tmpfile_stdout 01:33:54 INFO - Detecting whether we're running mozinstall >=1.0... 01:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:33:54 INFO - Reading from file tmpfile_stdout 01:33:54 INFO - Output received: 01:33:54 INFO - Usage: mozinstall [options] installer 01:33:54 INFO - Options: 01:33:54 INFO - -h, --help show this help message and exit 01:33:54 INFO - -d DEST, --destination=DEST 01:33:54 INFO - Directory to install application into. [default: 01:33:54 INFO - "/builds/slave/test"] 01:33:54 INFO - --app=APP Application being installed. [default: firefox] 01:33:54 INFO - mkdir: /builds/slave/test/build/application 01:33:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:34:11 INFO - Reading from file tmpfile_stdout 01:34:11 INFO - Output received: 01:34:11 INFO - /builds/slave/test/build/application/firefox/firefox 01:34:11 INFO - Running post-action listener: _resource_record_post_action 01:34:11 INFO - [mozharness: 2016-07-27 08:34:11.958385Z] Finished install step (success) 01:34:11 INFO - [mozharness: 2016-07-27 08:34:11.958661Z] Running run-tests step. 01:34:11 INFO - Running pre-action listener: _resource_record_pre_action 01:34:11 INFO - Running main action method: run_tests 01:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:34:11 INFO - Python 2.7.3 01:34:11 INFO - Return code: 0 01:34:11 INFO - grabbing minidump binary from tooltool 01:34: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')]} 01:34:11 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 0x1eaf570>, '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 0x1eb0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:34:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:34:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:34:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:34:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:34:12 INFO - Return code: 0 01:34:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:34:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:34:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:34:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:34:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:34:12 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/1469597458/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 01:34:12 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/1469597458/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 01:34:12 INFO - Using env: {'DISPLAY': ':0', 01:34:12 INFO - 'HOME': '/home/cltbld', 01:34:12 INFO - 'LANG': 'en_US.UTF-8', 01:34:12 INFO - 'LANGUAGE': 'en_US:en', 01:34:12 INFO - 'LOGNAME': 'cltbld', 01:34:12 INFO - 'MAIL': '/var/mail/cltbld', 01:34:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:34:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:12 INFO - 'MOZ_NO_REMOTE': '1', 01:34:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:12 INFO - 'NO_EM_RESTART': '1', 01:34:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:12 INFO - 'PWD': '/builds/slave/test', 01:34:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:34:12 INFO - 'SHELL': '/bin/bash', 01:34:12 INFO - 'SHLVL': '1', 01:34:12 INFO - 'TERM': 'linux', 01:34:12 INFO - 'TMOUT': '86400', 01:34:12 INFO - 'USER': 'cltbld', 01:34:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047', 01:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:12 INFO - '_': '/tools/buildbot/bin/python'} 01:34:12 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/1469597458/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 01:34:12 INFO - mozversion application_buildid: 20160726223058 01:34:12 INFO - mozversion application_changeset: 5070b24e986b66f3a2576111b545972e052b841f 01:34:12 INFO - mozversion application_display_name: Nightly 01:34:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:34:12 INFO - mozversion application_name: Firefox 01:34:12 INFO - mozversion application_remotingname: firefox 01:34:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:34:12 INFO - mozversion application_vendor: Mozilla 01:34:12 INFO - mozversion application_version: 50.0a1 01:34:12 INFO - mozversion platform_buildid: 20160726223058 01:34:12 INFO - mozversion platform_changeset: 5070b24e986b66f3a2576111b545972e052b841f 01:34:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:34:12 INFO - mozversion platform_version: 50.0a1 01:34:12 INFO - using testdate: 1469608452 01:34:12 INFO - actual date: 1469608452 01:34:12 INFO - starting webserver on 'localhost:45579' 01:34:12 INFO - SUITE-START | Running 2 tests 01:34:12 INFO - TEST-START | dromaeo_css 01:34:12 INFO - operating with platform_type : linux_ 01:34:12 INFO - Initialising browser for dromaeo_css test... 01:34:12 INFO - TEST-INFO | started process 1283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1TJBVy/profile http://localhost:45579/getInfo.html) 01:34:15 INFO - PROCESS | 1283 | JavaScript error: , line 0: uncaught exception: undefined 01:34:16 INFO - PROCESS | 1283 | __metrics Screen width/height:1600/1200 01:34:16 INFO - PROCESS | 1283 | colorDepth:24 01:34:16 INFO - PROCESS | 1283 | Browser inner width/height: 1024/697 01:34:16 INFO - PROCESS | 1283 | __metrics 01:34:17 ERROR - PROCESS | 1283 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:34:18 INFO - TEST-INFO | 1283: exit 0 01:34:18 INFO - Browser initialized. 01:34:18 INFO - Running cycle 1/1 for dromaeo_css test... 01:34:18 INFO - TEST-INFO | started process 1403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1TJBVy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:34:30 INFO - PROCESS | 1403 | RSS: Main: 164990976 01:34:30 INFO - PROCESS | 1403 | 01:35:19 INFO - PROCESS | 1403 | 1469608519616 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:37:27 INFO - PROCESS | 1403 | Cycle 1(1): loaded http://localhost:45579/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45579/tests/dromaeo/cssquery-ext.html) 01:37:28 INFO - PROCESS | 1403 | RSS: Main: 170237952 01:37:28 INFO - PROCESS | 1403 | 01:40:31 INFO - PROCESS | 1403 | Cycle 1(1): loaded http://localhost:45579/tests/dromaeo/cssquery-ext.html (next: http://localhost:45579/tests/dromaeo/cssquery-jquery.html) 01:40:31 INFO - PROCESS | 1403 | RSS: Main: 168411136 01:40:31 INFO - PROCESS | 1403 | 01:43:33 INFO - PROCESS | 1403 | Cycle 1(1): loaded http://localhost:45579/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45579/tests/dromaeo/cssquery-mootools.html) 01:43:34 INFO - PROCESS | 1403 | RSS: Main: 170893312 01:43:34 INFO - PROCESS | 1403 | 01:46:36 INFO - PROCESS | 1403 | Cycle 1(1): loaded http://localhost:45579/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45579/tests/dromaeo/cssquery-prototype.html) 01:46:36 INFO - PROCESS | 1403 | RSS: Main: 165130240 01:46:36 INFO - PROCESS | 1403 | 01:49:39 INFO - PROCESS | 1403 | Cycle 1(1): loaded http://localhost:45579/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45579/tests/dromaeo/cssquery-yui.html) 01:49:40 INFO - PROCESS | 1403 | RSS: Main: 167653376 01:49:40 INFO - PROCESS | 1403 | 01:52:42 INFO - PROCESS | 1403 | Cycle 1(1): loaded http://localhost:45579/tests/dromaeo/cssquery-yui.html (next: http://localhost:45579/tests/dromaeo/cssquery-dojo.html) 01:52:42 INFO - PROCESS | 1403 | RSS: Main: 170807296 01:52:42 INFO - PROCESS | 1403 | 01:52:42 INFO - PROCESS | 1403 | __start_tp_report 01:52:42 INFO - PROCESS | 1403 | _x_x_mozilla_page_load 01:52:42 INFO - PROCESS | 1403 | _x_x_mozilla_page_load_details 01:52:42 INFO - PROCESS | 1403 | |i|pagename|runs| 01:52:42 INFO - PROCESS | 1403 | |0;dojo.html;3108.1297236773703;3131.311111555457;3148.1342630776535;3157.778955473116;3157.9368412631748;5376.650517716345;5407.188921661747;5465.59008074394;5493.670379777216;5496;5341.30563026807;5360.517553420192;5415.675059496433;5433.510984011438;5466.262054622624;4835.105505481497;4929.50704929506;4979.10376132296;4988.152014157602;5052.14113600687;4930.359053323063;4974.1295273327205;4986.10250154972;5041.445441001505;5101.132807422747;4844.394450693663;4909.975450122763;4919.040787046527;4968.254761785725;5011.774470148852;4967.4784147664695;4968;4969.701817890938;4986.326845875833;4995.9250611240495;4819.903601927942;4938.4814594467425;4944.777485013183;4950.529699678525;4978.6763860348965;5344.812931547377;5349.759260833272;5363.275957745733;5477.780888764445;5482.506574408322;5813.593048486608;5821.67980761058;5828.912566311508;5830.650160990312;5842.415758424124;5701.71491425427;5872.941270587282;5876.059830427112;5878.559108066912;5882.617629854046;5374.838754837361;5407.540359069484;5438.8912221755345;5476.370217424967;5535.723213839332;5946.583739138306;5969.224000879858;5983.37174596661;5995.190649262381;6001.12983617373;5636.802711905146;5749.310082790092;5754.395788442237;5755.194272801811;5758.452946970031;5697.373288938214;5709.714514274353;5775.220345253421;5789.45000224978;5839.270091238595;5619.578531610146;5740.1102829061565;5764.221830052973;5848.88302233953;5852.619579727304;5799.159121927381;5806.187133801272;5870.530357571384;5871.882562348729;5874.500667443315;4344.695871288979;4355.956440435619;4363.127374525045;4366.934495982499;4470.664700147502;3931.567527571965;3931.6461518463475;3954.8220330085214;3963.8810835674976;3972.106276087915;5580.553555715533;5582.49757521825;5586.748596313176;5591.832245032656;5633.859153521113;5703.315602127771;5721;5721.656700597978;5723.399043100498;5863.912041319383;5472.50747432733;5481.287432633732;5530.087535556588;5537.446255374431;5543.972280138573;4947.158982972904;4959.429665588431;4965;4977.104121258136;4988.12707776145;5946.959282125611;5951.940480595139;5974.581779275409;5987.760489580455;6020.397960204032;5839.182514448065;5843.532517398683;5849.181114643869;5856.795012174553;5886.793962211302;6053.273607167168;6064.151018857452;6074.088886667036;6076.0278355462915;6076.361981991828;5518.724063796874;5728.3985181557;5747;5792.652440853562;5800.9419905800405;5909.349971503218;5952.553558483218;5958.046712525975;5963.2844058713235;6013.879722405615;5718.914216286842;5751.1085781703905;5767.106098554731;5781.161731548817;5791.82624521265;5526.640768350045;5631.1271752878365;5706.743196556082;5728.198052272602;5783.566232532493;5679.488846003879;5694.914576281276;5698.173764803997;5712.200291959212;5713.914291285717;5780.450857168562;5805.41945805433;5828.0966450200285;5833.970830145822;5835.4748072673665;5434.565234781129;5535.059039963136;5549.972250138723;5589.888202235851;5650.3219613646625 01:52:42 INFO - PROCESS | 1403 | |1;ext.html;544.5793585962776;574.3509833887706;585.5227989188813;593.8099808061422;605.73650462049;31163;43797.78101109494;44986.32520512191;45045.32432013514;48247.51752482474;45511;45990.310145347845;46029.07941841161;46056;46285.76857115718;9094.818103637923;9236.538173091352;9242.72271831846;9244.722658320228;9255.259579233645;9021.729348119567;9064.36549441536;9156.084391560857;9169.633214671405;9247;9202.861957070649;9237.261019118489;9250.982391936881;9307.90692093077;9308.534573271309;9187.081291870792;9197.356185067049;9198.034206408298;9218.446893186398;9222;9082.545872706338;9150.450972941644;9153.542322883895;9171;9175.770605734844;43536.56463435388;43861;43924.56075439237;43968.12063758739;44003.559964400265;3518.48981897626;3596.856125754967;3664.1022949377307;3720.3675375186285;4104.958950410488;33612.663873361445;33951.793133446496;34206.31587368239;34281.31437371264;34459.655403446144;4412.271975124101;4429.933550996738;4457.264551349023;4549.385832912548;4561.042181141964;351296;355740.99999999744;355756;357965;358714;32899.50650740241;34304.142396440286;58099.4190058094;58221.4177858216;58802.41197588055;36494.45258321127;36543.4518482223;36567;36646;36671.266574668894;15058;15235.771463428058;15271.770923436157;15319.540413787605;15321.6169595761;11960.043196544255;12091.939540302243;12207.877921220852;12210.08424368176;12225.960793332666;8144.348452123816;8154.103048664642;8175.959120204361;8293.585320733939;8307.543085130375;3145.748340132784;3186.2193762527863;3199.4880819068835;3208.470602350633;3225.8870939517005;1026.4559783314855;1027.2501074215716;1048.496721573649;1050.4380156616173;1112.204773586873;33740.66259337375;33856.49215261773;33902.66097339044;34064.14839629029;34130.31739365199;1079.83262594298;1087.3258579680491;1130.8416821644976;1179.979317890019;1197.8323034775137;17548.824511754974;17617.973932997615;17625.559361016076;17718.91140544315;17762;581425;583824;584352;589794;600363;57427;57878;58219.12671309934;58290.12564811531;58561.4143858556;1341.5975207437925;1359.422245545639;1367.2001878900955;1373.587923622909;1374.1411617738913;30589.54115688311;32751.18122046968;33040.33919321648;33164.668353316156;33246.667533324355;52175.47824521706;52199.21701174409;52491.850488970784;52570.21144682756;52821.471785281654;482021;484071;486015;486219;486541;28030.71969280281;28402.43195136127;28428.85785571059;28735.5689664651;28764.568531471625;47963.520364795906;48505.75747121242;48642.75678621584;49635;49857.252141217185;41176.38235426411;42355.7882210587;43275.783621082956;43377.34933976056;44000;42439.36340954826;42480;43141;43416;43905.56094439015;41600.167996640506;42261;42970.78514607407;43358.78320608503;44981.32528012148;32734.508982365758;37992.430113547765;38009.42985855159;38770.22459550737;39551.60448395479;28787;29198.708012920448;29344.08164480995;29379.55930660999;29547 01:52:42 INFO - PROCESS | 1403 | |2;jquery.html;373.9663430291273;386.7872670031482;390.1455811772219;402.4084595644402;411.8949667834702;17523.824761752378;19319.517012074706;19812.30656927008;20223.59552808943;20230.98845057745;11723.7069073273;11767.70580735482;12015.759684806299;12078.456469458873;12096.213746106498;4930.975345123269;5156.071907056728;5161.122609156452;5182.766775495093;5194.662346947455;4910.533499317559;5103.4896510349035;5151.381834179885;5188.948110518884;5201.713905735183;5066.214736715815;5074.8731281718065;5099.821506247282;5101.056304583645;5110.463401342861;5024.924626130611;5037.143685573461;5088.338515992916;5099.515546023141;5134.922976155361;4914.803407863681;4989.775460104304;5027.773750181251;5038.395392552917;5054.292399064134;13010.544630937966;13175.275359855204;13310.467581296736;13445.26051067191;13565.728685426237;2236.586231547169;2295.8737269450176;2319.8492098013576;2364.2788949370433;2604.387968827324;9017;9140.451572905647;9150.359474836763;9653.662121825702;10179.491025448771;1767.372582733124;1797.3349860551548;1801.6937120689515;1848.7781466224005;1882.2471011595335;78904;82633;86556.13443865544;87096.99999999936;88847.55576222143;10191.439470829027;10358.585656573652;10424.113950314157;10656.307340022873;11099.72250693739;14190.432382704783;14246.501372451914;14254.216018118896;14269.857301426853;14328.641783955276;7903.486273392326;8328.721091124704;8339.374546909006;8554.14458554152;8566.27186689126;7805.2194780521495;7818.569978651115;7984.720534781255;8027.117017128111;8063.354931605458;4291.635211007099;4510.954890451054;4544.409226800495;4645.628349732014;4698.154332220233;1886.7264246684153;1934.816192461742;1939.41817454763;1946.425804387709;1986.8609197356047;944.1691311645708;1031.3554028732042;1049.8897615750388;1051.5163025008583;1072.3780207479642;19849.40451786449;20642.919027654716;20655.17379304841;20664.276750313667;20721.68917466239;977.867987821635;1023.7082431507133;1038.4496217004998;1056.6143357674548;1057.6351158850184;10798.190135739851;11209.719757005976;11312;11432.142589305835;11447.713807154722;491100;496661;498392;501332;503638;74718.25281747113;93526;94158.52920735352;94403.52798235965;94585;974.6783561424854;986.413084214891;1005.5726316315537;1010.3028910052041;1016.1870503597092;16954.745678815074;16990.405335813186;17456.47630571085;17816.46550603484;18374.632507350045;34972.65027349694;43154.78422607867;43248.56751432445;43251;43349.78325108354;55107.72446137744;58250;58862.117068244865;59019;60422.97885105815;7221.494495385273;7359.8160045999275;7373.225811289952;8125.228103330174;8129.79675508117;9065.274778017874;12492.063095268073;12537.811932821198;12627.621171364874;13761.105528140639;9932.205423566242;9964.608493961541;10811.6215932442;10836.187285953427;11209.71975700614;10415.479226038819;10714.25000249975;10848.67453976382;11504.367259800456;11508.739147504366;11394.829077563678;11863.288202707865;11879.940600296943;12031.939840301093;12306.507739690313;7320.524165929198;7368.410527157922;7408.888866666896;7549.09410870677;7649.04386951631;10741.409222492837;10889.836652450378;11314.377709226072;11473.426328683365;12178.147529672839 01:52:42 INFO - PROCESS | 1403 | |3;mootools.html;1497.8352381238062;1506.5630967019565;1663.8419350161737;1774.3967051202596;1775.8668099892511;8160.714374996876;8785.253253473447;8833.734987950364;9410.011948745378;9414.623415063397;8903.198712115909;9203.58583863726;9206.401583897043;9225.215856652176;9247.676331328405;2304.896279667415;2342.2504798464415;2343.8828058597087;2348.283773449097;2349.4126468382906;2229.15292188968;2290.198430549311;2315.7221133463922;2316.3977365884907;2317.9536409271805;2333.9883300583474;2339.9064037438566;2348.1194552042984;2353.8352315337934;2357.434215788207;2268.3875353654503;2274.863508189514;2277.567262220173;2296.942576435594;2297.6553516972504;2246.7753224677563;2266.331432227497;2273.1589311954517;2281.1445707859552;2296.9425764355856;9290.535473226379;9324.160825525736;9333.206677432427;9342.439453632804;9368.57841397132;5254.343207099113;5363.249145119687;5379.085555455582;5379.838604841861;5391.514763671288;3255.2675647979254;3274.6070471543567;3281.1633033576286;3285.655006224336;3360.8823691170937;1006.4967516241879;1015.9695209143738;1017.018577073128;1017.776089260369;1029.2897900448665;12483.812742808865;12555.372231388394;12638.431270592846;13040.217586944718;13079.41142648583;4348.673849461303;4415.359772832921;4485.394471746337;4495.865124046284;4539.205639013159;10002.599896004223;10059.44673042975;10060.647877324258;10079.848802267972;10092.495375231209;5195.6622819516615;5196.090684130262;5198.844034678966;5199.7920083197005;5205.193195054772;4251.086016506466;4646.83736069236;4829.420469543677;4857.684250523705;4896.975515122473;3917.216556688674;3965.9603403966166;4082.7346222495444;4176.8120434579905;4185.455890734185;1270.5224811617384;1277.5464710027993;1295.6825577733516;1297.4680381043727;1306.2423794199342;993.4635296939716;998.7003898830321;1017.3793985668736;1020.9132223760915;1028.7068185567077;5988.37122102173;6040.426159514839;6181.84545386369;6195.535334849814;6264.718087686065;423.96184343408623;427.2821659611882;432.7684688691535;433.1121201536837;437.25448110970717;4113.177364527107;4139.317012692933;4196.118815048874;4208.263553878059;4224.640905523065;11276.830847537294;11602;11622.360770157722;11662.067034637208;11680.824787628193;11002.174836887265;11238.157138214667;11371.772564548663;11495.71260718472;11516.193866429438;8165.265126138676;8177.754667359989;8218.958905205554;8256.628451719687;8306.8338633227;6016.939830601638;6078.969605151946;6165.969170154121;6235.625862448268;6242.65665388408;10346.896531034594;10377.533011014673;10431.791364172523;10577.36535807854;10586.629467968583;10004.549795259376;10370.948145259226;10433.582656693647;10463.581456741646;10648.361098334124;7248;7680.5391676499585;7848.254415830487;7980.122186559358;8135.145809690134;8978.595963181542;8987;9071.274298056007;9073.682421115229;9078.31912606544;7999.080105787676;8003.439759217032;8208.712695055645;8298.792530186553;8313.625886835229;7935.484193527403;7972.402069844668;8001.559914204775;8010.198980101944;8178.386621003329;7384.630768461448;7439.665215065227;7475.2151024141685;7494.325510704063;7599.4680372373405;5192.844214673566;5212.270282160424;5231.581473482189;5237.607179461479;5479.150731636602;5129.410117836496;5149.304843846033;5162.045021671003;5208.583313334849;5258.710770907637 01:52:42 INFO - PROCESS | 1403 | |4;prototype.html;296.24309888235564;313.36699866270135;314.93701259748025;318.19337978225195;323.94169049571076;5460.071787796074;5494.32423110951;5583.413741557139;5626.943730562693;5647.265855438793;5542.722863856811;5569.693666848332;5590.692511911843;5608.327000759915;5636.549076073915;4326.502452217988;4329.199098166833;4361.542038086003;4370.934435983463;4381.408509851161;4074.3684728867074;4249.150169966004;4297.269464191095;4313.964648484357;4384.473863136413;4246.766427846467;4252.19208350414;4262.190183865071;4268.253055715253;4271.1671224111315;4263.808128634203;4290.613844753956;4298.247806633843;4301.78491075445;4324.286492728696;3518.47222916562;3754.4180651998986;3758.699304055669;3771.3965765477665;3775.754575952554;5352.330958630171;5413.350397952231;5448.945510544883;5456.61803673743;5469.890602187974;4925.950740492585;4943.307936888838;4943.431505376891;4943.6539442239055;4949.455559888409;5636.379998200195;5808.361080281165;5864.7067646617925;5899.410058994109;5917.792877249276;4147.6474499667565;4176.561461046607;4186.120914607936;4190.53904070552;4191.3293872980175;6107.908381374283;6145.251396648041;6152.292486364081;6156.6613836238985;6270.843228919268;4128.6284234419045;4293.5706429356815;4316.978415107905;4327.156204540147;4362.890927726832;4356.172327257874;4396.054848207651;4400.669949753717;4405.933910991338;4406;5019.422766381913;5021.121303771825;5021.824236151717;5026.723530205873;5054.9241761373605;5801.390853960358;5918.496927761103;5960.642361458326;6001.7599296027665;6037.9396206038255;1498.8351281359041;1503.5339044896118;1503.6090616439803;1504.0599625234229;1506.6158129676862;936.4548494983223;958.9232861371213;967.7241986033946;976.4775844923074;982.6413359124011;5037.269595908573;5048.334049763569;5087.592992560586;5097.655078663782;5100.48995100487;5299.947000530023;5320.813771517978;5322.467753224647;5340.7688348549345;5351.046867893191;4835.639230734676;5048.848534543969;5061.670991385548;5069.467705890902;5125.794968201305;2808.719128087175;2870.5263631500984;2888.306806366499;2888.324771632448;2888.884444622234;5470.835874923759;5514.944850551524;5516.503514683698;5519.8260999924405;5555.666660000413;5210.649107994791;5342.767625586542;5430.56555475561;5439.830436456181;5483.862903427446;5419.729013549307;5463.7814487420055;5490.615656903979;5504.752286147133;5534.813748569292;5340.252364669027;5370.919436208382;5411.431799660979;5420.186971954238;5680.68756218412;5972.70136493165;6010.278766548042;6011.128386384037;6023.789167379121;6084.695765211633;6306.621602703853;6330.277980468259;6351.872962540816;6371.235451745635;6412.134361861089;3909.5504017038406;4049.230646177217;4129.380592911088;4185.539590645088;4186.748795072183;6019.080745838178;6033.909491357545;6045.697715114139;6048.243969503812;6078.179445774764;5699.344575373885;5866.413358664099;5887.322957859901;5912.320083190488;5954.136650185612;5776.826695199151;5847.356790752929;5860.443257890493;5894.789453954767;5923.970380148072;5814.5348372130975;5857.736401861841;5859.882802344015;5861.531077513703;5868.882622347443;5697.971510142423;5910.202122713551;5936.1689363488285;5985.820425387245;5991.191189189578;5837.357890632112;5899.882002359843;5911;5913.733881975408;5925.792597259076 01:52:42 INFO - PROCESS | 1403 | |5;yui.html;740.5334639177318;756.8145804277951;770.9421793365498;771.8263390737085;862.598891515446;15543.378264869405;16211.270492827822;16300.103494307808;16344;16345.591360216;15754.448594299201;15815.209239538006;15885.682286354266;15895.28471218795;15938;650.5771248688343;786.0371045469298;794.2057942057942;797.0475282037967;797.9281864632181;796.0884786918974;799.6641410607559;804.7022601637373;807.6567458830003;809.380823669893;853.4409961475212;856.7643897928058;860.6256278518833;862.9395942284043;864.2869632553137;847.0386111763162;847.3306088190353;852.26705033671;853.5177624642057;858.5149390594356;627.0844566932284;628.4061561824078;629.9275583307932;631.3055638797332;632.3865850125371;15114.39542418302;15118.848811511854;15291.770623440658;15297.847021529753;15305.693886122326;15898.841011589851;15962.840371596367;16116.194190290438;16188;16247.512574622662;11616.88383116175;11900.464479098462;11987.400629968466;12105.15263931525;12248.326342051183;3943.4084887266854;3959.3862951242604;3975.2447035063246;4003.11931375097;4057.7159598827798;81905.18094819094;83161.16838831655;84456.57771711164;86237;87497.56251218703;11996.520139194508;11998.58004969822;12016.25798913828;12130.150889437655;12185.573504927463;22924.312270631908;22974;23058.538829223322;23166.7683323168;23560.29319120429;8349.33205343571;8426.705065322683;8501.532415717194;8542.829143417097;8770.51762153075;4586.701864378805;4730.810767569259;4809.350737650442;4830.734309613005;5046.974765126224;3678.3930651442747;3738.32710112177;3748.4002559590335;3750.043738846631;3754.511913451234;619.4796371048341;634.4480302137171;635.7711223959371;650.9641969691712;658.6542065415599;691.2983321928247;730.4339137168737;787.2127872127872;788.7791418402857;788.9900031380266;9286.860697089549;9714.708558743248;10111.736587363832;10492.26554141218;10683.679489615324;676.5872817581271;724.1274264511251;743.1759314604482;796.9790320977817;830.6801881275632;4987.501249874984;5195.050065000137;5260.605454590921;5293.841184764463;5338.439463856239;116237.41881290708;116832;119110;121555;121981;100102.4994875021;101945;103852;104287;108740.456297718;90678;91227.54386228159;91366.54316728507;92490;92627.99999999865;9271.397359171633;9480.478573678514;9747.317687762072;10054.49727513636;10099.899001009895;38621.80689096537;48688.903500905646;50009;52141.47858521366;52351.214731779815;77234;78556;78929.21070789218;79096.20903790889;80179.59910200411;12283.938580307042;12285.938570307091;12311.938440307742;12447.066470014966;12608;12987.935060324638;12989.28558929268;13191.934040329737;13248.271345076113;13914.721705566035;13089.41097650589;13106.475740970254;13344.199348039148;13718.0397372183;14083.366248518636;12658.303793291458;12667.176633518791;13008.284544350152;13044.02169837285;13133.277669728257;12922.483100676243;13359.933200334324;13370.197788132744;13703.657408564866;13815.79276310836;10609.628662996758;10777.407242601732;10855.29440586391;10870.130389568974;11145.331280123219;9635.710928672152;9916.355436896578;10681.58900991379;11352.262102963281;11629.24409913353 01:52:42 INFO - PROCESS | 1403 | __end_tp_report 01:52:42 INFO - PROCESS | 1403 | __start_cc_report 01:52:42 INFO - PROCESS | 1403 | _x_x_mozilla_cycle_collect,350 01:52:42 INFO - PROCESS | 1403 | __end_cc_report 01:52:42 INFO - PROCESS | 1403 | __startTimestamp1469609562882__endTimestamp 01:52:42 INFO - PROCESS | 1403 | 01:52:42 INFO - PROCESS | 1403 | ------- Summary: start ------- 01:52:42 INFO - PROCESS | 1403 | Number of tests: 6 01:52:42 INFO - PROCESS | 1403 | 01:52:42 INFO - PROCESS | 1403 | [#0] dojo.html Cycles:165 Average:5412.97 Median:5633.86 stddev:625.55 (11.1%) stddev-sans-first:600.77 01:52:42 INFO - PROCESS | 1403 | Values: 3108.1 3131.3 3148.1 3157.8 3157.9 5376.7 5407.2 5465.6 5493.7 5496.0 5341.3 5360.5 5415.7 5433.5 5466.3 4835.1 4929.5 4979.1 4988.2 5052.1 4930.4 4974.1 4986.1 5041.4 5101.1 4844.4 4910.0 4919.0 4968.3 5011.8 4967.5 4968.0 4969.7 4986.3 4995.9 4819.9 4938.5 4944.8 4950.5 4978.7 5344.8 5349.8 5363.3 5477.8 5482.5 5813.6 5821.7 5828.9 5830.7 5842.4 5701.7 5872.9 5876.1 5878.6 5882.6 5374.8 5407.5 5438.9 5476.4 5535.7 5946.6 5969.2 5983.4 5995.2 6001.1 5636.8 5749.3 5754.4 5755.2 5758.5 5697.4 5709.7 5775.2 5789.5 5839.3 5619.6 5740.1 5764.2 5848.9 5852.6 5799.2 5806.2 5870.5 5871.9 5874.5 4344.7 4356.0 4363.1 4366.9 4470.7 3931.6 3931.6 3954.8 3963.9 3972.1 5580.6 5582.5 5586.7 5591.8 5633.9 5703.3 5721.0 5721.7 5723.4 5863.9 5472.5 5481.3 5530.1 5537.4 5544.0 4947.2 4959.4 4965.0 4977.1 4988.1 5947.0 5951.9 5974.6 5987.8 6020.4 5839.2 5843.5 5849.2 5856.8 5886.8 6053.3 6064.2 6074.1 6076.0 6076.4 5518.7 5728.4 5747.0 5792.7 5800.9 5909.3 5952.6 5958.0 5963.3 6013.9 5718.9 5751.1 5767.1 5781.2 5791.8 5526.6 5631.1 5706.7 5728.2 5783.6 5679.5 5694.9 5698.2 5712.2 5713.9 5780.5 5805.4 5828.1 5834.0 5835.5 5434.6 5535.1 5550.0 5589.9 5650.3 01:52:42 INFO - PROCESS | 1403 | 01:52:42 INFO - PROCESS | 1403 | [#1] ext.html Cycles:180 Average:62367.19 Median:43208.39 stddev:129356.15 (299.4%) stddev-sans-first:129635.75 01:52:42 INFO - PROCESS | 1403 | Values: 544.6 574.4 585.5 593.8 605.7 31163.0 43797.8 44986.3 45045.3 48247.5 45511.0 45990.3 46029.1 46056.0 46285.8 9094.8 9236.5 9242.7 9244.7 9255.3 9021.7 9064.4 9156.1 9169.6 9247.0 9202.9 9237.3 9251.0 9307.9 9308.5 9187.1 9197.4 9198.0 9218.4 9222.0 9082.5 9150.5 9153.5 9171.0 9175.8 43536.6 43861.0 43924.6 43968.1 44003.6 3518.5 3596.9 3664.1 3720.4 4105.0 33612.7 33951.8 34206.3 34281.3 34459.7 4412.3 4429.9 4457.3 4549.4 4561.0 351296.0 355741.0 355756.0 357965.0 358714.0 32899.5 34304.1 58099.4 58221.4 58802.4 36494.5 36543.5 36567.0 36646.0 36671.3 15058.0 15235.8 15271.8 15319.5 15321.6 11960.0 12091.9 12207.9 12210.1 12226.0 8144.3 8154.1 8176.0 8293.6 8307.5 3145.7 3186.2 3199.5 3208.5 3225.9 1026.5 1027.3 1048.5 1050.4 1112.2 33740.7 33856.5 33902.7 34064.1 34130.3 1079.8 1087.3 1130.8 1180.0 1197.8 17548.8 17618.0 17625.6 17718.9 17762.0 581425.0 583824.0 584352.0 589794.0 600363.0 57427.0 57878.0 58219.1 58290.1 58561.4 1341.6 1359.4 1367.2 1373.6 1374.1 30589.5 32751.2 33040.3 33164.7 33246.7 52175.5 52199.2 52491.9 52570.2 52821.5 482021.0 484071.0 486015.0 486219.0 486541.0 28030.7 28402.4 28428.9 28735.6 28764.6 47963.5 48505.8 48642.8 49635.0 49857.3 41176.4 42355.8 43275.8 43377.3 44000.0 42439.4 42480.0 43141.0 43416.0 43905.6 41600.2 42261.0 42970.8 43358.8 44981.3 32734.5 37992.4 38009.4 38770.2 39551.6 28787.0 29198.7 29344.1 29379.6 29547.0 01:52:42 INFO - PROCESS | 1403 | 01:52:42 INFO - PROCESS | 1403 | [#2] jquery.html Cycles:180 Average:28587.70 Median:380.38 stddev:82287.07 (21633.0%) stddev-sans-first:82490.63 01:52:42 INFO - PROCESS | 1403 | Values: 374.0 386.8 390.1 402.4 411.9 17523.8 19319.5 19812.3 20223.6 20231.0 11723.7 11767.7 12015.8 12078.5 12096.2 4931.0 5156.1 5161.1 5182.8 5194.7 4910.5 5103.5 5151.4 5188.9 5201.7 5066.2 5074.9 5099.8 5101.1 5110.5 5024.9 5037.1 5088.3 5099.5 5134.9 4914.8 4989.8 5027.8 5038.4 5054.3 13010.5 13175.3 13310.5 13445.3 13565.7 2236.6 2295.9 2319.8 2364.3 2604.4 9017.0 9140.5 9150.4 9653.7 10179.5 1767.4 1797.3 1801.7 1848.8 1882.2 78904.0 82633.0 86556.1 87097.0 88847.6 10191.4 10358.6 10424.1 10656.3 11099.7 14190.4 14246.5 14254.2 14269.9 14328.6 7903.5 8328.7 8339.4 8554.1 8566.3 7805.2 7818.6 7984.7 8027.1 8063.4 4291.6 4511.0 4544.4 4645.6 4698.2 1886.7 1934.8 1939.4 1946.4 1986.9 944.2 1031.4 1049.9 1051.5 1072.4 19849.4 20642.9 20655.2 20664.3 20721.7 977.9 1023.7 1038.4 1056.6 1057.6 10798.2 11209.7 11312.0 11432.1 11447.7 491100.0 496661.0 498392.0 501332.0 503638.0 74718.3 93526.0 94158.5 94403.5 94585.0 974.7 986.4 1005.6 1010.3 1016.2 16954.7 16990.4 17456.5 17816.5 18374.6 34972.7 43154.8 43248.6 43251.0 43349.8 55107.7 58250.0 58862.1 59019.0 60423.0 7221.5 7359.8 7373.2 8125.2 8129.8 9065.3 12492.1 12537.8 12627.6 13761.1 9932.2 9964.6 10811.6 10836.2 11209.7 10415.5 10714.3 10848.7 11504.4 11508.7 11394.8 11863.3 11879.9 12031.9 12306.5 7320.5 7368.4 7408.9 7549.1 7649.0 10741.4 10889.8 11314.4 11473.4 12178.1 01:52:42 INFO - PROCESS | 1403 | 01:52:42 INFO - PROCESS | 1403 | [#3] mootools.html Cycles:180 Average:5932.66 Median:430.03 stddev:3465.53 (805.9%) stddev-sans-first:3459.23 01:52:42 INFO - PROCESS | 1403 | Values: 1497.8 1506.6 1663.8 1774.4 1775.9 8160.7 8785.3 8833.7 9410.0 9414.6 8903.2 9203.6 9206.4 9225.2 9247.7 2304.9 2342.3 2343.9 2348.3 2349.4 2229.2 2290.2 2315.7 2316.4 2318.0 2334.0 2339.9 2348.1 2353.8 2357.4 2268.4 2274.9 2277.6 2296.9 2297.7 2246.8 2266.3 2273.2 2281.1 2296.9 9290.5 9324.2 9333.2 9342.4 9368.6 5254.3 5363.2 5379.1 5379.8 5391.5 3255.3 3274.6 3281.2 3285.7 3360.9 1006.5 1016.0 1017.0 1017.8 1029.3 12483.8 12555.4 12638.4 13040.2 13079.4 4348.7 4415.4 4485.4 4495.9 4539.2 10002.6 10059.4 10060.6 10079.8 10092.5 5195.7 5196.1 5198.8 5199.8 5205.2 4251.1 4646.8 4829.4 4857.7 4897.0 3917.2 3966.0 4082.7 4176.8 4185.5 1270.5 1277.5 1295.7 1297.5 1306.2 993.5 998.7 1017.4 1020.9 1028.7 5988.4 6040.4 6181.8 6195.5 6264.7 424.0 427.3 432.8 433.1 437.3 4113.2 4139.3 4196.1 4208.3 4224.6 11276.8 11602.0 11622.4 11662.1 11680.8 11002.2 11238.2 11371.8 11495.7 11516.2 8165.3 8177.8 8219.0 8256.6 8306.8 6016.9 6079.0 6166.0 6235.6 6242.7 10346.9 10377.5 10431.8 10577.4 10586.6 10004.5 10370.9 10433.6 10463.6 10648.4 7248.0 7680.5 7848.3 7980.1 8135.1 8978.6 8987.0 9071.3 9073.7 9078.3 7999.1 8003.4 8208.7 8298.8 8313.6 7935.5 7972.4 8001.6 8010.2 8178.4 7384.6 7439.7 7475.2 7494.3 7599.5 5192.8 5212.3 5231.6 5237.6 5479.2 5129.4 5149.3 5162.0 5208.6 5258.7 01:52:42 INFO - PROCESS | 1403 | 01:52:42 INFO - PROCESS | 1403 | [#4] prototype.html Cycles:180 Average:4806.33 Median:5412.39 stddev:1421.86 (26.3%) stddev-sans-first:1384.97 01:52:42 INFO - PROCESS | 1403 | Values: 296.2 313.4 314.9 318.2 323.9 5460.1 5494.3 5583.4 5626.9 5647.3 5542.7 5569.7 5590.7 5608.3 5636.5 4326.5 4329.2 4361.5 4370.9 4381.4 4074.4 4249.2 4297.3 4314.0 4384.5 4246.8 4252.2 4262.2 4268.3 4271.2 4263.8 4290.6 4298.2 4301.8 4324.3 3518.5 3754.4 3758.7 3771.4 3775.8 5352.3 5413.4 5448.9 5456.6 5469.9 4926.0 4943.3 4943.4 4943.7 4949.5 5636.4 5808.4 5864.7 5899.4 5917.8 4147.6 4176.6 4186.1 4190.5 4191.3 6107.9 6145.3 6152.3 6156.7 6270.8 4128.6 4293.6 4317.0 4327.2 4362.9 4356.2 4396.1 4400.7 4405.9 4406.0 5019.4 5021.1 5021.8 5026.7 5054.9 5801.4 5918.5 5960.6 6001.8 6037.9 1498.8 1503.5 1503.6 1504.1 1506.6 936.5 958.9 967.7 976.5 982.6 5037.3 5048.3 5087.6 5097.7 5100.5 5299.9 5320.8 5322.5 5340.8 5351.0 4835.6 5048.8 5061.7 5069.5 5125.8 2808.7 2870.5 2888.3 2888.3 2888.9 5470.8 5514.9 5516.5 5519.8 5555.7 5210.6 5342.8 5430.6 5439.8 5483.9 5419.7 5463.8 5490.6 5504.8 5534.8 5340.3 5370.9 5411.4 5420.2 5680.7 5972.7 6010.3 6011.1 6023.8 6084.7 6306.6 6330.3 6351.9 6371.2 6412.1 3909.6 4049.2 4129.4 4185.5 4186.7 6019.1 6033.9 6045.7 6048.2 6078.2 5699.3 5866.4 5887.3 5912.3 5954.1 5776.8 5847.4 5860.4 5894.8 5924.0 5814.5 5857.7 5859.9 5861.5 5868.9 5698.0 5910.2 5936.2 5985.8 5991.2 5837.4 5899.9 5911.0 5913.7 5925.8 01:52:42 INFO - PROCESS | 1403 | 01:52:42 INFO - PROCESS | 1403 | [#5] yui.html Cycles:180 Average:21576.33 Median:3967.32 stddev:31553.05 (795.3%) stddev-sans-first:31602.78 01:52:42 INFO - PROCESS | 1403 | Values: 740.5 756.8 770.9 771.8 862.6 15543.4 16211.3 16300.1 16344.0 16345.6 15754.4 15815.2 15885.7 15895.3 15938.0 650.6 786.0 794.2 797.0 797.9 796.1 799.7 804.7 807.7 809.4 853.4 856.8 860.6 862.9 864.3 847.0 847.3 852.3 853.5 858.5 627.1 628.4 629.9 631.3 632.4 15114.4 15118.8 15291.8 15297.8 15305.7 15898.8 15962.8 16116.2 16188.0 16247.5 11616.9 11900.5 11987.4 12105.2 12248.3 3943.4 3959.4 3975.2 4003.1 4057.7 81905.2 83161.2 84456.6 86237.0 87497.6 11996.5 11998.6 12016.3 12130.2 12185.6 22924.3 22974.0 23058.5 23166.8 23560.3 8349.3 8426.7 8501.5 8542.8 8770.5 4586.7 4730.8 4809.4 4830.7 5047.0 3678.4 3738.3 3748.4 3750.0 3754.5 619.5 634.4 635.8 651.0 658.7 691.3 730.4 787.2 788.8 789.0 9286.9 9714.7 10111.7 10492.3 10683.7 676.6 724.1 743.2 797.0 830.7 4987.5 5195.1 5260.6 5293.8 5338.4 116237.4 116832.0 119110.0 121555.0 121981.0 100102.5 101945.0 103852.0 104287.0 108740.5 90678.0 91227.5 91366.5 92490.0 92628.0 9271.4 9480.5 9747.3 10054.5 10099.9 38621.8 48688.9 50009.0 52141.5 52351.2 77234.0 78556.0 78929.2 79096.2 80179.6 12283.9 12285.9 12311.9 12447.1 12608.0 12987.9 12989.3 13191.9 13248.3 13914.7 13089.4 13106.5 13344.2 13718.0 14083.4 12658.3 12667.2 13008.3 13044.0 13133.3 12922.5 13359.9 13370.2 13703.7 13815.8 10609.6 10777.4 10855.3 10870.1 11145.3 9635.7 9916.4 10681.6 11352.3 11629.2 01:52:42 INFO - PROCESS | 1403 | -------- Summary: end -------- 01:52:42 INFO - PROCESS | 1403 | 01:52:43 INFO - TEST-INFO | 1403: exit 0 01:52:43 INFO - TEST-OK | dromaeo_css | took 1111399ms 01:52:43 INFO - TEST-START | kraken 01:52:43 INFO - operating with platform_type : linux_ 01:52:43 INFO - Initialising browser for kraken test... 01:52:43 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph_dKrU/profile http://localhost:45579/getInfo.html) 01:52:46 INFO - PROCESS | 1647 | JavaScript error: , line 0: uncaught exception: undefined 01:52:48 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 01:52:48 INFO - PROCESS | 1647 | colorDepth:24 01:52:48 INFO - PROCESS | 1647 | Browser inner width/height: 1024/697 01:52:48 INFO - PROCESS | 1647 | __metrics 01:52:48 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:52:49 INFO - TEST-INFO | 1647: exit 0 01:52:49 INFO - Browser initialized. 01:52:49 INFO - Running cycle 1/1 for kraken test... 01:52:49 INFO - TEST-INFO | started process 1766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph_dKrU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:53:01 INFO - PROCESS | 1766 | RSS: Main: 164536320 01:53:01 INFO - PROCESS | 1766 | 01:53:04 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45579/tests/kraken/driver.html?testName=audio-beat-detection) 01:53:04 INFO - PROCESS | 1766 | RSS: Main: 170102784 01:53:04 INFO - PROCESS | 1766 | 01:53:07 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45579/tests/kraken/driver.html?testName=audio-dft) 01:53:08 INFO - PROCESS | 1766 | RSS: Main: 169385984 01:53:08 INFO - PROCESS | 1766 | 01:53:11 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45579/tests/kraken/driver.html?testName=audio-fft) 01:53:11 INFO - PROCESS | 1766 | RSS: Main: 164868096 01:53:11 INFO - PROCESS | 1766 | 01:53:13 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45579/tests/kraken/driver.html?testName=audio-oscillator) 01:53:14 INFO - PROCESS | 1766 | RSS: Main: 166301696 01:53:14 INFO - PROCESS | 1766 | 01:53:16 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45579/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:53:17 INFO - PROCESS | 1766 | RSS: Main: 166547456 01:53:17 INFO - PROCESS | 1766 | 01:53:20 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45579/tests/kraken/driver.html?testName=imaging-darkroom) 01:53:20 INFO - PROCESS | 1766 | RSS: Main: 166129664 01:53:20 INFO - PROCESS | 1766 | 01:53:24 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45579/tests/kraken/driver.html?testName=imaging-desaturate) 01:53:25 INFO - PROCESS | 1766 | RSS: Main: 164118528 01:53:25 INFO - PROCESS | 1766 | 01:53:27 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45579/tests/kraken/driver.html?testName=json-parse-financial) 01:53:28 INFO - PROCESS | 1766 | RSS: Main: 165801984 01:53:28 INFO - PROCESS | 1766 | 01:53:30 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45579/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:53:30 INFO - PROCESS | 1766 | RSS: Main: 165990400 01:53:30 INFO - PROCESS | 1766 | 01:53:32 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45579/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:53:33 INFO - PROCESS | 1766 | RSS: Main: 166109184 01:53:33 INFO - PROCESS | 1766 | 01:53:35 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45579/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:53:35 INFO - PROCESS | 1766 | RSS: Main: 167018496 01:53:35 INFO - PROCESS | 1766 | 01:53:38 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:53:39 INFO - PROCESS | 1766 | RSS: Main: 167628800 01:53:39 INFO - PROCESS | 1766 | 01:53:41 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:53:42 INFO - PROCESS | 1766 | RSS: Main: 167268352 01:53:42 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | Cycle 1(1): loaded http://localhost:45579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45579/tests/kraken/driver.html?testName=ai-astar) 01:53:44 INFO - PROCESS | 1766 | RSS: Main: 167890944 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | __start_tp_report 01:53:44 INFO - PROCESS | 1766 | _x_x_mozilla_page_load 01:53:44 INFO - PROCESS | 1766 | _x_x_mozilla_page_load_details 01:53:44 INFO - PROCESS | 1766 | |i|pagename|runs| 01:53:44 INFO - PROCESS | 1766 | |0;ai-astar;101;113;106;112;113;112;115;111;113;112 01:53:44 INFO - PROCESS | 1766 | |1;audio-beat-detection;149;118;150;178;122;147;149;120;183;124 01:53:44 INFO - PROCESS | 1766 | |2;audio-dft;162;164;164;164;163;165;175;162;162;162 01:53:44 INFO - PROCESS | 1766 | |3;audio-fft;75;76;75;166;77;76;75;75;167;77 01:53:44 INFO - PROCESS | 1766 | |4;audio-oscillator;85;83;158;85;85;84;137;85;84;137 01:53:44 INFO - PROCESS | 1766 | |5;imaging-gaussian-blur;117;118;118;117;117;117;117;117;117;117 01:53:44 INFO - PROCESS | 1766 | |6;imaging-darkroom;149;148;147;147;147;151;151;150;147;147 01:53:44 INFO - PROCESS | 1766 | |7;imaging-desaturate;95;97;96;95;95;95;96;96;96;95 01:53:44 INFO - PROCESS | 1766 | |8;json-parse-financial;52;53;53;52;57;52;52;54;51;55 01:53:44 INFO - PROCESS | 1766 | |9;json-stringify-tinderbox;63;62;62;61;63;62;63;63;63;63 01:53:44 INFO - PROCESS | 1766 | |10;stanford-crypto-aes;79;78;78;77;79;75;78;77;82;78 01:53:44 INFO - PROCESS | 1766 | |11;stanford-crypto-ccm;124;123;136;133;130;127;124;131;168;132 01:53:44 INFO - PROCESS | 1766 | |12;stanford-crypto-pbkdf2;160;159;158;159;162;159;162;155;169;166 01:53:44 INFO - PROCESS | 1766 | |13;stanford-crypto-sha256-iterative;72;68;64;64;64;71;72;66;63;63 01:53:44 INFO - PROCESS | 1766 | __end_tp_report 01:53:44 INFO - PROCESS | 1766 | __start_cc_report 01:53:44 INFO - PROCESS | 1766 | _x_x_mozilla_cycle_collect,859 01:53:44 INFO - PROCESS | 1766 | __end_cc_report 01:53:44 INFO - PROCESS | 1766 | __startTimestamp1469609624458__endTimestamp 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | ------- Summary: start ------- 01:53:44 INFO - PROCESS | 1766 | Number of tests: 14 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:4.16 (3.7%) stddev-sans-first:2.47 01:53:44 INFO - PROCESS | 1766 | Values: 101.0 113.0 106.0 112.0 113.0 112.0 115.0 111.0 113.0 112.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:149.00 stddev:23.35 (15.7%) stddev-sans-first:24.70 01:53:44 INFO - PROCESS | 1766 | Values: 149.0 118.0 150.0 178.0 122.0 147.0 149.0 120.0 183.0 124.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:3.92 (2.4%) stddev-sans-first:4.07 01:53:44 INFO - PROCESS | 1766 | Values: 162.0 164.0 164.0 164.0 163.0 165.0 175.0 162.0 162.0 162.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.50 stddev:38.27 (50.7%) stddev-sans-first:39.98 01:53:44 INFO - PROCESS | 1766 | Values: 75.0 76.0 75.0 166.0 77.0 76.0 75.0 75.0 167.0 77.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.50 stddev:29.34 (34.7%) stddev-sans-first:30.45 01:53:44 INFO - PROCESS | 1766 | Values: 85.0 83.0 158.0 85.0 85.0 84.0 137.0 85.0 84.0 137.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:53:44 INFO - PROCESS | 1766 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.71 (1.2%) stddev-sans-first:1.80 01:53:44 INFO - PROCESS | 1766 | Values: 149.0 148.0 147.0 147.0 147.0 151.0 151.0 150.0 147.0 147.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 01:53:44 INFO - PROCESS | 1766 | Values: 95.0 97.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:1.79 (3.4%) stddev-sans-first:1.86 01:53:44 INFO - PROCESS | 1766 | Values: 52.0 53.0 53.0 52.0 57.0 52.0 52.0 54.0 51.0 55.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 01:53:44 INFO - PROCESS | 1766 | Values: 63.0 62.0 62.0 61.0 63.0 62.0 63.0 63.0 63.0 63.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:1.79 (2.3%) stddev-sans-first:1.87 01:53:44 INFO - PROCESS | 1766 | Values: 79.0 78.0 78.0 77.0 79.0 75.0 78.0 77.0 82.0 78.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:131.50 stddev:13.10 (10.0%) stddev-sans-first:13.51 01:53:44 INFO - PROCESS | 1766 | Values: 124.0 123.0 136.0 133.0 130.0 127.0 124.0 131.0 168.0 132.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.00 stddev:4.07 (2.5%) stddev-sans-first:4.30 01:53:44 INFO - PROCESS | 1766 | Values: 160.0 159.0 158.0 159.0 162.0 159.0 162.0 155.0 169.0 166.0 01:53:44 INFO - PROCESS | 1766 | 01:53:44 INFO - PROCESS | 1766 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:3.74 (5.6%) stddev-sans-first:3.44 01:53:44 INFO - PROCESS | 1766 | Values: 72.0 68.0 64.0 64.0 64.0 71.0 72.0 66.0 63.0 63.0 01:53:44 INFO - PROCESS | 1766 | -------- Summary: end -------- 01:53:44 INFO - PROCESS | 1766 | 01:53:45 INFO - TEST-INFO | 1766: exit 0 01:53:45 INFO - TEST-OK | kraken | took 61844ms 01:53:45 INFO - SUITE-END | took 1173s 01:53:45 INFO - Completed test suite (00:19:33) 01:53:45 INFO - javascript benchmark 01:53:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7199.246060350814, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.1297236773703, 3131.311111555457, 3148.1342630776535, 3157.778955473116, 3157.9368412631748, 5376.650517716345, 5407.188921661747, 5465.59008074394, 5493.670379777216, 5496.0, 5341.30563026807, 5360.517553420192, 5415.675059496433, 5433.510984011438, 5466.262054622624, 4835.105505481497, 4929.50704929506, 4979.10376132296, 4988.152014157602, 5052.14113600687, 4930.359053323063, 4974.1295273327205, 4986.10250154972, 5041.445441001505, 5101.132807422747, 4844.394450693663, 4909.975450122763, 4919.040787046527, 4968.254761785725, 5011.774470148852, 4967.4784147664695, 4968.0, 4969.701817890938, 4986.326845875833, 4995.9250611240495, 4819.903601927942, 4938.4814594467425, 4944.777485013183, 4950.529699678525, 4978.6763860348965, 5344.812931547377, 5349.759260833272, 5363.275957745733, 5477.780888764445, 5482.506574408322, 5813.593048486608, 5821.67980761058, 5828.912566311508, 5830.650160990312, 5842.415758424124, 5701.71491425427, 5872.941270587282, 5876.059830427112, 5878.559108066912, 5882.617629854046, 5374.838754837361, 5407.540359069484, 5438.8912221755345, 5476.370217424967, 5535.723213839332, 5946.583739138306, 5969.224000879858, 5983.37174596661, 5995.190649262381, 6001.12983617373, 5636.802711905146, 5749.310082790092, 5754.395788442237, 5755.194272801811, 5758.452946970031, 5697.373288938214, 5709.714514274353, 5775.220345253421, 5789.45000224978, 5839.270091238595, 5619.578531610146, 5740.1102829061565, 5764.221830052973, 5848.88302233953, 5852.619579727304, 5799.159121927381, 5806.187133801272, 5870.530357571384, 5871.882562348729, 5874.500667443315, 4344.695871288979, 4355.956440435619, 4363.127374525045, 4366.934495982499, 4470.664700147502, 3931.567527571965, 3931.6461518463475, 3954.8220330085214, 3963.8810835674976, 3972.106276087915, 5580.553555715533, 5582.49757521825, 5586.748596313176, 5591.832245032656, 5633.859153521113, 5703.315602127771, 5721.0, 5721.656700597978, 5723.399043100498, 5863.912041319383, 5472.50747432733, 5481.287432633732, 5530.087535556588, 5537.446255374431, 5543.972280138573, 4947.158982972904, 4959.429665588431, 4965.0, 4977.104121258136, 4988.12707776145, 5946.959282125611, 5951.940480595139, 5974.581779275409, 5987.760489580455, 6020.397960204032, 5839.182514448065, 5843.532517398683, 5849.181114643869, 5856.795012174553, 5886.793962211302, 6053.273607167168, 6064.151018857452, 6074.088886667036, 6076.0278355462915, 6076.361981991828, 5518.724063796874, 5728.3985181557, 5747.0, 5792.652440853562, 5800.9419905800405, 5909.349971503218, 5952.553558483218, 5958.046712525975, 5963.2844058713235, 6013.879722405615, 5718.914216286842, 5751.1085781703905, 5767.106098554731, 5781.161731548817, 5791.82624521265, 5526.640768350045, 5631.1271752878365, 5706.743196556082, 5728.198052272602, 5783.566232532493, 5679.488846003879, 5694.914576281276, 5698.173764803997, 5712.200291959212, 5713.914291285717, 5780.450857168562, 5805.41945805433, 5828.0966450200285, 5833.970830145822, 5835.4748072673665, 5434.565234781129, 5535.059039963136, 5549.972250138723, 5589.888202235851, 5650.3219613646625], "value": 5369.931407663418, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.5793585962776, 574.3509833887706, 585.5227989188813, 593.8099808061422, 605.73650462049, 31163.0, 43797.78101109494, 44986.32520512191, 45045.32432013514, 48247.51752482474, 45511.0, 45990.310145347845, 46029.07941841161, 46056.0, 46285.76857115718, 9094.818103637923, 9236.538173091352, 9242.72271831846, 9244.722658320228, 9255.259579233645, 9021.729348119567, 9064.36549441536, 9156.084391560857, 9169.633214671405, 9247.0, 9202.861957070649, 9237.261019118489, 9250.982391936881, 9307.90692093077, 9308.534573271309, 9187.081291870792, 9197.356185067049, 9198.034206408298, 9218.446893186398, 9222.0, 9082.545872706338, 9150.450972941644, 9153.542322883895, 9171.0, 9175.770605734844, 43536.56463435388, 43861.0, 43924.56075439237, 43968.12063758739, 44003.559964400265, 3518.48981897626, 3596.856125754967, 3664.1022949377307, 3720.3675375186285, 4104.958950410488, 33612.663873361445, 33951.793133446496, 34206.31587368239, 34281.31437371264, 34459.655403446144, 4412.271975124101, 4429.933550996738, 4457.264551349023, 4549.385832912548, 4561.042181141964, 351296.0, 355740.99999999744, 355756.0, 357965.0, 358714.0, 32899.50650740241, 34304.142396440286, 58099.4190058094, 58221.4177858216, 58802.41197588055, 36494.45258321127, 36543.4518482223, 36567.0, 36646.0, 36671.266574668894, 15058.0, 15235.771463428058, 15271.770923436157, 15319.540413787605, 15321.6169595761, 11960.043196544255, 12091.939540302243, 12207.877921220852, 12210.08424368176, 12225.960793332666, 8144.348452123816, 8154.103048664642, 8175.959120204361, 8293.585320733939, 8307.543085130375, 3145.748340132784, 3186.2193762527863, 3199.4880819068835, 3208.470602350633, 3225.8870939517005, 1026.4559783314855, 1027.2501074215716, 1048.496721573649, 1050.4380156616173, 1112.204773586873, 33740.66259337375, 33856.49215261773, 33902.66097339044, 34064.14839629029, 34130.31739365199, 1079.83262594298, 1087.3258579680491, 1130.8416821644976, 1179.979317890019, 1197.8323034775137, 17548.824511754974, 17617.973932997615, 17625.559361016076, 17718.91140544315, 17762.0, 581425.0, 583824.0, 584352.0, 589794.0, 600363.0, 57427.0, 57878.0, 58219.12671309934, 58290.12564811531, 58561.4143858556, 1341.5975207437925, 1359.422245545639, 1367.2001878900955, 1373.587923622909, 1374.1411617738913, 30589.54115688311, 32751.18122046968, 33040.33919321648, 33164.668353316156, 33246.667533324355, 52175.47824521706, 52199.21701174409, 52491.850488970784, 52570.21144682756, 52821.471785281654, 482021.0, 484071.0, 486015.0, 486219.0, 486541.0, 28030.71969280281, 28402.43195136127, 28428.85785571059, 28735.5689664651, 28764.568531471625, 47963.520364795906, 48505.75747121242, 48642.75678621584, 49635.0, 49857.252141217185, 41176.38235426411, 42355.7882210587, 43275.783621082956, 43377.34933976056, 44000.0, 42439.36340954826, 42480.0, 43141.0, 43416.0, 43905.56094439015, 41600.167996640506, 42261.0, 42970.78514607407, 43358.78320608503, 44981.32528012148, 32734.508982365758, 37992.430113547765, 38009.42985855159, 38770.22459550737, 39551.60448395479, 28787.0, 29198.708012920448, 29344.08164480995, 29379.55930660999, 29547.0], "value": 19302.962449261253, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.9663430291273, 386.7872670031482, 390.1455811772219, 402.4084595644402, 411.8949667834702, 17523.824761752378, 19319.517012074706, 19812.30656927008, 20223.59552808943, 20230.98845057745, 11723.7069073273, 11767.70580735482, 12015.759684806299, 12078.456469458873, 12096.213746106498, 4930.975345123269, 5156.071907056728, 5161.122609156452, 5182.766775495093, 5194.662346947455, 4910.533499317559, 5103.4896510349035, 5151.381834179885, 5188.948110518884, 5201.713905735183, 5066.214736715815, 5074.8731281718065, 5099.821506247282, 5101.056304583645, 5110.463401342861, 5024.924626130611, 5037.143685573461, 5088.338515992916, 5099.515546023141, 5134.922976155361, 4914.803407863681, 4989.775460104304, 5027.773750181251, 5038.395392552917, 5054.292399064134, 13010.544630937966, 13175.275359855204, 13310.467581296736, 13445.26051067191, 13565.728685426237, 2236.586231547169, 2295.8737269450176, 2319.8492098013576, 2364.2788949370433, 2604.387968827324, 9017.0, 9140.451572905647, 9150.359474836763, 9653.662121825702, 10179.491025448771, 1767.372582733124, 1797.3349860551548, 1801.6937120689515, 1848.7781466224005, 1882.2471011595335, 78904.0, 82633.0, 86556.13443865544, 87096.99999999936, 88847.55576222143, 10191.439470829027, 10358.585656573652, 10424.113950314157, 10656.307340022873, 11099.72250693739, 14190.432382704783, 14246.501372451914, 14254.216018118896, 14269.857301426853, 14328.641783955276, 7903.486273392326, 8328.721091124704, 8339.374546909006, 8554.14458554152, 8566.27186689126, 7805.2194780521495, 7818.569978651115, 7984.720534781255, 8027.117017128111, 8063.354931605458, 4291.635211007099, 4510.954890451054, 4544.409226800495, 4645.628349732014, 4698.154332220233, 1886.7264246684153, 1934.816192461742, 1939.41817454763, 1946.425804387709, 1986.8609197356047, 944.1691311645708, 1031.3554028732042, 1049.8897615750388, 1051.5163025008583, 1072.3780207479642, 19849.40451786449, 20642.919027654716, 20655.17379304841, 20664.276750313667, 20721.68917466239, 977.867987821635, 1023.7082431507133, 1038.4496217004998, 1056.6143357674548, 1057.6351158850184, 10798.190135739851, 11209.719757005976, 11312.0, 11432.142589305835, 11447.713807154722, 491100.0, 496661.0, 498392.0, 501332.0, 503638.0, 74718.25281747113, 93526.0, 94158.52920735352, 94403.52798235965, 94585.0, 974.6783561424854, 986.413084214891, 1005.5726316315537, 1010.3028910052041, 1016.1870503597092, 16954.745678815074, 16990.405335813186, 17456.47630571085, 17816.46550603484, 18374.632507350045, 34972.65027349694, 43154.78422607867, 43248.56751432445, 43251.0, 43349.78325108354, 55107.72446137744, 58250.0, 58862.117068244865, 59019.0, 60422.97885105815, 7221.494495385273, 7359.8160045999275, 7373.225811289952, 8125.228103330174, 8129.79675508117, 9065.274778017874, 12492.063095268073, 12537.811932821198, 12627.621171364874, 13761.105528140639, 9932.205423566242, 9964.608493961541, 10811.6215932442, 10836.187285953427, 11209.71975700614, 10415.479226038819, 10714.25000249975, 10848.67453976382, 11504.367259800456, 11508.739147504366, 11394.829077563678, 11863.288202707865, 11879.940600296943, 12031.939840301093, 12306.507739690313, 7320.524165929198, 7368.410527157922, 7408.888866666896, 7549.09410870677, 7649.04386951631, 10741.409222492837, 10889.836652450378, 11314.377709226072, 11473.426328683365, 12178.147529672839], "value": 8685.615798187464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.8352381238062, 1506.5630967019565, 1663.8419350161737, 1774.3967051202596, 1775.8668099892511, 8160.714374996876, 8785.253253473447, 8833.734987950364, 9410.011948745378, 9414.623415063397, 8903.198712115909, 9203.58583863726, 9206.401583897043, 9225.215856652176, 9247.676331328405, 2304.896279667415, 2342.2504798464415, 2343.8828058597087, 2348.283773449097, 2349.4126468382906, 2229.15292188968, 2290.198430549311, 2315.7221133463922, 2316.3977365884907, 2317.9536409271805, 2333.9883300583474, 2339.9064037438566, 2348.1194552042984, 2353.8352315337934, 2357.434215788207, 2268.3875353654503, 2274.863508189514, 2277.567262220173, 2296.942576435594, 2297.6553516972504, 2246.7753224677563, 2266.331432227497, 2273.1589311954517, 2281.1445707859552, 2296.9425764355856, 9290.535473226379, 9324.160825525736, 9333.206677432427, 9342.439453632804, 9368.57841397132, 5254.343207099113, 5363.249145119687, 5379.085555455582, 5379.838604841861, 5391.514763671288, 3255.2675647979254, 3274.6070471543567, 3281.1633033576286, 3285.655006224336, 3360.8823691170937, 1006.4967516241879, 1015.9695209143738, 1017.018577073128, 1017.776089260369, 1029.2897900448665, 12483.812742808865, 12555.372231388394, 12638.431270592846, 13040.217586944718, 13079.41142648583, 4348.673849461303, 4415.359772832921, 4485.394471746337, 4495.865124046284, 4539.205639013159, 10002.599896004223, 10059.44673042975, 10060.647877324258, 10079.848802267972, 10092.495375231209, 5195.6622819516615, 5196.090684130262, 5198.844034678966, 5199.7920083197005, 5205.193195054772, 4251.086016506466, 4646.83736069236, 4829.420469543677, 4857.684250523705, 4896.975515122473, 3917.216556688674, 3965.9603403966166, 4082.7346222495444, 4176.8120434579905, 4185.455890734185, 1270.5224811617384, 1277.5464710027993, 1295.6825577733516, 1297.4680381043727, 1306.2423794199342, 993.4635296939716, 998.7003898830321, 1017.3793985668736, 1020.9132223760915, 1028.7068185567077, 5988.37122102173, 6040.426159514839, 6181.84545386369, 6195.535334849814, 6264.718087686065, 423.96184343408623, 427.2821659611882, 432.7684688691535, 433.1121201536837, 437.25448110970717, 4113.177364527107, 4139.317012692933, 4196.118815048874, 4208.263553878059, 4224.640905523065, 11276.830847537294, 11602.0, 11622.360770157722, 11662.067034637208, 11680.824787628193, 11002.174836887265, 11238.157138214667, 11371.772564548663, 11495.71260718472, 11516.193866429438, 8165.265126138676, 8177.754667359989, 8218.958905205554, 8256.628451719687, 8306.8338633227, 6016.939830601638, 6078.969605151946, 6165.969170154121, 6235.625862448268, 6242.65665388408, 10346.896531034594, 10377.533011014673, 10431.791364172523, 10577.36535807854, 10586.629467968583, 10004.549795259376, 10370.948145259226, 10433.582656693647, 10463.581456741646, 10648.361098334124, 7248.0, 7680.5391676499585, 7848.254415830487, 7980.122186559358, 8135.145809690134, 8978.595963181542, 8987.0, 9071.274298056007, 9073.682421115229, 9078.31912606544, 7999.080105787676, 8003.439759217032, 8208.712695055645, 8298.792530186553, 8313.625886835229, 7935.484193527403, 7972.402069844668, 8001.559914204775, 8010.198980101944, 8178.386621003329, 7384.630768461448, 7439.665215065227, 7475.2151024141685, 7494.325510704063, 7599.4680372373405, 5192.844214673566, 5212.270282160424, 5231.581473482189, 5237.607179461479, 5479.150731636602, 5129.410117836496, 5149.304843846033, 5162.045021671003, 5208.583313334849, 5258.710770907637], "value": 4615.311181372049, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.24309888235564, 313.36699866270135, 314.93701259748025, 318.19337978225195, 323.94169049571076, 5460.071787796074, 5494.32423110951, 5583.413741557139, 5626.943730562693, 5647.265855438793, 5542.722863856811, 5569.693666848332, 5590.692511911843, 5608.327000759915, 5636.549076073915, 4326.502452217988, 4329.199098166833, 4361.542038086003, 4370.934435983463, 4381.408509851161, 4074.3684728867074, 4249.150169966004, 4297.269464191095, 4313.964648484357, 4384.473863136413, 4246.766427846467, 4252.19208350414, 4262.190183865071, 4268.253055715253, 4271.1671224111315, 4263.808128634203, 4290.613844753956, 4298.247806633843, 4301.78491075445, 4324.286492728696, 3518.47222916562, 3754.4180651998986, 3758.699304055669, 3771.3965765477665, 3775.754575952554, 5352.330958630171, 5413.350397952231, 5448.945510544883, 5456.61803673743, 5469.890602187974, 4925.950740492585, 4943.307936888838, 4943.431505376891, 4943.6539442239055, 4949.455559888409, 5636.379998200195, 5808.361080281165, 5864.7067646617925, 5899.410058994109, 5917.792877249276, 4147.6474499667565, 4176.561461046607, 4186.120914607936, 4190.53904070552, 4191.3293872980175, 6107.908381374283, 6145.251396648041, 6152.292486364081, 6156.6613836238985, 6270.843228919268, 4128.6284234419045, 4293.5706429356815, 4316.978415107905, 4327.156204540147, 4362.890927726832, 4356.172327257874, 4396.054848207651, 4400.669949753717, 4405.933910991338, 4406.0, 5019.422766381913, 5021.121303771825, 5021.824236151717, 5026.723530205873, 5054.9241761373605, 5801.390853960358, 5918.496927761103, 5960.642361458326, 6001.7599296027665, 6037.9396206038255, 1498.8351281359041, 1503.5339044896118, 1503.6090616439803, 1504.0599625234229, 1506.6158129676862, 936.4548494983223, 958.9232861371213, 967.7241986033946, 976.4775844923074, 982.6413359124011, 5037.269595908573, 5048.334049763569, 5087.592992560586, 5097.655078663782, 5100.48995100487, 5299.947000530023, 5320.813771517978, 5322.467753224647, 5340.7688348549345, 5351.046867893191, 4835.639230734676, 5048.848534543969, 5061.670991385548, 5069.467705890902, 5125.794968201305, 2808.719128087175, 2870.5263631500984, 2888.306806366499, 2888.324771632448, 2888.884444622234, 5470.835874923759, 5514.944850551524, 5516.503514683698, 5519.8260999924405, 5555.666660000413, 5210.649107994791, 5342.767625586542, 5430.56555475561, 5439.830436456181, 5483.862903427446, 5419.729013549307, 5463.7814487420055, 5490.615656903979, 5504.752286147133, 5534.813748569292, 5340.252364669027, 5370.919436208382, 5411.431799660979, 5420.186971954238, 5680.68756218412, 5972.70136493165, 6010.278766548042, 6011.128386384037, 6023.789167379121, 6084.695765211633, 6306.621602703853, 6330.277980468259, 6351.872962540816, 6371.235451745635, 6412.134361861089, 3909.5504017038406, 4049.230646177217, 4129.380592911088, 4185.539590645088, 4186.748795072183, 6019.080745838178, 6033.909491357545, 6045.697715114139, 6048.243969503812, 6078.179445774764, 5699.344575373885, 5866.413358664099, 5887.322957859901, 5912.320083190488, 5954.136650185612, 5776.826695199151, 5847.356790752929, 5860.443257890493, 5894.789453954767, 5923.970380148072, 5814.5348372130975, 5857.736401861841, 5859.882802344015, 5861.531077513703, 5868.882622347443, 5697.971510142423, 5910.202122713551, 5936.1689363488285, 5985.820425387245, 5991.191189189578, 5837.357890632112, 5899.882002359843, 5911.0, 5913.733881975408, 5925.792597259076], "value": 4344.992873930959, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.5334639177318, 756.8145804277951, 770.9421793365498, 771.8263390737085, 862.598891515446, 15543.378264869405, 16211.270492827822, 16300.103494307808, 16344.0, 16345.591360216, 15754.448594299201, 15815.209239538006, 15885.682286354266, 15895.28471218795, 15938.0, 650.5771248688343, 786.0371045469298, 794.2057942057942, 797.0475282037967, 797.9281864632181, 796.0884786918974, 799.6641410607559, 804.7022601637373, 807.6567458830003, 809.380823669893, 853.4409961475212, 856.7643897928058, 860.6256278518833, 862.9395942284043, 864.2869632553137, 847.0386111763162, 847.3306088190353, 852.26705033671, 853.5177624642057, 858.5149390594356, 627.0844566932284, 628.4061561824078, 629.9275583307932, 631.3055638797332, 632.3865850125371, 15114.39542418302, 15118.848811511854, 15291.770623440658, 15297.847021529753, 15305.693886122326, 15898.841011589851, 15962.840371596367, 16116.194190290438, 16188.0, 16247.512574622662, 11616.88383116175, 11900.464479098462, 11987.400629968466, 12105.15263931525, 12248.326342051183, 3943.4084887266854, 3959.3862951242604, 3975.2447035063246, 4003.11931375097, 4057.7159598827798, 81905.18094819094, 83161.16838831655, 84456.57771711164, 86237.0, 87497.56251218703, 11996.520139194508, 11998.58004969822, 12016.25798913828, 12130.150889437655, 12185.573504927463, 22924.312270631908, 22974.0, 23058.538829223322, 23166.7683323168, 23560.29319120429, 8349.33205343571, 8426.705065322683, 8501.532415717194, 8542.829143417097, 8770.51762153075, 4586.701864378805, 4730.810767569259, 4809.350737650442, 4830.734309613005, 5046.974765126224, 3678.3930651442747, 3738.32710112177, 3748.4002559590335, 3750.043738846631, 3754.511913451234, 619.4796371048341, 634.4480302137171, 635.7711223959371, 650.9641969691712, 658.6542065415599, 691.2983321928247, 730.4339137168737, 787.2127872127872, 788.7791418402857, 788.9900031380266, 9286.860697089549, 9714.708558743248, 10111.736587363832, 10492.26554141218, 10683.679489615324, 676.5872817581271, 724.1274264511251, 743.1759314604482, 796.9790320977817, 830.6801881275632, 4987.501249874984, 5195.050065000137, 5260.605454590921, 5293.841184764463, 5338.439463856239, 116237.41881290708, 116832.0, 119110.0, 121555.0, 121981.0, 100102.4994875021, 101945.0, 103852.0, 104287.0, 108740.456297718, 90678.0, 91227.54386228159, 91366.54316728507, 92490.0, 92627.99999999865, 9271.397359171633, 9480.478573678514, 9747.317687762072, 10054.49727513636, 10099.899001009895, 38621.80689096537, 48688.903500905646, 50009.0, 52141.47858521366, 52351.214731779815, 77234.0, 78556.0, 78929.21070789218, 79096.20903790889, 80179.59910200411, 12283.938580307042, 12285.938570307091, 12311.938440307742, 12447.066470014966, 12608.0, 12987.935060324638, 12989.28558929268, 13191.934040329737, 13248.271345076113, 13914.721705566035, 13089.41097650589, 13106.475740970254, 13344.199348039148, 13718.0397372183, 14083.366248518636, 12658.303793291458, 12667.176633518791, 13008.284544350152, 13044.02169837285, 13133.277669728257, 12922.483100676243, 13359.933200334324, 13370.197788132744, 13703.657408564866, 13815.79276310836, 10609.628662996758, 10777.407242601732, 10855.29440586391, 10870.130389568974, 11145.331280123219, 9635.710928672152, 9916.355436896578, 10681.58900991379, 11352.262102963281, 11629.24409913353], "value": 7710.755631725419, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 106.0, 112.0, 113.0, 112.0, 115.0, 111.0, 113.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 150.0, 178.0, 122.0, 147.0, 149.0, 120.0, 183.0, 124.0], "value": 144.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 164.0, 163.0, 165.0, 175.0, 162.0, 162.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 166.0, 77.0, 76.0, 75.0, 75.0, 167.0, 77.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 158.0, 85.0, 85.0, 84.0, 137.0, 85.0, 84.0, 137.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 147.0, 151.0, 151.0, 150.0, 147.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 57.0, 52.0, 52.0, 54.0, 51.0, 55.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 61.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 77.0, 79.0, 75.0, 78.0, 77.0, 82.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 136.0, 133.0, 130.0, 127.0, 124.0, 131.0, 168.0, 132.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 158.0, 159.0, 162.0, 159.0, 162.0, 155.0, 169.0, 166.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 64.0, 64.0, 64.0, 71.0, 72.0, 66.0, 63.0, 63.0], "value": 66.7, "unit": "score"}]}]} 01:53:45 INFO - Return code: 0 01:53:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:53:45 ERROR - # TBPL SUCCESS # 01:53:45 INFO - Running post-action listener: _resource_record_post_action 01:53:45 INFO - [mozharness: 2016-07-27 08:53:45.741389Z] Finished run-tests step (success) 01:53:45 INFO - Running post-run listener: _resource_record_post_run 01:53:45 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 570384384; Read time: 180; Write time: 494088 01:53:45 INFO - TinderboxPrint: CPU usage
13.4% 01:53:45 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 180 01:53:45 INFO - TinderboxPrint: I/O write bytes / time
570,384,384 / 494,088 01:53:45 INFO - TinderboxPrint: CPU idle
8,229.2 (86.6%) 01:53:45 INFO - TinderboxPrint: CPU user
1,215.4 (12.8%) 01:53:45 INFO - TinderboxPrint: Swap in / out
0 / 0 01:53:45 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 251764736; Read time: 0; Write time: 289908 01:53:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293044224; Read time: 164; Write time: 197976 01:53:46 INFO - Running post-run listener: _upload_blobber_files 01:53:46 INFO - Blob upload gear active. 01:53:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:53:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:53:46 INFO - (blobuploader) - INFO - Open directory for files ... 01:53:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:53:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:53:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:56 INFO - (blobuploader) - INFO - Done attempting. 01:53:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:53:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:53:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:56 INFO - (blobuploader) - INFO - Done attempting. 01:53:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:53:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:53:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:53:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:53:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:53:57 INFO - (blobuploader) - INFO - Done attempting. 01:53:57 INFO - (blobuploader) - INFO - Iteration through files over. 01:53:57 INFO - Return code: 0 01:53:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:53:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:53:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4a3b733c3260629b14011ff830b796edeb49e0b283352851a397e3377b62a683220862a5dcf124521fc42a36fb9741d1bc9776dd3a56bf1fba946cbf2a7594a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4457fd83dd497cba93d908b7ae855b3f803650b9a8984cd4c4d4fd6c382f278671a682b2746a543ee1a6285a1f98648b79178cc31f0f86d6a5042430f142255f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c671382f2465394fc86bc1c097147804d186279602b2a190ba55600e8a2d113ebc033fda209309d42abca8270e75ea7774d3ea7bb1efaa451fb96035d6e8505"} 01:53:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:53:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:53:57 INFO - Contents: 01:53:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4a3b733c3260629b14011ff830b796edeb49e0b283352851a397e3377b62a683220862a5dcf124521fc42a36fb9741d1bc9776dd3a56bf1fba946cbf2a7594a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4457fd83dd497cba93d908b7ae855b3f803650b9a8984cd4c4d4fd6c382f278671a682b2746a543ee1a6285a1f98648b79178cc31f0f86d6a5042430f142255f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c671382f2465394fc86bc1c097147804d186279602b2a190ba55600e8a2d113ebc033fda209309d42abca8270e75ea7774d3ea7bb1efaa451fb96035d6e8505"} 01:53:57 INFO - Running post-run listener: copy_logs_to_upload_dir 01:53:57 INFO - Copying logs to upload dir... 01:53:57 INFO - mkdir: /builds/slave/test/build/upload/logs 01:53:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.899825 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-27 01:53:57.274065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 01:53:57.277263) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047 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/a4a3b733c3260629b14011ff830b796edeb49e0b283352851a397e3377b62a683220862a5dcf124521fc42a36fb9741d1bc9776dd3a56bf1fba946cbf2a7594a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4457fd83dd497cba93d908b7ae855b3f803650b9a8984cd4c4d4fd6c382f278671a682b2746a543ee1a6285a1f98648b79178cc31f0f86d6a5042430f142255f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c671382f2465394fc86bc1c097147804d186279602b2a190ba55600e8a2d113ebc033fda209309d42abca8270e75ea7774d3ea7bb1efaa451fb96035d6e8505"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1469597458/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/a4a3b733c3260629b14011ff830b796edeb49e0b283352851a397e3377b62a683220862a5dcf124521fc42a36fb9741d1bc9776dd3a56bf1fba946cbf2a7594a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4457fd83dd497cba93d908b7ae855b3f803650b9a8984cd4c4d4fd6c382f278671a682b2746a543ee1a6285a1f98648b79178cc31f0f86d6a5042430f142255f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c671382f2465394fc86bc1c097147804d186279602b2a190ba55600e8a2d113ebc033fda209309d42abca8270e75ea7774d3ea7bb1efaa451fb96035d6e8505"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 01:53:57.305802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 01:53:57.306409) ========= 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=8887e36bb8e381bfd44124ac000001a8-1469605332.541368-439710047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 01:53:57.390413) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 01:53:57.391100) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 01:53:57.391741) ========= ========= Total master_lag: 0.20 =========