builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1462835493.08 results: success (0) buildid: 20160509133020 builduid: fcce04ef59c241e58d3e355fa5a7795b revision: 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.082207) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.082654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.082937) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.136267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.136600) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 16:11:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-05-09 16:11:33 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168401 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.349911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.350202) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018486 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.414060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.414396) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 --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 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 --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=e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 16:11:33,589 truncating revision to first 12 chars 2016-05-09 16:11:33,589 Setting DEBUG logging. 2016-05-09 16:11:33,589 attempt 1/10 2016-05-09 16:11:33,589 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/648d9d0fd2f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 16:11:33,818 unpacking tar archive at: mozilla-inbound-648d9d0fd2f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.489522 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.919699) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.920245) ========= script_repo_revision: 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.920927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:33.921366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:11:34.166989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-09 16:11:34.167413) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:11:34 INFO - MultiFileLogger online at 20160509 16:11:34 in /builds/slave/test 16:11:34 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 16:11:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:11:34 INFO - {'append_to_log': False, 16:11:34 INFO - 'base_work_dir': '/builds/slave/test', 16:11:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:11:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:11:34 INFO - 'branch': 'Mozilla-Inbound', 16:11:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:11:34 INFO - 'config_files': ('talos/linux_config.py',), 16:11:34 INFO - 'default_actions': ('clobber', 16:11:34 INFO - 'read-buildbot-config', 16:11:34 INFO - 'download-and-extract', 16:11:34 INFO - 'populate-webroot', 16:11:34 INFO - 'create-virtualenv', 16:11:34 INFO - 'install', 16:11:34 INFO - 'run-tests'), 16:11:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:11:34 INFO - 'download_minidump_stackwalk': True, 16:11:34 INFO - 'download_symbols': 'ondemand', 16:11:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:11:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:11:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:11:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:11:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:11:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:11:34 INFO - 'installer_path': 'installer.exe', 16:11:34 INFO - 'log_level': 'info', 16:11:34 INFO - 'log_name': 'talos', 16:11:34 INFO - 'log_to_console': True, 16:11:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:11:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:11:34 INFO - 'opt_config_files': (), 16:11:34 INFO - 'pip_index': False, 16:11:34 INFO - 'sps_profile': False, 16:11:34 INFO - 'sps_profile_interval': 0, 16:11:34 INFO - 'suite': 'dromaeojs-e10s', 16:11:34 INFO - 'system_bits': '32', 16:11:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:11:34 INFO - 'title': 'talos-linux64-ix-067', 16:11:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:11:34 INFO - 'use_talos_json': True, 16:11:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:11:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:11:34 INFO - 'work_dir': 'build'} 16:11:34 INFO - ##### 16:11:34 INFO - ##### Running clobber step. 16:11:34 INFO - ##### 16:11:34 INFO - Running pre-action listener: _resource_record_pre_action 16:11:34 INFO - Running main action method: clobber 16:11:34 INFO - rmtree: /builds/slave/test/build 16:11:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:11:35 INFO - Running post-action listener: _resource_record_post_action 16:11:35 INFO - ##### 16:11:35 INFO - ##### Finished clobber step (success) 16:11:35 INFO - ##### 16:11:35 INFO - ##### 16:11:35 INFO - ##### Running read-buildbot-config step. 16:11:35 INFO - ##### 16:11:35 INFO - Running pre-action listener: _resource_record_pre_action 16:11:35 INFO - Running main action method: read_buildbot_config 16:11:35 INFO - Using buildbot properties: 16:11:35 INFO - { 16:11:35 INFO - "project": "", 16:11:35 INFO - "product": "firefox", 16:11:35 INFO - "script_repo_revision": "production", 16:11:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:11:35 INFO - "repository": "", 16:11:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:11:35 INFO - "buildid": "20160509133020", 16:11:35 INFO - "pgo_build": "True", 16:11:35 INFO - "basedir": "/builds/slave/test", 16:11:35 INFO - "buildnumber": 630, 16:11:35 INFO - "slavename": "talos-linux64-ix-067", 16:11:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:11:35 INFO - "platform": "ubuntu64_hw", 16:11:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:11:35 INFO - "branch": "mozilla-inbound", 16:11:35 INFO - "repo_path": "integration/mozilla-inbound", 16:11:35 INFO - "revision": "648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4", 16:11:35 INFO - "stage_platform": "linux64-pgo", 16:11:35 INFO - "builduid": "fcce04ef59c241e58d3e355fa5a7795b", 16:11:35 INFO - "slavebuilddir": "test" 16:11:35 INFO - } 16:11:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:11:35 INFO - Running post-action listener: _resource_record_post_action 16:11:35 INFO - ##### 16:11:35 INFO - ##### Finished read-buildbot-config step (success) 16:11:35 INFO - ##### 16:11:35 INFO - ##### 16:11:35 INFO - ##### Running download-and-extract step. 16:11:35 INFO - ##### 16:11:35 INFO - Running pre-action listener: _resource_record_pre_action 16:11:35 INFO - Running main action method: download_and_extract 16:11:35 INFO - mkdir: /builds/slave/test/build/tests 16:11: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')]} 16:11:35 INFO - https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:11:36 INFO - Downloaded 1361 bytes. 16:11:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:11:36 INFO - Using the following test package requirements: 16:11:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:11:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:11:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:36 INFO - u'jsshell-linux-x86_64.zip'], 16:11:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:11:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:11:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:11:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:11:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:11:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:36 INFO - https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:11:38 INFO - Downloaded 23897515 bytes. 16:11:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:11:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:11:39 INFO - Return code: 0 16:11:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:39 INFO - https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:11:46 INFO - Downloaded 23897515 bytes. 16:11:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:11:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:11:48 INFO - Return code: 0 16:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:48 INFO - https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:11:49 INFO - Downloaded 10840152 bytes. 16:11:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:11:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:11:49 INFO - Return code: 0 16:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:49 INFO - https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:11:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:11:50 INFO - Downloaded 58440120 bytes. 16:11:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:50 INFO - mkdir: /builds/slave/test/properties 16:11:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:11:50 INFO - Writing to file /builds/slave/test/properties/build_url 16:11:50 INFO - Contents: 16:11:50 INFO - build_url:https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:11:51 INFO - Running post-action listener: _resource_record_post_action 16:11:51 INFO - Running post-action listener: set_extra_try_arguments 16:11:51 INFO - ##### 16:11:51 INFO - ##### Finished download-and-extract step (success) 16:11:51 INFO - ##### 16:11:51 INFO - ##### 16:11:51 INFO - ##### Running populate-webroot step. 16:11:51 INFO - ##### 16:11:51 INFO - Running pre-action listener: _resource_record_pre_action 16:11:51 INFO - Running main action method: populate_webroot 16:11:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:11:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:11:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:11:51 INFO - '--tppagecycles', 16:11:51 INFO - '7'], 16:11:51 INFO - 'tests': ['tsvgm']}}, 16:11:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:11:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:11:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:11:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:11:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:11:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:11:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:51 INFO - 'talos_options': ['--disable-e10s'], 16:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:51 INFO - 'talos_options': ['--disable-e10s'], 16:11:51 INFO - 'tests': ['damp', 'tps']}, 16:11:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:51 INFO - 'tests': ['damp', 'tps']}, 16:11:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:11:51 INFO - 'tests': ['dromaeo_dom']}, 16:11:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:11:51 INFO - 'tests': ['a11yr', 16:11:51 INFO - 'ts_paint', 16:11:51 INFO - 'tpaint', 16:11:51 INFO - 'sessionrestore', 16:11:51 INFO - 'sessionrestore_no_auto_restore', 16:11:51 INFO - 'tabpaint']}, 16:11:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:11:51 INFO - 'ts_paint', 16:11:51 INFO - 'tpaint', 16:11:51 INFO - 'sessionrestore', 16:11:51 INFO - 'sessionrestore_no_auto_restore', 16:11:51 INFO - 'tabpaint']}, 16:11:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:11:51 INFO - 'ts_paint', 16:11:51 INFO - 'tpaint', 16:11:51 INFO - 'sessionrestore', 16:11:51 INFO - 'sessionrestore_no_auto_restore', 16:11:51 INFO - 'tabpaint']}, 16:11:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:11:51 INFO - 'ts_paint', 16:11:51 INFO - 'tpaint', 16:11:51 INFO - 'sessionrestore', 16:11:51 INFO - 'sessionrestore_no_auto_restore', 16:11:51 INFO - 'tabpaint']}, 16:11:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:11:51 INFO - 'tests': ['a11yr', 16:11:51 INFO - 'ts_paint', 16:11:51 INFO - 'tpaint', 16:11:51 INFO - 'sessionrestore', 16:11:51 INFO - 'sessionrestore_no_auto_restore', 16:11:51 INFO - 'tabpaint']}, 16:11:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:11:51 INFO - 'tests': ['a11yr', 16:11:51 INFO - 'ts_paint', 16:11:51 INFO - 'tpaint', 16:11:51 INFO - 'sessionrestore', 16:11:51 INFO - 'sessionrestore_no_auto_restore', 16:11:51 INFO - 'tabpaint']}, 16:11:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:11:51 INFO - 'tests': ['tsvgx', 16:11:51 INFO - 'tsvgr_opacity', 16:11:51 INFO - 'tart', 16:11:51 INFO - 'tscrollx', 16:11:51 INFO - 'cart']}, 16:11:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:11:51 INFO - 'tsvgr_opacity', 16:11:51 INFO - 'tart', 16:11:51 INFO - 'tscrollx', 16:11:51 INFO - 'cart']}, 16:11:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:51 INFO - 'talos_options': ['--disable-e10s'], 16:11:51 INFO - 'tests': ['tp5o']}, 16:11:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:51 INFO - 'tests': ['tp5o']}, 16:11:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:51 INFO - 'talos_options': ['--disable-e10s', 16:11:51 INFO - '--xperf_path', 16:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:51 INFO - 'tests': ['tp5n']}, 16:11:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:51 INFO - 'talos_options': ['--xperf_path', 16:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:51 INFO - 'tests': ['tp5n']}}, 16:11:51 INFO - 'talos.zip': {'path': '', 16:11:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:11:51 INFO - Running post-action listener: _resource_record_post_action 16:11:51 INFO - ##### 16:11:51 INFO - ##### Finished populate-webroot step (success) 16:11:51 INFO - ##### 16:11:51 INFO - ##### 16:11:51 INFO - ##### Running create-virtualenv step. 16:11:51 INFO - ##### 16:11:51 INFO - Running pre-action listener: _resource_record_pre_action 16:11:51 INFO - Running main action method: create_virtualenv 16:11:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:11:51 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 16:11:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:11:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:51 INFO - Using real prefix '/usr' 16:11:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:11:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:11:54 INFO - Installing pip.................done. 16:11:54 INFO - Return code: 0 16:11:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4943dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, '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 0x1f7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', '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 16:11: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', 'pip>=1.5'] in /builds/slave/test/build 16:11: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 pip>=1.5 16:11:54 INFO - Using env: {'DISPLAY': ':0', 16:11:54 INFO - 'HOME': '/home/cltbld', 16:11:54 INFO - 'LANG': 'en_US.UTF-8', 16:11:54 INFO - 'LANGUAGE': 'en_US:en', 16:11:54 INFO - 'LOGNAME': 'cltbld', 16:11:54 INFO - 'MAIL': '/var/mail/cltbld', 16:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:54 INFO - 'MOZ_NO_REMOTE': '1', 16:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:54 INFO - 'NO_EM_RESTART': '1', 16:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:54 INFO - 'PWD': '/builds/slave/test', 16:11:54 INFO - 'SHELL': '/bin/bash', 16:11:54 INFO - 'SHLVL': '1', 16:11:54 INFO - 'TERM': 'linux', 16:11:54 INFO - 'TMOUT': '86400', 16:11:54 INFO - 'USER': 'cltbld', 16:11:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', 16:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:54 INFO - '_': '/tools/buildbot/bin/python'} 16:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:54 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 16:11:54 INFO - Cleaning up... 16:11:54 INFO - Return code: 0 16:11:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4943dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, '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 0x1f7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', '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 16:11: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:11: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 psutil>=0.7.1 16:11:54 INFO - Using env: {'DISPLAY': ':0', 16:11:54 INFO - 'HOME': '/home/cltbld', 16:11:54 INFO - 'LANG': 'en_US.UTF-8', 16:11:54 INFO - 'LANGUAGE': 'en_US:en', 16:11:54 INFO - 'LOGNAME': 'cltbld', 16:11:54 INFO - 'MAIL': '/var/mail/cltbld', 16:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:54 INFO - 'MOZ_NO_REMOTE': '1', 16:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:54 INFO - 'NO_EM_RESTART': '1', 16:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:54 INFO - 'PWD': '/builds/slave/test', 16:11:54 INFO - 'SHELL': '/bin/bash', 16:11:54 INFO - 'SHLVL': '1', 16:11:54 INFO - 'TERM': 'linux', 16:11:54 INFO - 'TMOUT': '86400', 16:11:54 INFO - 'USER': 'cltbld', 16:11:54 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', 16:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:54 INFO - '_': '/tools/buildbot/bin/python'} 16:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:55 INFO - Downloading/unpacking psutil>=0.7.1 16:11:55 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 16:11:55 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 16:11:55 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 16:11:55 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 16:11:55 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 16:11:55 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 16:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:11:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:57 INFO - Installing collected packages: psutil 16:11:57 INFO - Running setup.py install for psutil 16:11:57 INFO - building 'psutil._psutil_linux' extension 16:11:57 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 16:11:58 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 16:11:58 INFO - building 'psutil._psutil_posix' extension 16:11:58 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 16:11:59 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 16:11:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:59 INFO - Successfully installed psutil 16:11:59 INFO - Cleaning up... 16:11:59 INFO - Return code: 0 16:11:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4943dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, '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 0x1f7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', '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 16:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:11:59 INFO - Using env: {'DISPLAY': ':0', 16:11:59 INFO - 'HOME': '/home/cltbld', 16:11:59 INFO - 'LANG': 'en_US.UTF-8', 16:11:59 INFO - 'LANGUAGE': 'en_US:en', 16:11:59 INFO - 'LOGNAME': 'cltbld', 16:11:59 INFO - 'MAIL': '/var/mail/cltbld', 16:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:59 INFO - 'MOZ_NO_REMOTE': '1', 16:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:59 INFO - 'NO_EM_RESTART': '1', 16:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:59 INFO - 'PWD': '/builds/slave/test', 16:11:59 INFO - 'SHELL': '/bin/bash', 16:11:59 INFO - 'SHLVL': '1', 16:11:59 INFO - 'TERM': 'linux', 16:11:59 INFO - 'TMOUT': '86400', 16:11:59 INFO - 'USER': 'cltbld', 16:11:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', 16:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:59 INFO - '_': '/tools/buildbot/bin/python'} 16:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:12:01 INFO - Installing collected packages: mozsystemmonitor 16:12:01 INFO - Running setup.py install for mozsystemmonitor 16:12:01 INFO - Successfully installed mozsystemmonitor 16:12:01 INFO - Cleaning up... 16:12:01 INFO - Return code: 0 16:12:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:01 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')]} 16:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:01 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')]} 16:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:01 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 0x7f4943dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, '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 0x1f7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', '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 16:12:01 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 16:12:01 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 16:12:01 INFO - Using env: {'DISPLAY': ':0', 16:12:01 INFO - 'HOME': '/home/cltbld', 16:12:01 INFO - 'LANG': 'en_US.UTF-8', 16:12:01 INFO - 'LANGUAGE': 'en_US:en', 16:12:01 INFO - 'LOGNAME': 'cltbld', 16:12:01 INFO - 'MAIL': '/var/mail/cltbld', 16:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:01 INFO - 'MOZ_NO_REMOTE': '1', 16:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:01 INFO - 'NO_EM_RESTART': '1', 16:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:01 INFO - 'PWD': '/builds/slave/test', 16:12:01 INFO - 'SHELL': '/bin/bash', 16:12:01 INFO - 'SHLVL': '1', 16:12:01 INFO - 'TERM': 'linux', 16:12:01 INFO - 'TMOUT': '86400', 16:12:01 INFO - 'USER': 'cltbld', 16:12:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', 16:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:01 INFO - '_': '/tools/buildbot/bin/python'} 16:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:01 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:01 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 16:12:01 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 16:12:01 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 16:12:01 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 16:12:01 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 16:12:01 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 16:12:03 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:04 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 16:12:04 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 16:12:04 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 16:12:04 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 16:12:04 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 16:12:04 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 16:12:04 INFO - Downloading docopt-0.6.1.tar.gz 16:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:04 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:04 INFO - Running setup.py install for blobuploader 16:12:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:04 INFO - Running setup.py install for requests 16:12:04 INFO - Running setup.py install for docopt 16:12:04 INFO - Successfully installed blobuploader requests docopt 16:12:04 INFO - Cleaning up... 16:12:05 INFO - Return code: 0 16:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:05 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 0x7f4943dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, '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 0x1f7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', '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 16:12:05 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 16:12:05 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 16:12:05 INFO - Using env: {'DISPLAY': ':0', 16:12:05 INFO - 'HOME': '/home/cltbld', 16:12:05 INFO - 'LANG': 'en_US.UTF-8', 16:12:05 INFO - 'LANGUAGE': 'en_US:en', 16:12:05 INFO - 'LOGNAME': 'cltbld', 16:12:05 INFO - 'MAIL': '/var/mail/cltbld', 16:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:05 INFO - 'MOZ_NO_REMOTE': '1', 16:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:05 INFO - 'NO_EM_RESTART': '1', 16:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:05 INFO - 'PWD': '/builds/slave/test', 16:12:05 INFO - 'SHELL': '/bin/bash', 16:12:05 INFO - 'SHLVL': '1', 16:12:05 INFO - 'TERM': 'linux', 16:12:05 INFO - 'TMOUT': '86400', 16:12:05 INFO - 'USER': 'cltbld', 16:12:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', 16:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:05 INFO - '_': '/tools/buildbot/bin/python'} 16:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:05 INFO - Running setup.py (path:/tmp/pip-eggLJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:05 INFO - Running setup.py (path:/tmp/pip-bHtFiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:05 INFO - Running setup.py (path:/tmp/pip-te0q0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:05 INFO - Running setup.py (path:/tmp/pip-Wv6Ymt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:05 INFO - Running setup.py (path:/tmp/pip-wsRt5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:05 INFO - Running setup.py (path:/tmp/pip-x7PAFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:05 INFO - Running setup.py (path:/tmp/pip-l8_ntZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:05 INFO - Running setup.py (path:/tmp/pip-F3SSmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:05 INFO - Running setup.py (path:/tmp/pip-QbhxRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:05 INFO - Running setup.py (path:/tmp/pip-JaUb8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:05 INFO - Running setup.py (path:/tmp/pip-SBrO6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:06 INFO - Running setup.py (path:/tmp/pip-crT3pW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:06 INFO - Running setup.py (path:/tmp/pip-Mgh7i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:06 INFO - Running setup.py (path:/tmp/pip-T27HEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:06 INFO - Running setup.py (path:/tmp/pip-XZ6uN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:06 INFO - Running setup.py (path:/tmp/pip-nem5i7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:06 INFO - Running setup.py (path:/tmp/pip-NHG5lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:06 INFO - Running setup.py install for manifestparser 16:12:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:06 INFO - Running setup.py install for mozcrash 16:12:06 INFO - Running setup.py install for mozdebug 16:12:06 INFO - Running setup.py install for mozdevice 16:12:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:12:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:06 INFO - Running setup.py install for mozfile 16:12:06 INFO - Running setup.py install for mozhttpd 16:12:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Running setup.py install for mozinfo 16:12:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Running setup.py install for mozInstall 16:12:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Running setup.py install for mozleak 16:12:07 INFO - Running setup.py install for mozlog 16:12:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Running setup.py install for moznetwork 16:12:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Running setup.py install for mozprocess 16:12:07 INFO - Running setup.py install for mozprofile 16:12:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Running setup.py install for mozrunner 16:12:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:07 INFO - Running setup.py install for mozscreenshot 16:12:08 INFO - Running setup.py install for moztest 16:12:08 INFO - Running setup.py install for mozversion 16:12:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:08 INFO - Cleaning up... 16:12:08 INFO - Return code: 0 16:12:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:08 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 0x7f4943dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, '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 0x1f7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', '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 16:12:08 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 16:12:08 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 16:12:08 INFO - Using env: {'DISPLAY': ':0', 16:12:08 INFO - 'HOME': '/home/cltbld', 16:12:08 INFO - 'LANG': 'en_US.UTF-8', 16:12:08 INFO - 'LANGUAGE': 'en_US:en', 16:12:08 INFO - 'LOGNAME': 'cltbld', 16:12:08 INFO - 'MAIL': '/var/mail/cltbld', 16:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:08 INFO - 'MOZ_NO_REMOTE': '1', 16:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:08 INFO - 'NO_EM_RESTART': '1', 16:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:08 INFO - 'PWD': '/builds/slave/test', 16:12:08 INFO - 'SHELL': '/bin/bash', 16:12:08 INFO - 'SHLVL': '1', 16:12:08 INFO - 'TERM': 'linux', 16:12:08 INFO - 'TMOUT': '86400', 16:12:08 INFO - 'USER': 'cltbld', 16:12:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', 16:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:08 INFO - '_': '/tools/buildbot/bin/python'} 16:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:08 INFO - Running setup.py (path:/tmp/pip-Z9ZU8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:08 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)) 16:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:08 INFO - Running setup.py (path:/tmp/pip-GKfGrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:08 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)) 16:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:08 INFO - Running setup.py (path:/tmp/pip-OLZekw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:08 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)) 16:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:08 INFO - Running setup.py (path:/tmp/pip-aE15fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:08 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)) 16:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:08 INFO - Running setup.py (path:/tmp/pip-we6RX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:08 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)) 16:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:08 INFO - Running setup.py (path:/tmp/pip-lvbOY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:08 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)) 16:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:08 INFO - Running setup.py (path:/tmp/pip-X3NsI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:08 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)) 16:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:08 INFO - Running setup.py (path:/tmp/pip-r6mCSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:09 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)) 16:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:09 INFO - Running setup.py (path:/tmp/pip-193Mwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:09 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)) 16:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:09 INFO - Running setup.py (path:/tmp/pip-beW5k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 16:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:09 INFO - Running setup.py (path:/tmp/pip-BxQp3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:09 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)) 16:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:09 INFO - Running setup.py (path:/tmp/pip-s_xpfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 16:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:09 INFO - Running setup.py (path:/tmp/pip-HDXP55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:09 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)) 16:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:09 INFO - Running setup.py (path:/tmp/pip-JWhLZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 16:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:09 INFO - Running setup.py (path:/tmp/pip-9KTaAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:09 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)) 16:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:09 INFO - Running setup.py (path:/tmp/pip-EjXa1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:09 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)) 16:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:09 INFO - Running setup.py (path:/tmp/pip-5ceaug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:09 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)) 16:12:09 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)) 16:12:09 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)) 16:12:09 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)) 16:12:09 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)) 16:12:09 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)) 16:12:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12:09 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 16:12:09 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 16:12:09 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 16:12:09 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 16:12:09 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 16:12:09 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 16:12:11 INFO - Downloading blessings-1.6.tar.gz 16:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:11 INFO - Installing collected packages: blessings 16:12:11 INFO - Running setup.py install for blessings 16:12:11 INFO - Successfully installed blessings 16:12:11 INFO - Cleaning up... 16:12:11 INFO - Return code: 0 16:12:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:12 INFO - Reading from file tmpfile_stdout 16:12:12 INFO - Current package versions: 16:12:12 INFO - argparse == 1.2.1 16:12:12 INFO - blessings == 1.6 16:12:12 INFO - blobuploader == 1.2.4 16:12:12 INFO - docopt == 0.6.1 16:12:12 INFO - manifestparser == 1.1 16:12:12 INFO - mozInstall == 1.12 16:12:12 INFO - mozcrash == 0.17 16:12:12 INFO - mozdebug == 0.1 16:12:12 INFO - mozdevice == 0.48 16:12:12 INFO - mozfile == 1.2 16:12:12 INFO - mozhttpd == 0.7 16:12:12 INFO - mozinfo == 0.9 16:12:12 INFO - mozleak == 0.1 16:12:12 INFO - mozlog == 3.1 16:12:12 INFO - moznetwork == 0.27 16:12:12 INFO - mozprocess == 0.22 16:12:12 INFO - mozprofile == 0.28 16:12:12 INFO - mozrunner == 6.11 16:12:12 INFO - mozscreenshot == 0.1 16:12:12 INFO - mozsystemmonitor == 0.0 16:12:12 INFO - moztest == 0.7 16:12:12 INFO - mozversion == 1.4 16:12:12 INFO - psutil == 3.1.1 16:12:12 INFO - requests == 1.2.3 16:12:12 INFO - wsgiref == 0.1.2 16:12:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:12 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')]} 16:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:12 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')]} 16:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:12 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 0x7f4943dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, '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 0x1f7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', '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 16:12:12 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 16:12:12 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 16:12:12 INFO - Using env: {'DISPLAY': ':0', 16:12:12 INFO - 'HOME': '/home/cltbld', 16:12:12 INFO - 'LANG': 'en_US.UTF-8', 16:12:12 INFO - 'LANGUAGE': 'en_US:en', 16:12:12 INFO - 'LOGNAME': 'cltbld', 16:12:12 INFO - 'MAIL': '/var/mail/cltbld', 16:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:12 INFO - 'MOZ_NO_REMOTE': '1', 16:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:12 INFO - 'NO_EM_RESTART': '1', 16:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:12 INFO - 'PWD': '/builds/slave/test', 16:12:12 INFO - 'SHELL': '/bin/bash', 16:12:12 INFO - 'SHLVL': '1', 16:12:12 INFO - 'TERM': 'linux', 16:12:12 INFO - 'TMOUT': '86400', 16:12:12 INFO - 'USER': 'cltbld', 16:12:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', 16:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:12 INFO - '_': '/tools/buildbot/bin/python'} 16:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:12 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)) 16:12:12 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)) 16:12:12 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)) 16:12:12 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)) 16:12:12 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)) 16:12:12 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)) 16:12:12 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)) 16:12:12 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)) 16:12:12 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)) 16:12:12 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)) 16:12:12 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)) 16:12:12 INFO - Cleaning up... 16:12:12 INFO - Return code: 0 16:12:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:12:12 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')]} 16:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:12 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')]} 16:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:12 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 0x7f4943dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, '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 0x1f7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', '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 16:12:12 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 16:12:12 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 16:12:12 INFO - Using env: {'DISPLAY': ':0', 16:12:12 INFO - 'HOME': '/home/cltbld', 16:12:12 INFO - 'LANG': 'en_US.UTF-8', 16:12:12 INFO - 'LANGUAGE': 'en_US:en', 16:12:12 INFO - 'LOGNAME': 'cltbld', 16:12:12 INFO - 'MAIL': '/var/mail/cltbld', 16:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:12 INFO - 'MOZ_NO_REMOTE': '1', 16:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:12 INFO - 'NO_EM_RESTART': '1', 16:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:12 INFO - 'PWD': '/builds/slave/test', 16:12:12 INFO - 'SHELL': '/bin/bash', 16:12:12 INFO - 'SHLVL': '1', 16:12:12 INFO - 'TERM': 'linux', 16:12:12 INFO - 'TMOUT': '86400', 16:12:12 INFO - 'USER': 'cltbld', 16:12:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', 16:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:12 INFO - '_': '/tools/buildbot/bin/python'} 16:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:12 INFO - Downloading/unpacking jsonschema 16:12:12 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 16:12:12 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 16:12:12 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 16:12:12 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 16:12:12 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 16:12:12 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 16:12:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:14 INFO - Downloading/unpacking functools32 (from jsonschema) 16:12:14 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 16:12:14 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 16:12:14 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 16:12:14 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 16:12:14 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 16:12:14 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 16:12:14 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:14 INFO - warning: no files found matching '*.txt' 16:12:14 INFO - no previously-included directories found matching 'build' 16:12:14 INFO - no previously-included directories found matching 'dist' 16:12:14 INFO - no previously-included directories found matching '.git*' 16:12:14 INFO - Installing collected packages: jsonschema, functools32 16:12:14 INFO - Running setup.py install for functools32 16:12:14 INFO - warning: no files found matching '*.txt' 16:12:14 INFO - no previously-included directories found matching 'build' 16:12:14 INFO - no previously-included directories found matching 'dist' 16:12:14 INFO - no previously-included directories found matching '.git*' 16:12:14 INFO - Successfully installed jsonschema functools32 16:12:14 INFO - Cleaning up... 16:12:14 INFO - Return code: 0 16:12:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:14 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4943dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eeb770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, '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 0x1f7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7bd50>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', '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 16:12:14 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', 'flake8'] in /builds/slave/test/build 16:12:14 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 flake8 16:12:14 INFO - Using env: {'DISPLAY': ':0', 16:12:14 INFO - 'HOME': '/home/cltbld', 16:12:14 INFO - 'LANG': 'en_US.UTF-8', 16:12:14 INFO - 'LANGUAGE': 'en_US:en', 16:12:14 INFO - 'LOGNAME': 'cltbld', 16:12:14 INFO - 'MAIL': '/var/mail/cltbld', 16:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:14 INFO - 'MOZ_NO_REMOTE': '1', 16:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:14 INFO - 'NO_EM_RESTART': '1', 16:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:14 INFO - 'PWD': '/builds/slave/test', 16:12:14 INFO - 'SHELL': '/bin/bash', 16:12:14 INFO - 'SHLVL': '1', 16:12:14 INFO - 'TERM': 'linux', 16:12:14 INFO - 'TMOUT': '86400', 16:12:14 INFO - 'USER': 'cltbld', 16:12:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', 16:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:14 INFO - '_': '/tools/buildbot/bin/python'} 16:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:15 INFO - Downloading/unpacking flake8 16:12:15 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 16:12:15 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 16:12:15 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 16:12:15 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 16:12:15 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 16:12:15 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 16:12:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:12:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:12:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:12:17 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 16:12:17 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 16:12:17 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 16:12:17 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 16:12:17 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 16:12:17 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 16:12:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:12:17 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 16:12:17 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 16:12:17 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 16:12:17 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 16:12:17 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 16:12:17 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 16:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:12:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:12:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:12:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:12:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:12:17 INFO - no previously-included directories found matching 'docs/_build' 16:12:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:12:17 INFO - Running setup.py install for pep8 16:12:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:12:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:12:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:12:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:12:17 INFO - no previously-included directories found matching 'docs/_build' 16:12:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:12:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:12:17 INFO - Cleaning up... 16:12:17 INFO - Return code: 0 16:12:17 INFO - Running post-action listener: _resource_record_post_action 16:12:17 INFO - Running post-action listener: _start_resource_monitoring 16:12:17 INFO - Starting resource monitoring. 16:12:17 INFO - ##### 16:12:17 INFO - ##### Finished create-virtualenv step (success) 16:12:17 INFO - ##### 16:12:17 INFO - ##### 16:12:17 INFO - ##### Running install step. 16:12:17 INFO - ##### 16:12:17 INFO - Running pre-action listener: _resource_record_pre_action 16:12:17 INFO - Running main action method: install 16:12:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:18 INFO - Reading from file tmpfile_stdout 16:12:18 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:18 INFO - Reading from file tmpfile_stdout 16:12:18 INFO - Output received: 16:12:18 INFO - Usage: mozinstall [options] installer 16:12:18 INFO - Options: 16:12:18 INFO - -h, --help show this help message and exit 16:12:18 INFO - -d DEST, --destination=DEST 16:12:18 INFO - Directory to install application into. [default: 16:12:18 INFO - "/builds/slave/test"] 16:12:18 INFO - --app=APP Application being installed. [default: firefox] 16:12:18 INFO - mkdir: /builds/slave/test/build/application 16:12:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:12:34 INFO - Reading from file tmpfile_stdout 16:12:34 INFO - Output received: 16:12:34 INFO - /builds/slave/test/build/application/firefox/firefox 16:12:34 INFO - Running post-action listener: _resource_record_post_action 16:12:34 INFO - ##### 16:12:34 INFO - ##### Finished install step (success) 16:12:34 INFO - ##### 16:12:34 INFO - ##### 16:12:34 INFO - ##### Running run-tests step. 16:12:34 INFO - ##### 16:12:34 INFO - Running pre-action listener: _resource_record_pre_action 16:12:34 INFO - Running main action method: run_tests 16:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:12:34 INFO - Python 2.7.3 16:12:34 INFO - Return code: 0 16:12:34 INFO - grabbing minidump binary from tooltool 16:12:34 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')]} 16:12:34 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7a9c0>, '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 0x1f7b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f7bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:12:34 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 16:12:34 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 16:12:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:34 INFO - Return code: 0 16:12:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:12:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:12:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:12:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:12:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:12:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:12:35 INFO - Return code: 0 16:12:35 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', 'https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:12:35 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 https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 16:12:35 INFO - Using env: {'DISPLAY': ':0', 16:12:35 INFO - 'HOME': '/home/cltbld', 16:12:35 INFO - 'LANG': 'en_US.UTF-8', 16:12:35 INFO - 'LANGUAGE': 'en_US:en', 16:12:35 INFO - 'LOGNAME': 'cltbld', 16:12:35 INFO - 'MAIL': '/var/mail/cltbld', 16:12:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:35 INFO - 'MOZ_NO_REMOTE': '1', 16:12:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:35 INFO - 'NO_EM_RESTART': '1', 16:12:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:35 INFO - 'PWD': '/builds/slave/test', 16:12:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:35 INFO - 'SHELL': '/bin/bash', 16:12:35 INFO - 'SHLVL': '1', 16:12:35 INFO - 'TERM': 'linux', 16:12:35 INFO - 'TMOUT': '86400', 16:12:35 INFO - 'USER': 'cltbld', 16:12:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048', 16:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:35 INFO - '_': '/tools/buildbot/bin/python'} 16:12:35 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', 'https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:12:36 INFO - mozversion application_buildid: 20160509133020 16:12:36 INFO - mozversion application_changeset: 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 16:12:36 INFO - mozversion application_display_name: Nightly 16:12:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:36 INFO - mozversion application_name: Firefox 16:12:36 INFO - mozversion application_remotingname: firefox 16:12:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:12:36 INFO - mozversion application_vendor: Mozilla 16:12:36 INFO - mozversion application_version: 49.0a1 16:12:36 INFO - mozversion platform_buildid: 20160509133020 16:12:36 INFO - mozversion platform_changeset: 648d9d0fd2f8dc75dfd2edf1e15aa6c1efeca4c4 16:12:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:12:36 INFO - mozversion platform_version: 49.0a1 16:12:36 INFO - using testdate: 1462835556 16:12:36 INFO - actual date: 1462835556 16:12:36 INFO - starting webserver on 'localhost:55735' 16:12:36 INFO - SUITE-START | Running 2 tests 16:12:36 INFO - TEST-START | dromaeo_css 16:12:36 INFO - operating with platform_type : linux_ 16:12:36 INFO - Initialising browser for dromaeo_css test... 16:12:36 INFO - TEST-INFO | started process 3269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA1WyVl/profile http://localhost:55735/getInfo.html) 16:12:39 INFO - PROCESS | 3269 | 16:12:39 INFO - PROCESS | 3269 | (process:3335): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:12:40 INFO - PROCESS | 3269 | __metrics Screen width/height:1600/1200 16:12:40 INFO - PROCESS | 3269 | colorDepth:24 16:12:40 INFO - PROCESS | 3269 | Browser inner width/height: 1024/697 16:12:40 INFO - PROCESS | 3269 | __metrics 16:12:41 ERROR - PROCESS | 3269 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 16:12:42 INFO - TEST-INFO | 3269: exit 0 16:12:42 INFO - Browser initialized. 16:12:42 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:42 INFO - TEST-INFO | started process 3388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA1WyVl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:44 INFO - PROCESS | 3388 | 16:12:44 INFO - PROCESS | 3388 | (process:3454): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:12:54 INFO - PROCESS | 3388 | RSS: Main: 162861056 16:12:54 INFO - PROCESS | 3388 | 16:13:43 INFO - PROCESS | 3388 | 1462835623861 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] 16:15:51 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:55735/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55735/tests/dromaeo/cssquery-ext.html) 16:15:52 INFO - PROCESS | 3388 | RSS: Main: 166211584 16:15:52 INFO - PROCESS | 3388 | 16:18:54 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:55735/tests/dromaeo/cssquery-ext.html (next: http://localhost:55735/tests/dromaeo/cssquery-jquery.html) 16:18:55 INFO - PROCESS | 3388 | RSS: Main: 166703104 16:18:55 INFO - PROCESS | 3388 | 16:21:56 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:55735/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55735/tests/dromaeo/cssquery-mootools.html) 16:21:57 INFO - PROCESS | 3388 | RSS: Main: 167378944 16:21:57 INFO - PROCESS | 3388 | 16:24:59 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:55735/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55735/tests/dromaeo/cssquery-prototype.html) 16:24:59 INFO - PROCESS | 3388 | RSS: Main: 164892672 16:24:59 INFO - PROCESS | 3388 | 16:28:02 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:55735/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55735/tests/dromaeo/cssquery-yui.html) 16:28:02 INFO - PROCESS | 3388 | RSS: Main: 165941248 16:28:02 INFO - PROCESS | 3388 | 16:31:05 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:55735/tests/dromaeo/cssquery-yui.html (next: http://localhost:55735/tests/dromaeo/cssquery-dojo.html) 16:31:05 INFO - PROCESS | 3388 | RSS: Main: 168329216 16:31:05 INFO - PROCESS | 3388 | 16:31:05 INFO - PROCESS | 3388 | __start_tp_report 16:31:05 INFO - PROCESS | 3388 | _x_x_mozilla_page_load 16:31:05 INFO - PROCESS | 3388 | _x_x_mozilla_page_load_details 16:31:05 INFO - PROCESS | 3388 | |i|pagename|runs| 16:31:05 INFO - PROCESS | 3388 | |0;dojo.html;3130.34262804811;3144.4182826177143;3175.523671449282;3176.0154352150835;3181.9999999999986;5342.412334643191;5393.298871146751;5418.40397556269;5454.290942177521;5469.808556700516;5275.525202731754;5313.149896016638;5344.599155063366;5403.83788486345;5414.83755487335;4887.389076365464;4921.704697718131;4954.232094025432;5006.22403527452;5046.09170349337;889.4029339911013;4783.54556317151;4867.732274724889;4968.130577149002;5019.247112933071;4887.120318342697;4922.753862306889;4925.482824303433;4934.6299027572895;4950.752462376885;4943.579795717368;4948.208286674151;4950.133726597831;4970.577500912426;4973.2291494818;4840.661153719241;4905.8282960096585;4919.557239848431;4925.507449255082;4941.332920055783;5336.946630533684;5353.544948679367;5397.919031214535;5398.082326004589;5399.730013499348;5720.22776925114;5814.767409303665;5828.184054232411;5843.1235314703135;5864.120381942743;5822.737976791054;5929.703514824285;5952.226210592638;5988.431099045583;5988.970055149696;5526.723663816793;5556.388797232301;5567.972160139173;5578.107502799533;5586.86032849178;5788.652680839163;5825.766969321265;5869;6036.973714468463;6042.758289668452;5760.2223699800825;5761.711914404263;5763.711814409263;5768.682722450221;5770.394108618619;5879.235699359056;5884.676342801102;5885.646861188342;5905.350411454737;5911.9704401478575;5727.3699893011735;5763.452472015152;5785.103308987113;5794.21778059965;5830.737616807254;5750.741216645261;5790.739416726257;5803.332616749043;5812.302523697099;5822.301323841166;4357.302831546937;4419.337099435046;4425.601695847389;4426.557344265612;4479.55204479556;3884.475595794588;3920.9019774505864;3924.4898163238595;3963.8810835674976;3969.047428617111;5502.394736578973;5524.640898341675;5572.247746554163;5608.635438696471;5609.382967873531;5813.069908814654;5861.238039054981;5883.441073098049;5893.616914900518;5895.4399332063385;5511.476409741068;5541.307336582927;5544.112941929272;5611.102223644198;5619.8595035124445;4987.526185012418;5017.688973043017;5026.974865125651;5028.748562571856;5037.0681423936685;5798.797042103506;5874.588778785529;6058.545609079249;6066.150738896558;6073.1497590337385;5748.712564371848;5795.59430839854;5814.360420353673;5821.970890145522;5823.18475413451;6001.879962400815;6007.969960150172;6020.397960203944;6027.095935609694;6029.427204415573;5639.464250896158;5756.568257380797;5780.624259423124;5781.942180578309;5803.216565763568;5947.821565352873;5963.970180149072;5965.701714914324;5970.343262241063;5990.400959904149;5735.053716136791;5784.392638773036;5786.103154011135;5789.623674461147;5796;5558.805441809517;5697.145428185805;5705.429457054262;5743.770249189985;5806.477417032487;5547.694876781654;5602.243697100839;5604.943950560442;5608.355039170548;5636.1827535008015;5565.833025009256;5730.742116604846;5787.276590426197;5788.710564471844;5800.59395842287;5349.919751203657;5611.579131565068;5612.579056570855;5640.971795140998;5654.745536450787 16:31:05 INFO - PROCESS | 3388 | |1;ext.html;596.6300893446064;635.2218532297935;653.3858173317083;656.1601150527326;672.48218871469;38276.23447531051;40046.399304010425;42261.57738422615;42429;42456.36315455271;43448;43491;43516;43957.7802110989;44063;8828.646854125844;8870.713746506754;8877.201051905327;8882.822343553125;8949.95525022374;8753.693620723276;8806.20744133028;8811.867821982676;8854.911450885505;8865.335099867503;8811.339149563777;8834.249088827457;8869.600867960926;8890.59992300348;8905.554722263862;8716.869246961302;8777.2100510954;8801.559922003906;8801.603927823264;8817.515036672981;8703.608337624823;8820.823583528294;8845.778855528599;8848.29213662912;8854.380193386402;33738.1565460863;39277.803610982046;39279.80360098181;39592.80203598963;39750.20499589992;3350.614679311886;3497.7551571390013;3569.28614277143;3693.3351996640595;4007.8597249096433;29986.200827950393;30118.397632047236;30447;30559;31080;3848.5574158971795;3865.4588357629955;3891.8637847675195;3932.1545867638597;4022.0749227677798;278498;279267;280017.59991199913;280021;281349;34331.31337373239;34563;34570.65429345725;34646.48030279548;34784.82607586946;35579.28841423209;35941;36494.27011459756;36807;37960.620393796264;14865;15114.773278400833;15147.242637868063;15151;15152.696946061016;12176.086793490524;12294.877051229374;12315.384230788424;12328.81506777399;12360.072994525266;19261.03761555633;19377.61244775125;19408.514787130152;19432.2227110914;19532.218711251677;6950.687219075154;7075.92924070763;7085.256048114977;7320.816979575447;7340.265973402724;981.4503877828439;1096.2819353323587;1125.6229163230246;1161.692151579832;1194.0447641886456;30378.392432151235;30892.138482689665;31397.372052559276;31533.684663153075;31715;1064.3826580583243;1156.3639998001233;1158.415000424797;1196.5991392883307;1233.7902556565405;16875.32498700063;16919.492415227563;16927.153642317833;17139.22873470697;17155.91422042907;488642.5567872138;493732;494522;499778;500788;53567;54270.45729542733;54353.1847022295;54470.72764636151;54475.36959358499;1389.5206153876895;1407.050241087262;1411.6964852556544;1427.1651084115701;1431.0698046270008;30102.05855330156;30445;30724.69275307308;30975;32071.679283207803;47802.76098619624;47957.76021120012;48011.5198848021;48154.75922620364;48324.516754832;381176;381824;385409;389081;389347;27658.5851212236;27958.440831182856;28037.299067522657;28117.43765124727;28210.71789282163;47268.527314726416;47575.286370703776;47833;48222.758886205345;48719;39119.80440097895;39215.21569568536;39743.60256397399;39831.601683982786;39868.60131398765;38342.80828595839;40096.59903400928;40670.38994415027;40674.593254067084;40675.1864962705;35725.28549429049;39801.60198397979;40037;41371;41420.893432992045;34573.30853382969;34783.652163479055;34942.65057349495;35778.463323050695;35831;26910;27113;27321.86339068292;27409.498588452316;27667 16:31:05 INFO - PROCESS | 3388 | |2;jquery.html;396.48852979656243;396.7520299812618;401.9698522610804;402.0732212250763;418.07188042545556;17927;18915.52711182221;19576.21695132195;19600.411987640375;19648.803511964878;16409.425670101547;16684;16900.66198676029;18734.531636709056;18826;5190.7664155112925;5502.697351645658;5538.861528461791;5692.430756924316;5701.429857014306;5364.383095943957;5458.645188062783;5458.6724796512135;5470.863228419282;5493.560515158798;6120.3267640559725;6328.525360597951;6331.651759153245;6361.077643741654;6376.139221205148;5314.707691076989;5638.971805140948;6263.24841019076;6296.716647750839;6314.93685063148;5385.111456609655;5501.944980550184;5505.03661859177;5515.25544051556;5520.420355862617;13026.54407095747;13241.602751917362;13250.536231231861;13370.732585348238;13383.732325353536;2272.261515007629;2297.7242730872235;2302.5148779037595;2410.9517809643885;2454.779069883701;9619.711408657751;10170;10302.690919272434;12062.517499300018;14436.927815360961;1970.4285757130415;1984.3848406993734;2011.7284166637462;2016.9703714007528;2045.948851278715;54775.452245477434;69499.30500694978;76105.23894761037;77271;77755;10480.213983951235;10701.946490267499;10706.678799636024;10837.891621083845;10837.945810271056;14141.434342626386;14239.715205695828;14384.35270412834;14421.639459013399;14532.418703251962;7472.887906681404;7782.883256751154;7786.532808031537;7828.804279893048;7877.4091943104495;7511.549307041595;7540.472166948371;7616.276453736886;7694.692212311445;8059.879101813477;4473.635541159977;4481.282994720829;4529.9547004530195;4607.7004994675235;4617.907641847211;1925.768907731053;1967.2721093195323;2063.473814177375;2096.727425434684;2115.0482282972416;946.9005754395827;1115.1859142825783;1125.454154734953;1131.179894576442;1143.5368675686361;17147.828521714622;19305.80694193068;19683.31108411199;19740.124688154603;19809.10859011348;996.7657600463886;998.485779823377;1004.3685543874948;1035.984460233097;1057.1067448006422;10485.970566924048;10824.621138260123;10846.069134596712;10860.185486088574;10875.293105948089;425790;455372;490528;496153;501131;54074;65163.022554661715;77614.61192694001;91077.54461227651;91289;1056.3186744549723;1082.8917108289108;1095.2442814457997;1104.6023431564631;1110.8333749937574;17536.82463175352;17579.82420175782;17611.55971100733;17795.555111122325;18002.819971800116;32407.837960810044;37913.86258412252;41326;41521.79239103785;42183.36724949067;56941;57479.7126014384;57734;58013.4198658008;58626.413735862094;6937.514373993772;7431.8142046449275;7723.691052357843;8313.334933205208;8357.289630381243;9142.08579142107;12364.938175309066;12718.554850580185;12980.15628984113;12983.221006739626;11444.42777861087;11680.94159529197;11788.410579471163;11951.402429878297;12006.699832504257;11275.379854107774;11505.194636375709;11562.710932226762;11602.303861768321;11908.16642835028;11701.941490292495;11739.119566032752;12114.757704845677;12137.453814578188;12149.514019439124;7956.2043795619975;8000.159983201913;8070.636821342936;8077.1115177329275;8202.38482113832;11135.830737772741;11640.94179529097;11675;11733.609433877777;11871.762564748484 16:31:05 INFO - PROCESS | 3388 | |3;mootools.html;1517.1049081042186;1525.8474152584743;1714.9142542872853;1813.755143055687;1842.7051671732524;7581.962090189541;8111.87832182517;8216.876746848802;8647.870281945776;8679.652813887446;8262.876056859137;8530.720391941211;8585.184407481294;8600.741977740661;8622.698205562807;2232.8771917544527;2253.752087270399;2259.548090381922;2265.66015097735;2268.1381075191402;2239.496113374486;2252.076648574077;2265.365697604665;2286.622707253301;2287.3824067501764;2221.6112180368373;2252.763459836718;2263.977360226393;2306.976930230693;2309.064828744353;2167.1439781286463;2174.4346469917778;2185.530111026129;2189.069645400706;2195.4072400451787;2161.967570486444;2174.4672555223915;2175.3473957812594;2177.923772667949;2183.148572056899;8322.16778322169;8399.076101628816;8426.705065322683;8443.282321002722;8456.323494120456;4754.738489383082;4837.612990960714;4883.682560633548;4886.071646387175;4891.8777030574165;3065.2949821540947;3138.921526961821;3271.8691252349877;3273.0508152635707;3287.128910838606;1043.3270540501335;1075.4138994248153;1082.7563798145434;1083.6748975307376;1085.5223701571363;11696.941515292454;11724.648260552198;11753.294802311888;11784.057275417947;11794.764104717857;4267.295896177096;4320.740755554677;4362.192994296002;4384.4081049058605;4406.669499787528;9823.852642210373;9831.213502919749;9851.113399794052;9857.359271647463;9859.605615775288;4750.928736068961;4763.785629646674;4777.140114779304;4780.330753694486;4780.904381912343;4161.8959526012095;4285.100128972888;4303.720258183208;4384.868453946387;4423.137488189836;3826.942595861064;3854.2676891390547;3918.1380096378753;3949.111449923744;4077.673786097105;1243.2043492165021;1274.4456161569747;1275.7002104505434;1283.1146508908823;1290.9806352904714;914.2548822709471;986.3243678080538;996.850472429127;999.1257649556638;1006.7885743993697;5836;5923.08192230205;5973.104034394789;6070.544709146831;6071.210742603522;956.383132879289;996.1383403356045;1017.4861694844057;1028.0798685176874;1045.8274384726587;4141.254574176617;4257.084726783756;4399.6040356368085;4409.096135292258;4438.5561443856;10654.414007229676;11018.50416731249;11038.17213708959;11044.061254793272;11139.610113645984;10797.892021079846;10982.890171098346;10997.34015959045;10999.780004399867;11015.504302306255;7582.696692132253;7892.644830982505;7981.3614910807;8046.275835174745;8134.552599607078;5860.882782344414;5874;5884.705764711833;5910.379410162043;5921.5558833086825;8952.552372381224;9441.339106262496;9481.336306458481;9535.47554884488;9569.712908612753;9552.092551207625;9586.376885502421;9595.520223988913;9709.737734094522;9852.802943941224;6900.7997615616505;7403.7408690695565;7571.091469023752;7636.80907977305;7737.961310193638;8549.957250213958;8554.78613034679;8622.870656940026;8624.870626940476;8633.611487483204;7296.160941491797;7462.925370746223;7513.1359893612935;7520.511166774142;7546.9622651888585;7372.778816635509;7398.482106252511;7421.740239091606;7431.219721929336;7554.395648348229;7041.964790176016;7070.39901608369;7126.714931402686;7131.358177764027;7139.428845692436;5034.647574669884;5046.924296135634;5159;5226.189940559219;5358.223057656696;5109.923351149661;5164.302819119371;5196.272521846869;5258.316418865523;5270.78916843322 16:31:05 INFO - PROCESS | 3388 | |4;prototype.html;307.9491883839167;318.8820136549476;321.53377602476405;323.7296857124301;325.8094015001224;5491.313585801775;5595.38450770415;5657.12314591238;5682.090865461532;5688.715564221788;5611.7474713637885;5613.736909195429;5623.943760562393;5635.492805647491;5657.717114144297;4287.807048682809;4326.459192600925;4328.4156638853665;4347.60871521563;4351.73889566627;4120.484939382577;4335.1979883721615;4344;4344.500382456026;4364.585364390377;4251.6173544381;4267.850625228118;4271.359296105578;4295.613394794468;4307.440032795732;4265.296226122686;4270.871873843789;4273.316269396897;4282.250606143913;4326.048269380763;3519.982400088009;3756.6476068615275;3784.7291625024764;3785.413260944558;3795.658390744846;5339.864054378279;5419.349678038621;5441.1838224266285;5444.428335024844;5498.285222921035;4843.2735089736825;4859.1010663027455;4878.317035615017;4893.217085266376;4902.240152776325;5528.308961379827;5817.360090390053;5840.094785308284;5861.824145275648;5908.172855800191;4044.534878488982;4085.713000404863;4092.5088989321175;4102.097538541516;4115.814788334532;6103.542234332443;6128.039027511199;6135.815925522242;6145.723442445101;6164.7534098636;4077.286474866946;4188.141431006637;4190.497140343117;4198.895027624334;4206.579342065769;4234.9364759528635;4245.617894389458;4249.68127390447;4263.552327005682;4276.444062271947;4872.902541949212;4875.756212189447;4889.951100489021;4917.844306587949;4925.38432695913;5657.660540367591;5861.329521086555;5916.763329466773;5927.911081333784;5955.67243801595;1456.5047883719585;1479.2529772464836;1480.533631905946;1485.3316007796534;1488.1220080152762;881.3830318776882;910.6220918318955;918.875951746519;932.7481579973369;944.0135058863367;4976.900461990812;5032.521910418504;5067.011932673094;5090.77091530882;5132.28148059272;5312.592163076788;5331.30693009914;5355.464453554613;5361.410244873061;5393.7572809223675;5055.317532133188;5060.139776238048;5131.512506311894;5334.306540149756;5800.274965629296;3245.902622921316;3254.316593515341;3269.594074547967;3281.3273278977754;3288.358770039867;6064.75740970365;6225.159603453566;6314.842128946813;6339.619622822645;6349.174607301114;6092.390760923872;6124.540659450559;6130.233720784902;6145.293291271561;6171.753129874754;6203.596766210272;6223.408776166257;6229.283632382334;6244.345248509148;6258.468030217391;5802.709864506842;6072.332043475126;6074.969625151846;6119.470132466883;6125.632462052291;5941.613795103304;6028.306744724413;6029.824184284198;6044.969775151096;6069.180660610761;5973.91039134422;6206.844828879314;6220.760526210651;6230.221222347207;6298.84252893663;4158.355454904495;4202.915941681088;4211.7262377945335;4213.220554197484;4225.72532785368;6083.452489275986;6140.8771824564155;6156.138140660221;6201.286852012076;6208.689565521796;5800.744043166445;5804.303483581997;5858.7070646468355;5878.970605146947;5937.851553711192;5811.622244554091;5879.764809407576;5882;5892.175095486549;5925.348211696796;5566.443355664401;5787.594868359174;5820.185174075548;5831.591788574759;5838.766449341979;5905.261842269716;5907.586468947133;5921.348651648229;5964.522838173022;5968.880622387441;5832.533397328289;5836;5864.237649105759;5885.705714714161;5923.763049477972 16:31:05 INFO - PROCESS | 3388 | |5;yui.html;646.8576913079122;800.6277081157265;802.2579114319253;814.3854956159904;847.4576271186442;13849.099808512452;14287.642808929782;14522.491712790055;14532.564023079298;14566.19885906276;13282.867171328284;13283.402246898888;13451.529196478125;13490.123141995764;13509.392077356519;685.4379408884716;773.1225059557414;795.9840803183962;796.2077732656015;815.5514467043132;792.6829268292671;794.3287921706149;795.8368534450424;799.5562462833125;807.2492581898832;841.3605659698643;846.4371193156544;849.129642116829;850.6299759604561;851.3189448441253;843.73844108326;844.7930257086991;844.9408541402104;845.4124383553433;846.699421705295;608.0666177417643;609.945104940553;610.5115907274208;612.0604871522237;616.0266778489976;12511;12600.306983115925;12601.810972835416;12641.557545485864;12664.11351205416;12496.625101246977;12504.937475312656;12527.686807829787;12570;12863.807042894365;11000.779984400348;11054.613088541862;11271.211015228855;11299.830502542469;11480.425978701032;3705.1663375740513;3724.571674257468;3740.9438858416875;3765.5669597996307;3843.077661361281;53943;54345.456545434434;55080.724596376764;55315;56004;9782.75543111428;9845.803083938425;9981.900180998242;10199.0820826126;10201.438920859424;16830.831691682928;17758.91120544389;17775.822241777416;17782.110894455225;17818.287268509375;7772.844543109106;8085;8277.04813946392;8282.875756863652;8284.378671599654;4566.292224705176;4600.010997635524;4718.740469274154;4740.928886066712;4751.121042607128;3198.63215730194;3331.3337332533106;3334.8165850878436;3335.3496068266454;3376.459766437358;598.5152026858259;602.7920367473215;603.6528995827417;607.0529973241757;613.5490414545305;668.7358493395179;709.4324540367788;761.2273542354515;776.8640487914593;782.7847341981001;9232.584533696;9552.761180970532;9586.856197157049;9593.42439453635;9694.369865958832;634.4195061518659;638.8466767975652;736.120336198238;748.7042618165794;778.9182135875765;4572.977135114304;4579.9084018319445;4607.9078418431445;4629.884252893705;4649.395578574831;65721.34278657248;66362.66818665972;68396.6580167106;69236;69749.30250697529;59089;60053.39946600478;60204;60494;61627.69186154041;51923.22115168275;52187.73906130445;52590;53166;56128.71935640377;8129.4715843469985;8140.59297035134;8165.305948994164;8309.584520773817;8342.666293348198;33924.49113263254;34120.48819267763;34720.652793471745;35111.82444087763;35605.46591801177;47234;47687.52312476831;47828.7608561955;47940.520594795;48546.75726621485;11451.942740286579;11556.248843825124;11671.533138674358;11721.706957326134;12002.75994480123;13248.20510769357;13639.659008524866;13988.230647314496;14165.929170354082;14169.079009864327;12382;12482.500699971899;12561.497540098293;12660.493580256687;13278.86721132815;13024.674383140497;13187.340632968506;13240.271785051915;13319.66700832487;13605.931970340085;12385.380730963596;12495.437705303102;13007.479700811862;13330.600081997556;13873.236971966639;9263.490508021854;9643.324967252225;9768.755781105245;10698.358098514114;11002.779944400907;10839;10957.671269861918;11004.614838480615;11014.50434730423;11171.497282622464 16:31:05 INFO - PROCESS | 3388 | __end_tp_report 16:31:05 INFO - PROCESS | 3388 | __start_cc_report 16:31:05 INFO - PROCESS | 3388 | _x_x_mozilla_cycle_collect,333 16:31:05 INFO - PROCESS | 3388 | __end_cc_report 16:31:05 INFO - PROCESS | 3388 | __startTimestamp1462836665510__endTimestamp 16:31:05 INFO - PROCESS | 3388 | 16:31:05 INFO - PROCESS | 3388 | ------- Summary: start ------- 16:31:05 INFO - PROCESS | 3388 | Number of tests: 6 16:31:05 INFO - PROCESS | 3388 | 16:31:05 INFO - PROCESS | 3388 | [#0] dojo.html Cycles:165 Average:5390.78 Median:5619.86 stddev:718.04 (12.8%) stddev-sans-first:698.00 16:31:05 INFO - PROCESS | 3388 | Values: 3130.3 3144.4 3175.5 3176.0 3182.0 5342.4 5393.3 5418.4 5454.3 5469.8 5275.5 5313.1 5344.6 5403.8 5414.8 4887.4 4921.7 4954.2 5006.2 5046.1 889.4 4783.5 4867.7 4968.1 5019.2 4887.1 4922.8 4925.5 4934.6 4950.8 4943.6 4948.2 4950.1 4970.6 4973.2 4840.7 4905.8 4919.6 4925.5 4941.3 5336.9 5353.5 5397.9 5398.1 5399.7 5720.2 5814.8 5828.2 5843.1 5864.1 5822.7 5929.7 5952.2 5988.4 5989.0 5526.7 5556.4 5568.0 5578.1 5586.9 5788.7 5825.8 5869.0 6037.0 6042.8 5760.2 5761.7 5763.7 5768.7 5770.4 5879.2 5884.7 5885.6 5905.4 5912.0 5727.4 5763.5 5785.1 5794.2 5830.7 5750.7 5790.7 5803.3 5812.3 5822.3 4357.3 4419.3 4425.6 4426.6 4479.6 3884.5 3920.9 3924.5 3963.9 3969.0 5502.4 5524.6 5572.2 5608.6 5609.4 5813.1 5861.2 5883.4 5893.6 5895.4 5511.5 5541.3 5544.1 5611.1 5619.9 4987.5 5017.7 5027.0 5028.7 5037.1 5798.8 5874.6 6058.5 6066.2 6073.1 5748.7 5795.6 5814.4 5822.0 5823.2 6001.9 6008.0 6020.4 6027.1 6029.4 5639.5 5756.6 5780.6 5781.9 5803.2 5947.8 5964.0 5965.7 5970.3 5990.4 5735.1 5784.4 5786.1 5789.6 5796.0 5558.8 5697.1 5705.4 5743.8 5806.5 5547.7 5602.2 5604.9 5608.4 5636.2 5565.8 5730.7 5787.3 5788.7 5800.6 5349.9 5611.6 5612.6 5641.0 5654.7 16:31:05 INFO - PROCESS | 3388 | 16:31:05 INFO - PROCESS | 3388 | [#1] ext.html Cycles:180 Average:53732.72 Median:194637.23 stddev:105102.00 (54.0%) stddev-sans-first:105321.12 16:31:05 INFO - PROCESS | 3388 | Values: 596.6 635.2 653.4 656.2 672.5 38276.2 40046.4 42261.6 42429.0 42456.4 43448.0 43491.0 43516.0 43957.8 44063.0 8828.6 8870.7 8877.2 8882.8 8950.0 8753.7 8806.2 8811.9 8854.9 8865.3 8811.3 8834.2 8869.6 8890.6 8905.6 8716.9 8777.2 8801.6 8801.6 8817.5 8703.6 8820.8 8845.8 8848.3 8854.4 33738.2 39277.8 39279.8 39592.8 39750.2 3350.6 3497.8 3569.3 3693.3 4007.9 29986.2 30118.4 30447.0 30559.0 31080.0 3848.6 3865.5 3891.9 3932.2 4022.1 278498.0 279267.0 280017.6 280021.0 281349.0 34331.3 34563.0 34570.7 34646.5 34784.8 35579.3 35941.0 36494.3 36807.0 37960.6 14865.0 15114.8 15147.2 15151.0 15152.7 12176.1 12294.9 12315.4 12328.8 12360.1 19261.0 19377.6 19408.5 19432.2 19532.2 6950.7 7075.9 7085.3 7320.8 7340.3 981.5 1096.3 1125.6 1161.7 1194.0 30378.4 30892.1 31397.4 31533.7 31715.0 1064.4 1156.4 1158.4 1196.6 1233.8 16875.3 16919.5 16927.2 17139.2 17155.9 488642.6 493732.0 494522.0 499778.0 500788.0 53567.0 54270.5 54353.2 54470.7 54475.4 1389.5 1407.1 1411.7 1427.2 1431.1 30102.1 30445.0 30724.7 30975.0 32071.7 47802.8 47957.8 48011.5 48154.8 48324.5 381176.0 381824.0 385409.0 389081.0 389347.0 27658.6 27958.4 28037.3 28117.4 28210.7 47268.5 47575.3 47833.0 48222.8 48719.0 39119.8 39215.2 39743.6 39831.6 39868.6 38342.8 40096.6 40670.4 40674.6 40675.2 35725.3 39801.6 40037.0 41371.0 41420.9 34573.3 34783.7 34942.7 35778.5 35831.0 26910.0 27113.0 27321.9 27409.5 27667.0 16:31:05 INFO - PROCESS | 3388 | 16:31:05 INFO - PROCESS | 3388 | [#2] jquery.html Cycles:180 Average:27358.84 Median:2284.99 stddev:77959.84 (3411.8%) stddev-sans-first:78152.25 16:31:05 INFO - PROCESS | 3388 | Values: 396.5 396.8 402.0 402.1 418.1 17927.0 18915.5 19576.2 19600.4 19648.8 16409.4 16684.0 16900.7 18734.5 18826.0 5190.8 5502.7 5538.9 5692.4 5701.4 5364.4 5458.6 5458.7 5470.9 5493.6 6120.3 6328.5 6331.7 6361.1 6376.1 5314.7 5639.0 6263.2 6296.7 6314.9 5385.1 5501.9 5505.0 5515.3 5520.4 13026.5 13241.6 13250.5 13370.7 13383.7 2272.3 2297.7 2302.5 2411.0 2454.8 9619.7 10170.0 10302.7 12062.5 14436.9 1970.4 1984.4 2011.7 2017.0 2045.9 54775.5 69499.3 76105.2 77271.0 77755.0 10480.2 10701.9 10706.7 10837.9 10837.9 14141.4 14239.7 14384.4 14421.6 14532.4 7472.9 7782.9 7786.5 7828.8 7877.4 7511.5 7540.5 7616.3 7694.7 8059.9 4473.6 4481.3 4530.0 4607.7 4617.9 1925.8 1967.3 2063.5 2096.7 2115.0 946.9 1115.2 1125.5 1131.2 1143.5 17147.8 19305.8 19683.3 19740.1 19809.1 996.8 998.5 1004.4 1036.0 1057.1 10486.0 10824.6 10846.1 10860.2 10875.3 425790.0 455372.0 490528.0 496153.0 501131.0 54074.0 65163.0 77614.6 91077.5 91289.0 1056.3 1082.9 1095.2 1104.6 1110.8 17536.8 17579.8 17611.6 17795.6 18002.8 32407.8 37913.9 41326.0 41521.8 42183.4 56941.0 57479.7 57734.0 58013.4 58626.4 6937.5 7431.8 7723.7 8313.3 8357.3 9142.1 12364.9 12718.6 12980.2 12983.2 11444.4 11680.9 11788.4 11951.4 12006.7 11275.4 11505.2 11562.7 11602.3 11908.2 11701.9 11739.1 12114.8 12137.5 12149.5 7956.2 8000.2 8070.6 8077.1 8202.4 11135.8 11640.9 11675.0 11733.6 11871.8 16:31:05 INFO - PROCESS | 3388 | 16:31:05 INFO - PROCESS | 3388 | [#3] mootools.html Cycles:180 Average:5635.82 Median:4860.65 stddev:3189.43 (65.6%) stddev-sans-first:3183.36 16:31:05 INFO - PROCESS | 3388 | Values: 1517.1 1525.8 1714.9 1813.8 1842.7 7582.0 8111.9 8216.9 8647.9 8679.7 8262.9 8530.7 8585.2 8600.7 8622.7 2232.9 2253.8 2259.5 2265.7 2268.1 2239.5 2252.1 2265.4 2286.6 2287.4 2221.6 2252.8 2264.0 2307.0 2309.1 2167.1 2174.4 2185.5 2189.1 2195.4 2162.0 2174.5 2175.3 2177.9 2183.1 8322.2 8399.1 8426.7 8443.3 8456.3 4754.7 4837.6 4883.7 4886.1 4891.9 3065.3 3138.9 3271.9 3273.1 3287.1 1043.3 1075.4 1082.8 1083.7 1085.5 11696.9 11724.6 11753.3 11784.1 11794.8 4267.3 4320.7 4362.2 4384.4 4406.7 9823.9 9831.2 9851.1 9857.4 9859.6 4750.9 4763.8 4777.1 4780.3 4780.9 4161.9 4285.1 4303.7 4384.9 4423.1 3826.9 3854.3 3918.1 3949.1 4077.7 1243.2 1274.4 1275.7 1283.1 1291.0 914.3 986.3 996.9 999.1 1006.8 5836.0 5923.1 5973.1 6070.5 6071.2 956.4 996.1 1017.5 1028.1 1045.8 4141.3 4257.1 4399.6 4409.1 4438.6 10654.4 11018.5 11038.2 11044.1 11139.6 10797.9 10982.9 10997.3 10999.8 11015.5 7582.7 7892.6 7981.4 8046.3 8134.6 5860.9 5874.0 5884.7 5910.4 5921.6 8952.6 9441.3 9481.3 9535.5 9569.7 9552.1 9586.4 9595.5 9709.7 9852.8 6900.8 7403.7 7571.1 7636.8 7738.0 8550.0 8554.8 8622.9 8624.9 8633.6 7296.2 7462.9 7513.1 7520.5 7547.0 7372.8 7398.5 7421.7 7431.2 7554.4 7042.0 7070.4 7126.7 7131.4 7139.4 5034.6 5046.9 5159.0 5226.2 5358.2 5109.9 5164.3 5196.3 5258.3 5270.8 16:31:05 INFO - PROCESS | 3388 | 16:31:05 INFO - PROCESS | 3388 | [#4] prototype.html Cycles:180 Average:4885.69 Median:5547.38 stddev:1465.14 (26.4%) stddev-sans-first:1428.40 16:31:05 INFO - PROCESS | 3388 | Values: 307.9 318.9 321.5 323.7 325.8 5491.3 5595.4 5657.1 5682.1 5688.7 5611.7 5613.7 5623.9 5635.5 5657.7 4287.8 4326.5 4328.4 4347.6 4351.7 4120.5 4335.2 4344.0 4344.5 4364.6 4251.6 4267.9 4271.4 4295.6 4307.4 4265.3 4270.9 4273.3 4282.3 4326.0 3520.0 3756.6 3784.7 3785.4 3795.7 5339.9 5419.3 5441.2 5444.4 5498.3 4843.3 4859.1 4878.3 4893.2 4902.2 5528.3 5817.4 5840.1 5861.8 5908.2 4044.5 4085.7 4092.5 4102.1 4115.8 6103.5 6128.0 6135.8 6145.7 6164.8 4077.3 4188.1 4190.5 4198.9 4206.6 4234.9 4245.6 4249.7 4263.6 4276.4 4872.9 4875.8 4890.0 4917.8 4925.4 5657.7 5861.3 5916.8 5927.9 5955.7 1456.5 1479.3 1480.5 1485.3 1488.1 881.4 910.6 918.9 932.7 944.0 4976.9 5032.5 5067.0 5090.8 5132.3 5312.6 5331.3 5355.5 5361.4 5393.8 5055.3 5060.1 5131.5 5334.3 5800.3 3245.9 3254.3 3269.6 3281.3 3288.4 6064.8 6225.2 6314.8 6339.6 6349.2 6092.4 6124.5 6130.2 6145.3 6171.8 6203.6 6223.4 6229.3 6244.3 6258.5 5802.7 6072.3 6075.0 6119.5 6125.6 5941.6 6028.3 6029.8 6045.0 6069.2 5973.9 6206.8 6220.8 6230.2 6298.8 4158.4 4202.9 4211.7 4213.2 4225.7 6083.5 6140.9 6156.1 6201.3 6208.7 5800.7 5804.3 5858.7 5879.0 5937.9 5811.6 5879.8 5882.0 5892.2 5925.3 5566.4 5787.6 5820.2 5831.6 5838.8 5905.3 5907.6 5921.3 5964.5 5968.9 5832.5 5836.0 5864.2 5885.7 5923.8 16:31:05 INFO - PROCESS | 3388 | 16:31:05 INFO - PROCESS | 3388 | [#5] yui.html Cycles:180 Average:15143.15 Median:47758.14 stddev:18256.64 (38.2%) stddev-sans-first:18275.40 16:31:05 INFO - PROCESS | 3388 | Values: 646.9 800.6 802.3 814.4 847.5 13849.1 14287.6 14522.5 14532.6 14566.2 13282.9 13283.4 13451.5 13490.1 13509.4 685.4 773.1 796.0 796.2 815.6 792.7 794.3 795.8 799.6 807.2 841.4 846.4 849.1 850.6 851.3 843.7 844.8 844.9 845.4 846.7 608.1 609.9 610.5 612.1 616.0 12511.0 12600.3 12601.8 12641.6 12664.1 12496.6 12504.9 12527.7 12570.0 12863.8 11000.8 11054.6 11271.2 11299.8 11480.4 3705.2 3724.6 3740.9 3765.6 3843.1 53943.0 54345.5 55080.7 55315.0 56004.0 9782.8 9845.8 9981.9 10199.1 10201.4 16830.8 17758.9 17775.8 17782.1 17818.3 7772.8 8085.0 8277.0 8282.9 8284.4 4566.3 4600.0 4718.7 4740.9 4751.1 3198.6 3331.3 3334.8 3335.3 3376.5 598.5 602.8 603.7 607.1 613.5 668.7 709.4 761.2 776.9 782.8 9232.6 9552.8 9586.9 9593.4 9694.4 634.4 638.8 736.1 748.7 778.9 4573.0 4579.9 4607.9 4629.9 4649.4 65721.3 66362.7 68396.7 69236.0 69749.3 59089.0 60053.4 60204.0 60494.0 61627.7 51923.2 52187.7 52590.0 53166.0 56128.7 8129.5 8140.6 8165.3 8309.6 8342.7 33924.5 34120.5 34720.7 35111.8 35605.5 47234.0 47687.5 47828.8 47940.5 48546.8 11451.9 11556.2 11671.5 11721.7 12002.8 13248.2 13639.7 13988.2 14165.9 14169.1 12382.0 12482.5 12561.5 12660.5 13278.9 13024.7 13187.3 13240.3 13319.7 13605.9 12385.4 12495.4 13007.5 13330.6 13873.2 9263.5 9643.3 9768.8 10698.4 11002.8 10839.0 10957.7 11004.6 11014.5 11171.5 16:31:05 INFO - PROCESS | 3388 | -------- Summary: end -------- 16:31:05 INFO - PROCESS | 3388 | 16:31:06 INFO - TEST-INFO | 3388: exit 0 16:31:06 INFO - TEST-OK | dromaeo_css | took 1110163ms 16:31:06 INFO - TEST-START | kraken 16:31:06 INFO - operating with platform_type : linux_ 16:31:06 INFO - Initialising browser for kraken test... 16:31:06 INFO - TEST-INFO | started process 3630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg4z3qd/profile http://localhost:55735/getInfo.html) 16:31:09 INFO - PROCESS | 3630 | 16:31:09 INFO - PROCESS | 3630 | (process:3699): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:31:10 INFO - PROCESS | 3630 | __metrics Screen width/height:1600/1200 16:31:10 INFO - PROCESS | 3630 | colorDepth:24 16:31:10 INFO - PROCESS | 3630 | Browser inner width/height: 1024/697 16:31:10 INFO - PROCESS | 3630 | __metrics 16:31:10 ERROR - PROCESS | 3630 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 16:31:11 INFO - TEST-INFO | 3630: exit 0 16:31:11 INFO - Browser initialized. 16:31:11 INFO - Running cycle 1/1 for kraken test... 16:31:11 INFO - TEST-INFO | started process 3750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg4z3qd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:13 INFO - PROCESS | 3750 | 16:31:13 INFO - PROCESS | 3750 | (process:3811): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:31:23 INFO - PROCESS | 3750 | RSS: Main: 163012608 16:31:23 INFO - PROCESS | 3750 | 16:31:26 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55735/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:26 INFO - PROCESS | 3750 | RSS: Main: 167522304 16:31:26 INFO - PROCESS | 3750 | 16:31:29 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55735/tests/kraken/driver.html?testName=audio-dft) 16:31:30 INFO - PROCESS | 3750 | RSS: Main: 167469056 16:31:30 INFO - PROCESS | 3750 | 16:31:33 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55735/tests/kraken/driver.html?testName=audio-fft) 16:31:33 INFO - PROCESS | 3750 | RSS: Main: 162521088 16:31:33 INFO - PROCESS | 3750 | 16:31:36 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55735/tests/kraken/driver.html?testName=audio-oscillator) 16:31:36 INFO - PROCESS | 3750 | RSS: Main: 162844672 16:31:36 INFO - PROCESS | 3750 | 16:31:38 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55735/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:39 INFO - PROCESS | 3750 | RSS: Main: 163069952 16:31:39 INFO - PROCESS | 3750 | 16:31:42 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55735/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:43 INFO - PROCESS | 3750 | RSS: Main: 163287040 16:31:43 INFO - PROCESS | 3750 | 16:31:46 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55735/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:47 INFO - PROCESS | 3750 | RSS: Main: 161943552 16:31:47 INFO - PROCESS | 3750 | 16:31:50 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55735/tests/kraken/driver.html?testName=json-parse-financial) 16:31:51 INFO - PROCESS | 3750 | RSS: Main: 163098624 16:31:51 INFO - PROCESS | 3750 | 16:31:52 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55735/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:31:53 INFO - PROCESS | 3750 | RSS: Main: 163266560 16:31:53 INFO - PROCESS | 3750 | 16:31:55 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55735/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:31:55 INFO - PROCESS | 3750 | RSS: Main: 163192832 16:31:55 INFO - PROCESS | 3750 | 16:31:57 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55735/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:31:58 INFO - PROCESS | 3750 | RSS: Main: 163545088 16:31:58 INFO - PROCESS | 3750 | 16:32:01 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:01 INFO - PROCESS | 3750 | RSS: Main: 163426304 16:32:01 INFO - PROCESS | 3750 | 16:32:04 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:05 INFO - PROCESS | 3750 | RSS: Main: 163610624 16:32:05 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | Cycle 1(1): loaded http://localhost:55735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55735/tests/kraken/driver.html?testName=ai-astar) 16:32:07 INFO - PROCESS | 3750 | RSS: Main: 164982784 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | __start_tp_report 16:32:07 INFO - PROCESS | 3750 | _x_x_mozilla_page_load 16:32:07 INFO - PROCESS | 3750 | _x_x_mozilla_page_load_details 16:32:07 INFO - PROCESS | 3750 | |i|pagename|runs| 16:32:07 INFO - PROCESS | 3750 | |0;ai-astar;112;111;103;110;111;114;107;109;112;110 16:32:07 INFO - PROCESS | 3750 | |1;audio-beat-detection;160;129;156;218;125;159;159;125;189;127 16:32:07 INFO - PROCESS | 3750 | |2;audio-dft;162;172;163;161;164;174;162;161;166;163 16:32:07 INFO - PROCESS | 3750 | |3;audio-fft;75;75;77;157;76;77;75;75;164;76 16:32:07 INFO - PROCESS | 3750 | |4;audio-oscillator;92;91;188;92;92;92;139;93;92;146 16:32:07 INFO - PROCESS | 3750 | |5;imaging-gaussian-blur;117;117;117;118;116;116;118;117;118;118 16:32:07 INFO - PROCESS | 3750 | |6;imaging-darkroom;147;146;147;146;146;147;147;146;147;146 16:32:07 INFO - PROCESS | 3750 | |7;imaging-desaturate;95;95;95;96;95;96;95;96;96;96 16:32:07 INFO - PROCESS | 3750 | |8;json-parse-financial;61;60;58;57;61;61;58;110;57;60 16:32:07 INFO - PROCESS | 3750 | |9;json-stringify-tinderbox;59;59;60;59;60;59;59;59;60;59 16:32:07 INFO - PROCESS | 3750 | |10;stanford-crypto-aes;80;84;80;80;81;79;81;83;81;81 16:32:07 INFO - PROCESS | 3750 | |11;stanford-crypto-ccm;135;125;136;136;133;128;127;134;192;136 16:32:07 INFO - PROCESS | 3750 | |12;stanford-crypto-pbkdf2;167;167;169;163;180;167;164;163;166;165 16:32:07 INFO - PROCESS | 3750 | |13;stanford-crypto-sha256-iterative;63;64;66;64;64;67;67;65;65;63 16:32:07 INFO - PROCESS | 3750 | __end_tp_report 16:32:07 INFO - PROCESS | 3750 | __start_cc_report 16:32:07 INFO - PROCESS | 3750 | _x_x_mozilla_cycle_collect,832 16:32:07 INFO - PROCESS | 3750 | __end_cc_report 16:32:07 INFO - PROCESS | 3750 | __startTimestamp1462836727271__endTimestamp 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | ------- Summary: start ------- 16:32:07 INFO - PROCESS | 3750 | Number of tests: 14 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.07 (2.8%) stddev-sans-first:3.16 16:32:07 INFO - PROCESS | 3750 | Values: 112.0 111.0 103.0 110.0 111.0 114.0 107.0 109.0 112.0 110.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:159.00 stddev:30.63 (19.3%) stddev-sans-first:32.42 16:32:07 INFO - PROCESS | 3750 | Values: 160.0 129.0 156.0 218.0 125.0 159.0 159.0 125.0 189.0 127.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:4.59 (2.8%) stddev-sans-first:4.76 16:32:07 INFO - PROCESS | 3750 | Values: 162.0 172.0 163.0 161.0 164.0 174.0 162.0 161.0 166.0 163.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.50 stddev:35.78 (47.4%) stddev-sans-first:37.37 16:32:07 INFO - PROCESS | 3750 | Values: 75.0 75.0 77.0 157.0 76.0 77.0 75.0 75.0 164.0 76.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:92.00 stddev:34.09 (37.1%) stddev-sans-first:35.41 16:32:07 INFO - PROCESS | 3750 | Values: 92.0 91.0 188.0 92.0 92.0 92.0 139.0 93.0 92.0 146.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 16:32:07 INFO - PROCESS | 3750 | Values: 117.0 117.0 117.0 118.0 116.0 116.0 118.0 117.0 118.0 118.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:32:07 INFO - PROCESS | 3750 | Values: 147.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:32:07 INFO - PROCESS | 3750 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:60.00 stddev:16.14 (26.9%) stddev-sans-first:17.07 16:32:07 INFO - PROCESS | 3750 | Values: 61.0 60.0 58.0 57.0 61.0 61.0 58.0 110.0 57.0 60.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 16:32:07 INFO - PROCESS | 3750 | Values: 59.0 59.0 60.0 59.0 60.0 59.0 59.0 59.0 60.0 59.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:1.49 (1.8%) stddev-sans-first:1.54 16:32:07 INFO - PROCESS | 3750 | Values: 80.0 84.0 80.0 80.0 81.0 79.0 81.0 83.0 81.0 81.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:135.50 stddev:19.34 (14.3%) stddev-sans-first:20.48 16:32:07 INFO - PROCESS | 3750 | Values: 135.0 125.0 136.0 136.0 133.0 128.0 127.0 134.0 192.0 136.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.00 stddev:4.93 (3.0%) stddev-sans-first:5.23 16:32:07 INFO - PROCESS | 3750 | Values: 167.0 167.0 169.0 163.0 180.0 167.0 164.0 163.0 166.0 165.0 16:32:07 INFO - PROCESS | 3750 | 16:32:07 INFO - PROCESS | 3750 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.48 (2.3%) stddev-sans-first:1.41 16:32:07 INFO - PROCESS | 3750 | Values: 63.0 64.0 66.0 64.0 64.0 67.0 67.0 65.0 65.0 63.0 16:32:07 INFO - PROCESS | 3750 | -------- Summary: end -------- 16:32:07 INFO - PROCESS | 3750 | 16:32:08 INFO - TEST-INFO | 3750: exit 0 16:32:08 INFO - TEST-OK | kraken | took 61998ms 16:32:08 INFO - SUITE-END | took 1172s 16:32:08 INFO - Completed test suite (00:19:32) 16:32:08 INFO - javascript benchmark 16:32:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.34262804811, 3144.4182826177143, 3175.523671449282, 3176.0154352150835, 3181.9999999999986, 5342.412334643191, 5393.298871146751, 5418.40397556269, 5454.290942177521, 5469.808556700516, 5275.525202731754, 5313.149896016638, 5344.599155063366, 5403.83788486345, 5414.83755487335, 4887.389076365464, 4921.704697718131, 4954.232094025432, 5006.22403527452, 5046.09170349337, 889.4029339911013, 4783.54556317151, 4867.732274724889, 4968.130577149002, 5019.247112933071, 4887.120318342697, 4922.753862306889, 4925.482824303433, 4934.6299027572895, 4950.752462376885, 4943.579795717368, 4948.208286674151, 4950.133726597831, 4970.577500912426, 4973.2291494818, 4840.661153719241, 4905.8282960096585, 4919.557239848431, 4925.507449255082, 4941.332920055783, 5336.946630533684, 5353.544948679367, 5397.919031214535, 5398.082326004589, 5399.730013499348, 5720.22776925114, 5814.767409303665, 5828.184054232411, 5843.1235314703135, 5864.120381942743, 5822.737976791054, 5929.703514824285, 5952.226210592638, 5988.431099045583, 5988.970055149696, 5526.723663816793, 5556.388797232301, 5567.972160139173, 5578.107502799533, 5586.86032849178, 5788.652680839163, 5825.766969321265, 5869.0, 6036.973714468463, 6042.758289668452, 5760.2223699800825, 5761.711914404263, 5763.711814409263, 5768.682722450221, 5770.394108618619, 5879.235699359056, 5884.676342801102, 5885.646861188342, 5905.350411454737, 5911.9704401478575, 5727.3699893011735, 5763.452472015152, 5785.103308987113, 5794.21778059965, 5830.737616807254, 5750.741216645261, 5790.739416726257, 5803.332616749043, 5812.302523697099, 5822.301323841166, 4357.302831546937, 4419.337099435046, 4425.601695847389, 4426.557344265612, 4479.55204479556, 3884.475595794588, 3920.9019774505864, 3924.4898163238595, 3963.8810835674976, 3969.047428617111, 5502.394736578973, 5524.640898341675, 5572.247746554163, 5608.635438696471, 5609.382967873531, 5813.069908814654, 5861.238039054981, 5883.441073098049, 5893.616914900518, 5895.4399332063385, 5511.476409741068, 5541.307336582927, 5544.112941929272, 5611.102223644198, 5619.8595035124445, 4987.526185012418, 5017.688973043017, 5026.974865125651, 5028.748562571856, 5037.0681423936685, 5798.797042103506, 5874.588778785529, 6058.545609079249, 6066.150738896558, 6073.1497590337385, 5748.712564371848, 5795.59430839854, 5814.360420353673, 5821.970890145522, 5823.18475413451, 6001.879962400815, 6007.969960150172, 6020.397960203944, 6027.095935609694, 6029.427204415573, 5639.464250896158, 5756.568257380797, 5780.624259423124, 5781.942180578309, 5803.216565763568, 5947.821565352873, 5963.970180149072, 5965.701714914324, 5970.343262241063, 5990.400959904149, 5735.053716136791, 5784.392638773036, 5786.103154011135, 5789.623674461147, 5796.0, 5558.805441809517, 5697.145428185805, 5705.429457054262, 5743.770249189985, 5806.477417032487, 5547.694876781654, 5602.243697100839, 5604.943950560442, 5608.355039170548, 5636.1827535008015, 5565.833025009256, 5730.742116604846, 5787.276590426197, 5788.710564471844, 5800.59395842287, 5349.919751203657, 5611.579131565068, 5612.579056570855, 5640.971795140998, 5654.745536450787], "value": 5343.123260424136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.6300893446064, 635.2218532297935, 653.3858173317083, 656.1601150527326, 672.48218871469, 38276.23447531051, 40046.399304010425, 42261.57738422615, 42429.0, 42456.36315455271, 43448.0, 43491.0, 43516.0, 43957.7802110989, 44063.0, 8828.646854125844, 8870.713746506754, 8877.201051905327, 8882.822343553125, 8949.95525022374, 8753.693620723276, 8806.20744133028, 8811.867821982676, 8854.911450885505, 8865.335099867503, 8811.339149563777, 8834.249088827457, 8869.600867960926, 8890.59992300348, 8905.554722263862, 8716.869246961302, 8777.2100510954, 8801.559922003906, 8801.603927823264, 8817.515036672981, 8703.608337624823, 8820.823583528294, 8845.778855528599, 8848.29213662912, 8854.380193386402, 33738.1565460863, 39277.803610982046, 39279.80360098181, 39592.80203598963, 39750.20499589992, 3350.614679311886, 3497.7551571390013, 3569.28614277143, 3693.3351996640595, 4007.8597249096433, 29986.200827950393, 30118.397632047236, 30447.0, 30559.0, 31080.0, 3848.5574158971795, 3865.4588357629955, 3891.8637847675195, 3932.1545867638597, 4022.0749227677798, 278498.0, 279267.0, 280017.59991199913, 280021.0, 281349.0, 34331.31337373239, 34563.0, 34570.65429345725, 34646.48030279548, 34784.82607586946, 35579.28841423209, 35941.0, 36494.27011459756, 36807.0, 37960.620393796264, 14865.0, 15114.773278400833, 15147.242637868063, 15151.0, 15152.696946061016, 12176.086793490524, 12294.877051229374, 12315.384230788424, 12328.81506777399, 12360.072994525266, 19261.03761555633, 19377.61244775125, 19408.514787130152, 19432.2227110914, 19532.218711251677, 6950.687219075154, 7075.92924070763, 7085.256048114977, 7320.816979575447, 7340.265973402724, 981.4503877828439, 1096.2819353323587, 1125.6229163230246, 1161.692151579832, 1194.0447641886456, 30378.392432151235, 30892.138482689665, 31397.372052559276, 31533.684663153075, 31715.0, 1064.3826580583243, 1156.3639998001233, 1158.415000424797, 1196.5991392883307, 1233.7902556565405, 16875.32498700063, 16919.492415227563, 16927.153642317833, 17139.22873470697, 17155.91422042907, 488642.5567872138, 493732.0, 494522.0, 499778.0, 500788.0, 53567.0, 54270.45729542733, 54353.1847022295, 54470.72764636151, 54475.36959358499, 1389.5206153876895, 1407.050241087262, 1411.6964852556544, 1427.1651084115701, 1431.0698046270008, 30102.05855330156, 30445.0, 30724.69275307308, 30975.0, 32071.679283207803, 47802.76098619624, 47957.76021120012, 48011.5198848021, 48154.75922620364, 48324.516754832, 381176.0, 381824.0, 385409.0, 389081.0, 389347.0, 27658.5851212236, 27958.440831182856, 28037.299067522657, 28117.43765124727, 28210.71789282163, 47268.527314726416, 47575.286370703776, 47833.0, 48222.758886205345, 48719.0, 39119.80440097895, 39215.21569568536, 39743.60256397399, 39831.601683982786, 39868.60131398765, 38342.80828595839, 40096.59903400928, 40670.38994415027, 40674.593254067084, 40675.1864962705, 35725.28549429049, 39801.60198397979, 40037.0, 41371.0, 41420.893432992045, 34573.30853382969, 34783.652163479055, 34942.65057349495, 35778.463323050695, 35831.0, 26910.0, 27113.0, 27321.86339068292, 27409.498588452316, 27667.0], "value": 19021.783723298133, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.48852979656243, 396.7520299812618, 401.9698522610804, 402.0732212250763, 418.07188042545556, 17927.0, 18915.52711182221, 19576.21695132195, 19600.411987640375, 19648.803511964878, 16409.425670101547, 16684.0, 16900.66198676029, 18734.531636709056, 18826.0, 5190.7664155112925, 5502.697351645658, 5538.861528461791, 5692.430756924316, 5701.429857014306, 5364.383095943957, 5458.645188062783, 5458.6724796512135, 5470.863228419282, 5493.560515158798, 6120.3267640559725, 6328.525360597951, 6331.651759153245, 6361.077643741654, 6376.139221205148, 5314.707691076989, 5638.971805140948, 6263.24841019076, 6296.716647750839, 6314.93685063148, 5385.111456609655, 5501.944980550184, 5505.03661859177, 5515.25544051556, 5520.420355862617, 13026.54407095747, 13241.602751917362, 13250.536231231861, 13370.732585348238, 13383.732325353536, 2272.261515007629, 2297.7242730872235, 2302.5148779037595, 2410.9517809643885, 2454.779069883701, 9619.711408657751, 10170.0, 10302.690919272434, 12062.517499300018, 14436.927815360961, 1970.4285757130415, 1984.3848406993734, 2011.7284166637462, 2016.9703714007528, 2045.948851278715, 54775.452245477434, 69499.30500694978, 76105.23894761037, 77271.0, 77755.0, 10480.213983951235, 10701.946490267499, 10706.678799636024, 10837.891621083845, 10837.945810271056, 14141.434342626386, 14239.715205695828, 14384.35270412834, 14421.639459013399, 14532.418703251962, 7472.887906681404, 7782.883256751154, 7786.532808031537, 7828.804279893048, 7877.4091943104495, 7511.549307041595, 7540.472166948371, 7616.276453736886, 7694.692212311445, 8059.879101813477, 4473.635541159977, 4481.282994720829, 4529.9547004530195, 4607.7004994675235, 4617.907641847211, 1925.768907731053, 1967.2721093195323, 2063.473814177375, 2096.727425434684, 2115.0482282972416, 946.9005754395827, 1115.1859142825783, 1125.454154734953, 1131.179894576442, 1143.5368675686361, 17147.828521714622, 19305.80694193068, 19683.31108411199, 19740.124688154603, 19809.10859011348, 996.7657600463886, 998.485779823377, 1004.3685543874948, 1035.984460233097, 1057.1067448006422, 10485.970566924048, 10824.621138260123, 10846.069134596712, 10860.185486088574, 10875.293105948089, 425790.0, 455372.0, 490528.0, 496153.0, 501131.0, 54074.0, 65163.022554661715, 77614.61192694001, 91077.54461227651, 91289.0, 1056.3186744549723, 1082.8917108289108, 1095.2442814457997, 1104.6023431564631, 1110.8333749937574, 17536.82463175352, 17579.82420175782, 17611.55971100733, 17795.555111122325, 18002.819971800116, 32407.837960810044, 37913.86258412252, 41326.0, 41521.79239103785, 42183.36724949067, 56941.0, 57479.7126014384, 57734.0, 58013.4198658008, 58626.413735862094, 6937.514373993772, 7431.8142046449275, 7723.691052357843, 8313.334933205208, 8357.289630381243, 9142.08579142107, 12364.938175309066, 12718.554850580185, 12980.15628984113, 12983.221006739626, 11444.42777861087, 11680.94159529197, 11788.410579471163, 11951.402429878297, 12006.699832504257, 11275.379854107774, 11505.194636375709, 11562.710932226762, 11602.303861768321, 11908.16642835028, 11701.941490292495, 11739.119566032752, 12114.757704845677, 12137.453814578188, 12149.514019439124, 7956.2043795619975, 8000.159983201913, 8070.636821342936, 8077.1115177329275, 8202.38482113832, 11135.830737772741, 11640.94179529097, 11675.0, 11733.609433877777, 11871.762564748484], "value": 8948.384426362516, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.1049081042186, 1525.8474152584743, 1714.9142542872853, 1813.755143055687, 1842.7051671732524, 7581.962090189541, 8111.87832182517, 8216.876746848802, 8647.870281945776, 8679.652813887446, 8262.876056859137, 8530.720391941211, 8585.184407481294, 8600.741977740661, 8622.698205562807, 2232.8771917544527, 2253.752087270399, 2259.548090381922, 2265.66015097735, 2268.1381075191402, 2239.496113374486, 2252.076648574077, 2265.365697604665, 2286.622707253301, 2287.3824067501764, 2221.6112180368373, 2252.763459836718, 2263.977360226393, 2306.976930230693, 2309.064828744353, 2167.1439781286463, 2174.4346469917778, 2185.530111026129, 2189.069645400706, 2195.4072400451787, 2161.967570486444, 2174.4672555223915, 2175.3473957812594, 2177.923772667949, 2183.148572056899, 8322.16778322169, 8399.076101628816, 8426.705065322683, 8443.282321002722, 8456.323494120456, 4754.738489383082, 4837.612990960714, 4883.682560633548, 4886.071646387175, 4891.8777030574165, 3065.2949821540947, 3138.921526961821, 3271.8691252349877, 3273.0508152635707, 3287.128910838606, 1043.3270540501335, 1075.4138994248153, 1082.7563798145434, 1083.6748975307376, 1085.5223701571363, 11696.941515292454, 11724.648260552198, 11753.294802311888, 11784.057275417947, 11794.764104717857, 4267.295896177096, 4320.740755554677, 4362.192994296002, 4384.4081049058605, 4406.669499787528, 9823.852642210373, 9831.213502919749, 9851.113399794052, 9857.359271647463, 9859.605615775288, 4750.928736068961, 4763.785629646674, 4777.140114779304, 4780.330753694486, 4780.904381912343, 4161.8959526012095, 4285.100128972888, 4303.720258183208, 4384.868453946387, 4423.137488189836, 3826.942595861064, 3854.2676891390547, 3918.1380096378753, 3949.111449923744, 4077.673786097105, 1243.2043492165021, 1274.4456161569747, 1275.7002104505434, 1283.1146508908823, 1290.9806352904714, 914.2548822709471, 986.3243678080538, 996.850472429127, 999.1257649556638, 1006.7885743993697, 5836.0, 5923.08192230205, 5973.104034394789, 6070.544709146831, 6071.210742603522, 956.383132879289, 996.1383403356045, 1017.4861694844057, 1028.0798685176874, 1045.8274384726587, 4141.254574176617, 4257.084726783756, 4399.6040356368085, 4409.096135292258, 4438.5561443856, 10654.414007229676, 11018.50416731249, 11038.17213708959, 11044.061254793272, 11139.610113645984, 10797.892021079846, 10982.890171098346, 10997.34015959045, 10999.780004399867, 11015.504302306255, 7582.696692132253, 7892.644830982505, 7981.3614910807, 8046.275835174745, 8134.552599607078, 5860.882782344414, 5874.0, 5884.705764711833, 5910.379410162043, 5921.5558833086825, 8952.552372381224, 9441.339106262496, 9481.336306458481, 9535.47554884488, 9569.712908612753, 9552.092551207625, 9586.376885502421, 9595.520223988913, 9709.737734094522, 9852.802943941224, 6900.7997615616505, 7403.7408690695565, 7571.091469023752, 7636.80907977305, 7737.961310193638, 8549.957250213958, 8554.78613034679, 8622.870656940026, 8624.870626940476, 8633.611487483204, 7296.160941491797, 7462.925370746223, 7513.1359893612935, 7520.511166774142, 7546.9622651888585, 7372.778816635509, 7398.482106252511, 7421.740239091606, 7431.219721929336, 7554.395648348229, 7041.964790176016, 7070.39901608369, 7126.714931402686, 7131.358177764027, 7139.428845692436, 5034.647574669884, 5046.924296135634, 5159.0, 5226.189940559219, 5358.223057656696, 5109.923351149661, 5164.302819119371, 5196.272521846869, 5258.316418865523, 5270.78916843322], "value": 4531.181706626048, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.9491883839167, 318.8820136549476, 321.53377602476405, 323.7296857124301, 325.8094015001224, 5491.313585801775, 5595.38450770415, 5657.12314591238, 5682.090865461532, 5688.715564221788, 5611.7474713637885, 5613.736909195429, 5623.943760562393, 5635.492805647491, 5657.717114144297, 4287.807048682809, 4326.459192600925, 4328.4156638853665, 4347.60871521563, 4351.73889566627, 4120.484939382577, 4335.1979883721615, 4344.0, 4344.500382456026, 4364.585364390377, 4251.6173544381, 4267.850625228118, 4271.359296105578, 4295.613394794468, 4307.440032795732, 4265.296226122686, 4270.871873843789, 4273.316269396897, 4282.250606143913, 4326.048269380763, 3519.982400088009, 3756.6476068615275, 3784.7291625024764, 3785.413260944558, 3795.658390744846, 5339.864054378279, 5419.349678038621, 5441.1838224266285, 5444.428335024844, 5498.285222921035, 4843.2735089736825, 4859.1010663027455, 4878.317035615017, 4893.217085266376, 4902.240152776325, 5528.308961379827, 5817.360090390053, 5840.094785308284, 5861.824145275648, 5908.172855800191, 4044.534878488982, 4085.713000404863, 4092.5088989321175, 4102.097538541516, 4115.814788334532, 6103.542234332443, 6128.039027511199, 6135.815925522242, 6145.723442445101, 6164.7534098636, 4077.286474866946, 4188.141431006637, 4190.497140343117, 4198.895027624334, 4206.579342065769, 4234.9364759528635, 4245.617894389458, 4249.68127390447, 4263.552327005682, 4276.444062271947, 4872.902541949212, 4875.756212189447, 4889.951100489021, 4917.844306587949, 4925.38432695913, 5657.660540367591, 5861.329521086555, 5916.763329466773, 5927.911081333784, 5955.67243801595, 1456.5047883719585, 1479.2529772464836, 1480.533631905946, 1485.3316007796534, 1488.1220080152762, 881.3830318776882, 910.6220918318955, 918.875951746519, 932.7481579973369, 944.0135058863367, 4976.900461990812, 5032.521910418504, 5067.011932673094, 5090.77091530882, 5132.28148059272, 5312.592163076788, 5331.30693009914, 5355.464453554613, 5361.410244873061, 5393.7572809223675, 5055.317532133188, 5060.139776238048, 5131.512506311894, 5334.306540149756, 5800.274965629296, 3245.902622921316, 3254.316593515341, 3269.594074547967, 3281.3273278977754, 3288.358770039867, 6064.75740970365, 6225.159603453566, 6314.842128946813, 6339.619622822645, 6349.174607301114, 6092.390760923872, 6124.540659450559, 6130.233720784902, 6145.293291271561, 6171.753129874754, 6203.596766210272, 6223.408776166257, 6229.283632382334, 6244.345248509148, 6258.468030217391, 5802.709864506842, 6072.332043475126, 6074.969625151846, 6119.470132466883, 6125.632462052291, 5941.613795103304, 6028.306744724413, 6029.824184284198, 6044.969775151096, 6069.180660610761, 5973.91039134422, 6206.844828879314, 6220.760526210651, 6230.221222347207, 6298.84252893663, 4158.355454904495, 4202.915941681088, 4211.7262377945335, 4213.220554197484, 4225.72532785368, 6083.452489275986, 6140.8771824564155, 6156.138140660221, 6201.286852012076, 6208.689565521796, 5800.744043166445, 5804.303483581997, 5858.7070646468355, 5878.970605146947, 5937.851553711192, 5811.622244554091, 5879.764809407576, 5882.0, 5892.175095486549, 5925.348211696796, 5566.443355664401, 5787.594868359174, 5820.185174075548, 5831.591788574759, 5838.766449341979, 5905.261842269716, 5907.586468947133, 5921.348651648229, 5964.522838173022, 5968.880622387441, 5832.533397328289, 5836.0, 5864.237649105759, 5885.705714714161, 5923.763049477972], "value": 4406.714987737487, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.8576913079122, 800.6277081157265, 802.2579114319253, 814.3854956159904, 847.4576271186442, 13849.099808512452, 14287.642808929782, 14522.491712790055, 14532.564023079298, 14566.19885906276, 13282.867171328284, 13283.402246898888, 13451.529196478125, 13490.123141995764, 13509.392077356519, 685.4379408884716, 773.1225059557414, 795.9840803183962, 796.2077732656015, 815.5514467043132, 792.6829268292671, 794.3287921706149, 795.8368534450424, 799.5562462833125, 807.2492581898832, 841.3605659698643, 846.4371193156544, 849.129642116829, 850.6299759604561, 851.3189448441253, 843.73844108326, 844.7930257086991, 844.9408541402104, 845.4124383553433, 846.699421705295, 608.0666177417643, 609.945104940553, 610.5115907274208, 612.0604871522237, 616.0266778489976, 12511.0, 12600.306983115925, 12601.810972835416, 12641.557545485864, 12664.11351205416, 12496.625101246977, 12504.937475312656, 12527.686807829787, 12570.0, 12863.807042894365, 11000.779984400348, 11054.613088541862, 11271.211015228855, 11299.830502542469, 11480.425978701032, 3705.1663375740513, 3724.571674257468, 3740.9438858416875, 3765.5669597996307, 3843.077661361281, 53943.0, 54345.456545434434, 55080.724596376764, 55315.0, 56004.0, 9782.75543111428, 9845.803083938425, 9981.900180998242, 10199.0820826126, 10201.438920859424, 16830.831691682928, 17758.91120544389, 17775.822241777416, 17782.110894455225, 17818.287268509375, 7772.844543109106, 8085.0, 8277.04813946392, 8282.875756863652, 8284.378671599654, 4566.292224705176, 4600.010997635524, 4718.740469274154, 4740.928886066712, 4751.121042607128, 3198.63215730194, 3331.3337332533106, 3334.8165850878436, 3335.3496068266454, 3376.459766437358, 598.5152026858259, 602.7920367473215, 603.6528995827417, 607.0529973241757, 613.5490414545305, 668.7358493395179, 709.4324540367788, 761.2273542354515, 776.8640487914593, 782.7847341981001, 9232.584533696, 9552.761180970532, 9586.856197157049, 9593.42439453635, 9694.369865958832, 634.4195061518659, 638.8466767975652, 736.120336198238, 748.7042618165794, 778.9182135875765, 4572.977135114304, 4579.9084018319445, 4607.9078418431445, 4629.884252893705, 4649.395578574831, 65721.34278657248, 66362.66818665972, 68396.6580167106, 69236.0, 69749.30250697529, 59089.0, 60053.39946600478, 60204.0, 60494.0, 61627.69186154041, 51923.22115168275, 52187.73906130445, 52590.0, 53166.0, 56128.71935640377, 8129.4715843469985, 8140.59297035134, 8165.305948994164, 8309.584520773817, 8342.666293348198, 33924.49113263254, 34120.48819267763, 34720.652793471745, 35111.82444087763, 35605.46591801177, 47234.0, 47687.52312476831, 47828.7608561955, 47940.520594795, 48546.75726621485, 11451.942740286579, 11556.248843825124, 11671.533138674358, 11721.706957326134, 12002.75994480123, 13248.20510769357, 13639.659008524866, 13988.230647314496, 14165.929170354082, 14169.079009864327, 12382.0, 12482.500699971899, 12561.497540098293, 12660.493580256687, 13278.86721132815, 13024.674383140497, 13187.340632968506, 13240.271785051915, 13319.66700832487, 13605.931970340085, 12385.380730963596, 12495.437705303102, 13007.479700811862, 13330.600081997556, 13873.236971966639, 9263.490508021854, 9643.324967252225, 9768.755781105245, 10698.358098514114, 11002.779944400907, 10839.0, 10957.671269861918, 11004.614838480615, 11014.50434730423, 11171.497282622464], "value": 6698.406427900403, "unit": "score"}], "name": "dromaeo_css", "value": 7039.175313339382, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 103.0, 110.0, 111.0, 114.0, 107.0, 109.0, 112.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 129.0, 156.0, 218.0, 125.0, 159.0, 159.0, 125.0, 189.0, 127.0], "value": 154.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 172.0, 163.0, 161.0, 164.0, 174.0, 162.0, 161.0, 166.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 157.0, 76.0, 77.0, 75.0, 75.0, 164.0, 76.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 188.0, 92.0, 92.0, 92.0, 139.0, 93.0, 92.0, 146.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 116.0, 116.0, 118.0, 117.0, 118.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 58.0, 57.0, 61.0, 61.0, 58.0, 110.0, 57.0, 60.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 80.0, 80.0, 81.0, 79.0, 81.0, 83.0, 81.0, 81.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 125.0, 136.0, 136.0, 133.0, 128.0, 127.0, 134.0, 192.0, 136.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 169.0, 163.0, 180.0, 167.0, 164.0, 163.0, 166.0, 165.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 64.0, 64.0, 67.0, 67.0, 65.0, 65.0, 63.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1567.7, "alertThreshold": 2.0}]} 16:32:08 INFO - Return code: 0 16:32:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:32:08 ERROR - # TBPL SUCCESS # 16:32:08 INFO - Running post-action listener: _resource_record_post_action 16:32:08 INFO - ##### 16:32:08 INFO - ##### Finished run-tests step (success) 16:32:08 INFO - ##### 16:32:08 INFO - Running post-run listener: _resource_record_post_run 16:32:09 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 7938048; Write bytes: 460349440; Read time: 2104; Write time: 331204 16:32:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 96284672; Read time: 0; Write time: 82764 16:32:09 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 6201344; Write bytes: 364064768; Read time: 2060; Write time: 248440 16:32:09 INFO - Running post-run listener: _upload_blobber_files 16:32:09 INFO - Blob upload gear active. 16:32:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:09 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 16:32:09 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'] 16:32:09 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 16:32:10 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:10 INFO - (blobuploader) - INFO - Done attempting. 16:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:32:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:11 INFO - (blobuploader) - INFO - Done attempting. 16:32:11 INFO - (blobuploader) - INFO - Iteration through files over. 16:32:11 INFO - Return code: 0 16:32:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:32:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:32:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f0d9ba88185fd9f514502f4c5fcf98b370c945857670d32d29eed70003dddf4407d539cc6c03816ad7d0947d56ddd9e936cf3f6087685e0bfabdbce5e816eaae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8482f136e70bb11a6543cd0135f432e2667f7e96736138f150844b9943f2dced705eac229d942416483847b4efc1e09ddccb144222684a57a139ca5fa48b8266"} 16:32:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:32:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:32:11 INFO - Contents: 16:32:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f0d9ba88185fd9f514502f4c5fcf98b370c945857670d32d29eed70003dddf4407d539cc6c03816ad7d0947d56ddd9e936cf3f6087685e0bfabdbce5e816eaae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8482f136e70bb11a6543cd0135f432e2667f7e96736138f150844b9943f2dced705eac229d942416483847b4efc1e09ddccb144222684a57a139ca5fa48b8266"} 16:32:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:32:11 INFO - Copying logs to upload dir... 16:32:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:32:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.696917 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-09 16:32:12.033032) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 16:32:12.036821) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048 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/f0d9ba88185fd9f514502f4c5fcf98b370c945857670d32d29eed70003dddf4407d539cc6c03816ad7d0947d56ddd9e936cf3f6087685e0bfabdbce5e816eaae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8482f136e70bb11a6543cd0135f432e2667f7e96736138f150844b9943f2dced705eac229d942416483847b4efc1e09ddccb144222684a57a139ca5fa48b8266"} build_url:https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011059 build_url: 'https://queue.taskcluster.net/v1/task/XAlnSwTYTS-OAvHd-6bKHg/artifacts/public/build/firefox-49.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/f0d9ba88185fd9f514502f4c5fcf98b370c945857670d32d29eed70003dddf4407d539cc6c03816ad7d0947d56ddd9e936cf3f6087685e0bfabdbce5e816eaae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8482f136e70bb11a6543cd0135f432e2667f7e96736138f150844b9943f2dced705eac229d942416483847b4efc1e09ddccb144222684a57a139ca5fa48b8266"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 16:32:12.061092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:32:12.061409) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1462835077.979407-891692048 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:32:12.144002) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 16:32:12.144283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 16:32:12.144596) ========= ========= Total master_lag: 0.37 =========