builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1450413215.5 results: success (0) buildid: 20151217191453 builduid: dcc939b248b24826b3a102db6d9dca33 revision: e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.503319) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.504216) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.504682) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006191 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.531148) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.531831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.546379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.546738) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.596574) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.596924) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.597350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.597682) ========= 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=7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 20:33:35-- 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% 43.5M=0s 2015-12-17 20:33:35 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.209284 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.820436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.820847) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020789 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.871003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:35.871399) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4 --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=7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 20:33:36,031 truncating revision to first 12 chars 2015-12-17 20:33:36,031 Setting DEBUG logging. 2015-12-17 20:33:36,031 attempt 1/10 2015-12-17 20:33:36,031 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/e9d5cb555ba7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 20:33:36,527 unpacking tar archive at: b2g-inbound-e9d5cb555ba7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.771432 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:36.659241) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:36.659768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:36.670473) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:36.670831) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 20:33:36.671321) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-17 20:33:36.671655) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-Non-PGO'] 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=7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:33:36 INFO - MultiFileLogger online at 20151217 20:33:36 in /builds/slave/test 20:33:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 20:33:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:33:36 INFO - {'append_to_log': False, 20:33:36 INFO - 'base_work_dir': '/builds/slave/test', 20:33:36 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 20:33:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:33:36 INFO - 'branch': 'B2G-Inbound-Non-PGO', 20:33:36 INFO - 'buildbot_json_path': 'buildprops.json', 20:33:36 INFO - 'config_files': ('talos/linux_config.py',), 20:33:36 INFO - 'default_actions': ('clobber', 20:33:36 INFO - 'read-buildbot-config', 20:33:36 INFO - 'download-and-extract', 20:33:36 INFO - 'populate-webroot', 20:33:36 INFO - 'create-virtualenv', 20:33:36 INFO - 'install', 20:33:36 INFO - 'run-tests'), 20:33:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:33:36 INFO - 'download_minidump_stackwalk': True, 20:33:36 INFO - 'download_symbols': 'ondemand', 20:33:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:33:36 INFO - 'tooltool.py': '/tools/tooltool.py', 20:33:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:33:36 INFO - '/tools/misc-python/virtualenv.py')}, 20:33:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:33:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:33:36 INFO - 'installer_path': 'installer.exe', 20:33:36 INFO - 'log_level': 'info', 20:33:36 INFO - 'log_name': 'talos', 20:33:36 INFO - 'log_to_console': True, 20:33:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:33:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:33:36 INFO - 'opt_config_files': (), 20:33:36 INFO - 'pip_index': False, 20:33:36 INFO - 'sps_profile': False, 20:33:36 INFO - 'sps_profile_interval': 0, 20:33:36 INFO - 'suite': 'dromaeojs', 20:33:36 INFO - 'system_bits': '64', 20:33:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:33:36 INFO - 'title': 'talos-linux64-ix-008', 20:33:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:33:36 INFO - 'use_talos_json': True, 20:33:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:33:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:33:36 INFO - 'work_dir': 'build'} 20:33:36 INFO - ##### 20:33:36 INFO - ##### Running clobber step. 20:33:36 INFO - ##### 20:33:36 INFO - Running pre-action listener: _resource_record_pre_action 20:33:36 INFO - Running main action method: clobber 20:33:36 INFO - rmtree: /builds/slave/test/build 20:33:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:33:37 INFO - Running post-action listener: _resource_record_post_action 20:33:37 INFO - ##### 20:33:37 INFO - ##### Running read-buildbot-config step. 20:33:37 INFO - ##### 20:33:37 INFO - Running pre-action listener: _resource_record_pre_action 20:33:37 INFO - Running main action method: read_buildbot_config 20:33:37 INFO - Using buildbot properties: 20:33:37 INFO - { 20:33:37 INFO - "project": "", 20:33:37 INFO - "product": "firefox", 20:33:37 INFO - "script_repo_revision": "production", 20:33:37 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 20:33:37 INFO - "repository": "", 20:33:37 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 20:33:37 INFO - "buildid": "20151217191453", 20:33:37 INFO - "pgo_build": "False", 20:33:37 INFO - "basedir": "/builds/slave/test", 20:33:37 INFO - "buildnumber": 787, 20:33:37 INFO - "slavename": "talos-linux64-ix-008", 20:33:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:33:37 INFO - "platform": "ubuntu64_hw", 20:33:37 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 20:33:37 INFO - "branch": "b2g-inbound", 20:33:37 INFO - "repo_path": "integration/b2g-inbound", 20:33:37 INFO - "revision": "e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4", 20:33:37 INFO - "stage_platform": "linux64", 20:33:37 INFO - "builduid": "dcc939b248b24826b3a102db6d9dca33", 20:33:37 INFO - "slavebuilddir": "test" 20:33:37 INFO - } 20:33:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:33:37 INFO - Running post-action listener: _resource_record_post_action 20:33:37 INFO - ##### 20:33:37 INFO - ##### Running download-and-extract step. 20:33:37 INFO - ##### 20:33:37 INFO - Running pre-action listener: _resource_record_pre_action 20:33:37 INFO - Running main action method: download_and_extract 20:33:37 INFO - mkdir: /builds/slave/test/build/tests 20:33:37 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')]} 20:33:37 INFO - https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/test_packages.json 20:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/test_packages.json 20:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:33:37 INFO - Downloaded 1302 bytes. 20:33:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:33:37 INFO - Using the following test package requirements: 20:33:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:33:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:33:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:37 INFO - u'jsshell-linux-x86_64.zip'], 20:33:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:33:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:33:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:33:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:33:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:33:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:33:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:33:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:33:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:33:37 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')]} 20:33:37 INFO - https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:33:38 INFO - Downloaded 21871020 bytes. 20:33:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:33:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:33:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:33:39 INFO - Return code: 0 20:33:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:33: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')]} 20:33:39 INFO - https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:33:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:33:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:33:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:33:40 INFO - Downloaded 21871020 bytes. 20:33:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:33:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:33:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:33:42 INFO - Return code: 0 20:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:42 INFO - https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:33:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:33:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:33:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:33:43 INFO - Downloaded 11132039 bytes. 20:33:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 20:33:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:33:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 20:33:43 INFO - Return code: 0 20:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:43 INFO - https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:33:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:33:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:33:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:33:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:33:44 INFO - Downloaded 53019169 bytes. 20:33:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:33:44 INFO - mkdir: /builds/slave/test/properties 20:33:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:33:44 INFO - Writing to file /builds/slave/test/properties/build_url 20:33:44 INFO - Contents: 20:33:44 INFO - build_url:https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:33:44 INFO - Running post-action listener: _resource_record_post_action 20:33:44 INFO - Running post-action listener: set_extra_try_arguments 20:33:44 INFO - ##### 20:33:44 INFO - ##### Running populate-webroot step. 20:33:44 INFO - ##### 20:33:44 INFO - Running pre-action listener: _resource_record_pre_action 20:33:44 INFO - Running main action method: populate_webroot 20:33:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:33:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:33:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:33:44 INFO - '--tppagecycles', 20:33:44 INFO - '7'], 20:33:44 INFO - 'tests': ['tsvgm']}}, 20:33:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:33:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:33:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:33:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:33:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:33:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:33:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:33:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:44 INFO - 'talos_options': ['--e10s'], 20:33:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:33:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:44 INFO - 'tests': ['damp', 'tps']}, 20:33:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:44 INFO - 'talos_options': ['--e10s'], 20:33:44 INFO - 'tests': ['damp', 'tps']}, 20:33:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:33:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:33:44 INFO - 'other': {'tests': ['a11yr', 20:33:44 INFO - 'ts_paint', 20:33:44 INFO - 'tpaint', 20:33:44 INFO - 'sessionrestore', 20:33:44 INFO - 'sessionrestore_no_auto_restore']}, 20:33:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:33:44 INFO - 'tests': ['a11yr', 20:33:44 INFO - 'ts_paint', 20:33:44 INFO - 'tpaint', 20:33:44 INFO - 'sessionrestore', 20:33:44 INFO - 'sessionrestore_no_auto_restore']}, 20:33:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:33:44 INFO - 'tests': ['a11yr', 20:33:44 INFO - 'ts_paint', 20:33:44 INFO - 'tpaint', 20:33:44 INFO - 'sessionrestore', 20:33:44 INFO - 'sessionrestore_no_auto_restore']}, 20:33:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:33:44 INFO - 'tests': ['a11yr', 20:33:44 INFO - 'ts_paint', 20:33:44 INFO - 'tpaint', 20:33:44 INFO - 'sessionrestore', 20:33:44 INFO - 'sessionrestore_no_auto_restore']}, 20:33:44 INFO - 'other_l64': {'tests': ['a11yr', 20:33:44 INFO - 'ts_paint', 20:33:44 INFO - 'tpaint', 20:33:44 INFO - 'sessionrestore', 20:33:44 INFO - 'sessionrestore_no_auto_restore']}, 20:33:44 INFO - 'other_nol64': {'tests': ['a11yr', 20:33:44 INFO - 'ts_paint', 20:33:44 INFO - 'tpaint', 20:33:44 INFO - 'sessionrestore', 20:33:44 INFO - 'sessionrestore_no_auto_restore']}, 20:33:44 INFO - 'svgr': {'tests': ['tsvgx', 20:33:44 INFO - 'tsvgr_opacity', 20:33:44 INFO - 'tart', 20:33:44 INFO - 'tscrollx', 20:33:44 INFO - 'cart']}, 20:33:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:33:44 INFO - 'tests': ['tsvgx', 20:33:44 INFO - 'tsvgr_opacity', 20:33:44 INFO - 'tart', 20:33:44 INFO - 'tscrollx', 20:33:44 INFO - 'cart']}, 20:33:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:44 INFO - 'tests': ['tp5o']}, 20:33:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:44 INFO - 'talos_options': ['--e10s'], 20:33:44 INFO - 'tests': ['tp5o']}, 20:33:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:44 INFO - 'talos_options': ['--xperf_path', 20:33:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:33:44 INFO - 'tests': ['tp5n']}, 20:33:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:44 INFO - 'talos_options': ['--e10s', 20:33:44 INFO - '--xperf_path', 20:33:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:33:44 INFO - 'tests': ['tp5n']}}, 20:33:44 INFO - 'talos.zip': {'path': '', 20:33:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:33:44 INFO - Running post-action listener: _resource_record_post_action 20:33:44 INFO - ##### 20:33:44 INFO - ##### Running create-virtualenv step. 20:33:44 INFO - ##### 20:33:44 INFO - Running pre-action listener: _resource_record_pre_action 20:33:44 INFO - Running main action method: create_virtualenv 20:33:44 INFO - Creating virtualenv /builds/slave/test/build/venv 20:33:44 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 20:33:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:33:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:33:44 INFO - Using real prefix '/usr' 20:33:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:33:45 INFO - Installing distribute.............................................................................................................................................................................................done. 20:33:47 INFO - Installing pip.................done. 20:33:47 INFO - Return code: 0 20:33:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:33:47 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')]} 20:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:47 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')]} 20:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f96e7601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f0b0>, '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 0xe1ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20440>, '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': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', '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 20:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:33:47 INFO - Using env: {'DISPLAY': ':0', 20:33:47 INFO - 'HOME': '/home/cltbld', 20:33:47 INFO - 'LANG': 'en_US.UTF-8', 20:33:47 INFO - 'LANGUAGE': 'en_US:en', 20:33:47 INFO - 'LOGNAME': 'cltbld', 20:33:47 INFO - 'MAIL': '/var/mail/cltbld', 20:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:47 INFO - 'MOZ_NO_REMOTE': '1', 20:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:47 INFO - 'NO_EM_RESTART': '1', 20:33:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:47 INFO - 'PWD': '/builds/slave/test', 20:33:47 INFO - 'SHELL': '/bin/bash', 20:33:47 INFO - 'SHLVL': '1', 20:33:47 INFO - 'TERM': 'linux', 20:33:47 INFO - 'TMOUT': '86400', 20:33:47 INFO - 'USER': 'cltbld', 20:33:47 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', 20:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:47 INFO - '_': '/tools/buildbot/bin/python'} 20:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:47 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 20:33:47 INFO - Cleaning up... 20:33:47 INFO - Return code: 0 20:33:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:33:47 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')]} 20:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:47 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')]} 20:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f96e7601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f0b0>, '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 0xe1ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20440>, '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': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', '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 20:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:33:47 INFO - Using env: {'DISPLAY': ':0', 20:33:47 INFO - 'HOME': '/home/cltbld', 20:33:47 INFO - 'LANG': 'en_US.UTF-8', 20:33:47 INFO - 'LANGUAGE': 'en_US:en', 20:33:47 INFO - 'LOGNAME': 'cltbld', 20:33:47 INFO - 'MAIL': '/var/mail/cltbld', 20:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:47 INFO - 'MOZ_NO_REMOTE': '1', 20:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:47 INFO - 'NO_EM_RESTART': '1', 20:33:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:47 INFO - 'PWD': '/builds/slave/test', 20:33:47 INFO - 'SHELL': '/bin/bash', 20:33:47 INFO - 'SHLVL': '1', 20:33:47 INFO - 'TERM': 'linux', 20:33:47 INFO - 'TMOUT': '86400', 20:33:47 INFO - 'USER': 'cltbld', 20:33:47 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', 20:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:47 INFO - '_': '/tools/buildbot/bin/python'} 20:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:47 INFO - Downloading/unpacking psutil>=0.7.1 20:33:47 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 20:33:47 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 20:33:47 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 20:33:47 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 20:33:47 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 20:33:47 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 20:33:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:33:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:33:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:33:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:33:49 INFO - Installing collected packages: psutil 20:33:49 INFO - Running setup.py install for psutil 20:33:49 INFO - building 'psutil._psutil_linux' extension 20:33:49 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 20:33:49 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 20:33:49 INFO - building 'psutil._psutil_posix' extension 20:33:49 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 20:33:49 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 20:33:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:33:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:33:49 INFO - Successfully installed psutil 20:33:49 INFO - Cleaning up... 20:33:49 INFO - Return code: 0 20:33:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:33: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')]} 20:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33: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')]} 20:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f96e7601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f0b0>, '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 0xe1ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20440>, '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': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', '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 20:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:33:49 INFO - Using env: {'DISPLAY': ':0', 20:33:49 INFO - 'HOME': '/home/cltbld', 20:33:49 INFO - 'LANG': 'en_US.UTF-8', 20:33:49 INFO - 'LANGUAGE': 'en_US:en', 20:33:49 INFO - 'LOGNAME': 'cltbld', 20:33:49 INFO - 'MAIL': '/var/mail/cltbld', 20:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:49 INFO - 'MOZ_NO_REMOTE': '1', 20:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:49 INFO - 'NO_EM_RESTART': '1', 20:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:49 INFO - 'PWD': '/builds/slave/test', 20:33:49 INFO - 'SHELL': '/bin/bash', 20:33:49 INFO - 'SHLVL': '1', 20:33:49 INFO - 'TERM': 'linux', 20:33:49 INFO - 'TMOUT': '86400', 20:33:49 INFO - 'USER': 'cltbld', 20:33:49 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', 20:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:49 INFO - '_': '/tools/buildbot/bin/python'} 20:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:33:50 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 20:33:50 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 20:33:50 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 20:33:50 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 20:33:50 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 20:33:50 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 20:33:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:33:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:33:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:33:51 INFO - Installing collected packages: mozsystemmonitor 20:33:51 INFO - Running setup.py install for mozsystemmonitor 20:33:51 INFO - Successfully installed mozsystemmonitor 20:33:51 INFO - Cleaning up... 20:33:51 INFO - Return code: 0 20:33:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:33:51 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')]} 20:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:51 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')]} 20:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f96e7601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f0b0>, '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 0xe1ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20440>, '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': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', '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 20:33:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:33:51 INFO - Using env: {'DISPLAY': ':0', 20:33:51 INFO - 'HOME': '/home/cltbld', 20:33:51 INFO - 'LANG': 'en_US.UTF-8', 20:33:51 INFO - 'LANGUAGE': 'en_US:en', 20:33:51 INFO - 'LOGNAME': 'cltbld', 20:33:51 INFO - 'MAIL': '/var/mail/cltbld', 20:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:51 INFO - 'MOZ_NO_REMOTE': '1', 20:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:51 INFO - 'NO_EM_RESTART': '1', 20:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:51 INFO - 'PWD': '/builds/slave/test', 20:33:51 INFO - 'SHELL': '/bin/bash', 20:33:51 INFO - 'SHLVL': '1', 20:33:51 INFO - 'TERM': 'linux', 20:33:51 INFO - 'TMOUT': '86400', 20:33:51 INFO - 'USER': 'cltbld', 20:33:51 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', 20:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:51 INFO - '_': '/tools/buildbot/bin/python'} 20:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:52 INFO - Downloading/unpacking blobuploader==1.2.4 20:33:52 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 20:33:52 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 20:33:52 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 20:33:52 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 20:33:52 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 20:33:52 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 20:33:53 INFO - Downloading blobuploader-1.2.4.tar.gz 20:33:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:33:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:33:54 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 20:33:54 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 20:33:54 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 20:33:54 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 20:33:54 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 20:33:54 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 20:33:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:33:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:33:54 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 20:33:54 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 20:33:54 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 20:33:54 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 20:33:54 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 20:33:54 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 20:33:54 INFO - Downloading docopt-0.6.1.tar.gz 20:33:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:33:54 INFO - Installing collected packages: blobuploader, requests, docopt 20:33:54 INFO - Running setup.py install for blobuploader 20:33:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:33:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:33:54 INFO - Running setup.py install for requests 20:33:55 INFO - Running setup.py install for docopt 20:33:55 INFO - Successfully installed blobuploader requests docopt 20:33:55 INFO - Cleaning up... 20:33:55 INFO - Return code: 0 20:33:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f96e7601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f0b0>, '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 0xe1ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20440>, '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': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', '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 20:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 20:33:55 INFO - Using env: {'DISPLAY': ':0', 20:33:55 INFO - 'HOME': '/home/cltbld', 20:33:55 INFO - 'LANG': 'en_US.UTF-8', 20:33:55 INFO - 'LANGUAGE': 'en_US:en', 20:33:55 INFO - 'LOGNAME': 'cltbld', 20:33:55 INFO - 'MAIL': '/var/mail/cltbld', 20:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:55 INFO - 'MOZ_NO_REMOTE': '1', 20:33:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:55 INFO - 'NO_EM_RESTART': '1', 20:33:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:55 INFO - 'PWD': '/builds/slave/test', 20:33:55 INFO - 'SHELL': '/bin/bash', 20:33:55 INFO - 'SHLVL': '1', 20:33:55 INFO - 'TERM': 'linux', 20:33:55 INFO - 'TMOUT': '86400', 20:33:55 INFO - 'USER': 'cltbld', 20:33:55 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', 20:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:55 INFO - '_': '/tools/buildbot/bin/python'} 20:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:33:55 INFO - Running setup.py (path:/tmp/pip-kwN9x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:33:55 INFO - Running setup.py (path:/tmp/pip-MOT14V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:33:55 INFO - Running setup.py (path:/tmp/pip-NYoGaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:33:55 INFO - Running setup.py (path:/tmp/pip-Sgkicz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:33:55 INFO - Running setup.py (path:/tmp/pip-UMKDA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:33:55 INFO - Running setup.py (path:/tmp/pip-aZZ7qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:33:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:33:55 INFO - Running setup.py (path:/tmp/pip-nvNpYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:33:56 INFO - Running setup.py (path:/tmp/pip-SfrcjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:33:56 INFO - Running setup.py (path:/tmp/pip-MYHLxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:33:56 INFO - Running setup.py (path:/tmp/pip-vH255i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:33:56 INFO - Running setup.py (path:/tmp/pip-18GSk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:33:56 INFO - Running setup.py (path:/tmp/pip-ZUeWAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:33:56 INFO - Running setup.py (path:/tmp/pip-p5XO27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:33:56 INFO - Running setup.py (path:/tmp/pip-eG9vNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:33:56 INFO - Running setup.py (path:/tmp/pip-HjjNnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:33:56 INFO - Running setup.py (path:/tmp/pip-z6vREs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:33:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:33:56 INFO - Running setup.py (path:/tmp/pip-HBUDJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:33:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:33:56 INFO - Running setup.py install for manifestparser 20:33:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:33:56 INFO - Running setup.py install for mozcrash 20:33:56 INFO - Running setup.py install for mozdebug 20:33:57 INFO - Running setup.py install for mozdevice 20:33:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for mozfile 20:33:57 INFO - Running setup.py install for mozhttpd 20:33:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for mozinfo 20:33:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for mozInstall 20:33:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for mozleak 20:33:57 INFO - Running setup.py install for mozlog 20:33:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for moznetwork 20:33:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:33:57 INFO - Running setup.py install for mozprocess 20:33:57 INFO - Running setup.py install for mozprofile 20:33:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Running setup.py install for mozrunner 20:33:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Running setup.py install for mozscreenshot 20:33:58 INFO - Running setup.py install for moztest 20:33:58 INFO - Running setup.py install for mozversion 20:33:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:33:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:33:58 INFO - Cleaning up... 20:33:58 INFO - Return code: 0 20:33:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:33:58 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')]} 20:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:58 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')]} 20:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f96e7601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f0b0>, '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 0xe1ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20440>, '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': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', '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 20:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:33:58 INFO - Using env: {'DISPLAY': ':0', 20:33:58 INFO - 'HOME': '/home/cltbld', 20:33:58 INFO - 'LANG': 'en_US.UTF-8', 20:33:58 INFO - 'LANGUAGE': 'en_US:en', 20:33:58 INFO - 'LOGNAME': 'cltbld', 20:33:58 INFO - 'MAIL': '/var/mail/cltbld', 20:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:58 INFO - 'MOZ_NO_REMOTE': '1', 20:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:33:58 INFO - 'NO_EM_RESTART': '1', 20:33:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:58 INFO - 'PWD': '/builds/slave/test', 20:33:58 INFO - 'SHELL': '/bin/bash', 20:33:58 INFO - 'SHLVL': '1', 20:33:58 INFO - 'TERM': 'linux', 20:33:58 INFO - 'TMOUT': '86400', 20:33:58 INFO - 'USER': 'cltbld', 20:33:58 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', 20:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:58 INFO - '_': '/tools/buildbot/bin/python'} 20:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:33:58 INFO - Running setup.py (path:/tmp/pip-EAVmfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:33:58 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)) 20:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:33:58 INFO - Running setup.py (path:/tmp/pip-_DVCzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:33:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 20:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:33:58 INFO - Running setup.py (path:/tmp/pip-tlj6bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:33:58 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)) 20:33:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:33:58 INFO - Running setup.py (path:/tmp/pip-hO40aV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:33:59 INFO - Running setup.py (path:/tmp/pip-YHVzNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:33:59 INFO - Running setup.py (path:/tmp/pip-4PhZ2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:33:59 INFO - Running setup.py (path:/tmp/pip-hNE7mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:33:59 INFO - Running setup.py (path:/tmp/pip-Y_4spS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:33:59 INFO - Running setup.py (path:/tmp/pip-Ck8ZF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:33:59 INFO - Running setup.py (path:/tmp/pip-SkvcNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:33:59 INFO - Running setup.py (path:/tmp/pip-gQTBiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:33:59 INFO - Running setup.py (path:/tmp/pip-CJTP5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:33:59 INFO - Running setup.py (path:/tmp/pip-GZ3sNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:33:59 INFO - Running setup.py (path:/tmp/pip-dz8EH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:33:59 INFO - Running setup.py (path:/tmp/pip-9c85Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:33:59 INFO - Running setup.py (path:/tmp/pip-iPTmAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:33:59 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)) 20:33:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:33:59 INFO - Running setup.py (path:/tmp/pip-vgSJ5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:33:59 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)) 20:33:59 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:33:59 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:33:59 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)) 20:33:59 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:33:59 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:33:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:33: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 20:33: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 20:33: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 20:33: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 20:33: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 20:33: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 20:34:01 INFO - Downloading blessings-1.5.1.tar.gz 20:34:01 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 20:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:34:01 INFO - Installing collected packages: blessings 20:34:01 INFO - Running setup.py install for blessings 20:34:01 INFO - Successfully installed blessings 20:34:01 INFO - Cleaning up... 20:34:01 INFO - Return code: 0 20:34:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:34:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:34:02 INFO - Reading from file tmpfile_stdout 20:34:02 INFO - Current package versions: 20:34:02 INFO - argparse == 1.2.1 20:34:02 INFO - blessings == 1.5.1 20:34:02 INFO - blobuploader == 1.2.4 20:34:02 INFO - docopt == 0.6.1 20:34:02 INFO - manifestparser == 1.1 20:34:02 INFO - mozInstall == 1.12 20:34:02 INFO - mozcrash == 0.16 20:34:02 INFO - mozdebug == 0.1 20:34:02 INFO - mozdevice == 0.47 20:34:02 INFO - mozfile == 1.2 20:34:02 INFO - mozhttpd == 0.7 20:34:02 INFO - mozinfo == 0.9 20:34:02 INFO - mozleak == 0.1 20:34:02 INFO - mozlog == 3.1 20:34:02 INFO - moznetwork == 0.27 20:34:02 INFO - mozprocess == 0.22 20:34:02 INFO - mozprofile == 0.27 20:34:02 INFO - mozrunner == 6.11 20:34:02 INFO - mozscreenshot == 0.1 20:34:02 INFO - mozsystemmonitor == 0.0 20:34:02 INFO - moztest == 0.7 20:34:02 INFO - mozversion == 1.4 20:34:02 INFO - psutil == 3.1.1 20:34:02 INFO - requests == 1.2.3 20:34:02 INFO - wsgiref == 0.1.2 20:34:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f96e7601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f0b0>, '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 0xe1ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20440>, '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': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', '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 20:34:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:34:02 INFO - Using env: {'DISPLAY': ':0', 20:34:02 INFO - 'HOME': '/home/cltbld', 20:34:02 INFO - 'LANG': 'en_US.UTF-8', 20:34:02 INFO - 'LANGUAGE': 'en_US:en', 20:34:02 INFO - 'LOGNAME': 'cltbld', 20:34:02 INFO - 'MAIL': '/var/mail/cltbld', 20:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:02 INFO - 'MOZ_NO_REMOTE': '1', 20:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:02 INFO - 'NO_EM_RESTART': '1', 20:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:02 INFO - 'PWD': '/builds/slave/test', 20:34:02 INFO - 'SHELL': '/bin/bash', 20:34:02 INFO - 'SHLVL': '1', 20:34:02 INFO - 'TERM': 'linux', 20:34:02 INFO - 'TMOUT': '86400', 20:34:02 INFO - 'USER': 'cltbld', 20:34:02 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', 20:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:02 INFO - '_': '/tools/buildbot/bin/python'} 20:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:02 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 1)) 20:34:02 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 2)) 20:34:02 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 3)) 20:34:02 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 4)) 20:34:02 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 5)) 20:34:02 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 6)) 20:34:02 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 7)) 20:34:02 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 8)) 20:34:02 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:34:02 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 3)) 20:34:02 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:34:02 INFO - Cleaning up... 20:34:02 INFO - Return code: 0 20:34:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f96e7601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f0b0>, '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 0xe1ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20440>, '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': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', '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 20:34:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:34:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:34:02 INFO - Using env: {'DISPLAY': ':0', 20:34:02 INFO - 'HOME': '/home/cltbld', 20:34:02 INFO - 'LANG': 'en_US.UTF-8', 20:34:02 INFO - 'LANGUAGE': 'en_US:en', 20:34:02 INFO - 'LOGNAME': 'cltbld', 20:34:02 INFO - 'MAIL': '/var/mail/cltbld', 20:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:02 INFO - 'MOZ_NO_REMOTE': '1', 20:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:02 INFO - 'NO_EM_RESTART': '1', 20:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:02 INFO - 'PWD': '/builds/slave/test', 20:34:02 INFO - 'SHELL': '/bin/bash', 20:34:02 INFO - 'SHLVL': '1', 20:34:02 INFO - 'TERM': 'linux', 20:34:02 INFO - 'TMOUT': '86400', 20:34:02 INFO - 'USER': 'cltbld', 20:34:02 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', 20:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:02 INFO - '_': '/tools/buildbot/bin/python'} 20:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:02 INFO - Downloading/unpacking jsonschema 20:34:02 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 20:34:02 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 20:34:02 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 20:34:02 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 20:34:02 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 20:34:02 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 20:34:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:34:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 20:34:04 INFO - Downloading/unpacking functools32 (from jsonschema) 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34:04 INFO - Downloading functools32-3.2.3-2.tar.gz 20:34:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:34:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:34:04 INFO - warning: no files found matching '*.txt' 20:34:04 INFO - no previously-included directories found matching 'build' 20:34:04 INFO - no previously-included directories found matching 'dist' 20:34:04 INFO - no previously-included directories found matching '.git*' 20:34:04 INFO - Installing collected packages: jsonschema, functools32 20:34:04 INFO - Running setup.py install for functools32 20:34:04 INFO - warning: no files found matching '*.txt' 20:34:04 INFO - no previously-included directories found matching 'build' 20:34:04 INFO - no previously-included directories found matching 'dist' 20:34:04 INFO - no previously-included directories found matching '.git*' 20:34:04 INFO - Successfully installed jsonschema functools32 20:34:04 INFO - Cleaning up... 20:34:04 INFO - Return code: 0 20:34:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:34:04 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')]} 20:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:04 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')]} 20:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f96e7601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd90240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1f0b0>, '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 0xe1ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20440>, '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': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', '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 20:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 20:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 20:34:04 INFO - Using env: {'DISPLAY': ':0', 20:34:04 INFO - 'HOME': '/home/cltbld', 20:34:04 INFO - 'LANG': 'en_US.UTF-8', 20:34:04 INFO - 'LANGUAGE': 'en_US:en', 20:34:04 INFO - 'LOGNAME': 'cltbld', 20:34:04 INFO - 'MAIL': '/var/mail/cltbld', 20:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:04 INFO - 'MOZ_NO_REMOTE': '1', 20:34:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:04 INFO - 'NO_EM_RESTART': '1', 20:34:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:04 INFO - 'PWD': '/builds/slave/test', 20:34:04 INFO - 'SHELL': '/bin/bash', 20:34:04 INFO - 'SHLVL': '1', 20:34:04 INFO - 'TERM': 'linux', 20:34:04 INFO - 'TMOUT': '86400', 20:34:04 INFO - 'USER': 'cltbld', 20:34:04 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', 20:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:04 INFO - '_': '/tools/buildbot/bin/python'} 20:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:04 INFO - Downloading/unpacking flake8 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:34:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 20:34:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:34:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 20:34:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 20:34:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 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 20:34:06 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 20:34:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:34:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:34:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:34:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:34:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:34:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:34:07 INFO - no previously-included directories found matching 'docs/_build' 20:34:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:34:07 INFO - Running setup.py install for pep8 20:34:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:34:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:34:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:34:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:34:07 INFO - no previously-included directories found matching 'docs/_build' 20:34:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:34:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:34:07 INFO - Cleaning up... 20:34:07 INFO - Return code: 0 20:34:07 INFO - Running post-action listener: _resource_record_post_action 20:34:07 INFO - Running post-action listener: _start_resource_monitoring 20:34:07 INFO - Starting resource monitoring. 20:34:07 INFO - ##### 20:34:07 INFO - ##### Running install step. 20:34:07 INFO - ##### 20:34:07 INFO - Running pre-action listener: _resource_record_pre_action 20:34:07 INFO - Running main action method: install 20:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:34:07 INFO - Reading from file tmpfile_stdout 20:34:07 INFO - Detecting whether we're running mozinstall >=1.0... 20:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:34:07 INFO - Reading from file tmpfile_stdout 20:34:07 INFO - Output received: 20:34:07 INFO - Usage: mozinstall [options] installer 20:34:07 INFO - Options: 20:34:07 INFO - -h, --help show this help message and exit 20:34:07 INFO - -d DEST, --destination=DEST 20:34:07 INFO - Directory to install application into. [default: 20:34:07 INFO - "/builds/slave/test"] 20:34:07 INFO - --app=APP Application being installed. [default: firefox] 20:34:07 INFO - mkdir: /builds/slave/test/build/application 20:34:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:34:23 INFO - Reading from file tmpfile_stdout 20:34:23 INFO - Output received: 20:34:23 INFO - /builds/slave/test/build/application/firefox/firefox 20:34:23 INFO - Running post-action listener: _resource_record_post_action 20:34:23 INFO - ##### 20:34:23 INFO - ##### Running run-tests step. 20:34:23 INFO - ##### 20:34:23 INFO - Running pre-action listener: _resource_record_pre_action 20:34:23 INFO - Running main action method: run_tests 20:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:34:23 INFO - Python 2.7.3 20:34:23 INFO - Return code: 0 20:34:23 INFO - grabbing minidump binary from tooltool 20:34:23 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')]} 20:34:23 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 0xe1f0b0>, '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 0xe1ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe20440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:34:23 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 20:34:23 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 20:34:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:34:23 INFO - Return code: 0 20:34:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:34:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:34:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:34:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:34:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:34:24 INFO - Return code: 0 20:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test/build 20:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 20:34:24 INFO - Using env: {'DISPLAY': ':0', 20:34:24 INFO - 'HOME': '/home/cltbld', 20:34:24 INFO - 'LANG': 'en_US.UTF-8', 20:34:24 INFO - 'LANGUAGE': 'en_US:en', 20:34:24 INFO - 'LOGNAME': 'cltbld', 20:34:24 INFO - 'MAIL': '/var/mail/cltbld', 20:34:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:34:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:24 INFO - 'MOZ_NO_REMOTE': '1', 20:34:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:34:24 INFO - 'NO_EM_RESTART': '1', 20:34:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:24 INFO - 'PWD': '/builds/slave/test', 20:34:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:34:24 INFO - 'SHELL': '/bin/bash', 20:34:24 INFO - 'SHLVL': '1', 20:34:24 INFO - 'TERM': 'linux', 20:34:24 INFO - 'TMOUT': '86400', 20:34:24 INFO - 'USER': 'cltbld', 20:34:24 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130', 20:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:24 INFO - '_': '/tools/buildbot/bin/python'} 20:34:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 20:34:24 INFO - mozversion INFO | application_buildid: 20151217191453 20:34:24 INFO - mozversion INFO | application_changeset: e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4 20:34:24 INFO - mozversion INFO | application_display_name: Nightly 20:34:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:34:24 INFO - mozversion INFO | application_name: Firefox 20:34:24 INFO - mozversion INFO | application_remotingname: firefox 20:34:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 20:34:24 INFO - mozversion INFO | application_vendor: Mozilla 20:34:24 INFO - mozversion INFO | application_version: 46.0a1 20:34:24 INFO - mozversion INFO | platform_buildid: 20151217191453 20:34:24 INFO - mozversion INFO | platform_changeset: e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4 20:34:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 20:34:24 INFO - mozversion INFO | platform_version: 46.0a1 20:34:24 INFO - 2015-12-17 20:34:24,335 DEBUG : using testdate: 1450413264 20:34:24 INFO - 2015-12-17 20:34:24,335 DEBUG : actual date: 1450413264 20:34:24 INFO - 2015-12-17 20:34:24,343 INFO : starting webserver on 'localhost:39524' 20:34:24 INFO - 2015-12-17 20:34:24,344 INFO : Starting test suite talos-linux64-ix-008 20:34:24 INFO - 2015-12-17 20:34:24,345 INFO : Starting test dromaeo_css 20:34:24 INFO - 2015-12-17 20:34:24,345 DEBUG : operating with platform_type : linux_ 20:34:24 INFO - 2015-12-17 20:34:24,345 INFO : Initialising browser for dromaeo_css test... 20:34:24 INFO - 2015-12-17 20:34:24,362 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeoxkwX/profile http://localhost:39524/getInfo.html 20:34:28 INFO - 2015-12-17 20:34:28,594 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:34:28 INFO - 2015-12-17 20:34:28,594 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:34:28 INFO - 2015-12-17 20:34:28,594 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:34:28 INFO - 2015-12-17 20:34:28,594 DEBUG : BROWSER_OUTPUT: __metrics 20:34:28 INFO - 2015-12-17 20:34:28,650 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:34:28 INFO - 2015-12-17 20:34:28,714 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:34:29 INFO - 2015-12-17 20:34:29,832 INFO : Browser initialized. 20:34:29 INFO - 2015-12-17 20:34:29,832 INFO : Running cycle 1/1 for dromaeo_css test... 20:34:29 INFO - 2015-12-17 20:34:29,833 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeoxkwX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:34:41 INFO - 2015-12-17 20:34:41,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 149553152 20:34:41 INFO - 2015-12-17 20:34:41,784 DEBUG : BROWSER_OUTPUT: 20:35:33 INFO - 2015-12-17 20:35:33,267 DEBUG : BROWSER_OUTPUT: 1450413333265 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] 20:37:45 INFO - 2015-12-17 20:37:45,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39524/tests/dromaeo/cssquery-ext.html) 20:37:46 INFO - 2015-12-17 20:37:46,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 289316864 20:37:46 INFO - 2015-12-17 20:37:46,565 DEBUG : BROWSER_OUTPUT: 20:40:49 INFO - 2015-12-17 20:40:49,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/dromaeo/cssquery-ext.html (next: http://localhost:39524/tests/dromaeo/cssquery-jquery.html) 20:40:49 INFO - 2015-12-17 20:40:49,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 228941824 20:40:49 INFO - 2015-12-17 20:40:49,785 DEBUG : BROWSER_OUTPUT: 20:43:51 INFO - 2015-12-17 20:43:51,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39524/tests/dromaeo/cssquery-mootools.html) 20:43:52 INFO - 2015-12-17 20:43:52,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 224751616 20:43:52 INFO - 2015-12-17 20:43:52,575 DEBUG : BROWSER_OUTPUT: 20:46:54 INFO - 2015-12-17 20:46:54,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39524/tests/dromaeo/cssquery-prototype.html) 20:46:55 INFO - 2015-12-17 20:46:55,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 206938112 20:46:55 INFO - 2015-12-17 20:46:55,009 DEBUG : BROWSER_OUTPUT: 20:49:57 INFO - 2015-12-17 20:49:57,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39524/tests/dromaeo/cssquery-yui.html) 20:49:58 INFO - 2015-12-17 20:49:58,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 216199168 20:49:58 INFO - 2015-12-17 20:49:58,310 DEBUG : BROWSER_OUTPUT: 20:53:00 INFO - 2015-12-17 20:53:00,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/dromaeo/cssquery-yui.html (next: http://localhost:39524/tests/dromaeo/cssquery-dojo.html) 20:53:00 INFO - 2015-12-17 20:53:00,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 259047424 20:53:00 INFO - 2015-12-17 20:53:00,828 DEBUG : BROWSER_OUTPUT: 20:53:00 INFO - 2015-12-17 20:53:00,828 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:53:00 INFO - 2015-12-17 20:53:00,829 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:53:00 INFO - 2015-12-17 20:53:00,829 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:53:00 INFO - 2015-12-17 20:53:00,829 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:53:00 INFO - 2015-12-17 20:53:00,829 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2621.672290963629;2706.215197592698;2709.065372446508;2717.714639962805;2725.4821583899065;4517.932231016537;4640.303954406841;4648.372469716587;4674.649401294903;4689.788959496822;4560.31595260711;4620.468646105699;4632.652551058667;4648.163330600491;4748.287756836477;4162.562930892243;4286.078493123978;4296.248156572603;4342.9131417371555;4453.087117140978;4417.469903611571;4438.289873620221;4467.865964021084;4468.597826195642;4491.326301054852;4188.664906807463;4204.684648651363;4303.376010478494;4312.22379971605;4323.935140972888;4339.717918335298;4344.804483798205;4352.630026447756;4371.956280437187;4392.868213953587;4298.097399546099;4316.266234740102;4328.112736888962;4331.285337919239;4347.239233134189;4474.955250447487;4583.381243532147;4584.449866016066;4594.816207351702;4688.531146885318;5053.873653158664;5055.873603159914;5059.1905295152965;5081.212412076134;5103.362079740033;5042.092423363793;5066.82266120684;5066.923996140061;5077.466865979056;5100.897982040376;4499.302608095751;4600.493945665974;4602.033572949718;4679.27471241958;4705.364775755298;5018.146915024455;5095.31213286209;5128.79484820603;5158.871028224249;5161.74191290434;4958.404991400983;4979.57673597741;4983.700977941335;4989.201727723546;5034.244863270539;4794.2808578713475;4897.14299997499;4902.950970490249;5077.847664570068;5085.364329458817;4766.213574760126;4869.342638743724;4926.187179115477;4951.851444456672;4956.603471722254;4988.700677959334;4990.525900039491;4994.001199760062;4995.600351971833;5049.343585333883;4205.306124489425;4205.810738516774;4208.684348673862;4219.198352313051;4226.598473145046;3543.911402214965;3609.4766258892314;3653.83557739897;3671.816409179584;3703.4259689748133;4323.610875021263;4344.522102568715;4346.9347959780625;4358.128374325084;4384.057427653006;5045.672031317952;5055.747212639353;5055.823046193365;5056.544910958031;5100.770465329069;4125;4214.4310518079665;4230.746155230634;4231.534531201565;4235.428217190702;4470.6870519064005;4482.148391805546;4505.279155335196;4521.525239849769;4529.38853254813;4794.880127996828;4804.015176888799;4806.543378379119;4826.058918510927;4835.95164048369;4789.042191561632;4904.901901962012;4909.4354149273295;5085.364329458817;5087.64386492942;4680.251159814414;4711.128441238382;4715.2455607104075;4749.24012158053;4752.976235118802;4971.925421118758;5022.573081288131;5029.698218106925;5030.320906677698;5071.315372424676;4791.448983366818;4913.975430122827;5068.518490743373;5091.287219789307;5127.077126117186;4760.857174284777;4766.713997160182;4836.250381190921;4856.4415092263425;4865.391826021747;4933.062718083553;4935.504756213045;4937.28409380645;4944.456109827988;4989.800407983786;4803.255495398219;4834.854954351375;4846.80612775485;4883.145449546244;4892.877678058077;4712.363830882787;4812;4816.710997340171;4816.927746083882;4826.300186473012;4663.370444990019;4756.6908150970075;4846.636502262274;4862.319275301531;4898.559129678346 20:53:00 INFO - 2015-12-17 20:53:00,829 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.8344496651006;562.3504851896062;569.0667305618784;574.3423779772162;582.5427039773779;26750.197494075186;27220.455590888196;27276.318092047735;34936.82531587345;35540.11149721258;40475.59524404755;40700.79649601748;40914.79542602283;40976.590234097726;41063.58936410635;7889.644965976516;8059.07320658126;8070;8073.959630201841;8076.71731489398;7192.280771922792;7338.743143989961;7854.6465409056445;10089.192864570854;10405.583776648962;10081.69754907354;10196.643117490888;10206.285560010801;10210.795784084314;10212.336198147133;7083.18543367509;9625.326227164102;9667.806643867118;9675.951620241924;9679.564419601134;6912.101426814532;10153.238507111922;10447.05976462122;10466.581336746522;10468;37606.62393376059;38113.61886381129;38154.80922595369;38154.80922595397;38246.80876595627;2730.3856632257584;2797.139991717349;3067.647220569641;3153.810771353726;3309;28546.286342841388;28912.98804541852;28934.276643083882;29173.85413072942;29320.853395732884;3357.2781851901714;3403.3873902697505;3411.2154204533094;3457.4640930655787;3501.159721666807;226892;228747;228777.85611072005;228968;229192;52548.474515254355;54304.185437218475;54536;54860.725696371264;54862.17706734402;58986.705066474395;59920.70039649774;60183.69908150519;60207.397926021054;60265.69867150636;13336.866631333562;13453;13465.865341346462;13519.256440895846;13553.661158471117;9812.460314682761;9859.457729824928;9863.901360986441;9864.654737084167;9869.802603947881;19160.945388475997;19569.608607827762;19618.313359032367;19626;19629.705554416694;7370;7646.847063058708;7701.807454813675;7711.460197786101;7722.613869306625;835.9797781932997;846.5259454705384;900.7883147460342;986.9753256168653;998.0368943969105;26213.60679589808;26480.867595662283;26540.203793885827;26777.464450710875;29708;908.6774195160755;927.3832901120679;952.3619175152664;1019.9541020654088;1038.9220808439397;13910.58268251954;14013.369398377097;14128.43486260538;14154.504592339219;14163.85836141646;321604;326458;326708;327457;328150;46808.5319146811;47227.05545889063;47253.29120063202;47294.5270547297;47541;1223.1193540650718;1227.5212667059855;1252.2987127208792;1253.053944272087;1258.2324781883226;25115.74884251134;26121;29499.262518437212;31179.84410077935;31345.84327078441;42908.35637465503;43615.56384436115;43618;43624.34563481487;43721.56278437175;238515;245444;249012;249361;249579;24802;28325;28380.858095710217;28990.85504572548;29050.12849614515;32677.55126288409;36192.638073618924;36248.81875590605;36866.26267474689;37068.25863482661;30859.84570077135;38419;40071.39892901551;40274.395884061174;41078;33229.33541329111;33592.66407335895;37425.25149497049;38964.35016922474;39120.6087939117;32613.836930815192;33037.33925321528;33211.335773283914;33334.499982499794;33343.83328083344;27526.862365688045;27556.44887102287;29038.564421533272;29285.7071429283;29392.853035734686;23106.637595451637;23118.803713647176;23337.649935250643;23414.64878026865;23488.530229394975 20:53:00 INFO - 2015-12-17 20:53:00,829 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.1836742836054;320.775457179974;323.96922292382214;328.0437524615745;329.20496999745615;13041.934790326059;13497.730045399087;14865;15072.472463463795;15267;12471.127021108527;14114.71770564588;14811.629709257273;15216.771748423782;15271.465498707548;4807.567318941295;4822.397200349965;4911.557959783619;4914.410270767513;4959.504049595048;3777.697784177259;3811.714121440903;5040.621953353513;5125.2055931330515;5676.176954341618;5698.7435565399655;5732.856678583048;5761.049426844586;5763.193152958589;5763.337216220126;5552.86117847053;5669.177969194444;5697.4587414196;5704.65772053676;5719.313682358102;4999.625028122905;5001.549860512535;5008.899822003539;5015.247712843066;5015.473375295578;18897.62204755911;18914.337998169998;19305.131269092926;19424.417267481997;19445.22219111248;1779.599590092232;1903.684855338789;1955.882647041168;1967.7835438101797;1978.851586131046;8229.341652667772;8379.49723016621;8561.700340488116;8595.656173753105;9984.650537231162;1692.8222536633723;1717.450415866923;1718.6390857919853;1744.2264713185994;1780.7061834797244;53678;56281.43718562844;56885;57465.71267143638;57574.13638795421;9709.854352184722;9814.3620664658;9816.214702823758;9834.065763752433;9890.554925028391;12414.503419863286;12415.751684966432;12428.316442595564;12442.626721198378;12444.128910976326;6623.205215374186;6634.369734875179;6665.933340666628;6721.059051732761;6737.764178253738;6194.4115309045565;6409.871802563923;6501.902471462932;6509.576877502947;6512.837179070561;3959.148783011609;3959.544652364957;4076.9603751043887;4139.503259608866;4163.125743593819;1592.3789722008426;1634.3462614953876;1635.5256975477216;1675.2210222246713;1733.5319463744718;809.7773112394021;824.9092599814015;843.3379796859558;855.6745650735468;856.9400141990001;15089.47186848455;15943.920280398524;16428.67142657164;16456.341746330254;16850.32598696063;826.1325608111459;830.0537387378394;850.6469815026818;856.1139220906457;930.1582068228264;8810.339224558184;8972.8654070189;9245.583948722324;9352.953235233781;9409.858852117224;471933;476306;476662;479700;484184;73539;75070.6246468775;77256;77775.61112194402;77889.22110778933;1002.3735165521549;1022.4836457589018;1033.5968972100886;1033.7002269341956;1037.3827572594446;13678.86321136776;14322.427102915766;14484.855151448772;14541;14582.708345833236;32818;32820;33160;33736.831315843265;33976.83011584926;37647.435288470144;37959.430608540344;38053.4291985626;38138.42792358172;38928.6107138925;8679.652813887626;8761.38670293099;8841.557922103997;8858.601362938554;8986.775330616787;11570.76858462843;16611.83388166151;16644.417445389354;16778.66442671115;16851.578710532336;10781.568737250422;11133.55465781392;11572.074234061423;13482.258475783927;13827.792583111463;13034.665816745584;13423.865761342653;13491;14034.438622454987;14191.787123192953;12803.231806091664;13321.666958325732;13463.394147263201;14288.214148221532;14425.85574144245;7324.926750732638;7537.585432801248;8526.062133165471;8681.522516261413;8860.822783544165;9003.684871029482;9092.454452732858;12992.220466772023;13918.860811391756;14426.278686065865 20:53:00 INFO - 2015-12-17 20:53:00,830 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1230.4893469210278;1658.5024492652203;1693.280355848764;1719.750636157757;1719.982800171998;6167.537434692399;6944.236134025259;7095.574265544071;7117.145942486909;7126.75056373027;7073.893891591631;7263.60050197239;7264.927350726492;7276.9272307276915;7281.453890958186;2023.615513052519;2063.226290141197;2063.9484012899647;2063.9793602064015;2065.1326442893946;2061.7525896892394;2075.346265926236;2078.2933802507146;2111.271611294101;2111.4826867417505;2003.1486618187284;2026.2097781865084;2056.362527616436;2057.341650671778;2058.3619078085767;2024.1195080140187;2052.435580215453;2052.7434070741156;2055.106028877443;2055.496403381174;1971.2607772085469;1984.2063174730079;2043.52998810273;2044.488877780555;2045.0694933805082;7142.607156606385;7218.8917166242545;7225.674844631952;7229.060222171137;7232.421406287484;4134.441850350195;4216.810243539048;4220.704550681454;4222.303319952204;4226.746395216266;2593.4424098818845;2603.388203772131;2638.947221055568;2642.2205449392477;2688.932776680579;838.9664413423455;850.3239924260228;866.1684782608703;866.1944391715701;877.2148926710622;9770.36492627984;9776.95111524445;9781.119699227103;9809.068138526829;9809.313348065638;3921.117748506563;3936.9606303937167;3965.6629186518894;3978.562358140602;3992.261431635157;8399.580020998925;8409.915900841035;8437.282830959315;8439.324854011787;8447.45091569046;4311.310190369589;4315.568443155659;4338.891527711769;4349.804258808361;4350.521442641307;3136.0435067304234;3249;3733.757305775116;3947.3289540778137;3948.506436695413;3357.8153201574146;3397.490376443553;3411.403004474207;3426.794392336468;3429;1116.6984914073155;1118.1725523113;1118.6811758648746;1123.4102096399292;1140.133498541098;838.0153319849153;849.3332733803934;852.5183271451734;853.1298075962484;1081.1512962324537;6705.966470167716;6724.49566282521;6747.831304217434;6758.526903116833;6764.391204791494;377.7865505989107;379.8670465337165;380.46734571599427;381.56311023877504;392.7192057678773;4894.706317620954;4901.877453063631;4919.1391506486225;4928.334674818925;4930.309756634074;8550.871736923951;8555.101714320032;8752.69365572202;8768.78078048054;8850.468971861708;8687.044425113232;8687.739367818975;8690.652373905099;8716.084811094745;8798.47209167452;6488.902666459912;6618.4705223582;6619.834504137339;6696.263411024784;6737.461003119739;6433.5496515243485;6440.0983862260255;6443;6445.065465507569;6457.902156633478;7693.650294969885;7771.689132434639;7840.372770178258;7875.291223789886;7905.051393832777;7657.6554055066545;7764.767056988299;7873.291403773688;8147.10381858007;8164.918350816416;5259.42146363892;5392.325959255093;5968.850778730566;6095.359987201457;6101.481374083075;5854.765809367577;6042.063480160582;6831.0436538883605;6887.793366199022;6921.6193109379465;6518.413342799171;6527.902081468686;6684.197896252481;6690.966545167243;6691.59850408977;6545.639989800607;6546.214454265519;6611.438027767694;6617.073609694743;6688.799336019927;6697.866042679217;6705.4635629150525;6728.360805723449;6755.324467553205;6765.323467653196;5949.553783466344;5970.850728731816;6014.518838492998;6028.0355143176885;6030.879382412415;6081.087836824512;6108.908366374597;6116.938830611815;6117.877642447215;6119.571629986036 20:53:00 INFO - 2015-12-17 20:53:00,832 DEBUG : BROWSER_OUTPUT: |4;prototype.html;285.04509891862256;289.7435769344132;289.80003797379806;290.6584762903589;295.3546500895542;4967.379077615298;5189.247559103937;5206.375234971804;5252.264682944391;5284.3394575678085;4505.662075344346;5240.9213861792;5240.973795131019;5243.239730239113;5248.317718696564;4026.939595906064;4037.636612704856;4040.696947728917;4045.312296909518;4048.57489963554;3874.7093967952374;3935.5474120476224;3976.960230397688;4033.818478168475;4042.9191416171657;3990.04238982645;3994.121293315466;4009.278329900617;4010.258102251078;4016.8393264269394;3969.5435024972207;3986.1230529283803;3991.4611527443712;4000.159966407058;4017.8392864285393;3474.1835668617855;3476.774009689362;3478.478228265755;3479.373712731707;3479.7912125272564;5035.924461133086;5040.36995375578;5049.823256186016;5054.06499797535;5058.898822023576;4546.54510556622;4577.22187228172;4577.244754615518;4580.931286030712;4582.495925448198;5451.991381594417;5483.561315094783;5489.58828087891;5490.945090549083;5493.121100623921;3778.0932576181517;3778.6410291022307;3780.073881898925;3783.1298801275584;3785.4511095891216;5505.146702261116;5698.487136157724;5782.219400380979;5784;5794.884102317972;3425.2978139481347;3748.456473811282;3749.1751814600743;3788.6021967692996;3810.942835857464;3890.6692931101175;3901.9609803902167;3903.0437542802197;3946.5856085111222;4001.9399709004388;4586.2661974083985;4590.1737687215955;4590.609798167126;4591.334256532851;4597;5512.779488820403;5521.116621340647;5522.834314970557;5525.060739674265;5526.336839579196;1381.0884816021378;1406.2476575032308;1406.367134789349;1406.4936622815778;1406.5709958462562;920.346553946692;925.3984909808544;943.4527973775193;966.2077096780713;966.7244835222068;4860.392450943632;4872.926906096412;4873.390826146731;4873.756312184377;4875.219964805614;5741.598088133874;5746.367899531048;5752.28096487939;5757.050086735641;5769.336526299446;4868.930704450594;4870.0746858096845;4874.025194961022;4878.243872199815;4879.463259041502;3019.04899956513;3057.1898446911587;3088.5521599368417;3089.938201235963;3090.103869877755;5437.102878025161;5447.809326673548;5447.863803404946;5452.890942181134;5456.399796022434;5878.676672782953;5889.381614930457;5889.587728858939;5897;5902.1441890926435;5277.050130976308;5426.75579598919;5432.7555260012605;5436.70098144598;5442.646227995247;5475.698836564027;5568.9443105568425;5700.971495142498;5807.186993820953;5807.361190268983;5647.435256474319;5669.971650141888;5671.461211184931;5671.773129074791;5680.147977803363;5492.80775172867;5493.780248790164;5502;5508.173773933942;5508.44915508446;4010.5588385277015;4012.578679238638;4014.4580481634607;4015.3976903464713;4017.176478821776;5611.270534830609;5749.425057494217;5763.423657634371;5775.971120144372;5805.158252053513;5551.389347171888;5554.944450555443;5563.638363506359;5565.415631358811;5568.610197286313;5526.673598336451;5554.722263886709;5555.22226888244;5555.30558680165;5555.805546805843;5312.734363281743;5393.757280922289;5435.211894275229;5448.918266226089;5456.754446050017;5586.52514536269;5596.552275818006;5600.915986260128;5606.24315717373;5607.719614019365;5468.972655136698;5470.8085217017215;5471.671699698031;5472.097103977799;5478.424765399575 20:53:00 INFO - 2015-12-17 20:53:00,833 DEBUG : BROWSER_OUTPUT: |5;yui.html;727.4798519058875;738.7266711316813;740.7703611880318;742.6917829100923;748.9438292128092;10431.217658675601;10748.408837513934;10751.408672523008;10771.892281077196;10777.83833242501;10187.949060254688;10276.588936442533;10283.177345812335;10284;10288;612.4212619074976;616.8365383173463;768.9077310722721;788.3062904643905;806.1938061938062;785.9017622797151;787.6416230615085;794.126460893016;794.1264608930188;795.4749865089043;826.2192228344217;833.4124442268186;833.5790425834945;833.945793523422;834.2491757418342;644.3685188515234;650.3204151661525;820.3396266005893;831.3681601982477;835.0814104485079;625.4808508937571;625.5277265664395;625.8060001399535;626.0484064222356;626.2297374229678;9830.115289623896;10066.949665251626;10089.646862359856;10099.29304948654;10110.44392558409;9866.45734484603;10107.3430227035;10285.794284114276;10456.895431045745;11903.464344104535;8094.109647938722;8102.918970810276;8231.835363292761;8304.70933517324;8316.83366332676;3082.5992620959355;3097.8760849565992;3109.036198778386;3131.9686803131904;3141.4659507883716;37871.43192852082;38069.23861522782;38125.61874381276;38218.61781382179;38309.42535861964;8778;8823.426477279085;8842.911570884338;9076.818463630823;9379.062093790702;15914.76127858083;16149.111798850941;16156.27296771648;16161.676766464605;16171.514854554382;6155.446009859134;6210.9068363974575;6320.652364119926;6352.078948552434;6445.548811583238;3351.564296641421;3456.8617255309505;3477.217626034122;3487.442009278503;3497.7726447780815;2418.927432177002;2447.167962892625;2449.069353645639;2452.1049816816735;2454.12878428159;428.5650065183841;432.17238987338897;438.96049355557517;440.47583375782716;440.9074094440139;365.2548800447058;376.8712705447203;432.859320720767;436.96722745794193;439.606552135843;6983.476239282074;7010.579365238102;7040.331168538981;7163.820904477429;7296.927030729731;478.8563430970695;497.2814283360509;521.2478115549902;535.4672101259272;539.9821336780197;3244.951325730116;3255.5930508686415;3330.950035749417;3342.8997130086136;3409.4885767134633;48959.510404895496;49240.75379623079;49267;49394.259086113736;49589.50410495921;42374.576254237676;43128.56871431245;43284.78357608192;43607.563924360984;43625.34561981573;39953;40036.194751760835;40235.79882100571;40291.597084029374;40746.18507629831;6555.2789193189665;6570.934290657224;6684.598924064571;6700.631465269457;6752.966235168793;29980;30325.545116822825;30391.84804076054;30502;30554.84722576373;35640.28719425649;38005.23989520139;38040;38222.80888595539;38816.22367552577;8040.798980025546;8506.149385061444;8522.062573116827;8575.95712021436;8797.912020879709;9458.716238512581;9560.61757529691;9599.808003840024;9629;9648.75878103053;8697.652093916173;8698.826023479622;8712.39013269065;8712.825743484967;8716.564171791259;8830.646774128963;8841.115888411108;8845.469271843709;8898.4660920345;8944.597493112695;8590.82818343642;8615.741527754177;8629.22336989674;8657.523836188819;8665.653373864974;7605.88591171144;7624.618769061413;7750.379969602305;7750.806229844299;7773.222677732181;7197.109578513519;7619.961900190464;7638.847223055619;7758.495697779852;7810.414218933489 20:53:00 INFO - 2015-12-17 20:53:00,833 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:53:00 INFO - 2015-12-17 20:53:00,833 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:53:00 INFO - 2015-12-17 20:53:00,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1219 20:53:00 INFO - 2015-12-17 20:53:00,833 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:53:00 INFO - 2015-12-17 20:53:00,833 DEBUG : BROWSER_OUTPUT: __startTimestamp1450414380822__endTimestamp 20:53:00 INFO - 2015-12-17 20:53:00,833 DEBUG : BROWSER_OUTPUT: 20:53:00 INFO - 2015-12-17 20:53:00,833 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:53:00 INFO - 2015-12-17 20:53:00,833 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:53:00 INFO - 2015-12-17 20:53:00,833 DEBUG : BROWSER_OUTPUT: 20:53:00 INFO - 2015-12-17 20:53:00,834 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4626.98 Median:4756.69 stddev:482.83 (10.2%) stddev-sans-first:457.97 20:53:00 INFO - 2015-12-17 20:53:00,835 DEBUG : BROWSER_OUTPUT: Values: 2621.7 2706.2 2709.1 2717.7 2725.5 4517.9 4640.3 4648.4 4674.6 4689.8 4560.3 4620.5 4632.7 4648.2 4748.3 4162.6 4286.1 4296.2 4342.9 4453.1 4417.5 4438.3 4467.9 4468.6 4491.3 4188.7 4204.7 4303.4 4312.2 4323.9 4339.7 4344.8 4352.6 4372.0 4392.9 4298.1 4316.3 4328.1 4331.3 4347.2 4475.0 4583.4 4584.4 4594.8 4688.5 5053.9 5055.9 5059.2 5081.2 5103.4 5042.1 5066.8 5066.9 5077.5 5100.9 4499.3 4600.5 4602.0 4679.3 4705.4 5018.1 5095.3 5128.8 5158.9 5161.7 4958.4 4979.6 4983.7 4989.2 5034.2 4794.3 4897.1 4903.0 5077.8 5085.4 4766.2 4869.3 4926.2 4951.9 4956.6 4988.7 4990.5 4994.0 4995.6 5049.3 4205.3 4205.8 4208.7 4219.2 4226.6 3543.9 3609.5 3653.8 3671.8 3703.4 4323.6 4344.5 4346.9 4358.1 4384.1 5045.7 5055.7 5055.8 5056.5 5100.8 4125.0 4214.4 4230.7 4231.5 4235.4 4470.7 4482.1 4505.3 4521.5 4529.4 4794.9 4804.0 4806.5 4826.1 4836.0 4789.0 4904.9 4909.4 5085.4 5087.6 4680.3 4711.1 4715.2 4749.2 4753.0 4971.9 5022.6 5029.7 5030.3 5071.3 4791.4 4914.0 5068.5 5091.3 5127.1 4760.9 4766.7 4836.3 4856.4 4865.4 4933.1 4935.5 4937.3 4944.5 4989.8 4803.3 4834.9 4846.8 4883.1 4892.9 4712.4 4812.0 4816.7 4816.9 4826.3 4663.4 4756.7 4846.6 4862.3 4898.6 20:53:00 INFO - 2015-12-17 20:53:00,835 DEBUG : BROWSER_OUTPUT: 20:53:00 INFO - 2015-12-17 20:53:00,835 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42872.90 Median:33220.34 stddev:70691.60 (212.8%) stddev-sans-first:70818.49 20:53:00 INFO - 2015-12-17 20:53:00,835 DEBUG : BROWSER_OUTPUT: Values: 551.8 562.4 569.1 574.3 582.5 26750.2 27220.5 27276.3 34936.8 35540.1 40475.6 40700.8 40914.8 40976.6 41063.6 7889.6 8059.1 8070.0 8074.0 8076.7 7192.3 7338.7 7854.6 10089.2 10405.6 10081.7 10196.6 10206.3 10210.8 10212.3 7083.2 9625.3 9667.8 9676.0 9679.6 6912.1 10153.2 10447.1 10466.6 10468.0 37606.6 38113.6 38154.8 38154.8 38246.8 2730.4 2797.1 3067.6 3153.8 3309.0 28546.3 28913.0 28934.3 29173.9 29320.9 3357.3 3403.4 3411.2 3457.5 3501.2 226892.0 228747.0 228777.9 228968.0 229192.0 52548.5 54304.2 54536.0 54860.7 54862.2 58986.7 59920.7 60183.7 60207.4 60265.7 13336.9 13453.0 13465.9 13519.3 13553.7 9812.5 9859.5 9863.9 9864.7 9869.8 19160.9 19569.6 19618.3 19626.0 19629.7 7370.0 7646.8 7701.8 7711.5 7722.6 836.0 846.5 900.8 987.0 998.0 26213.6 26480.9 26540.2 26777.5 29708.0 908.7 927.4 952.4 1020.0 1038.9 13910.6 14013.4 14128.4 14154.5 14163.9 321604.0 326458.0 326708.0 327457.0 328150.0 46808.5 47227.1 47253.3 47294.5 47541.0 1223.1 1227.5 1252.3 1253.1 1258.2 25115.7 26121.0 29499.3 31179.8 31345.8 42908.4 43615.6 43618.0 43624.3 43721.6 238515.0 245444.0 249012.0 249361.0 249579.0 24802.0 28325.0 28380.9 28990.9 29050.1 32677.6 36192.6 36248.8 36866.3 37068.3 30859.8 38419.0 40071.4 40274.4 41078.0 33229.3 33592.7 37425.3 38964.4 39120.6 32613.8 33037.3 33211.3 33334.5 33343.8 27526.9 27556.4 29038.6 29285.7 29392.9 23106.6 23118.8 23337.6 23414.6 23488.5 20:53:00 INFO - 2015-12-17 20:53:00,835 DEBUG : BROWSER_OUTPUT: 20:53:00 INFO - 2015-12-17 20:53:00,835 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25999.51 Median:3959.35 stddev:78120.56 (1973.1%) stddev-sans-first:78315.91 20:53:00 INFO - 2015-12-17 20:53:00,835 DEBUG : BROWSER_OUTPUT: Values: 315.2 320.8 324.0 328.0 329.2 13041.9 13497.7 14865.0 15072.5 15267.0 12471.1 14114.7 14811.6 15216.8 15271.5 4807.6 4822.4 4911.6 4914.4 4959.5 3777.7 3811.7 5040.6 5125.2 5676.2 5698.7 5732.9 5761.0 5763.2 5763.3 5552.9 5669.2 5697.5 5704.7 5719.3 4999.6 5001.5 5008.9 5015.2 5015.5 18897.6 18914.3 19305.1 19424.4 19445.2 1779.6 1903.7 1955.9 1967.8 1978.9 8229.3 8379.5 8561.7 8595.7 9984.7 1692.8 1717.5 1718.6 1744.2 1780.7 53678.0 56281.4 56885.0 57465.7 57574.1 9709.9 9814.4 9816.2 9834.1 9890.6 12414.5 12415.8 12428.3 12442.6 12444.1 6623.2 6634.4 6665.9 6721.1 6737.8 6194.4 6409.9 6501.9 6509.6 6512.8 3959.1 3959.5 4077.0 4139.5 4163.1 1592.4 1634.3 1635.5 1675.2 1733.5 809.8 824.9 843.3 855.7 856.9 15089.5 15943.9 16428.7 16456.3 16850.3 826.1 830.1 850.6 856.1 930.2 8810.3 8972.9 9245.6 9353.0 9409.9 471933.0 476306.0 476662.0 479700.0 484184.0 73539.0 75070.6 77256.0 77775.6 77889.2 1002.4 1022.5 1033.6 1033.7 1037.4 13678.9 14322.4 14484.9 14541.0 14582.7 32818.0 32820.0 33160.0 33736.8 33976.8 37647.4 37959.4 38053.4 38138.4 38928.6 8679.7 8761.4 8841.6 8858.6 8986.8 11570.8 16611.8 16644.4 16778.7 16851.6 10781.6 11133.6 11572.1 13482.3 13827.8 13034.7 13423.9 13491.0 14034.4 14191.8 12803.2 13321.7 13463.4 14288.2 14425.9 7324.9 7537.6 8526.1 8681.5 8860.8 9003.7 9092.5 12992.2 13918.9 14426.3 20:53:00 INFO - 2015-12-17 20:53:00,835 DEBUG : BROWSER_OUTPUT: 20:53:00 INFO - 2015-12-17 20:53:00,835 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4972.64 Median:6117.41 stddev:2650.40 (43.3%) stddev-sans-first:2642.91 20:53:00 INFO - 2015-12-17 20:53:00,837 DEBUG : BROWSER_OUTPUT: Values: 1230.5 1658.5 1693.3 1719.8 1720.0 6167.5 6944.2 7095.6 7117.1 7126.8 7073.9 7263.6 7264.9 7276.9 7281.5 2023.6 2063.2 2063.9 2064.0 2065.1 2061.8 2075.3 2078.3 2111.3 2111.5 2003.1 2026.2 2056.4 2057.3 2058.4 2024.1 2052.4 2052.7 2055.1 2055.5 1971.3 1984.2 2043.5 2044.5 2045.1 7142.6 7218.9 7225.7 7229.1 7232.4 4134.4 4216.8 4220.7 4222.3 4226.7 2593.4 2603.4 2638.9 2642.2 2688.9 839.0 850.3 866.2 866.2 877.2 9770.4 9777.0 9781.1 9809.1 9809.3 3921.1 3937.0 3965.7 3978.6 3992.3 8399.6 8409.9 8437.3 8439.3 8447.5 4311.3 4315.6 4338.9 4349.8 4350.5 3136.0 3249.0 3733.8 3947.3 3948.5 3357.8 3397.5 3411.4 3426.8 3429.0 1116.7 1118.2 1118.7 1123.4 1140.1 838.0 849.3 852.5 853.1 1081.2 6706.0 6724.5 6747.8 6758.5 6764.4 377.8 379.9 380.5 381.6 392.7 4894.7 4901.9 4919.1 4928.3 4930.3 8550.9 8555.1 8752.7 8768.8 8850.5 8687.0 8687.7 8690.7 8716.1 8798.5 6488.9 6618.5 6619.8 6696.3 6737.5 6433.5 6440.1 6443.0 6445.1 6457.9 7693.7 7771.7 7840.4 7875.3 7905.1 7657.7 7764.8 7873.3 8147.1 8164.9 5259.4 5392.3 5968.9 6095.4 6101.5 5854.8 6042.1 6831.0 6887.8 6921.6 6518.4 6527.9 6684.2 6691.0 6691.6 6545.6 6546.2 6611.4 6617.1 6688.8 6697.9 6705.5 6728.4 6755.3 6765.3 5949.6 5970.9 6014.5 6028.0 6030.9 6081.1 6108.9 6116.9 6117.9 6119.6 20:53:00 INFO - 2015-12-17 20:53:00,837 DEBUG : BROWSER_OUTPUT: 20:53:00 INFO - 2015-12-17 20:53:00,837 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4562.23 Median:5242.11 stddev:1361.82 (26.0%) stddev-sans-first:1327.26 20:53:00 INFO - 2015-12-17 20:53:00,837 DEBUG : BROWSER_OUTPUT: Values: 285.0 289.7 289.8 290.7 295.4 4967.4 5189.2 5206.4 5252.3 5284.3 4505.7 5240.9 5241.0 5243.2 5248.3 4026.9 4037.6 4040.7 4045.3 4048.6 3874.7 3935.5 3977.0 4033.8 4042.9 3990.0 3994.1 4009.3 4010.3 4016.8 3969.5 3986.1 3991.5 4000.2 4017.8 3474.2 3476.8 3478.5 3479.4 3479.8 5035.9 5040.4 5049.8 5054.1 5058.9 4546.5 4577.2 4577.2 4580.9 4582.5 5452.0 5483.6 5489.6 5490.9 5493.1 3778.1 3778.6 3780.1 3783.1 3785.5 5505.1 5698.5 5782.2 5784.0 5794.9 3425.3 3748.5 3749.2 3788.6 3810.9 3890.7 3902.0 3903.0 3946.6 4001.9 4586.3 4590.2 4590.6 4591.3 4597.0 5512.8 5521.1 5522.8 5525.1 5526.3 1381.1 1406.2 1406.4 1406.5 1406.6 920.3 925.4 943.5 966.2 966.7 4860.4 4872.9 4873.4 4873.8 4875.2 5741.6 5746.4 5752.3 5757.1 5769.3 4868.9 4870.1 4874.0 4878.2 4879.5 3019.0 3057.2 3088.6 3089.9 3090.1 5437.1 5447.8 5447.9 5452.9 5456.4 5878.7 5889.4 5889.6 5897.0 5902.1 5277.1 5426.8 5432.8 5436.7 5442.6 5475.7 5568.9 5701.0 5807.2 5807.4 5647.4 5670.0 5671.5 5671.8 5680.1 5492.8 5493.8 5502.0 5508.2 5508.4 4010.6 4012.6 4014.5 4015.4 4017.2 5611.3 5749.4 5763.4 5776.0 5805.2 5551.4 5554.9 5563.6 5565.4 5568.6 5526.7 5554.7 5555.2 5555.3 5555.8 5312.7 5393.8 5435.2 5448.9 5456.8 5586.5 5596.6 5600.9 5606.2 5607.7 5469.0 5470.8 5471.7 5472.1 5478.4 20:53:00 INFO - 2015-12-17 20:53:00,837 DEBUG : BROWSER_OUTPUT: 20:53:00 INFO - 2015-12-17 20:53:00,837 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11432.58 Median:3413.87 stddev:13514.01 (395.9%) stddev-sans-first:13528.01 20:53:00 INFO - 2015-12-17 20:53:00,837 DEBUG : BROWSER_OUTPUT: Values: 727.5 738.7 740.8 742.7 748.9 10431.2 10748.4 10751.4 10771.9 10777.8 10187.9 10276.6 10283.2 10284.0 10288.0 612.4 616.8 768.9 788.3 806.2 785.9 787.6 794.1 794.1 795.5 826.2 833.4 833.6 833.9 834.2 644.4 650.3 820.3 831.4 835.1 625.5 625.5 625.8 626.0 626.2 9830.1 10066.9 10089.6 10099.3 10110.4 9866.5 10107.3 10285.8 10456.9 11903.5 8094.1 8102.9 8231.8 8304.7 8316.8 3082.6 3097.9 3109.0 3132.0 3141.5 37871.4 38069.2 38125.6 38218.6 38309.4 8778.0 8823.4 8842.9 9076.8 9379.1 15914.8 16149.1 16156.3 16161.7 16171.5 6155.4 6210.9 6320.7 6352.1 6445.5 3351.6 3456.9 3477.2 3487.4 3497.8 2418.9 2447.2 2449.1 2452.1 2454.1 428.6 432.2 439.0 440.5 440.9 365.3 376.9 432.9 437.0 439.6 6983.5 7010.6 7040.3 7163.8 7296.9 478.9 497.3 521.2 535.5 540.0 3245.0 3255.6 3331.0 3342.9 3409.5 48959.5 49240.8 49267.0 49394.3 49589.5 42374.6 43128.6 43284.8 43607.6 43625.3 39953.0 40036.2 40235.8 40291.6 40746.2 6555.3 6570.9 6684.6 6700.6 6753.0 29980.0 30325.5 30391.8 30502.0 30554.8 35640.3 38005.2 38040.0 38222.8 38816.2 8040.8 8506.1 8522.1 8576.0 8797.9 9458.7 9560.6 9599.8 9629.0 9648.8 8697.7 8698.8 8712.4 8712.8 8716.6 8830.6 8841.1 8845.5 8898.5 8944.6 8590.8 8615.7 8629.2 8657.5 8665.7 7605.9 7624.6 7750.4 7750.8 7773.2 7197.1 7620.0 7638.8 7758.5 7810.4 20:53:00 INFO - 2015-12-17 20:53:00,837 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:53:00 INFO - 2015-12-17 20:53:00,837 DEBUG : BROWSER_OUTPUT: 20:53:01 INFO - 2015-12-17 20:53:01,637 INFO : Browser exited with error code: 0 20:53:01 INFO - 2015-12-17 20:53:01,660 INFO : Completed test dromaeo_css (00:18:37) 20:53:01 INFO - 2015-12-17 20:53:01,660 INFO : Starting test kraken 20:53:01 INFO - 2015-12-17 20:53:01,661 DEBUG : operating with platform_type : linux_ 20:53:01 INFO - 2015-12-17 20:53:01,661 INFO : Initialising browser for kraken test... 20:53:01 INFO - 2015-12-17 20:53:01,667 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjHsYw/profile http://localhost:39524/getInfo.html 20:53:05 INFO - 2015-12-17 20:53:05,929 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:53:05 INFO - 2015-12-17 20:53:05,929 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:53:05 INFO - 2015-12-17 20:53:05,929 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:53:05 INFO - 2015-12-17 20:53:05,929 DEBUG : BROWSER_OUTPUT: __metrics 20:53:06 INFO - 2015-12-17 20:53:06,005 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:53:06 INFO - 2015-12-17 20:53:06,073 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:53:06 INFO - 2015-12-17 20:53:06,986 INFO : Browser initialized. 20:53:06 INFO - 2015-12-17 20:53:06,986 INFO : Running cycle 1/1 for kraken test... 20:53:06 INFO - 2015-12-17 20:53:06,987 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwjHsYw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:53:18 INFO - 2015-12-17 20:53:18,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 149880832 20:53:18 INFO - 2015-12-17 20:53:18,949 DEBUG : BROWSER_OUTPUT: 20:53:21 INFO - 2015-12-17 20:53:21,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39524/tests/kraken/driver.html?testName=audio-beat-detection) 20:53:22 INFO - 2015-12-17 20:53:22,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 185065472 20:53:22 INFO - 2015-12-17 20:53:22,186 DEBUG : BROWSER_OUTPUT: 20:53:24 INFO - 2015-12-17 20:53:24,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39524/tests/kraken/driver.html?testName=audio-dft) 20:53:25 INFO - 2015-12-17 20:53:25,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 175022080 20:53:25 INFO - 2015-12-17 20:53:25,491 DEBUG : BROWSER_OUTPUT: 20:53:28 INFO - 2015-12-17 20:53:28,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39524/tests/kraken/driver.html?testName=audio-fft) 20:53:29 INFO - 2015-12-17 20:53:29,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 160530432 20:53:29 INFO - 2015-12-17 20:53:29,049 DEBUG : BROWSER_OUTPUT: 20:53:31 INFO - 2015-12-17 20:53:31,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39524/tests/kraken/driver.html?testName=audio-oscillator) 20:53:31 INFO - 2015-12-17 20:53:31,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 163164160 20:53:31 INFO - 2015-12-17 20:53:31,667 DEBUG : BROWSER_OUTPUT: 20:53:33 INFO - 2015-12-17 20:53:33,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39524/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:53:34 INFO - 2015-12-17 20:53:34,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 164315136 20:53:34 INFO - 2015-12-17 20:53:34,479 DEBUG : BROWSER_OUTPUT: 20:53:37 INFO - 2015-12-17 20:53:37,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39524/tests/kraken/driver.html?testName=imaging-darkroom) 20:53:38 INFO - 2015-12-17 20:53:38,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 166289408 20:53:38 INFO - 2015-12-17 20:53:38,036 DEBUG : BROWSER_OUTPUT: 20:53:41 INFO - 2015-12-17 20:53:41,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39524/tests/kraken/driver.html?testName=imaging-desaturate) 20:53:42 INFO - 2015-12-17 20:53:42,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 166318080 20:53:42 INFO - 2015-12-17 20:53:42,036 DEBUG : BROWSER_OUTPUT: 20:53:44 INFO - 2015-12-17 20:53:44,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39524/tests/kraken/driver.html?testName=json-parse-financial) 20:53:45 INFO - 2015-12-17 20:53:45,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 166039552 20:53:45 INFO - 2015-12-17 20:53:45,436 DEBUG : BROWSER_OUTPUT: 20:53:47 INFO - 2015-12-17 20:53:47,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39524/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:53:47 INFO - 2015-12-17 20:53:47,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 174858240 20:53:47 INFO - 2015-12-17 20:53:47,745 DEBUG : BROWSER_OUTPUT: 20:53:49 INFO - 2015-12-17 20:53:49,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39524/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:53:50 INFO - 2015-12-17 20:53:50,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 171909120 20:53:50 INFO - 2015-12-17 20:53:50,201 DEBUG : BROWSER_OUTPUT: 20:53:52 INFO - 2015-12-17 20:53:52,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39524/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:53:52 INFO - 2015-12-17 20:53:52,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 184954880 20:53:52 INFO - 2015-12-17 20:53:52,872 DEBUG : BROWSER_OUTPUT: 20:53:55 INFO - 2015-12-17 20:53:55,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:53:55 INFO - 2015-12-17 20:53:55,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 191549440 20:53:55 INFO - 2015-12-17 20:53:55,967 DEBUG : BROWSER_OUTPUT: 20:53:58 INFO - 2015-12-17 20:53:58,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:53:59 INFO - 2015-12-17 20:53:59,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 189538304 20:53:59 INFO - 2015-12-17 20:53:59,164 DEBUG : BROWSER_OUTPUT: 20:54:00 INFO - 2015-12-17 20:54:00,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39524/tests/kraken/driver.html?testName=ai-astar) 20:54:01 INFO - 2015-12-17 20:54:01,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 248901632 20:54:01 INFO - 2015-12-17 20:54:01,180 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,184 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:54:01 INFO - 2015-12-17 20:54:01,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:54:01 INFO - 2015-12-17 20:54:01,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:54:01 INFO - 2015-12-17 20:54:01,184 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:54:01 INFO - 2015-12-17 20:54:01,184 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;115;107;115;115;113;103;113;112;105 20:54:01 INFO - 2015-12-17 20:54:01,184 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;129;163;164;134;152;150;137;172;134 20:54:01 INFO - 2015-12-17 20:54:01,184 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;160;163;161;162;162;162;163 20:54:01 INFO - 2015-12-17 20:54:01,185 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;80;92;70;71;73;98;89;73 20:54:01 INFO - 2015-12-17 20:54:01,185 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;132;94;94;94;130;94;95;129 20:54:01 INFO - 2015-12-17 20:54:01,185 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;109;109;109;111;110 20:54:01 INFO - 2015-12-17 20:54:01,185 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;146 20:54:01 INFO - 2015-12-17 20:54:01,185 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;95;96;95;95;95 20:54:01 INFO - 2015-12-17 20:54:01,185 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;70;70;70;71;71;79;68;68 20:54:01 INFO - 2015-12-17 20:54:01,185 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;68;68;68;68;67;68;68 20:54:01 INFO - 2015-12-17 20:54:01,186 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;85;85;85;84;88;82;82;83 20:54:01 INFO - 2015-12-17 20:54:01,186 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;119;122;128;128;119;128;124;119;120 20:54:01 INFO - 2015-12-17 20:54:01,186 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;146;151;147;146;134;152;145;151;136 20:54:01 INFO - 2015-12-17 20:54:01,186 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;71;68;70;71;71;71;72;70;71 20:54:01 INFO - 2015-12-17 20:54:01,186 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:54:01 INFO - 2015-12-17 20:54:01,186 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:54:01 INFO - 2015-12-17 20:54:01,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 20:54:01 INFO - 2015-12-17 20:54:01,186 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:54:01 INFO - 2015-12-17 20:54:01,187 DEBUG : BROWSER_OUTPUT: __startTimestamp1450414441181__endTimestamp 20:54:01 INFO - 2015-12-17 20:54:01,187 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,190 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:54:01 INFO - 2015-12-17 20:54:01,190 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:54:01 INFO - 2015-12-17 20:54:01,190 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,190 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:4.43 (3.9%) stddev-sans-first:4.65 20:54:01 INFO - 2015-12-17 20:54:01,190 DEBUG : BROWSER_OUTPUT: Values: 113.0 115.0 107.0 115.0 115.0 113.0 103.0 113.0 112.0 105.0 20:54:01 INFO - 2015-12-17 20:54:01,190 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.00 Median:153.50 stddev:14.87 (9.7%) stddev-sans-first:15.61 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: Values: 155.0 129.0 163.0 164.0 134.0 152.0 150.0 137.0 172.0 134.0 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 160.0 163.0 161.0 162.0 162.0 162.0 163.0 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:76.50 stddev:10.33 (13.5%) stddev-sans-first:10.65 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 80.0 92.0 70.0 71.0 73.0 98.0 89.0 73.0 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:94.00 stddev:17.43 (18.5%) stddev-sans-first:18.02 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 132.0 94.0 94.0 94.0 130.0 94.0 95.0 129.0 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 111.0 110.0 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,191 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.90 Median:71.00 stddev:3.07 (4.3%) stddev-sans-first:3.26 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 70.0 70.0 71.0 71.0 79.0 68.0 68.0 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 68.0 68.0 68.0 68.0 67.0 68.0 68.0 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.50 stddev:1.99 (2.4%) stddev-sans-first:2.00 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 85.0 85.0 85.0 84.0 88.0 82.0 82.0 83.0 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,192 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.50 stddev:3.91 (3.1%) stddev-sans-first:4.09 20:54:01 INFO - 2015-12-17 20:54:01,193 DEBUG : BROWSER_OUTPUT: Values: 125.0 119.0 122.0 128.0 128.0 119.0 128.0 124.0 119.0 120.0 20:54:01 INFO - 2015-12-17 20:54:01,193 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,193 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:146.50 stddev:6.47 (4.4%) stddev-sans-first:6.40 20:54:01 INFO - 2015-12-17 20:54:01,193 DEBUG : BROWSER_OUTPUT: Values: 138.0 146.0 151.0 147.0 146.0 134.0 152.0 145.0 151.0 136.0 20:54:01 INFO - 2015-12-17 20:54:01,193 DEBUG : BROWSER_OUTPUT: 20:54:01 INFO - 2015-12-17 20:54:01,193 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:1.17 (1.7%) stddev-sans-first:1.13 20:54:01 INFO - 2015-12-17 20:54:01,193 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 68.0 70.0 71.0 71.0 71.0 72.0 70.0 71.0 20:54:01 INFO - 2015-12-17 20:54:01,193 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:54:01 INFO - 2015-12-17 20:54:01,193 DEBUG : BROWSER_OUTPUT: 20:54:02 INFO - 2015-12-17 20:54:02,089 INFO : Browser exited with error code: 0 20:54:02 INFO - 2015-12-17 20:54:02,141 INFO : Completed test kraken (00:01:00) 20:54:02 INFO - 2015-12-17 20:54:02,141 INFO : Starting test v8_7 20:54:02 INFO - 2015-12-17 20:54:02,141 DEBUG : operating with platform_type : linux_ 20:54:02 INFO - 2015-12-17 20:54:02,141 INFO : Initialising browser for v8_7 test... 20:54:02 INFO - 2015-12-17 20:54:02,147 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEDPM3J/profile http://localhost:39524/getInfo.html 20:54:06 INFO - 2015-12-17 20:54:06,128 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:54:06 INFO - 2015-12-17 20:54:06,128 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:54:06 INFO - 2015-12-17 20:54:06,128 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:54:06 INFO - 2015-12-17 20:54:06,128 DEBUG : BROWSER_OUTPUT: __metrics 20:54:06 INFO - 2015-12-17 20:54:06,297 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:54:06 INFO - 2015-12-17 20:54:06,353 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:54:07 INFO - 2015-12-17 20:54:07,466 INFO : Browser initialized. 20:54:07 INFO - 2015-12-17 20:54:07,466 INFO : Running cycle 1/1 for v8_7 test... 20:54:07 INFO - 2015-12-17 20:54:07,467 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEDPM3J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:54:19 INFO - 2015-12-17 20:54:19,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 150654976 20:54:19 INFO - 2015-12-17 20:54:19,459 DEBUG : BROWSER_OUTPUT: 20:54:40 INFO - 2015-12-17 20:54:40,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39524/tests/v8_7/run.html (next: http://localhost:39524/tests/v8_7/run.html) 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 451440640 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: |0;Richards;165.59032952475576 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.01387604070305 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.2415136338342 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: |5;Earley;786.7820613690008 20:54:41 INFO - 2015-12-17 20:54:41,104 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 20:54:41 INFO - 2015-12-17 20:54:41,105 DEBUG : BROWSER_OUTPUT: |7;RegExp;26526.315789473683 20:54:41 INFO - 2015-12-17 20:54:41,105 DEBUG : BROWSER_OUTPUT: |8;Splay;618.0469715698393 20:54:41 INFO - 2015-12-17 20:54:41,105 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 20:54:41 INFO - 2015-12-17 20:54:41,105 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:54:41 INFO - 2015-12-17 20:54:41,105 DEBUG : BROWSER_OUTPUT: __startTimestamp1450414481098__endTimestamp 20:54:41 INFO - 2015-12-17 20:54:41,105 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,105 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:54:41 INFO - 2015-12-17 20:54:41,105 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:54:41 INFO - 2015-12-17 20:54:41,106 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,106 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.59 Median:165.59 stddev:0.00 (0.0%) 20:54:41 INFO - 2015-12-17 20:54:41,106 DEBUG : BROWSER_OUTPUT: Values: 165.6 20:54:41 INFO - 2015-12-17 20:54:41,106 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,106 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.01 Median:185.01 stddev:0.00 (0.0%) 20:54:41 INFO - 2015-12-17 20:54:41,106 DEBUG : BROWSER_OUTPUT: Values: 185.0 20:54:41 INFO - 2015-12-17 20:54:41,106 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,107 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 20:54:41 INFO - 2015-12-17 20:54:41,107 DEBUG : BROWSER_OUTPUT: Values: 278.2 20:54:41 INFO - 2015-12-17 20:54:41,107 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,107 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 20:54:41 INFO - 2015-12-17 20:54:41,107 DEBUG : BROWSER_OUTPUT: Values: 5186.5 20:54:41 INFO - 2015-12-17 20:54:41,107 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,107 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 20:54:41 INFO - 2015-12-17 20:54:41,107 DEBUG : BROWSER_OUTPUT: Values: 1984.1 20:54:41 INFO - 2015-12-17 20:54:41,108 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,108 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:786.78 Median:786.78 stddev:0.00 (0.0%) 20:54:41 INFO - 2015-12-17 20:54:41,108 DEBUG : BROWSER_OUTPUT: Values: 786.8 20:54:41 INFO - 2015-12-17 20:54:41,108 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,108 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 20:54:41 INFO - 2015-12-17 20:54:41,108 DEBUG : BROWSER_OUTPUT: Values: 12268.3 20:54:41 INFO - 2015-12-17 20:54:41,108 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,109 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26526.32 Median:26526.32 stddev:0.00 (0.0%) 20:54:41 INFO - 2015-12-17 20:54:41,109 DEBUG : BROWSER_OUTPUT: Values: 26526.3 20:54:41 INFO - 2015-12-17 20:54:41,109 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,109 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:618.05 Median:618.05 stddev:0.00 (0.0%) 20:54:41 INFO - 2015-12-17 20:54:41,109 DEBUG : BROWSER_OUTPUT: Values: 618.0 20:54:41 INFO - 2015-12-17 20:54:41,109 DEBUG : BROWSER_OUTPUT: 20:54:41 INFO - 2015-12-17 20:54:41,109 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 20:54:41 INFO - 2015-12-17 20:54:41,109 DEBUG : BROWSER_OUTPUT: Values: 4826.9 20:54:41 INFO - 2015-12-17 20:54:41,110 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:54:41 INFO - 2015-12-17 20:54:41,110 DEBUG : BROWSER_OUTPUT: 20:54:42 INFO - 2015-12-17 20:54:42,053 INFO : Browser exited with error code: 0 20:54:42 INFO - 2015-12-17 20:54:42,065 INFO : Completed test v8_7 (00:00:39) 20:54:42 INFO - 2015-12-17 20:54:42,147 INFO : Completed test suite (00:20:17) 20:54:42 INFO - 2015-12-17 20:54:42,147 DEBUG : Working with test: dromaeo_css 20:54:42 INFO - 2015-12-17 20:54:42,147 DEBUG : Generating results file: dromaeo_css 20:54:42 INFO - 2015-12-17 20:54:42,148 DEBUG : Working with test: kraken 20:54:42 INFO - 2015-12-17 20:54:42,149 DEBUG : Generating results file: kraken 20:54:42 INFO - 2015-12-17 20:54:42,149 INFO : javascript benchmark 20:54:42 INFO - 2015-12-17 20:54:42,149 DEBUG : Working with test: v8_7 20:54:42 INFO - 2015-12-17 20:54:42,149 DEBUG : Generating results file: v8_7 20:54:42 INFO - 2015-12-17 20:54:42,150 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:54:42 INFO - 2015-12-17 20:54:42,199 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 20:54:42 INFO - 2015-12-17 20:54:42,199 DEBUG : process_Request line: dromaeo_css 6176.46 graph.html#tests=[[72,203,35]] 20:54:42 INFO - 2015-12-17 20:54:42,199 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:54:42 INFO - 2015-12-17 20:54:42,234 DEBUG : process_Request line: kraken 1517.60 graph.html#tests=[[232,203,35]] 20:54:42 INFO - 2015-12-17 20:54:42,234 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:54:42 INFO - 2015-12-17 20:54:42,269 DEBUG : process_Request line: v8_7 19806.85 graph.html#tests=[[230,203,35]] 20:54:42 INFO - 2015-12-17 20:54:42,271 INFO : javascript benchmark 20:54:42 INFO - 2015-12-17 20:54:42,274 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2621.672290963629, 2706.215197592698, 2709.065372446508, 2717.714639962805, 2725.4821583899065, 4517.932231016537, 4640.303954406841, 4648.372469716587, 4674.649401294903, 4689.788959496822, 4560.31595260711, 4620.468646105699, 4632.652551058667, 4648.163330600491, 4748.287756836477, 4162.562930892243, 4286.078493123978, 4296.248156572603, 4342.9131417371555, 4453.087117140978, 4417.469903611571, 4438.289873620221, 4467.865964021084, 4468.597826195642, 4491.326301054852, 4188.664906807463, 4204.684648651363, 4303.376010478494, 4312.22379971605, 4323.935140972888, 4339.717918335298, 4344.804483798205, 4352.630026447756, 4371.956280437187, 4392.868213953587, 4298.097399546099, 4316.266234740102, 4328.112736888962, 4331.285337919239, 4347.239233134189, 4474.955250447487, 4583.381243532147, 4584.449866016066, 4594.816207351702, 4688.531146885318, 5053.873653158664, 5055.873603159914, 5059.1905295152965, 5081.212412076134, 5103.362079740033, 5042.092423363793, 5066.82266120684, 5066.923996140061, 5077.466865979056, 5100.897982040376, 4499.302608095751, 4600.493945665974, 4602.033572949718, 4679.27471241958, 4705.364775755298, 5018.146915024455, 5095.31213286209, 5128.79484820603, 5158.871028224249, 5161.74191290434, 4958.404991400983, 4979.57673597741, 4983.700977941335, 4989.201727723546, 5034.244863270539, 4794.2808578713475, 4897.14299997499, 4902.950970490249, 5077.847664570068, 5085.364329458817, 4766.213574760126, 4869.342638743724, 4926.187179115477, 4951.851444456672, 4956.603471722254, 4988.700677959334, 4990.525900039491, 4994.001199760062, 4995.600351971833, 5049.343585333883, 4205.306124489425, 4205.810738516774, 4208.684348673862, 4219.198352313051, 4226.598473145046, 3543.911402214965, 3609.4766258892314, 3653.83557739897, 3671.816409179584, 3703.4259689748133, 4323.610875021263, 4344.522102568715, 4346.9347959780625, 4358.128374325084, 4384.057427653006, 5045.672031317952, 5055.747212639353, 5055.823046193365, 5056.544910958031, 5100.770465329069, 4125.0, 4214.4310518079665, 4230.746155230634, 4231.534531201565, 4235.428217190702, 4470.6870519064005, 4482.148391805546, 4505.279155335196, 4521.525239849769, 4529.38853254813, 4794.880127996828, 4804.015176888799, 4806.543378379119, 4826.058918510927, 4835.95164048369, 4789.042191561632, 4904.901901962012, 4909.4354149273295, 5085.364329458817, 5087.64386492942, 4680.251159814414, 4711.128441238382, 4715.2455607104075, 4749.24012158053, 4752.976235118802, 4971.925421118758, 5022.573081288131, 5029.698218106925, 5030.320906677698, 5071.315372424676, 4791.448983366818, 4913.975430122827, 5068.518490743373, 5091.287219789307, 5127.077126117186, 4760.857174284777, 4766.713997160182, 4836.250381190921, 4856.4415092263425, 4865.391826021747, 4933.062718083553, 4935.504756213045, 4937.28409380645, 4944.456109827988, 4989.800407983786, 4803.255495398219, 4834.854954351375, 4846.80612775485, 4883.145449546244, 4892.877678058077, 4712.363830882787, 4812.0, 4816.710997340171, 4816.927746083882, 4826.300186473012, 4663.370444990019, 4756.6908150970075, 4846.636502262274, 4862.319275301531, 4898.559129678346], "unit": "score", "name": "dojo.html", "value": 4597.010002683325}, {"lowerIsBetter": false, "replicates": [551.8344496651006, 562.3504851896062, 569.0667305618784, 574.3423779772162, 582.5427039773779, 26750.197494075186, 27220.455590888196, 27276.318092047735, 34936.82531587345, 35540.11149721258, 40475.59524404755, 40700.79649601748, 40914.79542602283, 40976.590234097726, 41063.58936410635, 7889.644965976516, 8059.07320658126, 8070.0, 8073.959630201841, 8076.71731489398, 7192.280771922792, 7338.743143989961, 7854.6465409056445, 10089.192864570854, 10405.583776648962, 10081.69754907354, 10196.643117490888, 10206.285560010801, 10210.795784084314, 10212.336198147133, 7083.18543367509, 9625.326227164102, 9667.806643867118, 9675.951620241924, 9679.564419601134, 6912.101426814532, 10153.238507111922, 10447.05976462122, 10466.581336746522, 10468.0, 37606.62393376059, 38113.61886381129, 38154.80922595369, 38154.80922595397, 38246.80876595627, 2730.3856632257584, 2797.139991717349, 3067.647220569641, 3153.810771353726, 3309.0, 28546.286342841388, 28912.98804541852, 28934.276643083882, 29173.85413072942, 29320.853395732884, 3357.2781851901714, 3403.3873902697505, 3411.2154204533094, 3457.4640930655787, 3501.159721666807, 226892.0, 228747.0, 228777.85611072005, 228968.0, 229192.0, 52548.474515254355, 54304.185437218475, 54536.0, 54860.725696371264, 54862.17706734402, 58986.705066474395, 59920.70039649774, 60183.69908150519, 60207.397926021054, 60265.69867150636, 13336.866631333562, 13453.0, 13465.865341346462, 13519.256440895846, 13553.661158471117, 9812.460314682761, 9859.457729824928, 9863.901360986441, 9864.654737084167, 9869.802603947881, 19160.945388475997, 19569.608607827762, 19618.313359032367, 19626.0, 19629.705554416694, 7370.0, 7646.847063058708, 7701.807454813675, 7711.460197786101, 7722.613869306625, 835.9797781932997, 846.5259454705384, 900.7883147460342, 986.9753256168653, 998.0368943969105, 26213.60679589808, 26480.867595662283, 26540.203793885827, 26777.464450710875, 29708.0, 908.6774195160755, 927.3832901120679, 952.3619175152664, 1019.9541020654088, 1038.9220808439397, 13910.58268251954, 14013.369398377097, 14128.43486260538, 14154.504592339219, 14163.85836141646, 321604.0, 326458.0, 326708.0, 327457.0, 328150.0, 46808.5319146811, 47227.05545889063, 47253.29120063202, 47294.5270547297, 47541.0, 1223.1193540650718, 1227.5212667059855, 1252.2987127208792, 1253.053944272087, 1258.2324781883226, 25115.74884251134, 26121.0, 29499.262518437212, 31179.84410077935, 31345.84327078441, 42908.35637465503, 43615.56384436115, 43618.0, 43624.34563481487, 43721.56278437175, 238515.0, 245444.0, 249012.0, 249361.0, 249579.0, 24802.0, 28325.0, 28380.858095710217, 28990.85504572548, 29050.12849614515, 32677.55126288409, 36192.638073618924, 36248.81875590605, 36866.26267474689, 37068.25863482661, 30859.84570077135, 38419.0, 40071.39892901551, 40274.395884061174, 41078.0, 33229.33541329111, 33592.66407335895, 37425.25149497049, 38964.35016922474, 39120.6087939117, 32613.836930815192, 33037.33925321528, 33211.335773283914, 33334.499982499794, 33343.83328083344, 27526.862365688045, 27556.44887102287, 29038.564421533272, 29285.7071429283, 29392.853035734686, 23106.637595451637, 23118.803713647176, 23337.649935250643, 23414.64878026865, 23488.530229394975], "unit": "score", "name": "ext.html", "value": 17389.27840779165}, {"lowerIsBetter": false, "replicates": [315.1836742836054, 320.775457179974, 323.96922292382214, 328.0437524615745, 329.20496999745615, 13041.934790326059, 13497.730045399087, 14865.0, 15072.472463463795, 15267.0, 12471.127021108527, 14114.71770564588, 14811.629709257273, 15216.771748423782, 15271.465498707548, 4807.567318941295, 4822.397200349965, 4911.557959783619, 4914.410270767513, 4959.504049595048, 3777.697784177259, 3811.714121440903, 5040.621953353513, 5125.2055931330515, 5676.176954341618, 5698.7435565399655, 5732.856678583048, 5761.049426844586, 5763.193152958589, 5763.337216220126, 5552.86117847053, 5669.177969194444, 5697.4587414196, 5704.65772053676, 5719.313682358102, 4999.625028122905, 5001.549860512535, 5008.899822003539, 5015.247712843066, 5015.473375295578, 18897.62204755911, 18914.337998169998, 19305.131269092926, 19424.417267481997, 19445.22219111248, 1779.599590092232, 1903.684855338789, 1955.882647041168, 1967.7835438101797, 1978.851586131046, 8229.341652667772, 8379.49723016621, 8561.700340488116, 8595.656173753105, 9984.650537231162, 1692.8222536633723, 1717.450415866923, 1718.6390857919853, 1744.2264713185994, 1780.7061834797244, 53678.0, 56281.43718562844, 56885.0, 57465.71267143638, 57574.13638795421, 9709.854352184722, 9814.3620664658, 9816.214702823758, 9834.065763752433, 9890.554925028391, 12414.503419863286, 12415.751684966432, 12428.316442595564, 12442.626721198378, 12444.128910976326, 6623.205215374186, 6634.369734875179, 6665.933340666628, 6721.059051732761, 6737.764178253738, 6194.4115309045565, 6409.871802563923, 6501.902471462932, 6509.576877502947, 6512.837179070561, 3959.148783011609, 3959.544652364957, 4076.9603751043887, 4139.503259608866, 4163.125743593819, 1592.3789722008426, 1634.3462614953876, 1635.5256975477216, 1675.2210222246713, 1733.5319463744718, 809.7773112394021, 824.9092599814015, 843.3379796859558, 855.6745650735468, 856.9400141990001, 15089.47186848455, 15943.920280398524, 16428.67142657164, 16456.341746330254, 16850.32598696063, 826.1325608111459, 830.0537387378394, 850.6469815026818, 856.1139220906457, 930.1582068228264, 8810.339224558184, 8972.8654070189, 9245.583948722324, 9352.953235233781, 9409.858852117224, 471933.0, 476306.0, 476662.0, 479700.0, 484184.0, 73539.0, 75070.6246468775, 77256.0, 77775.61112194402, 77889.22110778933, 1002.3735165521549, 1022.4836457589018, 1033.5968972100886, 1033.7002269341956, 1037.3827572594446, 13678.86321136776, 14322.427102915766, 14484.855151448772, 14541.0, 14582.708345833236, 32818.0, 32820.0, 33160.0, 33736.831315843265, 33976.83011584926, 37647.435288470144, 37959.430608540344, 38053.4291985626, 38138.42792358172, 38928.6107138925, 8679.652813887626, 8761.38670293099, 8841.557922103997, 8858.601362938554, 8986.775330616787, 11570.76858462843, 16611.83388166151, 16644.417445389354, 16778.66442671115, 16851.578710532336, 10781.568737250422, 11133.55465781392, 11572.074234061423, 13482.258475783927, 13827.792583111463, 13034.665816745584, 13423.865761342653, 13491.0, 14034.438622454987, 14191.787123192953, 12803.231806091664, 13321.666958325732, 13463.394147263201, 14288.214148221532, 14425.85574144245, 7324.926750732638, 7537.585432801248, 8526.062133165471, 8681.522516261413, 8860.822783544165, 9003.684871029482, 9092.454452732858, 12992.220466772023, 13918.860811391756, 14426.278686065865], "unit": "score", "name": "jquery.html", "value": 8142.187101754352}, {"lowerIsBetter": false, "replicates": [1230.4893469210278, 1658.5024492652203, 1693.280355848764, 1719.750636157757, 1719.982800171998, 6167.537434692399, 6944.236134025259, 7095.574265544071, 7117.145942486909, 7126.75056373027, 7073.893891591631, 7263.60050197239, 7264.927350726492, 7276.9272307276915, 7281.453890958186, 2023.615513052519, 2063.226290141197, 2063.9484012899647, 2063.9793602064015, 2065.1326442893946, 2061.7525896892394, 2075.346265926236, 2078.2933802507146, 2111.271611294101, 2111.4826867417505, 2003.1486618187284, 2026.2097781865084, 2056.362527616436, 2057.341650671778, 2058.3619078085767, 2024.1195080140187, 2052.435580215453, 2052.7434070741156, 2055.106028877443, 2055.496403381174, 1971.2607772085469, 1984.2063174730079, 2043.52998810273, 2044.488877780555, 2045.0694933805082, 7142.607156606385, 7218.8917166242545, 7225.674844631952, 7229.060222171137, 7232.421406287484, 4134.441850350195, 4216.810243539048, 4220.704550681454, 4222.303319952204, 4226.746395216266, 2593.4424098818845, 2603.388203772131, 2638.947221055568, 2642.2205449392477, 2688.932776680579, 838.9664413423455, 850.3239924260228, 866.1684782608703, 866.1944391715701, 877.2148926710622, 9770.36492627984, 9776.95111524445, 9781.119699227103, 9809.068138526829, 9809.313348065638, 3921.117748506563, 3936.9606303937167, 3965.6629186518894, 3978.562358140602, 3992.261431635157, 8399.580020998925, 8409.915900841035, 8437.282830959315, 8439.324854011787, 8447.45091569046, 4311.310190369589, 4315.568443155659, 4338.891527711769, 4349.804258808361, 4350.521442641307, 3136.0435067304234, 3249.0, 3733.757305775116, 3947.3289540778137, 3948.506436695413, 3357.8153201574146, 3397.490376443553, 3411.403004474207, 3426.794392336468, 3429.0, 1116.6984914073155, 1118.1725523113, 1118.6811758648746, 1123.4102096399292, 1140.133498541098, 838.0153319849153, 849.3332733803934, 852.5183271451734, 853.1298075962484, 1081.1512962324537, 6705.966470167716, 6724.49566282521, 6747.831304217434, 6758.526903116833, 6764.391204791494, 377.7865505989107, 379.8670465337165, 380.46734571599427, 381.56311023877504, 392.7192057678773, 4894.706317620954, 4901.877453063631, 4919.1391506486225, 4928.334674818925, 4930.309756634074, 8550.871736923951, 8555.101714320032, 8752.69365572202, 8768.78078048054, 8850.468971861708, 8687.044425113232, 8687.739367818975, 8690.652373905099, 8716.084811094745, 8798.47209167452, 6488.902666459912, 6618.4705223582, 6619.834504137339, 6696.263411024784, 6737.461003119739, 6433.5496515243485, 6440.0983862260255, 6443.0, 6445.065465507569, 6457.902156633478, 7693.650294969885, 7771.689132434639, 7840.372770178258, 7875.291223789886, 7905.051393832777, 7657.6554055066545, 7764.767056988299, 7873.291403773688, 8147.10381858007, 8164.918350816416, 5259.42146363892, 5392.325959255093, 5968.850778730566, 6095.359987201457, 6101.481374083075, 5854.765809367577, 6042.063480160582, 6831.0436538883605, 6887.793366199022, 6921.6193109379465, 6518.413342799171, 6527.902081468686, 6684.197896252481, 6690.966545167243, 6691.59850408977, 6545.639989800607, 6546.214454265519, 6611.438027767694, 6617.073609694743, 6688.799336019927, 6697.866042679217, 6705.4635629150525, 6728.360805723449, 6755.324467553205, 6765.323467653196, 5949.553783466344, 5970.850728731816, 6014.518838492998, 6028.0355143176885, 6030.879382412415, 6081.087836824512, 6108.908366374597, 6116.938830611815, 6117.877642447215, 6119.571629986036], "unit": "score", "name": "mootools.html", "value": 3969.2441069977344}, {"lowerIsBetter": false, "replicates": [285.04509891862256, 289.7435769344132, 289.80003797379806, 290.6584762903589, 295.3546500895542, 4967.379077615298, 5189.247559103937, 5206.375234971804, 5252.264682944391, 5284.3394575678085, 4505.662075344346, 5240.9213861792, 5240.973795131019, 5243.239730239113, 5248.317718696564, 4026.939595906064, 4037.636612704856, 4040.696947728917, 4045.312296909518, 4048.57489963554, 3874.7093967952374, 3935.5474120476224, 3976.960230397688, 4033.818478168475, 4042.9191416171657, 3990.04238982645, 3994.121293315466, 4009.278329900617, 4010.258102251078, 4016.8393264269394, 3969.5435024972207, 3986.1230529283803, 3991.4611527443712, 4000.159966407058, 4017.8392864285393, 3474.1835668617855, 3476.774009689362, 3478.478228265755, 3479.373712731707, 3479.7912125272564, 5035.924461133086, 5040.36995375578, 5049.823256186016, 5054.06499797535, 5058.898822023576, 4546.54510556622, 4577.22187228172, 4577.244754615518, 4580.931286030712, 4582.495925448198, 5451.991381594417, 5483.561315094783, 5489.58828087891, 5490.945090549083, 5493.121100623921, 3778.0932576181517, 3778.6410291022307, 3780.073881898925, 3783.1298801275584, 3785.4511095891216, 5505.146702261116, 5698.487136157724, 5782.219400380979, 5784.0, 5794.884102317972, 3425.2978139481347, 3748.456473811282, 3749.1751814600743, 3788.6021967692996, 3810.942835857464, 3890.6692931101175, 3901.9609803902167, 3903.0437542802197, 3946.5856085111222, 4001.9399709004388, 4586.2661974083985, 4590.1737687215955, 4590.609798167126, 4591.334256532851, 4597.0, 5512.779488820403, 5521.116621340647, 5522.834314970557, 5525.060739674265, 5526.336839579196, 1381.0884816021378, 1406.2476575032308, 1406.367134789349, 1406.4936622815778, 1406.5709958462562, 920.346553946692, 925.3984909808544, 943.4527973775193, 966.2077096780713, 966.7244835222068, 4860.392450943632, 4872.926906096412, 4873.390826146731, 4873.756312184377, 4875.219964805614, 5741.598088133874, 5746.367899531048, 5752.28096487939, 5757.050086735641, 5769.336526299446, 4868.930704450594, 4870.0746858096845, 4874.025194961022, 4878.243872199815, 4879.463259041502, 3019.04899956513, 3057.1898446911587, 3088.5521599368417, 3089.938201235963, 3090.103869877755, 5437.102878025161, 5447.809326673548, 5447.863803404946, 5452.890942181134, 5456.399796022434, 5878.676672782953, 5889.381614930457, 5889.587728858939, 5897.0, 5902.1441890926435, 5277.050130976308, 5426.75579598919, 5432.7555260012605, 5436.70098144598, 5442.646227995247, 5475.698836564027, 5568.9443105568425, 5700.971495142498, 5807.186993820953, 5807.361190268983, 5647.435256474319, 5669.971650141888, 5671.461211184931, 5671.773129074791, 5680.147977803363, 5492.80775172867, 5493.780248790164, 5502.0, 5508.173773933942, 5508.44915508446, 4010.5588385277015, 4012.578679238638, 4014.4580481634607, 4015.3976903464713, 4017.176478821776, 5611.270534830609, 5749.425057494217, 5763.423657634371, 5775.971120144372, 5805.158252053513, 5551.389347171888, 5554.944450555443, 5563.638363506359, 5565.415631358811, 5568.610197286313, 5526.673598336451, 5554.722263886709, 5555.22226888244, 5555.30558680165, 5555.805546805843, 5312.734363281743, 5393.757280922289, 5435.211894275229, 5448.918266226089, 5456.754446050017, 5586.52514536269, 5596.552275818006, 5600.915986260128, 5606.24315717373, 5607.719614019365, 5468.972655136698, 5470.8085217017215, 5471.671699698031, 5472.097103977799, 5478.424765399575], "unit": "score", "name": "prototype.html", "value": 4121.557804624938}, {"lowerIsBetter": false, "replicates": [727.4798519058875, 738.7266711316813, 740.7703611880318, 742.6917829100923, 748.9438292128092, 10431.217658675601, 10748.408837513934, 10751.408672523008, 10771.892281077196, 10777.83833242501, 10187.949060254688, 10276.588936442533, 10283.177345812335, 10284.0, 10288.0, 612.4212619074976, 616.8365383173463, 768.9077310722721, 788.3062904643905, 806.1938061938062, 785.9017622797151, 787.6416230615085, 794.126460893016, 794.1264608930188, 795.4749865089043, 826.2192228344217, 833.4124442268186, 833.5790425834945, 833.945793523422, 834.2491757418342, 644.3685188515234, 650.3204151661525, 820.3396266005893, 831.3681601982477, 835.0814104485079, 625.4808508937571, 625.5277265664395, 625.8060001399535, 626.0484064222356, 626.2297374229678, 9830.115289623896, 10066.949665251626, 10089.646862359856, 10099.29304948654, 10110.44392558409, 9866.45734484603, 10107.3430227035, 10285.794284114276, 10456.895431045745, 11903.464344104535, 8094.109647938722, 8102.918970810276, 8231.835363292761, 8304.70933517324, 8316.83366332676, 3082.5992620959355, 3097.8760849565992, 3109.036198778386, 3131.9686803131904, 3141.4659507883716, 37871.43192852082, 38069.23861522782, 38125.61874381276, 38218.61781382179, 38309.42535861964, 8778.0, 8823.426477279085, 8842.911570884338, 9076.818463630823, 9379.062093790702, 15914.76127858083, 16149.111798850941, 16156.27296771648, 16161.676766464605, 16171.514854554382, 6155.446009859134, 6210.9068363974575, 6320.652364119926, 6352.078948552434, 6445.548811583238, 3351.564296641421, 3456.8617255309505, 3477.217626034122, 3487.442009278503, 3497.7726447780815, 2418.927432177002, 2447.167962892625, 2449.069353645639, 2452.1049816816735, 2454.12878428159, 428.5650065183841, 432.17238987338897, 438.96049355557517, 440.47583375782716, 440.9074094440139, 365.2548800447058, 376.8712705447203, 432.859320720767, 436.96722745794193, 439.606552135843, 6983.476239282074, 7010.579365238102, 7040.331168538981, 7163.820904477429, 7296.927030729731, 478.8563430970695, 497.2814283360509, 521.2478115549902, 535.4672101259272, 539.9821336780197, 3244.951325730116, 3255.5930508686415, 3330.950035749417, 3342.8997130086136, 3409.4885767134633, 48959.510404895496, 49240.75379623079, 49267.0, 49394.259086113736, 49589.50410495921, 42374.576254237676, 43128.56871431245, 43284.78357608192, 43607.563924360984, 43625.34561981573, 39953.0, 40036.194751760835, 40235.79882100571, 40291.597084029374, 40746.18507629831, 6555.2789193189665, 6570.934290657224, 6684.598924064571, 6700.631465269457, 6752.966235168793, 29980.0, 30325.545116822825, 30391.84804076054, 30502.0, 30554.84722576373, 35640.28719425649, 38005.23989520139, 38040.0, 38222.80888595539, 38816.22367552577, 8040.798980025546, 8506.149385061444, 8522.062573116827, 8575.95712021436, 8797.912020879709, 9458.716238512581, 9560.61757529691, 9599.808003840024, 9629.0, 9648.75878103053, 8697.652093916173, 8698.826023479622, 8712.39013269065, 8712.825743484967, 8716.564171791259, 8830.646774128963, 8841.115888411108, 8845.469271843709, 8898.4660920345, 8944.597493112695, 8590.82818343642, 8615.741527754177, 8629.22336989674, 8657.523836188819, 8665.653373864974, 7605.88591171144, 7624.618769061413, 7750.379969602305, 7750.806229844299, 7773.222677732181, 7197.109578513519, 7619.961900190464, 7638.847223055619, 7758.495697779852, 7810.414218933489], "unit": "score", "name": "yui.html", "value": 5213.430828701111}], "name": "dromaeo_css", "value": 6176.46493736031}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 115.0, 107.0, 115.0, 115.0, 113.0, 103.0, 113.0, 112.0, 105.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 163.0, 164.0, 134.0, 152.0, 150.0, 137.0, 172.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 163.0, 161.0, 162.0, 162.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 80.0, 92.0, 70.0, 71.0, 73.0, 98.0, 89.0, 73.0], "unit": "score", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 132.0, 94.0, 94.0, 94.0, 130.0, 94.0, 95.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 70.0, 70.0, 71.0, 71.0, 79.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 70.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 85.0, 85.0, 85.0, 84.0, 88.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [125.0, 119.0, 122.0, 128.0, 128.0, 119.0, 128.0, 124.0, 119.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [138.0, 146.0, 151.0, 147.0, 146.0, 134.0, 152.0, 145.0, 151.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 68.0, 70.0, 71.0, 71.0, 71.0, 72.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1517.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.59032952475576], "unit": "score", "name": "Richards", "value": 213.18877800000007}, {"lowerIsBetter": false, "replicates": [185.01387604070305], "unit": "score", "name": "DeltaBlue", "value": 357.36779000000007}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [786.7820613690008], "unit": "score", "name": "Earley", "value": 847.0744729999998}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26526.315789473683], "unit": "score", "name": "RegExp", "value": 34.34268849206351}, {"lowerIsBetter": false, "replicates": [618.0469715698393], "unit": "score", "name": "Splay", "value": 131.852438}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19806.84820239231}]} 20:54:42 INFO - RETURN: dromaeo_css: 6176.46 20:54:42 INFO - RETURN: kraken: 1517.60 20:54:42 INFO - RETURN: v8_7: 19806.85 20:54:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19806.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1517.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6176.46"}}} 20:54:42 INFO - Return code: 0 20:54:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:54:42 INFO - # TBPL SUCCESS # 20:54:42 INFO - Running post-action listener: _resource_record_post_action 20:54:42 INFO - Running post-run listener: _resource_record_post_run 20:54:43 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 561078272; Read time: 0; Write time: 635776 20:54:43 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 241958912; Read time: 0; Write time: 390548 20:54:43 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 319119360; Read time: 0; Write time: 245228 20:54:43 INFO - Running post-run listener: _upload_blobber_files 20:54:43 INFO - Blob upload gear active. 20:54:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:54:43 INFO - Copying logs to upload dir... 20:54:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.727780 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-17 20:54:43.411276) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 20:54:43.414439) ========= 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=7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009965 build_url: 'https://queue.taskcluster.net/v1/task/d92xeDDnSleqIeysh4Qxsw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 20:54:43.466314) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:54:43.466632) ========= 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=7d909545e45784438f4e8e36000001b3-1450413214.895846-1571758130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 20:54:43.516014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 20:54:43.516325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 20:54:43.516649) ========= ========= Total master_lag: 0.22 =========