builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1450700012.01 results: success (0) buildid: 20151221025128 builduid: 3cb7b8613dc5480789afda2206d53db8 revision: 091d6785608297bab2cf36b1b6a2d9a388b82a01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.011734) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.012787) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.013184) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005571 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.038805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.039429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.054092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.054734) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.107133) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.107899) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.108742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.109156) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 04:13:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-21 04:13:34 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196021 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.322446) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.323222) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015105 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:32.377593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 04:13:32.378409) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 091d6785608297bab2cf36b1b6a2d9a388b82a01 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 091d6785608297bab2cf36b1b6a2d9a388b82a01 --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=6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 04:13:34,310 truncating revision to first 12 chars 2015-12-21 04:13:34,310 Setting DEBUG logging. 2015-12-21 04:13:34,311 attempt 1/10 2015-12-21 04:13:34,311 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/091d67856082?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 04:13:34,563 unpacking tar archive at: mozilla-central-091d67856082/testing/mozharness/ program finished with exit code 0 elapsedTime=0.543735 ========= master_lag: 1.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 04:13:33.980679) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:33.981146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:33.998509) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:33.998889) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 04:13:33.999359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-21 04:13:33.999704) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:36 INFO - MultiFileLogger online at 20151221 04:13:36 in /builds/slave/test 04:13:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:13:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:36 INFO - {'append_to_log': False, 04:13:36 INFO - 'base_work_dir': '/builds/slave/test', 04:13:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:13:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:36 INFO - 'branch': 'Firefox-Non-PGO', 04:13:36 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:36 INFO - 'config_files': ('talos/linux_config.py',), 04:13:36 INFO - 'default_actions': ('clobber', 04:13:36 INFO - 'read-buildbot-config', 04:13:36 INFO - 'download-and-extract', 04:13:36 INFO - 'populate-webroot', 04:13:36 INFO - 'create-virtualenv', 04:13:36 INFO - 'install', 04:13:36 INFO - 'run-tests'), 04:13:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:36 INFO - 'download_minidump_stackwalk': True, 04:13:36 INFO - 'download_symbols': 'ondemand', 04:13:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:36 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:36 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:36 INFO - 'installer_path': 'installer.exe', 04:13:36 INFO - 'log_level': 'info', 04:13:36 INFO - 'log_name': 'talos', 04:13:36 INFO - 'log_to_console': True, 04:13:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:36 INFO - 'opt_config_files': (), 04:13:36 INFO - 'pip_index': False, 04:13:36 INFO - 'sps_profile': False, 04:13:36 INFO - 'sps_profile_interval': 0, 04:13:36 INFO - 'suite': 'dromaeojs-e10s', 04:13:36 INFO - 'system_bits': '64', 04:13:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:36 INFO - 'title': 'talos-linux64-ix-064', 04:13:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:36 INFO - 'use_talos_json': True, 04:13:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:36 INFO - 'work_dir': 'build'} 04:13:36 INFO - ##### 04:13:36 INFO - ##### Running clobber step. 04:13:36 INFO - ##### 04:13:36 INFO - Running pre-action listener: _resource_record_pre_action 04:13:36 INFO - Running main action method: clobber 04:13:36 INFO - rmtree: /builds/slave/test/build 04:13:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:36 INFO - Running post-action listener: _resource_record_post_action 04:13:36 INFO - ##### 04:13:36 INFO - ##### Running read-buildbot-config step. 04:13:36 INFO - ##### 04:13:36 INFO - Running pre-action listener: _resource_record_pre_action 04:13:36 INFO - Running main action method: read_buildbot_config 04:13:36 INFO - Using buildbot properties: 04:13:36 INFO - { 04:13:36 INFO - "project": "", 04:13:36 INFO - "product": "firefox", 04:13:36 INFO - "script_repo_revision": "production", 04:13:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:13:36 INFO - "repository": "", 04:13:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:13:36 INFO - "buildid": "20151221025128", 04:13:36 INFO - "pgo_build": "False", 04:13:36 INFO - "basedir": "/builds/slave/test", 04:13:36 INFO - "buildnumber": 183, 04:13:36 INFO - "slavename": "talos-linux64-ix-064", 04:13:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:13:36 INFO - "platform": "ubuntu64_hw", 04:13:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:13:36 INFO - "branch": "mozilla-central", 04:13:36 INFO - "repo_path": "mozilla-central", 04:13:36 INFO - "revision": "091d6785608297bab2cf36b1b6a2d9a388b82a01", 04:13:36 INFO - "stage_platform": "linux64", 04:13:36 INFO - "builduid": "3cb7b8613dc5480789afda2206d53db8", 04:13:36 INFO - "slavebuilddir": "test" 04:13:36 INFO - } 04:13:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:13:36 INFO - Running post-action listener: _resource_record_post_action 04:13:36 INFO - ##### 04:13:36 INFO - ##### Running download-and-extract step. 04:13:36 INFO - ##### 04:13:36 INFO - Running pre-action listener: _resource_record_pre_action 04:13:36 INFO - Running main action method: download_and_extract 04:13:36 INFO - mkdir: /builds/slave/test/build/tests 04:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:36 INFO - https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/test_packages.json 04:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/test_packages.json 04:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:13:37 INFO - Downloaded 1302 bytes. 04:13:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:13:37 INFO - Using the following test package requirements: 04:13:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:37 INFO - u'jsshell-linux-x86_64.zip'], 04:13:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13: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')]} 04:13:37 INFO - https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/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 04:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/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 04:13:38 INFO - Downloaded 21871910 bytes. 04:13: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 04:13:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13: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 04:13:39 INFO - Return code: 0 04:13: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 04:13: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')]} 04:13:39 INFO - https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/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 04:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/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 04:13:41 INFO - Downloaded 21871910 bytes. 04:13:41 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 04:13:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:13:41 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 04:13:42 INFO - Return code: 0 04:13: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')]} 04:13:42 INFO - https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/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 04:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/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 04:13:43 INFO - Downloaded 11132039 bytes. 04:13: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 04:13:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:13: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 04:13:43 INFO - Return code: 0 04:13: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')]} 04:13:43 INFO - https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/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 04:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RQOKlg3bQ9i3og6cb2_FSw/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 04:13:44 INFO - Downloaded 53069162 bytes. 04:13:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:44 INFO - mkdir: /builds/slave/test/properties 04:13:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:44 INFO - Contents: 04:13:44 INFO - build_url:https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:13:44 INFO - Running post-action listener: _resource_record_post_action 04:13:44 INFO - Running post-action listener: set_extra_try_arguments 04:13:44 INFO - ##### 04:13:44 INFO - ##### Running populate-webroot step. 04:13:44 INFO - ##### 04:13:44 INFO - Running pre-action listener: _resource_record_pre_action 04:13:44 INFO - Running main action method: populate_webroot 04:13:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:44 INFO - '--tppagecycles', 04:13:44 INFO - '7'], 04:13:44 INFO - 'tests': ['tsvgm']}}, 04:13:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:13:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:13:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:13:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:44 INFO - 'talos_options': ['--e10s'], 04:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:44 INFO - 'tests': ['damp', 'tps']}, 04:13:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:44 INFO - 'talos_options': ['--e10s'], 04:13:44 INFO - 'tests': ['damp', 'tps']}, 04:13:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:13:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:44 INFO - 'other': {'tests': ['a11yr', 04:13:44 INFO - 'ts_paint', 04:13:44 INFO - 'tpaint', 04:13:44 INFO - 'sessionrestore', 04:13:44 INFO - 'sessionrestore_no_auto_restore']}, 04:13:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:13:44 INFO - 'tests': ['a11yr', 04:13:44 INFO - 'ts_paint', 04:13:44 INFO - 'tpaint', 04:13:44 INFO - 'sessionrestore', 04:13:44 INFO - 'sessionrestore_no_auto_restore']}, 04:13:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:13:44 INFO - 'tests': ['a11yr', 04:13:44 INFO - 'ts_paint', 04:13:44 INFO - 'tpaint', 04:13:44 INFO - 'sessionrestore', 04:13:44 INFO - 'sessionrestore_no_auto_restore']}, 04:13:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:13:44 INFO - 'tests': ['a11yr', 04:13:44 INFO - 'ts_paint', 04:13:44 INFO - 'tpaint', 04:13:44 INFO - 'sessionrestore', 04:13:44 INFO - 'sessionrestore_no_auto_restore']}, 04:13:44 INFO - 'other_l64': {'tests': ['a11yr', 04:13:44 INFO - 'ts_paint', 04:13:44 INFO - 'tpaint', 04:13:44 INFO - 'sessionrestore', 04:13:44 INFO - 'sessionrestore_no_auto_restore']}, 04:13:44 INFO - 'other_nol64': {'tests': ['a11yr', 04:13:44 INFO - 'ts_paint', 04:13:44 INFO - 'tpaint', 04:13:44 INFO - 'sessionrestore', 04:13:44 INFO - 'sessionrestore_no_auto_restore']}, 04:13:44 INFO - 'svgr': {'tests': ['tsvgx', 04:13:44 INFO - 'tsvgr_opacity', 04:13:44 INFO - 'tart', 04:13:44 INFO - 'tscrollx', 04:13:44 INFO - 'cart']}, 04:13:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:13:44 INFO - 'tests': ['tsvgx', 04:13:44 INFO - 'tsvgr_opacity', 04:13:44 INFO - 'tart', 04:13:44 INFO - 'tscrollx', 04:13:44 INFO - 'cart']}, 04:13:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:44 INFO - 'tests': ['tp5o']}, 04:13:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:44 INFO - 'talos_options': ['--e10s'], 04:13:44 INFO - 'tests': ['tp5o']}, 04:13:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:44 INFO - 'talos_options': ['--xperf_path', 04:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:44 INFO - 'tests': ['tp5n']}, 04:13:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:44 INFO - 'talos_options': ['--e10s', 04:13:44 INFO - '--xperf_path', 04:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:44 INFO - 'tests': ['tp5n']}}, 04:13:44 INFO - 'talos.zip': {'path': '', 04:13:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:44 INFO - Running post-action listener: _resource_record_post_action 04:13:44 INFO - ##### 04:13:44 INFO - ##### Running create-virtualenv step. 04:13:44 INFO - ##### 04:13:44 INFO - Running pre-action listener: _resource_record_pre_action 04:13:44 INFO - Running main action method: create_virtualenv 04:13:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13: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 04:13:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:45 INFO - Using real prefix '/usr' 04:13:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:47 INFO - Installing pip.................done. 04:13:47 INFO - Return code: 0 04:13:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7f387a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b41240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd00b0>, '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 0x1bd0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', '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 04:13: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 04:13: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 04:13:47 INFO - Using env: {'DISPLAY': ':0', 04:13:47 INFO - 'HOME': '/home/cltbld', 04:13:47 INFO - 'LANG': 'en_US.UTF-8', 04:13:47 INFO - 'LANGUAGE': 'en_US:en', 04:13:47 INFO - 'LOGNAME': 'cltbld', 04:13:47 INFO - 'MAIL': '/var/mail/cltbld', 04:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:47 INFO - 'MOZ_NO_REMOTE': '1', 04:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:47 INFO - 'NO_EM_RESTART': '1', 04:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:47 INFO - 'PWD': '/builds/slave/test', 04:13:47 INFO - 'SHELL': '/bin/bash', 04:13:47 INFO - 'SHLVL': '1', 04:13:47 INFO - 'TERM': 'linux', 04:13:47 INFO - 'TMOUT': '86400', 04:13:47 INFO - 'USER': 'cltbld', 04:13:47 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', 04:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:47 INFO - '_': '/tools/buildbot/bin/python'} 04:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13: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 04:13:47 INFO - Cleaning up... 04:13:47 INFO - Return code: 0 04:13:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7f387a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b41240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd00b0>, '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 0x1bd0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', '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 04:13: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 04:13: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 04:13:47 INFO - Using env: {'DISPLAY': ':0', 04:13:47 INFO - 'HOME': '/home/cltbld', 04:13:47 INFO - 'LANG': 'en_US.UTF-8', 04:13:47 INFO - 'LANGUAGE': 'en_US:en', 04:13:47 INFO - 'LOGNAME': 'cltbld', 04:13:47 INFO - 'MAIL': '/var/mail/cltbld', 04:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:47 INFO - 'MOZ_NO_REMOTE': '1', 04:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:47 INFO - 'NO_EM_RESTART': '1', 04:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:47 INFO - 'PWD': '/builds/slave/test', 04:13:47 INFO - 'SHELL': '/bin/bash', 04:13:47 INFO - 'SHLVL': '1', 04:13:47 INFO - 'TERM': 'linux', 04:13:47 INFO - 'TMOUT': '86400', 04:13:47 INFO - 'USER': 'cltbld', 04:13:47 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', 04:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:47 INFO - '_': '/tools/buildbot/bin/python'} 04:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:48 INFO - Downloading/unpacking psutil>=0.7.1 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:48 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 04:13:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:13:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:49 INFO - Installing collected packages: psutil 04:13:49 INFO - Running setup.py install for psutil 04:13:49 INFO - building 'psutil._psutil_linux' extension 04:13: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 04:13:50 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 04:13:50 INFO - building 'psutil._psutil_posix' extension 04:13:50 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 04:13:50 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 04:13:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:50 INFO - Successfully installed psutil 04:13:50 INFO - Cleaning up... 04:13:50 INFO - Return code: 0 04:13:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:50 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 0x7f387a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b41240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd00b0>, '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 0x1bd0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', '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 04:13:50 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 04:13:50 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 04:13:50 INFO - Using env: {'DISPLAY': ':0', 04:13:50 INFO - 'HOME': '/home/cltbld', 04:13:50 INFO - 'LANG': 'en_US.UTF-8', 04:13:50 INFO - 'LANGUAGE': 'en_US:en', 04:13:50 INFO - 'LOGNAME': 'cltbld', 04:13:50 INFO - 'MAIL': '/var/mail/cltbld', 04:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:50 INFO - 'MOZ_NO_REMOTE': '1', 04:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:50 INFO - 'NO_EM_RESTART': '1', 04:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:50 INFO - 'PWD': '/builds/slave/test', 04:13:50 INFO - 'SHELL': '/bin/bash', 04:13:50 INFO - 'SHLVL': '1', 04:13:50 INFO - 'TERM': 'linux', 04:13:50 INFO - 'TMOUT': '86400', 04:13:50 INFO - 'USER': 'cltbld', 04:13:50 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', 04:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:50 INFO - '_': '/tools/buildbot/bin/python'} 04:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:13:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:13:52 INFO - Installing collected packages: mozsystemmonitor 04:13:52 INFO - Running setup.py install for mozsystemmonitor 04:13:52 INFO - Successfully installed mozsystemmonitor 04:13:52 INFO - Cleaning up... 04:13:52 INFO - Return code: 0 04:13:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 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 0x7f387a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b41240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd00b0>, '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 0x1bd0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', '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 04:13:52 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 04:13:52 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 04:13:52 INFO - Using env: {'DISPLAY': ':0', 04:13:52 INFO - 'HOME': '/home/cltbld', 04:13:52 INFO - 'LANG': 'en_US.UTF-8', 04:13:52 INFO - 'LANGUAGE': 'en_US:en', 04:13:52 INFO - 'LOGNAME': 'cltbld', 04:13:52 INFO - 'MAIL': '/var/mail/cltbld', 04:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:52 INFO - 'MOZ_NO_REMOTE': '1', 04:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:52 INFO - 'NO_EM_RESTART': '1', 04:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:52 INFO - 'PWD': '/builds/slave/test', 04:13:52 INFO - 'SHELL': '/bin/bash', 04:13:52 INFO - 'SHLVL': '1', 04:13:52 INFO - 'TERM': 'linux', 04:13:52 INFO - 'TMOUT': '86400', 04:13:52 INFO - 'USER': 'cltbld', 04:13:52 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', 04:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:52 INFO - '_': '/tools/buildbot/bin/python'} 04:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:54 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:55 INFO - Downloading docopt-0.6.1.tar.gz 04:13:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:55 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:55 INFO - Running setup.py install for blobuploader 04:13:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:55 INFO - Running setup.py install for requests 04:13:55 INFO - Running setup.py install for docopt 04:13:55 INFO - Successfully installed blobuploader requests docopt 04:13:55 INFO - Cleaning up... 04:13:55 INFO - Return code: 0 04:13:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7f387a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b41240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd00b0>, '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 0x1bd0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', '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 04:13: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 04:13: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 04:13:55 INFO - Using env: {'DISPLAY': ':0', 04:13:55 INFO - 'HOME': '/home/cltbld', 04:13:55 INFO - 'LANG': 'en_US.UTF-8', 04:13:55 INFO - 'LANGUAGE': 'en_US:en', 04:13:55 INFO - 'LOGNAME': 'cltbld', 04:13:55 INFO - 'MAIL': '/var/mail/cltbld', 04:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:55 INFO - 'MOZ_NO_REMOTE': '1', 04:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:55 INFO - 'NO_EM_RESTART': '1', 04:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:55 INFO - 'PWD': '/builds/slave/test', 04:13:55 INFO - 'SHELL': '/bin/bash', 04:13:55 INFO - 'SHLVL': '1', 04:13:55 INFO - 'TERM': 'linux', 04:13:55 INFO - 'TMOUT': '86400', 04:13:55 INFO - 'USER': 'cltbld', 04:13:55 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', 04:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:55 INFO - '_': '/tools/buildbot/bin/python'} 04:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:55 INFO - Running setup.py (path:/tmp/pip-B3Hxg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:55 INFO - Running setup.py (path:/tmp/pip-VebRbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:56 INFO - Running setup.py (path:/tmp/pip-vgmMUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:56 INFO - Running setup.py (path:/tmp/pip-gFZjSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:56 INFO - Running setup.py (path:/tmp/pip-h39fO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:56 INFO - Running setup.py (path:/tmp/pip-u1AXnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:56 INFO - Running setup.py (path:/tmp/pip-auZAFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:56 INFO - Running setup.py (path:/tmp/pip-VQmX8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:56 INFO - Running setup.py (path:/tmp/pip-Jzp3hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:56 INFO - Running setup.py (path:/tmp/pip-XDziau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:56 INFO - Running setup.py (path:/tmp/pip-P3ROT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:56 INFO - Running setup.py (path:/tmp/pip-keMMnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:56 INFO - Running setup.py (path:/tmp/pip-Q1Md1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:56 INFO - Running setup.py (path:/tmp/pip-KpOvFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:56 INFO - Running setup.py (path:/tmp/pip-sSTz3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:56 INFO - Running setup.py (path:/tmp/pip-sZpMnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:57 INFO - Running setup.py (path:/tmp/pip-rg5oIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:57 INFO - Running setup.py install for manifestparser 04:13:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:57 INFO - Running setup.py install for mozcrash 04:13:57 INFO - Running setup.py install for mozdebug 04:13:57 INFO - Running setup.py install for mozdevice 04:13:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:57 INFO - Running setup.py install for mozfile 04:13:57 INFO - Running setup.py install for mozhttpd 04:13:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:57 INFO - Running setup.py install for mozinfo 04:13:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:57 INFO - Running setup.py install for mozInstall 04:13:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:57 INFO - Running setup.py install for mozleak 04:13:58 INFO - Running setup.py install for mozlog 04:13:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:58 INFO - Running setup.py install for moznetwork 04:13:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:58 INFO - Running setup.py install for mozprocess 04:13:58 INFO - Running setup.py install for mozprofile 04:13:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:58 INFO - Running setup.py install for mozrunner 04:13:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:58 INFO - Running setup.py install for mozscreenshot 04:13:58 INFO - Running setup.py install for moztest 04:13:58 INFO - Running setup.py install for mozversion 04:13:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:58 INFO - Cleaning up... 04:13:58 INFO - Return code: 0 04:13:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7f387a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b41240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd00b0>, '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 0x1bd0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', '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 04:13: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 04:13: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 04:13:58 INFO - Using env: {'DISPLAY': ':0', 04:13:58 INFO - 'HOME': '/home/cltbld', 04:13:58 INFO - 'LANG': 'en_US.UTF-8', 04:13:58 INFO - 'LANGUAGE': 'en_US:en', 04:13:58 INFO - 'LOGNAME': 'cltbld', 04:13:58 INFO - 'MAIL': '/var/mail/cltbld', 04:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:58 INFO - 'MOZ_NO_REMOTE': '1', 04:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:58 INFO - 'NO_EM_RESTART': '1', 04:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:58 INFO - 'PWD': '/builds/slave/test', 04:13:58 INFO - 'SHELL': '/bin/bash', 04:13:58 INFO - 'SHLVL': '1', 04:13:58 INFO - 'TERM': 'linux', 04:13:58 INFO - 'TMOUT': '86400', 04:13:58 INFO - 'USER': 'cltbld', 04:13:58 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', 04:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:58 INFO - '_': '/tools/buildbot/bin/python'} 04:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:59 INFO - Running setup.py (path:/tmp/pip-dMEaDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:59 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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:59 INFO - Running setup.py (path:/tmp/pip-HEAaDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:59 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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:59 INFO - Running setup.py (path:/tmp/pip-K7ns2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:59 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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:59 INFO - Running setup.py (path:/tmp/pip-mzidwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13: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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:59 INFO - Running setup.py (path:/tmp/pip-iVf5Nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13: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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:59 INFO - Running setup.py (path:/tmp/pip-7UykGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13: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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:59 INFO - Running setup.py (path:/tmp/pip-0ZAwK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13: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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:59 INFO - Running setup.py (path:/tmp/pip-xsegkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13: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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:59 INFO - Running setup.py (path:/tmp/pip-bQoOm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13: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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:59 INFO - Running setup.py (path:/tmp/pip-MlNPDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13: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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:59 INFO - Running setup.py (path:/tmp/pip-IcZAZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13: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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:59 INFO - Running setup.py (path:/tmp/pip-3Wy2NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13: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)) 04:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:59 INFO - Running setup.py (path:/tmp/pip-v0xB0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:00 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)) 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:00 INFO - Running setup.py (path:/tmp/pip-zW1myr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:00 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)) 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:00 INFO - Running setup.py (path:/tmp/pip-dCp0HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:00 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)) 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:00 INFO - Running setup.py (path:/tmp/pip-tX7kMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:00 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)) 04:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:00 INFO - Running setup.py (path:/tmp/pip-BEh6dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:00 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)) 04:14:00 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)) 04:14:00 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)) 04:14:00 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)) 04:14:00 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)) 04:14:00 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)) 04:14:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:01 INFO - Downloading blessings-1.5.1.tar.gz 04:14:02 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 04:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:02 INFO - Installing collected packages: blessings 04:14:02 INFO - Running setup.py install for blessings 04:14:02 INFO - Successfully installed blessings 04:14:02 INFO - Cleaning up... 04:14:02 INFO - Return code: 0 04:14:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:02 INFO - Reading from file tmpfile_stdout 04:14:02 INFO - Current package versions: 04:14:02 INFO - argparse == 1.2.1 04:14:02 INFO - blessings == 1.5.1 04:14:02 INFO - blobuploader == 1.2.4 04:14:02 INFO - docopt == 0.6.1 04:14:02 INFO - manifestparser == 1.1 04:14:02 INFO - mozInstall == 1.12 04:14:02 INFO - mozcrash == 0.16 04:14:02 INFO - mozdebug == 0.1 04:14:02 INFO - mozdevice == 0.47 04:14:02 INFO - mozfile == 1.2 04:14:02 INFO - mozhttpd == 0.7 04:14:02 INFO - mozinfo == 0.9 04:14:02 INFO - mozleak == 0.1 04:14:02 INFO - mozlog == 3.1 04:14:02 INFO - moznetwork == 0.27 04:14:02 INFO - mozprocess == 0.22 04:14:02 INFO - mozprofile == 0.27 04:14:02 INFO - mozrunner == 6.11 04:14:02 INFO - mozscreenshot == 0.1 04:14:02 INFO - mozsystemmonitor == 0.0 04:14:02 INFO - moztest == 0.7 04:14:02 INFO - mozversion == 1.4 04:14:02 INFO - psutil == 3.1.1 04:14:02 INFO - requests == 1.2.3 04:14:02 INFO - wsgiref == 0.1.2 04:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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 0x7f387a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b41240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd00b0>, '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 0x1bd0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', '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 04:14: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 04:14: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 04:14:02 INFO - Using env: {'DISPLAY': ':0', 04:14:02 INFO - 'HOME': '/home/cltbld', 04:14:02 INFO - 'LANG': 'en_US.UTF-8', 04:14:02 INFO - 'LANGUAGE': 'en_US:en', 04:14:02 INFO - 'LOGNAME': 'cltbld', 04:14:02 INFO - 'MAIL': '/var/mail/cltbld', 04:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:02 INFO - 'MOZ_NO_REMOTE': '1', 04:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:02 INFO - 'NO_EM_RESTART': '1', 04:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:02 INFO - 'PWD': '/builds/slave/test', 04:14:02 INFO - 'SHELL': '/bin/bash', 04:14:02 INFO - 'SHLVL': '1', 04:14:02 INFO - 'TERM': 'linux', 04:14:02 INFO - 'TMOUT': '86400', 04:14:02 INFO - 'USER': 'cltbld', 04:14:02 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', 04:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:02 INFO - '_': '/tools/buildbot/bin/python'} 04:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14: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)) 04:14:02 INFO - Cleaning up... 04:14:02 INFO - Return code: 0 04:14:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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 0x7f387a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b41240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd00b0>, '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 0x1bd0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', '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 04:14: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 04:14: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 04:14:02 INFO - Using env: {'DISPLAY': ':0', 04:14:02 INFO - 'HOME': '/home/cltbld', 04:14:02 INFO - 'LANG': 'en_US.UTF-8', 04:14:02 INFO - 'LANGUAGE': 'en_US:en', 04:14:02 INFO - 'LOGNAME': 'cltbld', 04:14:02 INFO - 'MAIL': '/var/mail/cltbld', 04:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:02 INFO - 'MOZ_NO_REMOTE': '1', 04:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:02 INFO - 'NO_EM_RESTART': '1', 04:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:02 INFO - 'PWD': '/builds/slave/test', 04:14:02 INFO - 'SHELL': '/bin/bash', 04:14:02 INFO - 'SHLVL': '1', 04:14:02 INFO - 'TERM': 'linux', 04:14:02 INFO - 'TMOUT': '86400', 04:14:02 INFO - 'USER': 'cltbld', 04:14:02 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', 04:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:02 INFO - '_': '/tools/buildbot/bin/python'} 04:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:02 INFO - Downloading/unpacking jsonschema 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14: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 04:14:04 INFO - Downloading/unpacking functools32 (from jsonschema) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14: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 04:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:04 INFO - warning: no files found matching '*.txt' 04:14:04 INFO - no previously-included directories found matching 'build' 04:14:04 INFO - no previously-included directories found matching 'dist' 04:14:04 INFO - no previously-included directories found matching '.git*' 04:14:04 INFO - Installing collected packages: jsonschema, functools32 04:14:04 INFO - Running setup.py install for functools32 04:14:04 INFO - warning: no files found matching '*.txt' 04:14:04 INFO - no previously-included directories found matching 'build' 04:14:04 INFO - no previously-included directories found matching 'dist' 04:14:04 INFO - no previously-included directories found matching '.git*' 04:14:04 INFO - Successfully installed jsonschema functools32 04:14:04 INFO - Cleaning up... 04:14:05 INFO - Return code: 0 04:14:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:05 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 0x7f387a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b41240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd00b0>, '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 0x1bd0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1440>, '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': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', '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 04:14:05 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 04:14:05 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 04:14:05 INFO - Using env: {'DISPLAY': ':0', 04:14:05 INFO - 'HOME': '/home/cltbld', 04:14:05 INFO - 'LANG': 'en_US.UTF-8', 04:14:05 INFO - 'LANGUAGE': 'en_US:en', 04:14:05 INFO - 'LOGNAME': 'cltbld', 04:14:05 INFO - 'MAIL': '/var/mail/cltbld', 04:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:05 INFO - 'MOZ_NO_REMOTE': '1', 04:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:05 INFO - 'NO_EM_RESTART': '1', 04:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:05 INFO - 'PWD': '/builds/slave/test', 04:14:05 INFO - 'SHELL': '/bin/bash', 04:14:05 INFO - 'SHLVL': '1', 04:14:05 INFO - 'TERM': 'linux', 04:14:05 INFO - 'TMOUT': '86400', 04:14:05 INFO - 'USER': 'cltbld', 04:14:05 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', 04:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:05 INFO - '_': '/tools/buildbot/bin/python'} 04:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:05 INFO - Downloading/unpacking flake8 04:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:14: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 04:14:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:14:07 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 04:14:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:07 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 04:14:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:07 INFO - no previously-included directories found matching 'docs/_build' 04:14:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:14:07 INFO - Running setup.py install for pep8 04:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:07 INFO - no previously-included directories found matching 'docs/_build' 04:14:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:14:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:14:07 INFO - Cleaning up... 04:14:07 INFO - Return code: 0 04:14:07 INFO - Running post-action listener: _resource_record_post_action 04:14:07 INFO - Running post-action listener: _start_resource_monitoring 04:14:07 INFO - Starting resource monitoring. 04:14:07 INFO - ##### 04:14:07 INFO - ##### Running install step. 04:14:07 INFO - ##### 04:14:07 INFO - Running pre-action listener: _resource_record_pre_action 04:14:07 INFO - Running main action method: install 04:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:08 INFO - Reading from file tmpfile_stdout 04:14:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:08 INFO - Reading from file tmpfile_stdout 04:14:08 INFO - Output received: 04:14:08 INFO - Usage: mozinstall [options] installer 04:14:08 INFO - Options: 04:14:08 INFO - -h, --help show this help message and exit 04:14:08 INFO - -d DEST, --destination=DEST 04:14:08 INFO - Directory to install application into. [default: 04:14:08 INFO - "/builds/slave/test"] 04:14:08 INFO - --app=APP Application being installed. [default: firefox] 04:14:08 INFO - mkdir: /builds/slave/test/build/application 04:14:08 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'] 04:14:08 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 04:14:23 INFO - Reading from file tmpfile_stdout 04:14:23 INFO - Output received: 04:14:23 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:23 INFO - Running post-action listener: _resource_record_post_action 04:14:23 INFO - ##### 04:14:23 INFO - ##### Running run-tests step. 04:14:23 INFO - ##### 04:14:23 INFO - Running pre-action listener: _resource_record_pre_action 04:14:23 INFO - Running main action method: run_tests 04:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:23 INFO - Python 2.7.3 04:14:23 INFO - Return code: 0 04:14:23 INFO - grabbing minidump binary from tooltool 04:14: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')]} 04:14: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 0x1bd00b0>, '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 0x1bd0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bd1440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14: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 04:14: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 04:14:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:23 INFO - Return code: 0 04:14:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:24 INFO - Return code: 0 04:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost'] in /builds/slave/test/build 04:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost 04:14:24 INFO - Using env: {'DISPLAY': ':0', 04:14:24 INFO - 'HOME': '/home/cltbld', 04:14:24 INFO - 'LANG': 'en_US.UTF-8', 04:14:24 INFO - 'LANGUAGE': 'en_US:en', 04:14:24 INFO - 'LOGNAME': 'cltbld', 04:14:24 INFO - 'MAIL': '/var/mail/cltbld', 04:14:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:24 INFO - 'MOZ_NO_REMOTE': '1', 04:14:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:24 INFO - 'NO_EM_RESTART': '1', 04:14:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:24 INFO - 'PWD': '/builds/slave/test', 04:14:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:24 INFO - 'SHELL': '/bin/bash', 04:14:24 INFO - 'SHLVL': '1', 04:14:24 INFO - 'TERM': 'linux', 04:14:24 INFO - 'TMOUT': '86400', 04:14:24 INFO - 'USER': 'cltbld', 04:14:24 INFO - 'XDG_SESSION_COOKIE': '6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130', 04:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:24 INFO - '_': '/tools/buildbot/bin/python'} 04:14:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost'] with output_timeout 3600 04:14:24 INFO - mozversion INFO | application_buildid: 20151221025128 04:14:24 INFO - mozversion INFO | application_changeset: 091d6785608297bab2cf36b1b6a2d9a388b82a01 04:14:24 INFO - mozversion INFO | application_display_name: Nightly 04:14:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:24 INFO - mozversion INFO | application_name: Firefox 04:14:24 INFO - mozversion INFO | application_remotingname: firefox 04:14:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:14:24 INFO - mozversion INFO | application_vendor: Mozilla 04:14:24 INFO - mozversion INFO | application_version: 46.0a1 04:14:24 INFO - mozversion INFO | platform_buildid: 20151221025128 04:14:24 INFO - mozversion INFO | platform_changeset: 091d6785608297bab2cf36b1b6a2d9a388b82a01 04:14:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:14:24 INFO - mozversion INFO | platform_version: 46.0a1 04:14:24 INFO - 2015-12-21 04:14:24,728 DEBUG : using testdate: 1450700064 04:14:24 INFO - 2015-12-21 04:14:24,728 DEBUG : actual date: 1450700064 04:14:24 INFO - 2015-12-21 04:14:24,737 INFO : starting webserver on 'localhost:46319' 04:14:24 INFO - 2015-12-21 04:14:24,738 INFO : Starting test suite talos-linux64-ix-064.e 04:14:24 INFO - 2015-12-21 04:14:24,738 INFO : Starting test dromaeo_css 04:14:24 INFO - 2015-12-21 04:14:24,738 DEBUG : operating with platform_type : linux_ 04:14:24 INFO - 2015-12-21 04:14:24,739 INFO : Initialising browser for dromaeo_css test... 04:14:24 INFO - 2015-12-21 04:14:24,753 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr3RsGv/profile http://localhost:46319/getInfo.html 04:14:28 INFO - 2015-12-21 04:14:28,475 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:14:29 INFO - 2015-12-21 04:14:29,209 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:14:29 INFO - 2015-12-21 04:14:29,209 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:14:29 INFO - 2015-12-21 04:14:29,209 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:14:29 INFO - 2015-12-21 04:14:29,209 DEBUG : BROWSER_OUTPUT: __metrics 04:14:29 INFO - 2015-12-21 04:14:29,326 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] 04:14:30 INFO - 2015-12-21 04:14:30,211 INFO : Browser initialized. 04:14:30 INFO - 2015-12-21 04:14:30,212 INFO : Running cycle 1/1 for dromaeo_css test... 04:14:30 INFO - 2015-12-21 04:14:30,212 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr3RsGv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:14:42 INFO - 2015-12-21 04:14:42,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 150642688 04:14:42 INFO - 2015-12-21 04:14:42,232 DEBUG : BROWSER_OUTPUT: 04:15:31 INFO - 2015-12-21 04:15:31,863 DEBUG : BROWSER_OUTPUT: 1450700131857 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] 04:17:42 INFO - 2015-12-21 04:17:42,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46319/tests/dromaeo/cssquery-ext.html) 04:17:43 INFO - 2015-12-21 04:17:43,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 155648000 04:17:43 INFO - 2015-12-21 04:17:43,425 DEBUG : BROWSER_OUTPUT: 04:20:45 INFO - 2015-12-21 04:20:45,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/dromaeo/cssquery-ext.html (next: http://localhost:46319/tests/dromaeo/cssquery-jquery.html) 04:20:46 INFO - 2015-12-21 04:20:46,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 152829952 04:20:46 INFO - 2015-12-21 04:20:46,073 DEBUG : BROWSER_OUTPUT: 04:23:47 INFO - 2015-12-21 04:23:47,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46319/tests/dromaeo/cssquery-mootools.html) 04:23:48 INFO - 2015-12-21 04:23:48,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 154382336 04:23:48 INFO - 2015-12-21 04:23:48,455 DEBUG : BROWSER_OUTPUT: 04:26:50 INFO - 2015-12-21 04:26:50,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46319/tests/dromaeo/cssquery-prototype.html) 04:26:50 INFO - 2015-12-21 04:26:50,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 152367104 04:26:50 INFO - 2015-12-21 04:26:50,812 DEBUG : BROWSER_OUTPUT: 04:29:53 INFO - 2015-12-21 04:29:53,407 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46319/tests/dromaeo/cssquery-yui.html) 04:29:54 INFO - 2015-12-21 04:29:54,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 152547328 04:29:54 INFO - 2015-12-21 04:29:54,037 DEBUG : BROWSER_OUTPUT: 04:32:56 INFO - 2015-12-21 04:32:56,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/dromaeo/cssquery-yui.html (next: http://localhost:46319/tests/dromaeo/cssquery-dojo.html) 04:32:56 INFO - 2015-12-21 04:32:56,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 154251264 04:32:56 INFO - 2015-12-21 04:32:56,516 DEBUG : BROWSER_OUTPUT: 04:32:56 INFO - 2015-12-21 04:32:56,516 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:32:56 INFO - 2015-12-21 04:32:56,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:32:56 INFO - 2015-12-21 04:32:56,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:32:56 INFO - 2015-12-21 04:32:56,516 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:32:56 INFO - 2015-12-21 04:32:56,517 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2549.5538280800856;2582.9483410331795;2593.4164812917084;2596.8182227244088;2606.934826629334;4387.648988080954;4509.391232183651;4539.636829053676;4547.272436410175;4560.361549383085;4417.73493590384;4441.089576636789;4516.14193303273;4520.615747661444;4549.1584056949405;46.73600905639997;4198.5591512891015;4237.110206856564;4242.109157077018;4286.314189729644;3972.7616343019513;4034.979825100885;4130.772807495587;4152.397902304164;4159.604837540429;4212.873613791591;4221.936670949938;4230.598093181143;4264.637505812009;4273.252180868336;4202.6847986400835;4215.199112168678;4247.341662042389;4252.447181866338;4288.742675439484;4034.9394759078637;4122.299209134454;4125.958740412618;4212.073343864345;4216.219999300109;4423.7788110594665;4437.889052773674;4460.149038149164;4483.708558943658;4484.7084939479155;4623.32961720552;4861.270809378586;4884.072026315024;4885.413750349945;4895.804167833282;4799.568038876518;4802.135615589193;4805.687630304054;4893.828715994959;4922.212446008657;4596.931046034312;4607.654425918069;4619.745913974763;4622.168009758276;4660.207764679979;4786.425628924551;5042.647014708935;5050.9494905051215;5060.949390506122;5126.564242039469;4735.810567577328;4767.547083027107;4818.903621927542;4852.95147048525;4898.485659005824;4939.209726443752;4949.084419382426;4960.305557221992;4962.702237865739;4994.40067191932;4615.9076818463445;4718.150732868116;4861.270809378621;4883.106060230212;4926.531979461945;4728.905421891612;4779.163646361872;4785.234362501983;4806.110869489155;4845.491223421561;4054.8175332110127;4057.391391291271;4066.4916885389325;4085.816138273785;4110.34234522475;3474.7915125092577;3553.502509648651;3574.088607405095;3586.8923932282073;3660.304542137039;4138.503379594468;4185.602367775056;4258.872233832928;4266.658667306608;4301.118270754488;4915.754212289371;4921.261810728348;4930.137225985438;4942.9258561121615;4955.900881982412;4035.878923632296;4119.588041195856;4274.230638485041;4292.484901811803;4327.37253098299;4185.183889141649;4268.551802060801;4270.658347332206;4287.678424118204;4301.397804307399;4609.562091601292;4628.560286772751;4638.907221855544;4644.349791029191;4678.976605116953;4643.791029403617;4810.158222311012;4831.202851529599;4908.950910490849;4913.263010548446;4580.106879158532;4624.722516649012;4632.8146874126005;4633.953660463352;4676.55572720591;4844.0554091951735;4867.63492738039;4874.463808980939;4888.144574699484;4919;4662.440507139029;4779.832705855279;4780.521947805191;4872.780724867319;4931.186354251508;4752.667313288037;4756.8097276108565;4779.139754844162;4796.856094317176;4808.182608956556;4746.691465054761;4760.452547957029;4762.976185119052;4766.737829419277;4805.9038819224115;4466;4535.750533720677;4558.680892337505;4569;4652;4781.282807578891;4784.162771515041;4792.904141917073;4804.039192161512;4847.733374664427;4453.1316393303;4678.228092364858;4703.905921881475;4711.929321060118;4742.644301677319 04:32:56 INFO - 2015-12-21 04:32:56,517 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.7289301135452;565.5249590344113;576.5992635118592;578.0144853025591;583.6993948116719;35030.824845875766;35982.99999999997;36011.81994090029;36114.8194259029;36152.45771313426;39290.80354598223;39558.802205989;39688.80155599225;39740.205195896066;39917;7870.881936770953;8023.759287221393;8026.197380261956;8034.035915690096;8066.314363279128;7879.921200787976;7955.085165206017;7966.203379662016;7975.322097621709;7977.880331795028;7597.544147351176;7612.657430415645;7637.427192960522;7650.464467487278;7694;7923.722669706562;7994.280514753671;8005.599720013976;8022.919770802305;8027.518348899085;7885.290323870821;7956.363490920712;7990.640421181002;7997.840043199161;7999.840003199904;36434.45348319777;36740.71407500751;36809.81595092034;36856.81571592125;36959.815200924095;2348.7533808949984;2813.732695393934;2880.5247134223036;2927.970720292791;3594.6944509716704;26103.869480652476;26250.868745656342;26275.343116422053;26415;27155.45689086207;3403.2002479417315;3434.175797808533;3446.8104254266004;3511.841967111486;3566.982165089184;178685;178730.8507659692;178866;179611;181166;51186;51697.48302517002;54300.28498575056;55293.723531382086;55294.17058744122;48433.5156648436;48580.271295930586;48674;48692.51307486951;48763.75618121958;13094.541691040768;13201.141925774795;13274.336283185801;13288.667783305495;13300.135491193041;9707.6116955321;9886.950565247127;9933.25500587459;9982.450965196984;9984;19026.809731902504;19233.230670773293;19251.711224331648;19301.710474342897;19318;7455.403567714569;7622.5426474411715;7626.69493220276;7636.389088872988;7708.614569271514;804.5052292839978;850.7447765670274;872.6814712629845;884.7964968057382;916.3493919317226;25134.622980655306;25196;25493;25665.48669026609;25672.48655026889;915.1031988651026;953.0802775321848;961.9803008810683;971.7133445633555;1008.5209525475487;13820.585382438543;13913.30433478322;13986.370613322222;14294.642633934234;14382.640433989025;263585;267478;268042;268197;269254;45033;45192.09615807665;45263.77368113138;45338.773306133255;45369.77315113403;1174.3383112895328;1216.416120262279;1216.7809794236946;1216.7870622641003;1217.6773155113901;25770.613440798777;25935.870320648275;26062.478750425264;26261.474770504865;26307.60538591961;39477;39477.2104557913;39820.40269396019;39869.800650996556;39885.60400385973;253543;253758;254308;255628;256101;26754.21655722952;27473.17580472589;27678.861605691844;27774.44451111007;27781.16656500308;37949.430758539194;38139.23721525499;38425.23149536938;38755.6124438752;39519.80240098781;32249.51625725663;32849;32939.8353008243;33242;33354.4996825043;29318.560221596268;29361.85319073391;29388.7061129386;29425;29618.703812961594;32566.674333257313;34737.65262347445;34866.65133348634;34938.65061349354;35611.46582801312;33157.66842331546;34549.65450345464;35424.46863297001;35711.64288357083;36038.4594231092;27882.860585697752;28027.57958630663;28302.85848570744;28558.286042849097;28995 04:32:56 INFO - 2015-12-21 04:32:56,517 DEBUG : BROWSER_OUTPUT: |2;jquery.html;317.7886705340948;318.5333486442362;323.6860245561804;325.333067212215;330.2289154823487;14599.270036498172;15090.320935557898;15569.688606227883;16049.35802567896;16764.83235167648;15079.265884423266;15210.467633632825;15829.366825327003;16041.759373609406;16049.518514444557;4345.891352716184;4561.771911404433;4607.10161518504;4618.745968971705;4620.006698559809;4557.567031132037;4590.42619672541;4597.678162528624;4598.97700511497;4613.331066995283;4489.1021795641;4546.636269098481;4555.316702494636;4555.612772914306;4593.150267200579;4562.292844609091;4579.4046773919345;4590.655700822452;4595.919958809677;4596.632269418438;4324.783760811947;4399.670024748157;4416.072624748806;4431.313146462271;4447.110577884404;11916.225445346025;12033.819492707617;12069.336186509738;12102.576409825702;14731.779023314659;1809.1858663601301;1837.7335286383534;1844.5296449405316;1870.036930980546;1893.091316168233;8701.129887011248;8876.467411955304;9083.545822708904;9395.436273823525;11861.703457413547;1784.866609702848;1790.8030116687155;1794.1388133695768;1801.6937120689383;1868.3460788723974;55755.72122139404;57710;58378;58443.415565844225;59256.407435925954;9388.108129727801;9527.237820974444;9572.952135239279;9778.511074446249;9785.26610504215;11413.372264525366;11425.942870285762;11639.709007274885;12047.156699030984;12053.156279060557;6532.118164047888;6595.1096601958125;6681.298463661343;6683.832904177337;6696.933030669728;6071.392860713893;6349.682515874188;6354.555181137369;6474.611523308522;6497;4154.854580089683;4213.641840443596;4241.618254357123;4250.277452833026;4263.445752052214;1790.9820901791077;1813.6644720726708;1815.364622382182;1841.484384372351;1845.280340667141;375.1746158451418;377.92103544380944;849.8045449546639;875.382855087162;980.2892902645667;9857.605695772088;9955.352902061342;10105;10154.187664986783;10334.793304133875;393.95272567291534;399.9780012099304;409.3225711447559;415.33961002006953;426.6458839163487;5402.594805389612;5495.862603434866;5514.338279406416;9126.49804260772;9352.859707104399;515015;517668;523937;530745;530784;72407.63796180986;72564;72809.2719072813;74347;76080.61959690166;1047.7904419116055;1058.1270451877233;1058.576569372242;1066.914646828252;1078.379931539368;14512.274386280855;14680;14808.111513309235;14845.40618375253;14873.18197499148;25484.362890927874;28686.56970145408;29982.850085750306;33155.50266745953;34258;35167.29665406626;39386.606133939444;40300.59699403086;40834.91650834893;40970.1805963885;8535.3598480113;8897.332700047651;8932.955335223282;9010.14403631654;9050.140236677506;10209.54057067419;10998.505067272152;15685.215739212765;15880.126593037494;16026.198690065217;13190.868091318964;13401.597952061455;13597.52408665692;13728.65678358049;13753;12885.549005784753;13180.340982950622;13523.256220907944;13556.59330220095;13988.720225595634;14240.857591423954;14281.214533200773;14304.427822886968;14680.926595366955;14686.82505399544;8487.193716596914;8698.782530436789;8860.601272942604;8911.108889111038;9391.436513809193;9217.861732074158;9334.533273336441;11668.416579170838;13197.934010329887;13690.589282321545 04:32:56 INFO - 2015-12-21 04:32:56,518 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1478.120518291616;1636.9099699516526;1673.5816045988504;1688.932442702292;1706.4027590343378;5744.626599271044;5987.221661184051;7014.684339204735;7148.74979375722;7159.964200178998;7021.473389495783;7033.929660703391;7054.50618456707;7067.929320706791;7079.292070792918;2054.4555692741437;2104.0216299420767;2106.157536985203;2106.7893210678963;2109.177420805887;2040.1737296394983;2099.1870893003374;2109.04038662409;2112.7464704235435;2114.9048292826783;2085.1555120176354;2089.2269860151764;2097.0572589105054;2110.757262914769;2112.070688896888;1996.8302694271003;1998.7701414337319;2012.22529326209;2012.22529326209;2013.6375452418558;2068.048697599106;2072.4818795301176;2111.0289266937075;2114.9365519034454;2122.310249169026;6998.615076170809;7096.964515177391;7098.9290107099305;7103.147622285359;7109.8933515997305;4134.710570260083;4213.30480470722;4217.304144816102;4220.704550681454;4224.45082139323;2739.260399692072;2744.656917885264;2770.7506324430697;2795.7204279572084;2809.634747482814;926.7080869526078;1755.2189275772287;1774.8491378232866;1776.4581802550217;1786.8391844733906;9477.47873866937;9480.573374198178;9637.90362096377;9662.613495460173;9673.37123086997;3784;3816.866409675648;3880.670143037817;3881.1267464820753;3893.201893611803;8334.249917507454;8346.791330216793;8348.624311905858;8407.411481196257;8411;4272.4445822042935;4282.678799090081;4292.785360731951;4307.827686892552;4312.633426158749;3172.6034245719284;3243.870245190213;3476.461148521983;3834.1373191031794;3907.5701672815967;3467.9479807802904;3536.91157721059;3551.485034669958;3554.87557935471;3577.964220357815;1125.9605913792977;1153.2388623508612;1157.8842115788354;1163.959261425846;1165.1086918507349;968.8740463739668;987.1806400687412;991.2763682511662;1031.9484025798831;1138.9430528473542;6598.175228096488;6599.109120268702;6607.4053335199105;6620.337966203341;6643.800685979331;443.3615593545284;450.9797059132347;464.3267262469433;467.05887636412655;468.82419092840183;5359.196120581866;5382.811601594004;5389.541888939406;5413.810516631977;5417.512423881791;8056.5971701415865;8204.794880128045;8216.34269258458;8255.42212045151;8268.669253229804;8111.675532978733;8112.918870811216;8141.755747327589;8167.183281671785;8195.098539160688;6574.309697481791;6583.63789991555;6681.532292739462;6697.497687673346;6709.865802683919;6623.635700036544;6658.500612453989;6669.933300666931;6700.396964273239;6721.395074443128;7481.289277518845;7629.3133617974645;7639.618019099134;7673.155952845071;7738.806529836799;7556.65995030236;7870.09493908185;7877.842443151219;7979.321757650665;7982.361411087215;5286.20706893969;5433.728313584226;5928.0218763905195;6372.776952806629;6473.741050357933;6726.865462690621;6729.461643068641;6780.830479238059;6784.050232967487;6840.521163518506;6253.937460625518;6350.047492876106;6404.519661025535;6406.647634380154;6438.3883531064475;6257.155284036597;6327;6341.778037768656;6350.872982540231;6399.680015999088;6284.622922624657;6311.779087731908;6322.747090116344;6330.082138090043;6330.8100756977365;5816.621919575214;5831;5857.121431785266;5867.530597552271;5873.559483038704;6015.248093988252;6021.729022193924;6041.697915104315;6061.939380606137;6068.271807383142 04:32:56 INFO - 2015-12-21 04:32:56,521 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.16629188833434;299.65539629426155;303.49468135554287;306.47133694377203;306.77605348095904;5463.125899856024;5506.559475241981;5535.25274087998;5584.21820945068;5621.072523033695;5396.298481197448;5561.221428999943;5562.3047119110115;5565.833025009256;5572.86067848304;4306.246406878784;4320.481542214923;4323.3947247385395;4336.761478118694;4341.196878577473;4326.242907491192;4329.090890912912;4336.284513055342;4336.783160841961;4345.69580129391;4099.934017155546;4263.616274535291;4296.957030429687;4297.054647977456;4309.913801723964;4228.1966426379195;4231.1537692461325;4252.9149417011795;4254.638355739766;4269.6370808481315;3686.686631636314;3692.2430901665093;3692.390755525362;3697.500837386945;3706.054955986206;5286.154215325568;5408.567314614821;5413.106837371829;5418.593605479566;5427.294451721291;4848.878778030542;4889.804407823683;4891;4893.119238537062;4900.191468407708;5887.941120588825;5901.8819623607715;5903.852403689899;5912.024515954862;5920.911186332209;3885.7862817545024;4011.2178125265586;4013.25754735372;4019.8995025124605;4024.1750441159493;6050.606710563799;6197.845053873599;6199.473044791153;6200.286966998808;6201.224846894138;4128.153728485653;4132.40080188371;4133.2146892091005;4143.8964025898995;4149.25313443583;4156.397322388237;4170.749755014709;4200;4200.4959404871615;4206.47419072616;4758.714477131383;4833.202521583969;4835.927461088087;4839.879003024953;4839.951600484021;5850.444207800252;5863.325717542537;5866.941330586639;5867.266591676041;5873.177755114202;1447.4355001549404;1448.9855101449061;1455.6069861137435;1456.5557504961089;1457.1475686723174;977.4721650308753;979.5738853598707;982.6315131825565;992.2855544008303;996.3175224970918;5129.640925135204;5130;5132.28148059272;5140.820071297487;5148.9485105149215;6055.424734650202;6096.725647345791;6110.938890611037;6111.96944015277;6127.264728232641;5109.20807274873;5111.182210846321;5131.332926719502;5134.820281290137;5136.357955255593;3231.845697741992;3256.9837150814096;3290.2596915693775;3303.537504749337;3308.0902751742983;5573.749181286852;5688.77244910199;5709.05800542914;5717.142428635655;5723.942760572424;6254.74981000764;6296.811095667137;6338.366163383717;6345.524085693592;6346.365363463617;5710.571707121982;5732.742026608813;5738.5982981191755;5748.511376533042;5750.396208398058;6099.420555047263;6128.8774224516155;6135.570510064253;6138.662373569497;6161.753529858935;5786.392428795084;6017.578769486094;6021.668808215591;6030.939690603038;6044.032954727222;5759.798407055733;5764.394738552392;5780.913286300793;5783.074708046693;5795.710214489174;4054.290499162694;4064.898377540585;4072.185562887375;4075.3886916961505;4075.5109386873764;6027.156198132353;6054.878902422015;6136.23297087864;6141.477974372228;6163;5906.822795316148;5916.437938395846;5916.940830591639;5917.91123133162;5927.288725352985;5913.46778789911;5921.5558833086825;5922.466977972003;5946;5948.524118070457;5651.519620832275;5763.625364351304;5765.509931655856;5785.623934444247;5799.362070172362;5950.7917222896995;5953.970230148821;5955;5958.404159584007;5986.341502434816;5806.158107074366;5814.94185058144;5818.214541036906;5819.679917604572;5834.824955251349 04:32:56 INFO - 2015-12-21 04:32:56,523 DEBUG : BROWSER_OUTPUT: |5;yui.html;654.4012228810637;736.6869080640727;775.6486112906595;796.406677025616;796.9123396426396;10702.46487675616;10909.127269818415;10923.563057477691;10947.5620975161;10955.452227388618;11567.595134170306;11609.709757256072;11856;11882.405879706022;11887.940560297186;775.3874439193031;787.397640804782;805.9274665280124;808.0465051239535;808.1393316118315;788.5071830106184;792.0258082558456;799.3724925933144;800.6357107516095;801.2028032108061;826.6238861318116;829.0631586307494;830.7050996896105;831.085805613826;831.4637059096879;814.1410811593767;820.0815087102424;820.5281962871343;821.3142026407957;822.0792712162387;598.9610675306092;602.9125776762389;603.972821223046;604.3050491934267;609.9237595300588;11107;11212.719682007933;11278.15413843965;11299;11383.430828458626;9759.389700699376;10078.748031299203;10270.845937310947;10593.916513106307;10873.456327183609;9148.542572871329;9344.626214951393;9357.859632105525;9443.716688499357;9455.52722363886;3208.8395580220895;3225.7258133058717;3239.6440870274964;3246.0748686624197;3251.723603493706;39670;40117.398239026435;40123.19753604911;40256.798716006524;40276.79861600673;8891.73324800257;8897.599608017656;8953.104689531125;9126.81746365069;9159.633614655473;15858.127802970947;16021.679566408606;16035.599110022109;16076.43732469358;16080.195990200444;6125.418085281891;6285.9057114143325;6300.464460520907;6460.741570337228;6520.673966301666;3528.5236493073107;3548.503209550665;3553.2360542482975;3626.111602657366;3636.872709455209;2548;2574.4851029794117;2579.587266037425;2583.7416258374387;2584.3151564835334;458.79354290569376;461.3610149942354;469.20938219100924;475.6575265808612;477.5821156488073;445.7125154275539;468.12694325083476;530.8540151458379;546.8277492589822;555.2115995286703;6741.359570840762;6949.409300209539;7140.214576396592;7256.600886951268;7258.383037441771;419.1386700330788;434.68702534175975;435.6297147424727;469.01506835644875;521.2025600830735;3282.7373810095137;3296.8351582420783;3501.4047611905526;3538.8053657048595;3779.9244015120094;49087;49360;50544.74727626412;52053;52066.73966630142;41547;41969.37045944313;42032.57967420287;42085.36871946923;46661.30008049882;42030;42289.78855105705;42846.78576607097;43610.7819460907;44158.55841441544;7678.193789652006;7759.719646258304;7918.643661035152;8022.679092836222;8182.67269309221;30074.69925300719;31294.37411251808;31316.37367252688;31466.37067258688;31476.37047259088;37783;38293.4255986166;38336.61663383442;38350;38824.805875970436;9583.760405989906;9722.951385243312;9776.511174441108;9968.50157492137;10672.679819605424;10632.681019569425;10684.626038088629;10773.24587278883;10812.56749730002;10873.945630271797;10197.439140847324;10372.11836993864;10490.737731556772;10514.211434142317;10577.735556611146;10229.48852557384;10279.94860025695;10338.638147664795;10350.5342259597;10351.120154786928;8707.695230666895;9584.28117891175;9893.50532473359;10102;10115.59537618487;8488.915110849059;8489.40574159803;8537.103604121477;8693;8730.869036964577;7960.880586791087;8479.830403392021;8506.404551681322;8528.189821967151;8690.087540808378 04:32:56 INFO - 2015-12-21 04:32:56,523 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:32:56 INFO - 2015-12-21 04:32:56,523 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:32:56 INFO - 2015-12-21 04:32:56,523 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,327 04:32:56 INFO - 2015-12-21 04:32:56,523 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:32:56 INFO - 2015-12-21 04:32:56,523 DEBUG : BROWSER_OUTPUT: __startTimestamp1450701176509__endTimestamp 04:32:56 INFO - 2015-12-21 04:32:56,523 DEBUG : BROWSER_OUTPUT: 04:32:56 INFO - 2015-12-21 04:32:56,523 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:32:56 INFO - 2015-12-21 04:32:56,523 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:32:56 INFO - 2015-12-21 04:32:56,523 DEBUG : BROWSER_OUTPUT: 04:32:56 INFO - 2015-12-21 04:32:56,524 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4468.28 Median:4623.33 stddev:586.71 (12.7%) stddev-sans-first:568.87 04:32:56 INFO - 2015-12-21 04:32:56,525 DEBUG : BROWSER_OUTPUT: Values: 2549.6 2582.9 2593.4 2596.8 2606.9 4387.6 4509.4 4539.6 4547.3 4560.4 4417.7 4441.1 4516.1 4520.6 4549.2 46.7 4198.6 4237.1 4242.1 4286.3 3972.8 4035.0 4130.8 4152.4 4159.6 4212.9 4221.9 4230.6 4264.6 4273.3 4202.7 4215.2 4247.3 4252.4 4288.7 4034.9 4122.3 4126.0 4212.1 4216.2 4423.8 4437.9 4460.1 4483.7 4484.7 4623.3 4861.3 4884.1 4885.4 4895.8 4799.6 4802.1 4805.7 4893.8 4922.2 4596.9 4607.7 4619.7 4622.2 4660.2 4786.4 5042.6 5050.9 5060.9 5126.6 4735.8 4767.5 4818.9 4853.0 4898.5 4939.2 4949.1 4960.3 4962.7 4994.4 4615.9 4718.2 4861.3 4883.1 4926.5 4728.9 4779.2 4785.2 4806.1 4845.5 4054.8 4057.4 4066.5 4085.8 4110.3 3474.8 3553.5 3574.1 3586.9 3660.3 4138.5 4185.6 4258.9 4266.7 4301.1 4915.8 4921.3 4930.1 4942.9 4955.9 4035.9 4119.6 4274.2 4292.5 4327.4 4185.2 4268.6 4270.7 4287.7 4301.4 4609.6 4628.6 4638.9 4644.3 4679.0 4643.8 4810.2 4831.2 4909.0 4913.3 4580.1 4624.7 4632.8 4634.0 4676.6 4844.1 4867.6 4874.5 4888.1 4919.0 4662.4 4779.8 4780.5 4872.8 4931.2 4752.7 4756.8 4779.1 4796.9 4808.2 4746.7 4760.5 4763.0 4766.7 4805.9 4466.0 4535.8 4558.7 4569.0 4652.0 4781.3 4784.2 4792.9 4804.0 4847.7 4453.1 4678.2 4703.9 4711.9 4742.6 04:32:56 INFO - 2015-12-21 04:32:56,525 DEBUG : BROWSER_OUTPUT: 04:32:56 INFO - 2015-12-21 04:32:56,525 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39405.21 Median:19788.85 stddev:61714.55 (311.9%) stddev-sans-first:61818.77 04:32:56 INFO - 2015-12-21 04:32:56,525 DEBUG : BROWSER_OUTPUT: Values: 564.7 565.5 576.6 578.0 583.7 35030.8 35983.0 36011.8 36114.8 36152.5 39290.8 39558.8 39688.8 39740.2 39917.0 7870.9 8023.8 8026.2 8034.0 8066.3 7879.9 7955.1 7966.2 7975.3 7977.9 7597.5 7612.7 7637.4 7650.5 7694.0 7923.7 7994.3 8005.6 8022.9 8027.5 7885.3 7956.4 7990.6 7997.8 7999.8 36434.5 36740.7 36809.8 36856.8 36959.8 2348.8 2813.7 2880.5 2928.0 3594.7 26103.9 26250.9 26275.3 26415.0 27155.5 3403.2 3434.2 3446.8 3511.8 3567.0 178685.0 178730.9 178866.0 179611.0 181166.0 51186.0 51697.5 54300.3 55293.7 55294.2 48433.5 48580.3 48674.0 48692.5 48763.8 13094.5 13201.1 13274.3 13288.7 13300.1 9707.6 9887.0 9933.3 9982.5 9984.0 19026.8 19233.2 19251.7 19301.7 19318.0 7455.4 7622.5 7626.7 7636.4 7708.6 804.5 850.7 872.7 884.8 916.3 25134.6 25196.0 25493.0 25665.5 25672.5 915.1 953.1 962.0 971.7 1008.5 13820.6 13913.3 13986.4 14294.6 14382.6 263585.0 267478.0 268042.0 268197.0 269254.0 45033.0 45192.1 45263.8 45338.8 45369.8 1174.3 1216.4 1216.8 1216.8 1217.7 25770.6 25935.9 26062.5 26261.5 26307.6 39477.0 39477.2 39820.4 39869.8 39885.6 253543.0 253758.0 254308.0 255628.0 256101.0 26754.2 27473.2 27678.9 27774.4 27781.2 37949.4 38139.2 38425.2 38755.6 39519.8 32249.5 32849.0 32939.8 33242.0 33354.5 29318.6 29361.9 29388.7 29425.0 29618.7 32566.7 34737.7 34866.7 34938.7 35611.5 33157.7 34549.7 35424.5 35711.6 36038.5 27882.9 28027.6 28302.9 28558.3 28995.0 04:32:56 INFO - 2015-12-21 04:32:56,525 DEBUG : BROWSER_OUTPUT: 04:32:56 INFO - 2015-12-21 04:32:56,525 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26765.58 Median:20689.75 stddev:85600.11 (413.7%) stddev-sans-first:85817.21 04:32:56 INFO - 2015-12-21 04:32:56,525 DEBUG : BROWSER_OUTPUT: Values: 317.8 318.5 323.7 325.3 330.2 14599.3 15090.3 15569.7 16049.4 16764.8 15079.3 15210.5 15829.4 16041.8 16049.5 4345.9 4561.8 4607.1 4618.7 4620.0 4557.6 4590.4 4597.7 4599.0 4613.3 4489.1 4546.6 4555.3 4555.6 4593.2 4562.3 4579.4 4590.7 4595.9 4596.6 4324.8 4399.7 4416.1 4431.3 4447.1 11916.2 12033.8 12069.3 12102.6 14731.8 1809.2 1837.7 1844.5 1870.0 1893.1 8701.1 8876.5 9083.5 9395.4 11861.7 1784.9 1790.8 1794.1 1801.7 1868.3 55755.7 57710.0 58378.0 58443.4 59256.4 9388.1 9527.2 9573.0 9778.5 9785.3 11413.4 11425.9 11639.7 12047.2 12053.2 6532.1 6595.1 6681.3 6683.8 6696.9 6071.4 6349.7 6354.6 6474.6 6497.0 4154.9 4213.6 4241.6 4250.3 4263.4 1791.0 1813.7 1815.4 1841.5 1845.3 375.2 377.9 849.8 875.4 980.3 9857.6 9955.4 10105.0 10154.2 10334.8 394.0 400.0 409.3 415.3 426.6 5402.6 5495.9 5514.3 9126.5 9352.9 515015.0 517668.0 523937.0 530745.0 530784.0 72407.6 72564.0 72809.3 74347.0 76080.6 1047.8 1058.1 1058.6 1066.9 1078.4 14512.3 14680.0 14808.1 14845.4 14873.2 25484.4 28686.6 29982.9 33155.5 34258.0 35167.3 39386.6 40300.6 40834.9 40970.2 8535.4 8897.3 8933.0 9010.1 9050.1 10209.5 10998.5 15685.2 15880.1 16026.2 13190.9 13401.6 13597.5 13728.7 13753.0 12885.5 13180.3 13523.3 13556.6 13988.7 14240.9 14281.2 14304.4 14680.9 14686.8 8487.2 8698.8 8860.6 8911.1 9391.4 9217.9 9334.5 11668.4 13197.9 13690.6 04:32:56 INFO - 2015-12-21 04:32:56,525 DEBUG : BROWSER_OUTPUT: 04:32:56 INFO - 2015-12-21 04:32:56,525 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4941.71 Median:6001.23 stddev:2520.37 (42.0%) stddev-sans-first:2514.00 04:32:56 INFO - 2015-12-21 04:32:56,527 DEBUG : BROWSER_OUTPUT: Values: 1478.1 1636.9 1673.6 1688.9 1706.4 5744.6 5987.2 7014.7 7148.7 7160.0 7021.5 7033.9 7054.5 7067.9 7079.3 2054.5 2104.0 2106.2 2106.8 2109.2 2040.2 2099.2 2109.0 2112.7 2114.9 2085.2 2089.2 2097.1 2110.8 2112.1 1996.8 1998.8 2012.2 2012.2 2013.6 2068.0 2072.5 2111.0 2114.9 2122.3 6998.6 7097.0 7098.9 7103.1 7109.9 4134.7 4213.3 4217.3 4220.7 4224.5 2739.3 2744.7 2770.8 2795.7 2809.6 926.7 1755.2 1774.8 1776.5 1786.8 9477.5 9480.6 9637.9 9662.6 9673.4 3784.0 3816.9 3880.7 3881.1 3893.2 8334.2 8346.8 8348.6 8407.4 8411.0 4272.4 4282.7 4292.8 4307.8 4312.6 3172.6 3243.9 3476.5 3834.1 3907.6 3467.9 3536.9 3551.5 3554.9 3578.0 1126.0 1153.2 1157.9 1164.0 1165.1 968.9 987.2 991.3 1031.9 1138.9 6598.2 6599.1 6607.4 6620.3 6643.8 443.4 451.0 464.3 467.1 468.8 5359.2 5382.8 5389.5 5413.8 5417.5 8056.6 8204.8 8216.3 8255.4 8268.7 8111.7 8112.9 8141.8 8167.2 8195.1 6574.3 6583.6 6681.5 6697.5 6709.9 6623.6 6658.5 6669.9 6700.4 6721.4 7481.3 7629.3 7639.6 7673.2 7738.8 7556.7 7870.1 7877.8 7979.3 7982.4 5286.2 5433.7 5928.0 6372.8 6473.7 6726.9 6729.5 6780.8 6784.1 6840.5 6253.9 6350.0 6404.5 6406.6 6438.4 6257.2 6327.0 6341.8 6350.9 6399.7 6284.6 6311.8 6322.7 6330.1 6330.8 5816.6 5831.0 5857.1 5867.5 5873.6 6015.2 6021.7 6041.7 6061.9 6068.3 04:32:56 INFO - 2015-12-21 04:32:56,527 DEBUG : BROWSER_OUTPUT: 04:32:56 INFO - 2015-12-21 04:32:56,527 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4856.67 Median:5564.07 stddev:1453.95 (26.1%) stddev-sans-first:1417.17 04:32:56 INFO - 2015-12-21 04:32:56,527 DEBUG : BROWSER_OUTPUT: Values: 296.2 299.7 303.5 306.5 306.8 5463.1 5506.6 5535.3 5584.2 5621.1 5396.3 5561.2 5562.3 5565.8 5572.9 4306.2 4320.5 4323.4 4336.8 4341.2 4326.2 4329.1 4336.3 4336.8 4345.7 4099.9 4263.6 4297.0 4297.1 4309.9 4228.2 4231.2 4252.9 4254.6 4269.6 3686.7 3692.2 3692.4 3697.5 3706.1 5286.2 5408.6 5413.1 5418.6 5427.3 4848.9 4889.8 4891.0 4893.1 4900.2 5887.9 5901.9 5903.9 5912.0 5920.9 3885.8 4011.2 4013.3 4019.9 4024.2 6050.6 6197.8 6199.5 6200.3 6201.2 4128.2 4132.4 4133.2 4143.9 4149.3 4156.4 4170.7 4200.0 4200.5 4206.5 4758.7 4833.2 4835.9 4839.9 4840.0 5850.4 5863.3 5866.9 5867.3 5873.2 1447.4 1449.0 1455.6 1456.6 1457.1 977.5 979.6 982.6 992.3 996.3 5129.6 5130.0 5132.3 5140.8 5148.9 6055.4 6096.7 6110.9 6112.0 6127.3 5109.2 5111.2 5131.3 5134.8 5136.4 3231.8 3257.0 3290.3 3303.5 3308.1 5573.7 5688.8 5709.1 5717.1 5723.9 6254.7 6296.8 6338.4 6345.5 6346.4 5710.6 5732.7 5738.6 5748.5 5750.4 6099.4 6128.9 6135.6 6138.7 6161.8 5786.4 6017.6 6021.7 6030.9 6044.0 5759.8 5764.4 5780.9 5783.1 5795.7 4054.3 4064.9 4072.2 4075.4 4075.5 6027.2 6054.9 6136.2 6141.5 6163.0 5906.8 5916.4 5916.9 5917.9 5927.3 5913.5 5921.6 5922.5 5946.0 5948.5 5651.5 5763.6 5765.5 5785.6 5799.4 5950.8 5954.0 5955.0 5958.4 5986.3 5806.2 5814.9 5818.2 5819.7 5834.8 04:32:56 INFO - 2015-12-21 04:32:56,527 DEBUG : BROWSER_OUTPUT: 04:32:56 INFO - 2015-12-21 04:32:56,527 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12026.46 Median:460.08 stddev:13856.92 (3011.9%) stddev-sans-first:13869.48 04:32:56 INFO - 2015-12-21 04:32:56,528 DEBUG : BROWSER_OUTPUT: Values: 654.4 736.7 775.6 796.4 796.9 10702.5 10909.1 10923.6 10947.6 10955.5 11567.6 11609.7 11856.0 11882.4 11887.9 775.4 787.4 805.9 808.0 808.1 788.5 792.0 799.4 800.6 801.2 826.6 829.1 830.7 831.1 831.5 814.1 820.1 820.5 821.3 822.1 599.0 602.9 604.0 604.3 609.9 11107.0 11212.7 11278.2 11299.0 11383.4 9759.4 10078.7 10270.8 10593.9 10873.5 9148.5 9344.6 9357.9 9443.7 9455.5 3208.8 3225.7 3239.6 3246.1 3251.7 39670.0 40117.4 40123.2 40256.8 40276.8 8891.7 8897.6 8953.1 9126.8 9159.6 15858.1 16021.7 16035.6 16076.4 16080.2 6125.4 6285.9 6300.5 6460.7 6520.7 3528.5 3548.5 3553.2 3626.1 3636.9 2548.0 2574.5 2579.6 2583.7 2584.3 458.8 461.4 469.2 475.7 477.6 445.7 468.1 530.9 546.8 555.2 6741.4 6949.4 7140.2 7256.6 7258.4 419.1 434.7 435.6 469.0 521.2 3282.7 3296.8 3501.4 3538.8 3779.9 49087.0 49360.0 50544.7 52053.0 52066.7 41547.0 41969.4 42032.6 42085.4 46661.3 42030.0 42289.8 42846.8 43610.8 44158.6 7678.2 7759.7 7918.6 8022.7 8182.7 30074.7 31294.4 31316.4 31466.4 31476.4 37783.0 38293.4 38336.6 38350.0 38824.8 9583.8 9723.0 9776.5 9968.5 10672.7 10632.7 10684.6 10773.2 10812.6 10873.9 10197.4 10372.1 10490.7 10514.2 10577.7 10229.5 10279.9 10338.6 10350.5 10351.1 8707.7 9584.3 9893.5 10102.0 10115.6 8488.9 8489.4 8537.1 8693.0 8730.9 7960.9 8479.8 8506.4 8528.2 8690.1 04:32:56 INFO - 2015-12-21 04:32:56,528 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:32:56 INFO - 2015-12-21 04:32:56,528 DEBUG : BROWSER_OUTPUT: 04:32:57 INFO - 2015-12-21 04:32:57,231 INFO : Browser exited with error code: 0 04:32:57 INFO - 2015-12-21 04:32:57,250 INFO : Completed test dromaeo_css (00:18:32) 04:32:57 INFO - 2015-12-21 04:32:57,250 INFO : Starting test kraken 04:32:57 INFO - 2015-12-21 04:32:57,250 DEBUG : operating with platform_type : linux_ 04:32:57 INFO - 2015-12-21 04:32:57,250 INFO : Initialising browser for kraken test... 04:32:57 INFO - 2015-12-21 04:32:57,256 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuAc4eJ/profile http://localhost:46319/getInfo.html 04:33:00 INFO - 2015-12-21 04:33:00,911 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:33:01 INFO - 2015-12-21 04:33:01,644 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:33:01 INFO - 2015-12-21 04:33:01,645 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:33:01 INFO - 2015-12-21 04:33:01,645 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:33:01 INFO - 2015-12-21 04:33:01,645 DEBUG : BROWSER_OUTPUT: __metrics 04:33:01 INFO - 2015-12-21 04:33:01,766 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] 04:33:02 INFO - 2015-12-21 04:33:02,587 INFO : Browser initialized. 04:33:02 INFO - 2015-12-21 04:33:02,588 INFO : Running cycle 1/1 for kraken test... 04:33:02 INFO - 2015-12-21 04:33:02,588 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuAc4eJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:33:14 INFO - 2015-12-21 04:33:14,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 151224320 04:33:14 INFO - 2015-12-21 04:33:14,625 DEBUG : BROWSER_OUTPUT: 04:33:17 INFO - 2015-12-21 04:33:17,203 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46319/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:17 INFO - 2015-12-21 04:33:17,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 149995520 04:33:17 INFO - 2015-12-21 04:33:17,810 DEBUG : BROWSER_OUTPUT: 04:33:20 INFO - 2015-12-21 04:33:20,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46319/tests/kraken/driver.html?testName=audio-dft) 04:33:21 INFO - 2015-12-21 04:33:21,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 150745088 04:33:21 INFO - 2015-12-21 04:33:21,122 DEBUG : BROWSER_OUTPUT: 04:33:24 INFO - 2015-12-21 04:33:24,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46319/tests/kraken/driver.html?testName=audio-fft) 04:33:24 INFO - 2015-12-21 04:33:24,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 145555456 04:33:24 INFO - 2015-12-21 04:33:24,636 DEBUG : BROWSER_OUTPUT: 04:33:26 INFO - 2015-12-21 04:33:26,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46319/tests/kraken/driver.html?testName=audio-oscillator) 04:33:27 INFO - 2015-12-21 04:33:27,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 146427904 04:33:27 INFO - 2015-12-21 04:33:27,260 DEBUG : BROWSER_OUTPUT: 04:33:29 INFO - 2015-12-21 04:33:29,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46319/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:30 INFO - 2015-12-21 04:33:30,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 147111936 04:33:30 INFO - 2015-12-21 04:33:30,116 DEBUG : BROWSER_OUTPUT: 04:33:33 INFO - 2015-12-21 04:33:33,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46319/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:33 INFO - 2015-12-21 04:33:33,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 147243008 04:33:33 INFO - 2015-12-21 04:33:33,745 DEBUG : BROWSER_OUTPUT: 04:33:37 INFO - 2015-12-21 04:33:37,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46319/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:37 INFO - 2015-12-21 04:33:37,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 146087936 04:33:37 INFO - 2015-12-21 04:33:37,836 DEBUG : BROWSER_OUTPUT: 04:33:40 INFO - 2015-12-21 04:33:40,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46319/tests/kraken/driver.html?testName=json-parse-financial) 04:33:41 INFO - 2015-12-21 04:33:41,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 146751488 04:33:41 INFO - 2015-12-21 04:33:41,369 DEBUG : BROWSER_OUTPUT: 04:33:43 INFO - 2015-12-21 04:33:43,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46319/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:43 INFO - 2015-12-21 04:33:43,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 148103168 04:33:43 INFO - 2015-12-21 04:33:43,735 DEBUG : BROWSER_OUTPUT: 04:33:45 INFO - 2015-12-21 04:33:45,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46319/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:46 INFO - 2015-12-21 04:33:46,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 148959232 04:33:46 INFO - 2015-12-21 04:33:46,281 DEBUG : BROWSER_OUTPUT: 04:33:48 INFO - 2015-12-21 04:33:48,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46319/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:49 INFO - 2015-12-21 04:33:49,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 148074496 04:33:49 INFO - 2015-12-21 04:33:49,028 DEBUG : BROWSER_OUTPUT: 04:33:51 INFO - 2015-12-21 04:33:51,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:52 INFO - 2015-12-21 04:33:52,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 148463616 04:33:52 INFO - 2015-12-21 04:33:52,174 DEBUG : BROWSER_OUTPUT: 04:33:54 INFO - 2015-12-21 04:33:54,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:55 INFO - 2015-12-21 04:33:55,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 149020672 04:33:55 INFO - 2015-12-21 04:33:55,338 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46319/tests/kraken/driver.html?testName=ai-astar) 04:33:57 INFO - 2015-12-21 04:33:57,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 148103168 04:33:57 INFO - 2015-12-21 04:33:57,371 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,374 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:33:57 INFO - 2015-12-21 04:33:57,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:33:57 INFO - 2015-12-21 04:33:57,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:33:57 INFO - 2015-12-21 04:33:57,374 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;110;113;112;113;122;112;112;111;113 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;129;158;165;130;156;158;131;163;130 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;164;162;163;165;171;165;165;163 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;75;72;74;73;136;73;77;72;72 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;96;138;94;96;95;130;95;95;130 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;111;109;110;110;110;110;111;110 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;147;148;149;148;147;149;148 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;98;100;96;96;96;96;95;95 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;74;74;73;74;75;75;78;74;73 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;71;69;79;69;68;70;69;70 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;83;84;85;83;82;84;86;85 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;122;119;127;128;124;123;120;124;122 04:33:57 INFO - 2015-12-21 04:33:57,375 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;147;147;143;150;135;145;143;146;138 04:33:57 INFO - 2015-12-21 04:33:57,376 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;77;72;71;71;69;69;69;71 04:33:57 INFO - 2015-12-21 04:33:57,376 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:33:57 INFO - 2015-12-21 04:33:57,376 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:33:57 INFO - 2015-12-21 04:33:57,376 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,785 04:33:57 INFO - 2015-12-21 04:33:57,376 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:33:57 INFO - 2015-12-21 04:33:57,376 DEBUG : BROWSER_OUTPUT: __startTimestamp1450701237373__endTimestamp 04:33:57 INFO - 2015-12-21 04:33:57,376 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,379 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:33:57 INFO - 2015-12-21 04:33:57,379 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:33:57 INFO - 2015-12-21 04:33:57,379 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,379 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.00 Median:112.50 stddev:3.30 (2.9%) stddev-sans-first:3.48 04:33:57 INFO - 2015-12-21 04:33:57,379 DEBUG : BROWSER_OUTPUT: Values: 112.0 110.0 113.0 112.0 113.0 122.0 112.0 112.0 111.0 113.0 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.80 Median:158.00 stddev:15.55 (9.8%) stddev-sans-first:16.05 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: Values: 158.0 129.0 158.0 165.0 130.0 156.0 158.0 131.0 163.0 130.0 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.51 (1.5%) stddev-sans-first:2.60 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 164.0 162.0 163.0 165.0 171.0 165.0 165.0 163.0 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:73.50 stddev:19.78 (26.9%) stddev-sans-first:20.90 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: Values: 75.0 75.0 72.0 74.0 73.0 136.0 73.0 77.0 72.0 72.0 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:95.00 stddev:18.14 (19.1%) stddev-sans-first:18.90 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 138.0 94.0 96.0 95.0 130.0 95.0 95.0 130.0 04:33:57 INFO - 2015-12-21 04:33:57,380 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 111.0 109.0 110.0 110.0 110.0 110.0 111.0 110.0 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 147.0 148.0 149.0 148.0 147.0 149.0 148.0 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.51 (1.6%) stddev-sans-first:1.59 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 98.0 100.0 96.0 96.0 96.0 96.0 95.0 95.0 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.50 Median:74.50 stddev:1.43 (1.9%) stddev-sans-first:1.51 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 74.0 73.0 74.0 75.0 75.0 78.0 74.0 73.0 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:69.50 stddev:3.22 (4.6%) stddev-sans-first:3.32 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 71.0 69.0 79.0 69.0 68.0 70.0 69.0 70.0 04:33:57 INFO - 2015-12-21 04:33:57,381 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,382 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.34 (1.6%) stddev-sans-first:1.27 04:33:57 INFO - 2015-12-21 04:33:57,382 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 83.0 84.0 85.0 83.0 82.0 84.0 86.0 85.0 04:33:57 INFO - 2015-12-21 04:33:57,382 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,382 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.00 stddev:3.03 (2.4%) stddev-sans-first:2.95 04:33:57 INFO - 2015-12-21 04:33:57,382 DEBUG : BROWSER_OUTPUT: Values: 127.0 122.0 119.0 127.0 128.0 124.0 123.0 120.0 124.0 122.0 04:33:57 INFO - 2015-12-21 04:33:57,382 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,382 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:145.50 stddev:5.41 (3.7%) stddev-sans-first:4.71 04:33:57 INFO - 2015-12-21 04:33:57,382 DEBUG : BROWSER_OUTPUT: Values: 134.0 147.0 147.0 143.0 150.0 135.0 145.0 143.0 146.0 138.0 04:33:57 INFO - 2015-12-21 04:33:57,383 DEBUG : BROWSER_OUTPUT: 04:33:57 INFO - 2015-12-21 04:33:57,383 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:2.44 (3.4%) stddev-sans-first:2.50 04:33:57 INFO - 2015-12-21 04:33:57,383 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 77.0 72.0 71.0 71.0 69.0 69.0 69.0 71.0 04:33:57 INFO - 2015-12-21 04:33:57,383 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:33:57 INFO - 2015-12-21 04:33:57,383 DEBUG : BROWSER_OUTPUT: 04:33:58 INFO - 2015-12-21 04:33:58,347 INFO : Browser exited with error code: 0 04:33:58 INFO - 2015-12-21 04:33:58,398 INFO : Completed test kraken (00:01:01) 04:33:58 INFO - 2015-12-21 04:33:58,398 INFO : Starting test v8_7 04:33:58 INFO - 2015-12-21 04:33:58,399 DEBUG : operating with platform_type : linux_ 04:33:58 INFO - 2015-12-21 04:33:58,399 INFO : Initialising browser for v8_7 test... 04:33:58 INFO - 2015-12-21 04:33:58,405 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNL7zqe/profile http://localhost:46319/getInfo.html 04:34:02 INFO - 2015-12-21 04:34:02,102 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 04:34:02 INFO - 2015-12-21 04:34:02,944 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:34:02 INFO - 2015-12-21 04:34:02,944 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:34:02 INFO - 2015-12-21 04:34:02,945 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:34:02 INFO - 2015-12-21 04:34:02,945 DEBUG : BROWSER_OUTPUT: __metrics 04:34:03 INFO - 2015-12-21 04:34:03,061 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] 04:34:03 INFO - 2015-12-21 04:34:03,963 INFO : Browser initialized. 04:34:03 INFO - 2015-12-21 04:34:03,964 INFO : Running cycle 1/1 for v8_7 test... 04:34:03 INFO - 2015-12-21 04:34:03,964 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNL7zqe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:34:15 INFO - 2015-12-21 04:34:15,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 150962176 04:34:15 INFO - 2015-12-21 04:34:15,897 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46319/tests/v8_7/run.html (next: http://localhost:46319/tests/v8_7/run.html) 04:34:37 INFO - 2015-12-21 04:34:37,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 145829888 04:34:37 INFO - 2015-12-21 04:34:37,571 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,571 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:37 INFO - 2015-12-21 04:34:37,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:37 INFO - 2015-12-21 04:34:37,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:37 INFO - 2015-12-21 04:34:37,571 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:37 INFO - 2015-12-21 04:34:37,571 DEBUG : BROWSER_OUTPUT: |0;Richards;164.41959881617888 04:34:37 INFO - 2015-12-21 04:34:37,572 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.76688286913392 04:34:37 INFO - 2015-12-21 04:34:37,572 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.77777777777777 04:34:37 INFO - 2015-12-21 04:34:37,572 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 04:34:37 INFO - 2015-12-21 04:34:37,572 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1064.9627263045793 04:34:37 INFO - 2015-12-21 04:34:37,572 DEBUG : BROWSER_OUTPUT: |5;Earley;695.8942240779402 04:34:37 INFO - 2015-12-21 04:34:37,572 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 04:34:37 INFO - 2015-12-21 04:34:37,572 DEBUG : BROWSER_OUTPUT: |7;RegExp;27108.108108108107 04:34:37 INFO - 2015-12-21 04:34:37,572 DEBUG : BROWSER_OUTPUT: |8;Splay;632.9113924050633 04:34:37 INFO - 2015-12-21 04:34:37,573 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 04:34:37 INFO - 2015-12-21 04:34:37,573 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:37 INFO - 2015-12-21 04:34:37,573 DEBUG : BROWSER_OUTPUT: __startTimestamp1450701277570__endTimestamp 04:34:37 INFO - 2015-12-21 04:34:37,573 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,574 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:37 INFO - 2015-12-21 04:34:37,575 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:34:37 INFO - 2015-12-21 04:34:37,575 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,575 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.42 Median:164.42 stddev:0.00 (0.0%) 04:34:37 INFO - 2015-12-21 04:34:37,575 DEBUG : BROWSER_OUTPUT: Values: 164.4 04:34:37 INFO - 2015-12-21 04:34:37,575 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,575 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.77 Median:190.77 stddev:0.00 (0.0%) 04:34:37 INFO - 2015-12-21 04:34:37,575 DEBUG : BROWSER_OUTPUT: Values: 190.8 04:34:37 INFO - 2015-12-21 04:34:37,575 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,575 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.78 Median:277.78 stddev:0.00 (0.0%) 04:34:37 INFO - 2015-12-21 04:34:37,575 DEBUG : BROWSER_OUTPUT: Values: 277.8 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: Values: 5133.3 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1064.96 Median:1064.96 stddev:0.00 (0.0%) 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: Values: 1065.0 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:695.89 Median:695.89 stddev:0.00 (0.0%) 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: Values: 695.9 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: Values: 12207.3 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27108.11 Median:27108.11 stddev:0.00 (0.0%) 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: Values: 27108.1 04:34:37 INFO - 2015-12-21 04:34:37,576 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,577 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:632.91 Median:632.91 stddev:0.00 (0.0%) 04:34:37 INFO - 2015-12-21 04:34:37,577 DEBUG : BROWSER_OUTPUT: Values: 632.9 04:34:37 INFO - 2015-12-21 04:34:37,577 DEBUG : BROWSER_OUTPUT: 04:34:37 INFO - 2015-12-21 04:34:37,577 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 04:34:37 INFO - 2015-12-21 04:34:37,577 DEBUG : BROWSER_OUTPUT: Values: 4845.4 04:34:37 INFO - 2015-12-21 04:34:37,577 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:37 INFO - 2015-12-21 04:34:37,577 DEBUG : BROWSER_OUTPUT: 04:34:38 INFO - 2015-12-21 04:34:38,471 INFO : Browser exited with error code: 0 04:34:38 INFO - 2015-12-21 04:34:38,488 INFO : Completed test v8_7 (00:00:40) 04:34:38 INFO - 2015-12-21 04:34:38,576 INFO : Completed test suite (00:20:13) 04:34:38 INFO - 2015-12-21 04:34:38,576 DEBUG : Working with test: dromaeo_css 04:34:38 INFO - 2015-12-21 04:34:38,577 DEBUG : Generating results file: dromaeo_css 04:34:38 INFO - 2015-12-21 04:34:38,578 DEBUG : Working with test: kraken 04:34:38 INFO - 2015-12-21 04:34:38,578 DEBUG : Generating results file: kraken 04:34:38 INFO - 2015-12-21 04:34:38,578 INFO : javascript benchmark 04:34:38 INFO - 2015-12-21 04:34:38,578 DEBUG : Working with test: v8_7 04:34:38 INFO - 2015-12-21 04:34:38,578 DEBUG : Generating results file: v8_7 04:34:38 INFO - 2015-12-21 04:34:38,579 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:38 INFO - 2015-12-21 04:34:38,636 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:34:38 INFO - 2015-12-21 04:34:38,636 DEBUG : process_Request line: dromaeo_css 6175.42 graph.html#tests=[[72,94,43]] 04:34:38 INFO - 2015-12-21 04:34:38,636 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:38 INFO - 2015-12-21 04:34:38,667 DEBUG : process_Request line: kraken 1531.90 graph.html#tests=[[232,94,43]] 04:34:38 INFO - 2015-12-21 04:34:38,667 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:38 INFO - 2015-12-21 04:34:38,700 DEBUG : process_Request line: v8_7 21225.39 graph.html#tests=[[230,94,43]] 04:34:38 INFO - 2015-12-21 04:34:38,701 INFO : javascript benchmark 04:34:38 INFO - 2015-12-21 04:34:38,705 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2549.5538280800856, 2582.9483410331795, 2593.4164812917084, 2596.8182227244088, 2606.934826629334, 4387.648988080954, 4509.391232183651, 4539.636829053676, 4547.272436410175, 4560.361549383085, 4417.73493590384, 4441.089576636789, 4516.14193303273, 4520.615747661444, 4549.1584056949405, 46.73600905639997, 4198.5591512891015, 4237.110206856564, 4242.109157077018, 4286.314189729644, 3972.7616343019513, 4034.979825100885, 4130.772807495587, 4152.397902304164, 4159.604837540429, 4212.873613791591, 4221.936670949938, 4230.598093181143, 4264.637505812009, 4273.252180868336, 4202.6847986400835, 4215.199112168678, 4247.341662042389, 4252.447181866338, 4288.742675439484, 4034.9394759078637, 4122.299209134454, 4125.958740412618, 4212.073343864345, 4216.219999300109, 4423.7788110594665, 4437.889052773674, 4460.149038149164, 4483.708558943658, 4484.7084939479155, 4623.32961720552, 4861.270809378586, 4884.072026315024, 4885.413750349945, 4895.804167833282, 4799.568038876518, 4802.135615589193, 4805.687630304054, 4893.828715994959, 4922.212446008657, 4596.931046034312, 4607.654425918069, 4619.745913974763, 4622.168009758276, 4660.207764679979, 4786.425628924551, 5042.647014708935, 5050.9494905051215, 5060.949390506122, 5126.564242039469, 4735.810567577328, 4767.547083027107, 4818.903621927542, 4852.95147048525, 4898.485659005824, 4939.209726443752, 4949.084419382426, 4960.305557221992, 4962.702237865739, 4994.40067191932, 4615.9076818463445, 4718.150732868116, 4861.270809378621, 4883.106060230212, 4926.531979461945, 4728.905421891612, 4779.163646361872, 4785.234362501983, 4806.110869489155, 4845.491223421561, 4054.8175332110127, 4057.391391291271, 4066.4916885389325, 4085.816138273785, 4110.34234522475, 3474.7915125092577, 3553.502509648651, 3574.088607405095, 3586.8923932282073, 3660.304542137039, 4138.503379594468, 4185.602367775056, 4258.872233832928, 4266.658667306608, 4301.118270754488, 4915.754212289371, 4921.261810728348, 4930.137225985438, 4942.9258561121615, 4955.900881982412, 4035.878923632296, 4119.588041195856, 4274.230638485041, 4292.484901811803, 4327.37253098299, 4185.183889141649, 4268.551802060801, 4270.658347332206, 4287.678424118204, 4301.397804307399, 4609.562091601292, 4628.560286772751, 4638.907221855544, 4644.349791029191, 4678.976605116953, 4643.791029403617, 4810.158222311012, 4831.202851529599, 4908.950910490849, 4913.263010548446, 4580.106879158532, 4624.722516649012, 4632.8146874126005, 4633.953660463352, 4676.55572720591, 4844.0554091951735, 4867.63492738039, 4874.463808980939, 4888.144574699484, 4919.0, 4662.440507139029, 4779.832705855279, 4780.521947805191, 4872.780724867319, 4931.186354251508, 4752.667313288037, 4756.8097276108565, 4779.139754844162, 4796.856094317176, 4808.182608956556, 4746.691465054761, 4760.452547957029, 4762.976185119052, 4766.737829419277, 4805.9038819224115, 4466.0, 4535.750533720677, 4558.680892337505, 4569.0, 4652.0, 4781.282807578891, 4784.162771515041, 4792.904141917073, 4804.039192161512, 4847.733374664427, 4453.1316393303, 4678.228092364858, 4703.905921881475, 4711.929321060118, 4742.644301677319], "unit": "score", "name": "dojo.html", "value": 4434.213155568965}, {"lowerIsBetter": false, "replicates": [564.7289301135452, 565.5249590344113, 576.5992635118592, 578.0144853025591, 583.6993948116719, 35030.824845875766, 35982.99999999997, 36011.81994090029, 36114.8194259029, 36152.45771313426, 39290.80354598223, 39558.802205989, 39688.80155599225, 39740.205195896066, 39917.0, 7870.881936770953, 8023.759287221393, 8026.197380261956, 8034.035915690096, 8066.314363279128, 7879.921200787976, 7955.085165206017, 7966.203379662016, 7975.322097621709, 7977.880331795028, 7597.544147351176, 7612.657430415645, 7637.427192960522, 7650.464467487278, 7694.0, 7923.722669706562, 7994.280514753671, 8005.599720013976, 8022.919770802305, 8027.518348899085, 7885.290323870821, 7956.363490920712, 7990.640421181002, 7997.840043199161, 7999.840003199904, 36434.45348319777, 36740.71407500751, 36809.81595092034, 36856.81571592125, 36959.815200924095, 2348.7533808949984, 2813.732695393934, 2880.5247134223036, 2927.970720292791, 3594.6944509716704, 26103.869480652476, 26250.868745656342, 26275.343116422053, 26415.0, 27155.45689086207, 3403.2002479417315, 3434.175797808533, 3446.8104254266004, 3511.841967111486, 3566.982165089184, 178685.0, 178730.8507659692, 178866.0, 179611.0, 181166.0, 51186.0, 51697.48302517002, 54300.28498575056, 55293.723531382086, 55294.17058744122, 48433.5156648436, 48580.271295930586, 48674.0, 48692.51307486951, 48763.75618121958, 13094.541691040768, 13201.141925774795, 13274.336283185801, 13288.667783305495, 13300.135491193041, 9707.6116955321, 9886.950565247127, 9933.25500587459, 9982.450965196984, 9984.0, 19026.809731902504, 19233.230670773293, 19251.711224331648, 19301.710474342897, 19318.0, 7455.403567714569, 7622.5426474411715, 7626.69493220276, 7636.389088872988, 7708.614569271514, 804.5052292839978, 850.7447765670274, 872.6814712629845, 884.7964968057382, 916.3493919317226, 25134.622980655306, 25196.0, 25493.0, 25665.48669026609, 25672.48655026889, 915.1031988651026, 953.0802775321848, 961.9803008810683, 971.7133445633555, 1008.5209525475487, 13820.585382438543, 13913.30433478322, 13986.370613322222, 14294.642633934234, 14382.640433989025, 263585.0, 267478.0, 268042.0, 268197.0, 269254.0, 45033.0, 45192.09615807665, 45263.77368113138, 45338.773306133255, 45369.77315113403, 1174.3383112895328, 1216.416120262279, 1216.7809794236946, 1216.7870622641003, 1217.6773155113901, 25770.613440798777, 25935.870320648275, 26062.478750425264, 26261.474770504865, 26307.60538591961, 39477.0, 39477.2104557913, 39820.40269396019, 39869.800650996556, 39885.60400385973, 253543.0, 253758.0, 254308.0, 255628.0, 256101.0, 26754.21655722952, 27473.17580472589, 27678.861605691844, 27774.44451111007, 27781.16656500308, 37949.430758539194, 38139.23721525499, 38425.23149536938, 38755.6124438752, 39519.80240098781, 32249.51625725663, 32849.0, 32939.8353008243, 33242.0, 33354.4996825043, 29318.560221596268, 29361.85319073391, 29388.7061129386, 29425.0, 29618.703812961594, 32566.674333257313, 34737.65262347445, 34866.65133348634, 34938.65061349354, 35611.46582801312, 33157.66842331546, 34549.65450345464, 35424.46863297001, 35711.64288357083, 36038.4594231092, 27882.860585697752, 28027.57958630663, 28302.85848570744, 28558.286042849097, 28995.0], "unit": "score", "name": "ext.html", "value": 16633.659308751437}, {"lowerIsBetter": false, "replicates": [317.7886705340948, 318.5333486442362, 323.6860245561804, 325.333067212215, 330.2289154823487, 14599.270036498172, 15090.320935557898, 15569.688606227883, 16049.35802567896, 16764.83235167648, 15079.265884423266, 15210.467633632825, 15829.366825327003, 16041.759373609406, 16049.518514444557, 4345.891352716184, 4561.771911404433, 4607.10161518504, 4618.745968971705, 4620.006698559809, 4557.567031132037, 4590.42619672541, 4597.678162528624, 4598.97700511497, 4613.331066995283, 4489.1021795641, 4546.636269098481, 4555.316702494636, 4555.612772914306, 4593.150267200579, 4562.292844609091, 4579.4046773919345, 4590.655700822452, 4595.919958809677, 4596.632269418438, 4324.783760811947, 4399.670024748157, 4416.072624748806, 4431.313146462271, 4447.110577884404, 11916.225445346025, 12033.819492707617, 12069.336186509738, 12102.576409825702, 14731.779023314659, 1809.1858663601301, 1837.7335286383534, 1844.5296449405316, 1870.036930980546, 1893.091316168233, 8701.129887011248, 8876.467411955304, 9083.545822708904, 9395.436273823525, 11861.703457413547, 1784.866609702848, 1790.8030116687155, 1794.1388133695768, 1801.6937120689383, 1868.3460788723974, 55755.72122139404, 57710.0, 58378.0, 58443.415565844225, 59256.407435925954, 9388.108129727801, 9527.237820974444, 9572.952135239279, 9778.511074446249, 9785.26610504215, 11413.372264525366, 11425.942870285762, 11639.709007274885, 12047.156699030984, 12053.156279060557, 6532.118164047888, 6595.1096601958125, 6681.298463661343, 6683.832904177337, 6696.933030669728, 6071.392860713893, 6349.682515874188, 6354.555181137369, 6474.611523308522, 6497.0, 4154.854580089683, 4213.641840443596, 4241.618254357123, 4250.277452833026, 4263.445752052214, 1790.9820901791077, 1813.6644720726708, 1815.364622382182, 1841.484384372351, 1845.280340667141, 375.1746158451418, 377.92103544380944, 849.8045449546639, 875.382855087162, 980.2892902645667, 9857.605695772088, 9955.352902061342, 10105.0, 10154.187664986783, 10334.793304133875, 393.95272567291534, 399.9780012099304, 409.3225711447559, 415.33961002006953, 426.6458839163487, 5402.594805389612, 5495.862603434866, 5514.338279406416, 9126.49804260772, 9352.859707104399, 515015.0, 517668.0, 523937.0, 530745.0, 530784.0, 72407.63796180986, 72564.0, 72809.2719072813, 74347.0, 76080.61959690166, 1047.7904419116055, 1058.1270451877233, 1058.576569372242, 1066.914646828252, 1078.379931539368, 14512.274386280855, 14680.0, 14808.111513309235, 14845.40618375253, 14873.18197499148, 25484.362890927874, 28686.56970145408, 29982.850085750306, 33155.50266745953, 34258.0, 35167.29665406626, 39386.606133939444, 40300.59699403086, 40834.91650834893, 40970.1805963885, 8535.3598480113, 8897.332700047651, 8932.955335223282, 9010.14403631654, 9050.140236677506, 10209.54057067419, 10998.505067272152, 15685.215739212765, 15880.126593037494, 16026.198690065217, 13190.868091318964, 13401.597952061455, 13597.52408665692, 13728.65678358049, 13753.0, 12885.549005784753, 13180.340982950622, 13523.256220907944, 13556.59330220095, 13988.720225595634, 14240.857591423954, 14281.214533200773, 14304.427822886968, 14680.926595366955, 14686.82505399544, 8487.193716596914, 8698.782530436789, 8860.601272942604, 8911.108889111038, 9391.436513809193, 9217.861732074158, 9334.533273336441, 11668.416579170838, 13197.934010329887, 13690.589282321545], "unit": "score", "name": "jquery.html", "value": 7635.659645764746}, {"lowerIsBetter": false, "replicates": [1478.120518291616, 1636.9099699516526, 1673.5816045988504, 1688.932442702292, 1706.4027590343378, 5744.626599271044, 5987.221661184051, 7014.684339204735, 7148.74979375722, 7159.964200178998, 7021.473389495783, 7033.929660703391, 7054.50618456707, 7067.929320706791, 7079.292070792918, 2054.4555692741437, 2104.0216299420767, 2106.157536985203, 2106.7893210678963, 2109.177420805887, 2040.1737296394983, 2099.1870893003374, 2109.04038662409, 2112.7464704235435, 2114.9048292826783, 2085.1555120176354, 2089.2269860151764, 2097.0572589105054, 2110.757262914769, 2112.070688896888, 1996.8302694271003, 1998.7701414337319, 2012.22529326209, 2012.22529326209, 2013.6375452418558, 2068.048697599106, 2072.4818795301176, 2111.0289266937075, 2114.9365519034454, 2122.310249169026, 6998.615076170809, 7096.964515177391, 7098.9290107099305, 7103.147622285359, 7109.8933515997305, 4134.710570260083, 4213.30480470722, 4217.304144816102, 4220.704550681454, 4224.45082139323, 2739.260399692072, 2744.656917885264, 2770.7506324430697, 2795.7204279572084, 2809.634747482814, 926.7080869526078, 1755.2189275772287, 1774.8491378232866, 1776.4581802550217, 1786.8391844733906, 9477.47873866937, 9480.573374198178, 9637.90362096377, 9662.613495460173, 9673.37123086997, 3784.0, 3816.866409675648, 3880.670143037817, 3881.1267464820753, 3893.201893611803, 8334.249917507454, 8346.791330216793, 8348.624311905858, 8407.411481196257, 8411.0, 4272.4445822042935, 4282.678799090081, 4292.785360731951, 4307.827686892552, 4312.633426158749, 3172.6034245719284, 3243.870245190213, 3476.461148521983, 3834.1373191031794, 3907.5701672815967, 3467.9479807802904, 3536.91157721059, 3551.485034669958, 3554.87557935471, 3577.964220357815, 1125.9605913792977, 1153.2388623508612, 1157.8842115788354, 1163.959261425846, 1165.1086918507349, 968.8740463739668, 987.1806400687412, 991.2763682511662, 1031.9484025798831, 1138.9430528473542, 6598.175228096488, 6599.109120268702, 6607.4053335199105, 6620.337966203341, 6643.800685979331, 443.3615593545284, 450.9797059132347, 464.3267262469433, 467.05887636412655, 468.82419092840183, 5359.196120581866, 5382.811601594004, 5389.541888939406, 5413.810516631977, 5417.512423881791, 8056.5971701415865, 8204.794880128045, 8216.34269258458, 8255.42212045151, 8268.669253229804, 8111.675532978733, 8112.918870811216, 8141.755747327589, 8167.183281671785, 8195.098539160688, 6574.309697481791, 6583.63789991555, 6681.532292739462, 6697.497687673346, 6709.865802683919, 6623.635700036544, 6658.500612453989, 6669.933300666931, 6700.396964273239, 6721.395074443128, 7481.289277518845, 7629.3133617974645, 7639.618019099134, 7673.155952845071, 7738.806529836799, 7556.65995030236, 7870.09493908185, 7877.842443151219, 7979.321757650665, 7982.361411087215, 5286.20706893969, 5433.728313584226, 5928.0218763905195, 6372.776952806629, 6473.741050357933, 6726.865462690621, 6729.461643068641, 6780.830479238059, 6784.050232967487, 6840.521163518506, 6253.937460625518, 6350.047492876106, 6404.519661025535, 6406.647634380154, 6438.3883531064475, 6257.155284036597, 6327.0, 6341.778037768656, 6350.872982540231, 6399.680015999088, 6284.622922624657, 6311.779087731908, 6322.747090116344, 6330.082138090043, 6330.8100756977365, 5816.621919575214, 5831.0, 5857.121431785266, 5867.530597552271, 5873.559483038704, 6015.248093988252, 6021.729022193924, 6041.697915104315, 6061.939380606137, 6068.271807383142], "unit": "score", "name": "mootools.html", "value": 4059.571220378505}, {"lowerIsBetter": false, "replicates": [296.16629188833434, 299.65539629426155, 303.49468135554287, 306.47133694377203, 306.77605348095904, 5463.125899856024, 5506.559475241981, 5535.25274087998, 5584.21820945068, 5621.072523033695, 5396.298481197448, 5561.221428999943, 5562.3047119110115, 5565.833025009256, 5572.86067848304, 4306.246406878784, 4320.481542214923, 4323.3947247385395, 4336.761478118694, 4341.196878577473, 4326.242907491192, 4329.090890912912, 4336.284513055342, 4336.783160841961, 4345.69580129391, 4099.934017155546, 4263.616274535291, 4296.957030429687, 4297.054647977456, 4309.913801723964, 4228.1966426379195, 4231.1537692461325, 4252.9149417011795, 4254.638355739766, 4269.6370808481315, 3686.686631636314, 3692.2430901665093, 3692.390755525362, 3697.500837386945, 3706.054955986206, 5286.154215325568, 5408.567314614821, 5413.106837371829, 5418.593605479566, 5427.294451721291, 4848.878778030542, 4889.804407823683, 4891.0, 4893.119238537062, 4900.191468407708, 5887.941120588825, 5901.8819623607715, 5903.852403689899, 5912.024515954862, 5920.911186332209, 3885.7862817545024, 4011.2178125265586, 4013.25754735372, 4019.8995025124605, 4024.1750441159493, 6050.606710563799, 6197.845053873599, 6199.473044791153, 6200.286966998808, 6201.224846894138, 4128.153728485653, 4132.40080188371, 4133.2146892091005, 4143.8964025898995, 4149.25313443583, 4156.397322388237, 4170.749755014709, 4200.0, 4200.4959404871615, 4206.47419072616, 4758.714477131383, 4833.202521583969, 4835.927461088087, 4839.879003024953, 4839.951600484021, 5850.444207800252, 5863.325717542537, 5866.941330586639, 5867.266591676041, 5873.177755114202, 1447.4355001549404, 1448.9855101449061, 1455.6069861137435, 1456.5557504961089, 1457.1475686723174, 977.4721650308753, 979.5738853598707, 982.6315131825565, 992.2855544008303, 996.3175224970918, 5129.640925135204, 5130.0, 5132.28148059272, 5140.820071297487, 5148.9485105149215, 6055.424734650202, 6096.725647345791, 6110.938890611037, 6111.96944015277, 6127.264728232641, 5109.20807274873, 5111.182210846321, 5131.332926719502, 5134.820281290137, 5136.357955255593, 3231.845697741992, 3256.9837150814096, 3290.2596915693775, 3303.537504749337, 3308.0902751742983, 5573.749181286852, 5688.77244910199, 5709.05800542914, 5717.142428635655, 5723.942760572424, 6254.74981000764, 6296.811095667137, 6338.366163383717, 6345.524085693592, 6346.365363463617, 5710.571707121982, 5732.742026608813, 5738.5982981191755, 5748.511376533042, 5750.396208398058, 6099.420555047263, 6128.8774224516155, 6135.570510064253, 6138.662373569497, 6161.753529858935, 5786.392428795084, 6017.578769486094, 6021.668808215591, 6030.939690603038, 6044.032954727222, 5759.798407055733, 5764.394738552392, 5780.913286300793, 5783.074708046693, 5795.710214489174, 4054.290499162694, 4064.898377540585, 4072.185562887375, 4075.3886916961505, 4075.5109386873764, 6027.156198132353, 6054.878902422015, 6136.23297087864, 6141.477974372228, 6163.0, 5906.822795316148, 5916.437938395846, 5916.940830591639, 5917.91123133162, 5927.288725352985, 5913.46778789911, 5921.5558833086825, 5922.466977972003, 5946.0, 5948.524118070457, 5651.519620832275, 5763.625364351304, 5765.509931655856, 5785.623934444247, 5799.362070172362, 5950.7917222896995, 5953.970230148821, 5955.0, 5958.404159584007, 5986.341502434816, 5806.158107074366, 5814.94185058144, 5818.214541036906, 5819.679917604572, 5834.824955251349], "unit": "score", "name": "prototype.html", "value": 4380.9957393180175}, {"lowerIsBetter": false, "replicates": [654.4012228810637, 736.6869080640727, 775.6486112906595, 796.406677025616, 796.9123396426396, 10702.46487675616, 10909.127269818415, 10923.563057477691, 10947.5620975161, 10955.452227388618, 11567.595134170306, 11609.709757256072, 11856.0, 11882.405879706022, 11887.940560297186, 775.3874439193031, 787.397640804782, 805.9274665280124, 808.0465051239535, 808.1393316118315, 788.5071830106184, 792.0258082558456, 799.3724925933144, 800.6357107516095, 801.2028032108061, 826.6238861318116, 829.0631586307494, 830.7050996896105, 831.085805613826, 831.4637059096879, 814.1410811593767, 820.0815087102424, 820.5281962871343, 821.3142026407957, 822.0792712162387, 598.9610675306092, 602.9125776762389, 603.972821223046, 604.3050491934267, 609.9237595300588, 11107.0, 11212.719682007933, 11278.15413843965, 11299.0, 11383.430828458626, 9759.389700699376, 10078.748031299203, 10270.845937310947, 10593.916513106307, 10873.456327183609, 9148.542572871329, 9344.626214951393, 9357.859632105525, 9443.716688499357, 9455.52722363886, 3208.8395580220895, 3225.7258133058717, 3239.6440870274964, 3246.0748686624197, 3251.723603493706, 39670.0, 40117.398239026435, 40123.19753604911, 40256.798716006524, 40276.79861600673, 8891.73324800257, 8897.599608017656, 8953.104689531125, 9126.81746365069, 9159.633614655473, 15858.127802970947, 16021.679566408606, 16035.599110022109, 16076.43732469358, 16080.195990200444, 6125.418085281891, 6285.9057114143325, 6300.464460520907, 6460.741570337228, 6520.673966301666, 3528.5236493073107, 3548.503209550665, 3553.2360542482975, 3626.111602657366, 3636.872709455209, 2548.0, 2574.4851029794117, 2579.587266037425, 2583.7416258374387, 2584.3151564835334, 458.79354290569376, 461.3610149942354, 469.20938219100924, 475.6575265808612, 477.5821156488073, 445.7125154275539, 468.12694325083476, 530.8540151458379, 546.8277492589822, 555.2115995286703, 6741.359570840762, 6949.409300209539, 7140.214576396592, 7256.600886951268, 7258.383037441771, 419.1386700330788, 434.68702534175975, 435.6297147424727, 469.01506835644875, 521.2025600830735, 3282.7373810095137, 3296.8351582420783, 3501.4047611905526, 3538.8053657048595, 3779.9244015120094, 49087.0, 49360.0, 50544.74727626412, 52053.0, 52066.73966630142, 41547.0, 41969.37045944313, 42032.57967420287, 42085.36871946923, 46661.30008049882, 42030.0, 42289.78855105705, 42846.78576607097, 43610.7819460907, 44158.55841441544, 7678.193789652006, 7759.719646258304, 7918.643661035152, 8022.679092836222, 8182.67269309221, 30074.69925300719, 31294.37411251808, 31316.37367252688, 31466.37067258688, 31476.37047259088, 37783.0, 38293.4255986166, 38336.61663383442, 38350.0, 38824.805875970436, 9583.760405989906, 9722.951385243312, 9776.511174441108, 9968.50157492137, 10672.679819605424, 10632.681019569425, 10684.626038088629, 10773.24587278883, 10812.56749730002, 10873.945630271797, 10197.439140847324, 10372.11836993864, 10490.737731556772, 10514.211434142317, 10577.735556611146, 10229.48852557384, 10279.94860025695, 10338.638147664795, 10350.5342259597, 10351.120154786928, 8707.695230666895, 9584.28117891175, 9893.50532473359, 10102.0, 10115.59537618487, 8488.915110849059, 8489.40574159803, 8537.103604121477, 8693.0, 8730.869036964577, 7960.880586791087, 8479.830403392021, 8506.404551681322, 8528.189821967151, 8690.087540808378], "unit": "score", "name": "yui.html", "value": 5536.710155896598}], "name": "dromaeo_css", "value": 6175.42052890671}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 113.0, 112.0, 113.0, 122.0, 112.0, 112.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.0}, {"lowerIsBetter": true, "replicates": [158.0, 129.0, 158.0, 165.0, 130.0, 156.0, 158.0, 131.0, 163.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 164.0, 162.0, 163.0, 165.0, 171.0, 165.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 72.0, 74.0, 73.0, 136.0, 73.0, 77.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 138.0, 94.0, 96.0, 95.0, 130.0, 95.0, 95.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 149.0, 148.0, 147.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 98.0, 100.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 74.0, 73.0, 74.0, 75.0, 75.0, 78.0, 74.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 74.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 69.0, 79.0, 69.0, 68.0, 70.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.2}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 84.0, 85.0, 83.0, 82.0, 84.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [127.0, 122.0, 119.0, 127.0, 128.0, 124.0, 123.0, 120.0, 124.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [134.0, 147.0, 147.0, 143.0, 150.0, 135.0, 145.0, 143.0, 146.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 77.0, 72.0, 71.0, 71.0, 69.0, 69.0, 69.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1531.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.41959881617888], "unit": "score", "name": "Richards", "value": 214.70676399999994}, {"lowerIsBetter": false, "replicates": [190.76688286913392], "unit": "score", "name": "DeltaBlue", "value": 346.59055600000005}, {"lowerIsBetter": false, "replicates": [277.77777777777777], "unit": "score", "name": "Encrypt", "value": 958.2516000000002}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1064.9627263045793], "unit": "score", "name": "RayTrace", "value": 694.8496709999997}, {"lowerIsBetter": false, "replicates": [695.8942240779402], "unit": "score", "name": "Earley", "value": 957.7073310000004}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [27108.108108108107], "unit": "score", "name": "RegExp", "value": 33.60562811565303}, {"lowerIsBetter": false, "replicates": [632.9113924050633], "unit": "score", "name": "Splay", "value": 128.75577999999996}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21225.391400063843}]} 04:34:38 INFO - RETURN: dromaeo_css: 6175.42 04:34:38 INFO - RETURN: kraken: 1531.90 04:34:38 INFO - RETURN: v8_7: 21225.39 04:34:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21225.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1531.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6175.42"}}} 04:34:38 INFO - Return code: 0 04:34:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:34:38 INFO - # TBPL SUCCESS # 04:34:38 INFO - Running post-action listener: _resource_record_post_action 04:34:38 INFO - Running post-run listener: _resource_record_post_run 04:34:39 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 8192; Write bytes: 554426368; Read time: 28; Write time: 479436 04:34:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235954176; Read time: 0; Write time: 249704 04:34:39 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 8192; Write bytes: 318472192; Read time: 28; Write time: 229732 04:34:39 INFO - Running post-run listener: _upload_blobber_files 04:34:39 INFO - Blob upload gear active. 04:34:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:34:39 INFO - Copying logs to upload dir... 04:34:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1264.071075 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-21 04:34:38.073277) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-21 04:34:38.076466) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009943 build_url: 'https://queue.taskcluster.net/v1/task/RQOKlg3bQ9i3og6cb2_FSw/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-21 04:34:38.128277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:34:38.128632) ========= 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=6d10e77667a3a93f6a3fb0d0000001b0-1450700013.137152-793544130 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 04:34:38.179405) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 04:34:38.179838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 04:34:38.180234) ========= ========= Total master_lag: 1.27 =========